builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0017 starttime: 1448373274.07 results: success (0) buildid: 20151124042330 builduid: 6db6042971ae4abeb02c4df70720533c revision: 337f0ed43821944b9ba77dd4b98083192413a765 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.066106) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.066574) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.067103) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005788 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.086661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.087094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.138197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.138489) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005248 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.189033) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.189468) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.189995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.190881) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-24 05:54:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-24 05:54:34 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.337185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.545418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.545718) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.019082 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.594366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:34.594711) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 337f0ed43821944b9ba77dd4b98083192413a765 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 337f0ed43821944b9ba77dd4b98083192413a765 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-24 05:54:34,672 truncating revision to first 12 chars 2015-11-24 05:54:34,672 Setting DEBUG logging. 2015-11-24 05:54:34,672 attempt 1/10 2015-11-24 05:54:34,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/337f0ed43821?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 05:54:35,205 unpacking tar archive at: mozilla-aurora-337f0ed43821/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:35.385778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:35.386089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:35.397761) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:35.398012) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:54:35.398367) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-24 05:54:35.398665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:54:35 INFO - MultiFileLogger online at 20151124 05:54:35 in /builds/slave/test 05:54:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:54:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:35 INFO - {'append_to_log': False, 05:54:35 INFO - 'base_work_dir': '/builds/slave/test', 05:54:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:54:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:35 INFO - 'branch': 'Mozilla-Aurora', 05:54:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:35 INFO - 'config_files': ('talos/mac_config.py',), 05:54:35 INFO - 'default_actions': ('clobber', 05:54:35 INFO - 'read-buildbot-config', 05:54:35 INFO - 'download-and-extract', 05:54:35 INFO - 'populate-webroot', 05:54:35 INFO - 'create-virtualenv', 05:54:35 INFO - 'install', 05:54:35 INFO - 'run-tests'), 05:54:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:35 INFO - 'download_minidump_stackwalk': True, 05:54:35 INFO - 'download_symbols': 'ondemand', 05:54:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:35 INFO - 'installer_path': 'installer.exe', 05:54:35 INFO - 'log_level': 'info', 05:54:35 INFO - 'log_name': 'talos', 05:54:35 INFO - 'log_to_console': True, 05:54:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:54:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:54:35 INFO - 'opt_config_files': (), 05:54:35 INFO - 'pip_index': False, 05:54:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:35 INFO - 'cmd': ('bash', 05:54:35 INFO - '-c', 05:54:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:35 INFO - 'enabled': True, 05:54:35 INFO - 'halt_on_failure': False, 05:54:35 INFO - 'name': 'check_screen_resolution'},), 05:54:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:35 INFO - 'cmd': ('bash', 05:54:35 INFO - '-c', 05:54:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:35 INFO - 'enabled': True, 05:54:35 INFO - 'halt_on_failure': False, 05:54:35 INFO - 'name': 'check_screen_resolution'},), 05:54:35 INFO - 'run_cmd_checks_enabled': True, 05:54:35 INFO - 'sps_profile': False, 05:54:35 INFO - 'sps_profile_interval': 0, 05:54:35 INFO - 'suite': 'dromaeojs', 05:54:35 INFO - 'system_bits': '64', 05:54:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:35 INFO - 'title': 't-yosemite-r5-0017', 05:54:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:35 INFO - 'use_talos_json': True, 05:54:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:35 INFO - 'work_dir': 'build'} 05:54:35 INFO - ##### 05:54:35 INFO - ##### Running clobber step. 05:54:35 INFO - ##### 05:54:35 INFO - Running pre-action listener: _resource_record_pre_action 05:54:35 INFO - Running main action method: clobber 05:54:35 INFO - rmtree: /builds/slave/test/build 05:54:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:37 INFO - Running post-action listener: _resource_record_post_action 05:54:37 INFO - ##### 05:54:37 INFO - ##### Running read-buildbot-config step. 05:54:37 INFO - ##### 05:54:37 INFO - Running pre-action listener: _resource_record_pre_action 05:54:37 INFO - Running main action method: read_buildbot_config 05:54:37 INFO - Using buildbot properties: 05:54:37 INFO - { 05:54:37 INFO - "properties": { 05:54:37 INFO - "buildnumber": 435, 05:54:37 INFO - "product": "firefox", 05:54:37 INFO - "script_repo_revision": "production", 05:54:37 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 05:54:37 INFO - "repository": "", 05:54:37 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 05:54:37 INFO - "buildid": "20151124042330", 05:54:37 INFO - "slavename": "t-yosemite-r5-0017", 05:54:37 INFO - "pgo_build": "False", 05:54:37 INFO - "basedir": "/builds/slave/test", 05:54:37 INFO - "project": "", 05:54:37 INFO - "platform": "yosemite", 05:54:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:54:37 INFO - "slavebuilddir": "test", 05:54:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:54:37 INFO - "branch": "mozilla-aurora", 05:54:37 INFO - "repo_path": "releases/mozilla-aurora", 05:54:37 INFO - "stage_platform": "macosx64", 05:54:37 INFO - "builduid": "6db6042971ae4abeb02c4df70720533c", 05:54:37 INFO - "revision": "337f0ed43821944b9ba77dd4b98083192413a765" 05:54:37 INFO - }, 05:54:37 INFO - "sourcestamp": { 05:54:37 INFO - "repository": "", 05:54:37 INFO - "hasPatch": false, 05:54:37 INFO - "project": "", 05:54:37 INFO - "branch": "mozilla-aurora-macosx64-talos", 05:54:37 INFO - "changes": [ 05:54:37 INFO - { 05:54:37 INFO - "category": null, 05:54:37 INFO - "files": [ 05:54:37 INFO - { 05:54:37 INFO - "url": null, 05:54:37 INFO - "name": "https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 05:54:37 INFO - } 05:54:37 INFO - ], 05:54:37 INFO - "repository": "", 05:54:37 INFO - "rev": "337f0ed43821944b9ba77dd4b98083192413a765", 05:54:37 INFO - "who": "cbook@mozilla.com", 05:54:37 INFO - "when": 1448373245, 05:54:37 INFO - "number": 6700176, 05:54:37 INFO - "comments": "fix bad merge a=bustage-fix", 05:54:37 INFO - "project": "", 05:54:37 INFO - "at": "Tue 24 Nov 2015 05:54:05", 05:54:37 INFO - "branch": "mozilla-aurora-macosx64-talos", 05:54:37 INFO - "revlink": "", 05:54:37 INFO - "properties": [ 05:54:37 INFO - [ 05:54:37 INFO - "buildid", 05:54:37 INFO - "20151124042330", 05:54:37 INFO - "Change" 05:54:37 INFO - ], 05:54:37 INFO - [ 05:54:37 INFO - "builduid", 05:54:37 INFO - "6db6042971ae4abeb02c4df70720533c", 05:54:37 INFO - "Change" 05:54:37 INFO - ], 05:54:37 INFO - [ 05:54:37 INFO - "pgo_build", 05:54:37 INFO - "False", 05:54:37 INFO - "Change" 05:54:37 INFO - ] 05:54:37 INFO - ], 05:54:37 INFO - "revision": "337f0ed43821944b9ba77dd4b98083192413a765" 05:54:37 INFO - } 05:54:37 INFO - ], 05:54:37 INFO - "revision": "337f0ed43821944b9ba77dd4b98083192413a765" 05:54:37 INFO - } 05:54:37 INFO - } 05:54:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 05:54:37 INFO - Running post-action listener: _resource_record_post_action 05:54:37 INFO - ##### 05:54:37 INFO - ##### Running download-and-extract step. 05:54:37 INFO - ##### 05:54:37 INFO - Running pre-action listener: _resource_record_pre_action 05:54:37 INFO - Running main action method: download_and_extract 05:54:37 INFO - mkdir: /builds/slave/test/build/tests 05:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:37 INFO - https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/test_packages.json 05:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/test_packages.json 05:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:54:38 INFO - Downloaded 1149 bytes. 05:54:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:54:38 INFO - Using the following test package requirements: 05:54:38 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 05:54:38 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 05:54:38 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 05:54:38 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 05:54:38 INFO - u'jsshell-mac.zip'], 05:54:38 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 05:54:38 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 05:54:38 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 05:54:38 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 05:54:38 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 05:54:38 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 05:54:38 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 05:54:38 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 05:54:38 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 05:54:38 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 05:54:38 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 05:54:38 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 05:54:38 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:38 INFO - https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:39 INFO - Downloaded 17448053 bytes. 05:54:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:54:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 05:54:44 INFO - Return code: 0 05:54:44 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:44 INFO - https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:47 INFO - Downloaded 17448053 bytes. 05:54:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:54:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 05:54:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 05:54:52 INFO - Return code: 0 05:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:52 INFO - https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:54:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 05:54:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 05:54:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 05:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:54:53 INFO - Downloaded 11131307 bytes. 05:54:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:54:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 05:54:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:54:54 INFO - Return code: 0 05:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:54 INFO - https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 05:54:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 05:54:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 05:54:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 05:54:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 05:54:58 INFO - Downloaded 107805524 bytes. 05:54:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 05:54:58 INFO - mkdir: /builds/slave/test/properties 05:54:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:58 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:58 INFO - Contents: 05:54:58 INFO - build_url:https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 05:54:58 INFO - Running post-action listener: _resource_record_post_action 05:54:58 INFO - Running post-action listener: set_extra_try_arguments 05:54:58 INFO - ##### 05:54:58 INFO - ##### Running populate-webroot step. 05:54:58 INFO - ##### 05:54:58 INFO - Running pre-action listener: _resource_record_pre_action 05:54:58 INFO - Running main action method: populate_webroot 05:54:58 INFO - Guessing talos json url... 05:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:58 INFO - https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 05:54:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 05:54:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 05:54:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 05:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 05:54:58 INFO - Downloaded 107 bytes. 05:54:58 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 05:54:58 INFO - Contents: 05:54:58 INFO - 20151124042330 05:54:58 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/337f0ed43821944b9ba77dd4b98083192413a765 05:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:58 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/337f0ed438/testing/talos/talos.json 05:54:58 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/337f0ed438/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/337f0ed438/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:54:59 INFO - Downloaded 4264 bytes. 05:54:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:54:59 INFO - '../fennec_ids.txt'], 05:54:59 INFO - 'tests': ['tcheck2']}, 05:54:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:59 INFO - '--tppagecycles', 05:54:59 INFO - '7'], 05:54:59 INFO - 'tests': ['tsvgm']}}, 05:54:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:54:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:54:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:54:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'tests': ['damp', 'tps']}, 05:54:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['damp', 'tps']}, 05:54:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:54:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:59 INFO - 'other': {'tests': ['a11yr', 05:54:59 INFO - 'ts_paint', 05:54:59 INFO - 'tpaint', 05:54:59 INFO - 'sessionrestore', 05:54:59 INFO - 'sessionrestore_no_auto_restore']}, 05:54:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['a11yr', 05:54:59 INFO - 'ts_paint', 05:54:59 INFO - 'tpaint', 05:54:59 INFO - 'sessionrestore', 05:54:59 INFO - 'sessionrestore_no_auto_restore']}, 05:54:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['a11yr', 05:54:59 INFO - 'ts_paint', 05:54:59 INFO - 'tpaint', 05:54:59 INFO - 'sessionrestore', 05:54:59 INFO - 'sessionrestore_no_auto_restore']}, 05:54:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['a11yr', 05:54:59 INFO - 'ts_paint', 05:54:59 INFO - 'tpaint', 05:54:59 INFO - 'sessionrestore', 05:54:59 INFO - 'sessionrestore_no_auto_restore']}, 05:54:59 INFO - 'other_l64': {'tests': ['a11yr', 05:54:59 INFO - 'ts_paint', 05:54:59 INFO - 'tpaint', 05:54:59 INFO - 'sessionrestore', 05:54:59 INFO - 'sessionrestore_no_auto_restore']}, 05:54:59 INFO - 'other_nol64': {'tests': ['a11yr', 05:54:59 INFO - 'ts_paint', 05:54:59 INFO - 'tpaint', 05:54:59 INFO - 'sessionrestore', 05:54:59 INFO - 'sessionrestore_no_auto_restore']}, 05:54:59 INFO - 'svgr': {'tests': ['tsvgx', 05:54:59 INFO - 'tsvgr_opacity', 05:54:59 INFO - 'tart', 05:54:59 INFO - 'tscrollx', 05:54:59 INFO - 'cart']}, 05:54:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['tsvgx', 05:54:59 INFO - 'tsvgr_opacity', 05:54:59 INFO - 'tart', 05:54:59 INFO - 'tscrollx', 05:54:59 INFO - 'cart']}, 05:54:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'tests': ['tp5o']}, 05:54:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'talos_options': ['--e10s'], 05:54:59 INFO - 'tests': ['tp5o']}, 05:54:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'talos_options': ['--xperf_path', 05:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:59 INFO - 'tests': ['tp5n']}, 05:54:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:59 INFO - 'talos_options': ['--e10s', 05:54:59 INFO - '--xperf_path', 05:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:54:59 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:54:59 INFO - 'tests': ['tp5n']}}, 05:54:59 INFO - 'talos.zip': {'path': '', 05:54:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:59 INFO - Running post-action listener: _resource_record_post_action 05:54:59 INFO - ##### 05:54:59 INFO - ##### Running create-virtualenv step. 05:54:59 INFO - ##### 05:54:59 INFO - Running pre-action listener: _resource_record_pre_action 05:54:59 INFO - Running main action method: create_virtualenv 05:54:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:54:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:59 INFO - Using real prefix '/tools/python27' 05:54:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:03 INFO - Installing pip.................done. 05:55:03 INFO - Return code: 0 05:55:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba80d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:55:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:03 INFO - 'HOME': '/Users/cltbld', 05:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:03 INFO - 'LOGNAME': 'cltbld', 05:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:03 INFO - 'MOZ_NO_REMOTE': '1', 05:55:03 INFO - 'NO_EM_RESTART': '1', 05:55:03 INFO - 'PAGER': '/bin/cat', 05:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:03 INFO - 'PWD': '/builds/slave/test', 05:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:03 INFO - 'SHELL': '/bin/bash', 05:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:55:03 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:03 INFO - 'USER': 'cltbld', 05:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:03 INFO - 'XPC_FLAGS': '0x0', 05:55:03 INFO - 'XPC_SERVICE_NAME': '0', 05:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:55:04 INFO - Cleaning up... 05:55:04 INFO - Return code: 0 05:55:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba80d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:04 INFO - 'HOME': '/Users/cltbld', 05:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:04 INFO - 'LOGNAME': 'cltbld', 05:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:04 INFO - 'MOZ_NO_REMOTE': '1', 05:55:04 INFO - 'NO_EM_RESTART': '1', 05:55:04 INFO - 'PAGER': '/bin/cat', 05:55:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:04 INFO - 'PWD': '/builds/slave/test', 05:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:04 INFO - 'SHELL': '/bin/bash', 05:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:55:04 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:04 INFO - 'USER': 'cltbld', 05:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:04 INFO - 'XPC_FLAGS': '0x0', 05:55:04 INFO - 'XPC_SERVICE_NAME': '0', 05:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:04 INFO - Downloading/unpacking psutil>=0.7.1 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:55:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:07 INFO - Installing collected packages: psutil 05:55:07 INFO - Running setup.py install for psutil 05:55:07 INFO - building 'psutil._psutil_osx' extension 05:55:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:55:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:55:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:55:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:55:07 INFO - building 'psutil._psutil_posix' extension 05:55:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:55:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:55:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:55:07 INFO - ^ 05:55:07 INFO - 1 warning generated. 05:55:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:55:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:08 INFO - Successfully installed psutil 05:55:08 INFO - Cleaning up... 05:55:08 INFO - Return code: 0 05:55:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba80d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:08 INFO - 'HOME': '/Users/cltbld', 05:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:08 INFO - 'LOGNAME': 'cltbld', 05:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:08 INFO - 'MOZ_NO_REMOTE': '1', 05:55:08 INFO - 'NO_EM_RESTART': '1', 05:55:08 INFO - 'PAGER': '/bin/cat', 05:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:08 INFO - 'PWD': '/builds/slave/test', 05:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:08 INFO - 'SHELL': '/bin/bash', 05:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:55:08 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:08 INFO - 'USER': 'cltbld', 05:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:08 INFO - 'XPC_FLAGS': '0x0', 05:55:08 INFO - 'XPC_SERVICE_NAME': '0', 05:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:55:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:55:11 INFO - Installing collected packages: mozsystemmonitor 05:55:11 INFO - Running setup.py install for mozsystemmonitor 05:55:11 INFO - Successfully installed mozsystemmonitor 05:55:11 INFO - Cleaning up... 05:55:11 INFO - Return code: 0 05:55:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba80d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:11 INFO - 'HOME': '/Users/cltbld', 05:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:11 INFO - 'LOGNAME': 'cltbld', 05:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:11 INFO - 'MOZ_NO_REMOTE': '1', 05:55:11 INFO - 'NO_EM_RESTART': '1', 05:55:11 INFO - 'PAGER': '/bin/cat', 05:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:11 INFO - 'PWD': '/builds/slave/test', 05:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:11 INFO - 'SHELL': '/bin/bash', 05:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:55:11 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:11 INFO - 'USER': 'cltbld', 05:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:11 INFO - 'XPC_FLAGS': '0x0', 05:55:11 INFO - 'XPC_SERVICE_NAME': '0', 05:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:15 INFO - Downloading docopt-0.6.1.tar.gz 05:55:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:15 INFO - Running setup.py install for blobuploader 05:55:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:15 INFO - Running setup.py install for requests 05:55:16 INFO - Running setup.py install for docopt 05:55:16 INFO - Successfully installed blobuploader requests docopt 05:55:16 INFO - Cleaning up... 05:55:16 INFO - Return code: 0 05:55:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba80d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:55:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:55:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:16 INFO - 'HOME': '/Users/cltbld', 05:55:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:16 INFO - 'LOGNAME': 'cltbld', 05:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:16 INFO - 'MOZ_NO_REMOTE': '1', 05:55:16 INFO - 'NO_EM_RESTART': '1', 05:55:16 INFO - 'PAGER': '/bin/cat', 05:55:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:16 INFO - 'PWD': '/builds/slave/test', 05:55:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:16 INFO - 'SHELL': '/bin/bash', 05:55:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:55:16 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:55:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:16 INFO - 'USER': 'cltbld', 05:55:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:16 INFO - 'XPC_FLAGS': '0x0', 05:55:16 INFO - 'XPC_SERVICE_NAME': '0', 05:55:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-_g6QSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-XG4UGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-AQPgjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-Ri4ztx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-WauqSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-WFiEBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-RWpAf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:17 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-SBiwTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-8HkNGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-ymUO9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-SFItot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-aM3itR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-VQfsoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-yevXjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-pJBTYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-rXCZXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:18 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-oDGiP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:19 INFO - Running setup.py install for manifestparser 05:55:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Running setup.py install for mozcrash 05:55:19 INFO - Running setup.py install for mozdebug 05:55:19 INFO - Running setup.py install for mozdevice 05:55:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Running setup.py install for mozfile 05:55:19 INFO - Running setup.py install for mozhttpd 05:55:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for mozinfo 05:55:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for mozInstall 05:55:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for mozleak 05:55:20 INFO - Running setup.py install for mozlog 05:55:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:20 INFO - Running setup.py install for moznetwork 05:55:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:21 INFO - Running setup.py install for mozprocess 05:55:21 INFO - Running setup.py install for mozprofile 05:55:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:21 INFO - Running setup.py install for mozrunner 05:55:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:21 INFO - Running setup.py install for mozscreenshot 05:55:21 INFO - Running setup.py install for moztest 05:55:21 INFO - Running setup.py install for mozversion 05:55:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:22 INFO - Cleaning up... 05:55:22 INFO - Return code: 0 05:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba80d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:22 INFO - 'HOME': '/Users/cltbld', 05:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:22 INFO - 'LOGNAME': 'cltbld', 05:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:22 INFO - 'MOZ_NO_REMOTE': '1', 05:55:22 INFO - 'NO_EM_RESTART': '1', 05:55:22 INFO - 'PAGER': '/bin/cat', 05:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:22 INFO - 'PWD': '/builds/slave/test', 05:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:22 INFO - 'SHELL': '/bin/bash', 05:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:55:22 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:22 INFO - 'USER': 'cltbld', 05:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:22 INFO - 'XPC_FLAGS': '0x0', 05:55:22 INFO - 'XPC_SERVICE_NAME': '0', 05:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:22 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-0s1a9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:22 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-RjX3zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:22 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-ov9msx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:22 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-eWUhkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:22 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-ITJ82c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-5pwAlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-gzlNTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-jEb9F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-yDXHfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-0tNguO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-mXWcUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-cwaT4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:23 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-R_F208-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:24 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-iOxg4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:24 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-BDSaUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:24 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-2K4TNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:24 INFO - Running setup.py (path:/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/pip-QDXY8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:27 INFO - Downloading blessings-1.5.1.tar.gz 05:55:27 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:27 INFO - Installing collected packages: blessings 05:55:27 INFO - Running setup.py install for blessings 05:55:27 INFO - Successfully installed blessings 05:55:27 INFO - Cleaning up... 05:55:27 INFO - Return code: 0 05:55:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:27 INFO - Reading from file tmpfile_stdout 05:55:27 INFO - Current package versions: 05:55:27 INFO - blessings == 1.5.1 05:55:27 INFO - blobuploader == 1.2.4 05:55:27 INFO - docopt == 0.6.1 05:55:27 INFO - manifestparser == 1.1 05:55:27 INFO - mozInstall == 1.12 05:55:27 INFO - mozcrash == 0.16 05:55:27 INFO - mozdebug == 0.1 05:55:27 INFO - mozdevice == 0.46 05:55:27 INFO - mozfile == 1.2 05:55:27 INFO - mozhttpd == 0.7 05:55:27 INFO - mozinfo == 0.8 05:55:27 INFO - mozleak == 0.1 05:55:27 INFO - mozlog == 3.0 05:55:27 INFO - moznetwork == 0.27 05:55:27 INFO - mozprocess == 0.22 05:55:27 INFO - mozprofile == 0.27 05:55:27 INFO - mozrunner == 6.11 05:55:27 INFO - mozscreenshot == 0.1 05:55:27 INFO - mozsystemmonitor == 0.0 05:55:27 INFO - moztest == 0.7 05:55:27 INFO - mozversion == 1.4 05:55:27 INFO - psutil == 3.1.1 05:55:27 INFO - requests == 1.2.3 05:55:27 INFO - wsgiref == 0.1.2 05:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f80a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba80d85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:27 INFO - 'HOME': '/Users/cltbld', 05:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:27 INFO - 'LOGNAME': 'cltbld', 05:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:27 INFO - 'MOZ_NO_REMOTE': '1', 05:55:27 INFO - 'NO_EM_RESTART': '1', 05:55:27 INFO - 'PAGER': '/bin/cat', 05:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:27 INFO - 'PWD': '/builds/slave/test', 05:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:27 INFO - 'SHELL': '/bin/bash', 05:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:55:27 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:27 INFO - 'USER': 'cltbld', 05:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:27 INFO - 'XPC_FLAGS': '0x0', 05:55:27 INFO - 'XPC_SERVICE_NAME': '0', 05:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:55:28 INFO - Cleaning up... 05:55:28 INFO - Return code: 0 05:55:28 INFO - Running post-action listener: _resource_record_post_action 05:55:28 INFO - Running post-action listener: _start_resource_monitoring 05:55:28 INFO - Starting resource monitoring. 05:55:28 INFO - ##### 05:55:28 INFO - ##### Running install step. 05:55:28 INFO - ##### 05:55:28 INFO - Running pre-action listener: _resource_record_pre_action 05:55:28 INFO - Running main action method: install 05:55:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:28 INFO - Reading from file tmpfile_stdout 05:55:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:28 INFO - Reading from file tmpfile_stdout 05:55:28 INFO - Output received: 05:55:28 INFO - Usage: mozinstall [options] installer 05:55:28 INFO - Options: 05:55:28 INFO - -h, --help show this help message and exit 05:55:28 INFO - -d DEST, --destination=DEST 05:55:28 INFO - Directory to install application into. [default: 05:55:28 INFO - "/builds/slave/test"] 05:55:28 INFO - --app=APP Application being installed. [default: firefox] 05:55:28 INFO - mkdir: /builds/slave/test/build/application 05:55:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:56:06 INFO - Reading from file tmpfile_stdout 05:56:06 INFO - Output received: 05:56:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:56:06 INFO - Running post-action listener: _resource_record_post_action 05:56:06 INFO - ##### 05:56:06 INFO - ##### Running run-tests step. 05:56:06 INFO - ##### 05:56:06 INFO - Running pre-action listener: _resource_record_pre_action 05:56:06 INFO - Running main action method: run_tests 05:56:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:06 INFO - 2015-11-24 05:56:06.868 screenresolution[2221:15878] starting screenresolution argv=screenresolution get 05:56:06 INFO - 2015-11-24 05:56:06.872 screenresolution[2221:15878] Display 0: 1600x1200x32@60 05:56:06 INFO - 2015-11-24 05:56:06.879 screenresolution[2222:15880] starting screenresolution argv=screenresolution list 05:56:06 INFO - Available Modes on Display 0 05:56:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:07 INFO - Intel HD Graphics 3000: 05:56:07 INFO - Chipset Model: Intel HD Graphics 3000 05:56:07 INFO - Type: GPU 05:56:07 INFO - Bus: Built-In 05:56:07 INFO - VRAM (Total): 512 MB 05:56:07 INFO - VRAM (Dynamic, Max): 10 05:56:07 INFO - Vendor: Intel (0x8086) 05:56:07 INFO - Device ID: 0x0116 05:56:07 INFO - Revision ID: 0x0009 05:56:07 INFO - Displays: 05:56:07 INFO - Display: 05:56:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:07 INFO - Display Serial Number: 1600x1200 60 05:56:07 INFO - Main Display: Yes 05:56:07 INFO - Mirror: Off 05:56:07 INFO - Online: Yes 05:56:07 INFO - Rotation: Supported 05:56:07 INFO - Return code: 0 05:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:56:07 INFO - Python 2.7.3 05:56:07 INFO - Return code: 0 05:56:07 INFO - grabbing minidump binary from tooltool 05:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f359f0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c94cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eff990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:56:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:56:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:56:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:56:07 INFO - Return code: 0 05:56:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:56:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:56:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:56:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:56:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0017', '--webServer', 'localhost'] in /builds/slave/test/build 05:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0017 --webServer localhost 05:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render', 05:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:07 INFO - 'HOME': '/Users/cltbld', 05:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:07 INFO - 'LOGNAME': 'cltbld', 05:56:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:56:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:07 INFO - 'MOZ_NO_REMOTE': '1', 05:56:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:56:07 INFO - 'NO_EM_RESTART': '1', 05:56:07 INFO - 'PAGER': '/bin/cat', 05:56:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:07 INFO - 'PWD': '/builds/slave/test', 05:56:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:07 INFO - 'SHELL': '/bin/bash', 05:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners', 05:56:07 INFO - 'TMPDIR': '/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/', 05:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:07 INFO - 'USER': 'cltbld', 05:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:07 INFO - 'XPC_FLAGS': '0x0', 05:56:07 INFO - 'XPC_SERVICE_NAME': '0', 05:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:56:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0017', '--webServer', 'localhost'] with output_timeout 3600 05:56:07 INFO - mozversion INFO | application_buildid: 20151124042330 05:56:07 INFO - mozversion INFO | application_changeset: 337f0ed43821944b9ba77dd4b98083192413a765 05:56:07 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 05:56:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:56:07 INFO - mozversion INFO | application_name: Firefox 05:56:07 INFO - mozversion INFO | application_remotingname: firefox-dev 05:56:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:56:07 INFO - mozversion INFO | application_vendor: Mozilla 05:56:07 INFO - mozversion INFO | application_version: 44.0a2 05:56:07 INFO - mozversion INFO | platform_buildid: 20151124042330 05:56:07 INFO - mozversion INFO | platform_changeset: 337f0ed43821944b9ba77dd4b98083192413a765 05:56:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:56:07 INFO - mozversion INFO | platform_version: 44.0a2 05:56:07 INFO - 2015-11-24 05:56:07,507 DEBUG : using testdate: 1448373367 05:56:07 INFO - 2015-11-24 05:56:07,507 DEBUG : actual date: 1448373367 05:56:07 INFO - 2015-11-24 05:56:07,518 INFO : starting webserver on 'localhost:50018' 05:56:07 INFO - 2015-11-24 05:56:07,520 INFO : Starting test suite t-yosemite-r5-0017 05:56:07 INFO - 2015-11-24 05:56:07,520 INFO : Starting test dromaeo_css 05:56:07 INFO - 2015-11-24 05:56:07,520 DEBUG : operating with platform_type : mac_ 05:56:07 INFO - 2015-11-24 05:56:07,521 INFO : Initialising browser for dromaeo_css test... 05:56:07 INFO - 2015-11-24 05:56:07,535 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpzD0IYs/profile http://localhost:50018/getInfo.html 05:56:09 INFO - 2015-11-24 05:56:09,876 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:56:09 INFO - 2015-11-24 05:56:09,877 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:56:09 INFO - 2015-11-24 05:56:09,877 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:56:09 INFO - 2015-11-24 05:56:09,877 DEBUG : BROWSER_OUTPUT: __metrics 05:56:09 INFO - 2015-11-24 05:56:09,897 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:10 INFO - 2015-11-24 05:56:10,585 INFO : Browser initialized. 05:56:10 INFO - 2015-11-24 05:56:10,585 INFO : Running cycle 1/1 for dromaeo_css test... 05:56:10 INFO - 2015-11-24 05:56:10,585 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpzD0IYs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:56:22 INFO - 2015-11-24 05:56:22,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 200433664 05:56:22 INFO - 2015-11-24 05:56:22,564 DEBUG : BROWSER_OUTPUT: 05:57:14 INFO - 2015-11-24 05:57:14,004 DEBUG : BROWSER_OUTPUT: 1448373434002 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:59:24 INFO - 2015-11-24 05:59:24,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50018/tests/dromaeo/cssquery-ext.html) 05:59:25 INFO - 2015-11-24 05:59:25,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 322359296 05:59:25 INFO - 2015-11-24 05:59:25,602 DEBUG : BROWSER_OUTPUT: 06:02:28 INFO - 2015-11-24 06:02:28,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/dromaeo/cssquery-ext.html (next: http://localhost:50018/tests/dromaeo/cssquery-jquery.html) 06:02:28 INFO - 2015-11-24 06:02:28,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 338243584 06:02:28 INFO - 2015-11-24 06:02:28,951 DEBUG : BROWSER_OUTPUT: 06:05:30 INFO - 2015-11-24 06:05:30,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50018/tests/dromaeo/cssquery-mootools.html) 06:05:31 INFO - 2015-11-24 06:05:31,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 316583936 06:05:31 INFO - 2015-11-24 06:05:31,549 DEBUG : BROWSER_OUTPUT: 06:08:33 INFO - 2015-11-24 06:08:33,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50018/tests/dromaeo/cssquery-prototype.html) 06:08:34 INFO - 2015-11-24 06:08:34,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 299270144 06:08:34 INFO - 2015-11-24 06:08:34,129 DEBUG : BROWSER_OUTPUT: 06:11:37 INFO - 2015-11-24 06:11:37,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50018/tests/dromaeo/cssquery-yui.html) 06:11:37 INFO - 2015-11-24 06:11:37,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 302592000 06:11:37 INFO - 2015-11-24 06:11:37,732 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/dromaeo/cssquery-yui.html (next: http://localhost:50018/tests/dromaeo/cssquery-dojo.html) 06:14:40 INFO - 2015-11-24 06:14:40,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 344604672 06:14:40 INFO - 2015-11-24 06:14:40,522 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,523 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:14:40 INFO - 2015-11-24 06:14:40,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:14:40 INFO - 2015-11-24 06:14:40,524 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:14:40 INFO - 2015-11-24 06:14:40,524 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:14:40 INFO - 2015-11-24 06:14:40,525 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2990.3869706710125;3020.6375234971806;3024.8185108893467;3121.3445176512932;3195.744340452764;4957.5968732997535;5046.974765126179;5051.67164134332;5085.982803439313;5094.312267843845;5032.320636714043;5110.616703747215;5142.845714628567;5144.819931302396;5181.6113791465605;4518.570735780112;4651.000034992476;4653.976730116353;4778.307145463906;4792.472827988919;4552;4564.589186973171;4570.040291538764;4589.265717485203;4592.15045216636;4582.427196600425;4599.747013914233;4612.861614151564;4617.445906491226;4622.560856718606;4500.5949464548185;4596.954030459703;4602.562756538124;4662.580367766917;4683.555062269079;4714.905701885943;4717.433907931036;4734.739589322586;4775.164346239394;4824.179889418807;4847.830325938575;5078.187490001619;5104.489551044903;5120.129577971717;5236.6857988520815;5149.047426226122;5223.138182199932;5234.6335756497065;5253.238280449314;5329.866753331159;5414.458554144593;5526.364468086182;5585.916211256835;5606.6636001840025;5614.719264036782;4945.901081978341;5017.9247311290355;5141.922871156936;5189.143791274473;5194.142966410575;5416.322959630046;5489.560835133179;5599.80400685974;5611.382747897728;5672.546196304285;5277.894442111136;5298.125809241509;5298.6290959633225;5309.840704778863;5333.946660533423;5245.816396426183;5362.490563396471;5431.321084864392;5470.124780035176;5544.695041772741;5208.348956380452;5300.814471493479;5348.358197016383;5353.9732301338245;5382.03123437785;5217.113090774577;5228.9477105229225;5264.763085661154;5284.07528682479;5295.285136506599;4080.959190408117;4083.612056854594;4085.9795701021303;4095.3037983542868;4156.355764856452;3720.2373513429684;3787.5454945406727;3814.904627384282;3821.178446633987;3839.4432807242792;5088.643794934393;5112.156494178419;5144.125498665236;5149;5153.690778553224;5237.214417837355;5355.357357117171;5541.362743284493;5585.888282234332;5626.35296940857;4884.12085824555;5037.244413338029;5138.203578445347;5143.717095559706;5176.818811341585;4849.2968519564465;4853.49038350968;4874.878128046827;4898.779554920037;4922.138625740481;5327.760250788801;5476.014317422902;5601.6358936668985;5616.494515493625;5621;5246.737663116905;5323.3878104016985;5326.09456392422;5405.162199859028;5466.34403871522;5512.6968016759465;5525.392206857162;5526.088195447706;5536;5541.113421852484;5186.688798671941;5300.443453437488;5436.374816896107;5442.727863606883;5447.673139611636;5359.356877174608;5391.865203369947;5455.045367060828;5456.263404440349;5474.753636086306;5227.790888364575;5392.352917649907;5419.3225846769155;5422.132458806572;5432.945670543244;4982.8754281143265;5098.923516147187;5411.810586629449;5424.701641409761;5445.754941027584;5072.1123803335;5170.793168273227;5180.715060671549;5207.531322181022;5209.114450543341;5301.655392399482;5374.6506477078865;5401.621886468067;5412.350517937715;5453.04571699943;5103.87240318995;5243.108671525926;5290.365156181283;5323.866903327448;5338.466153384786 06:14:40 INFO - 2015-11-24 06:14:40,528 DEBUG : BROWSER_OUTPUT: |1;ext.html;529.489043073434;532.5526557691538;540.3785646506515;556.457453982367;562.7242651100962;30737.077887663378;31630.84184579077;37903.43144852826;38224;38757.806210968905;39638.80180599093;40055.19889602206;40067;40174.19651606966;40652;7935.801604959865;8514.063453020148;8696.26081783046;8719.694810681627;8739.257163141141;8090.878636820453;10368.53341599626;10595.205359598023;10649;10696.946515267451;10302.072813446788;10386.065254127127;10419.583216671363;10469.79060418795;10475.947620261888;8167.714130005481;8351.039630442456;10403.167746580293;10510.00154985279;10585.523651435627;10143.594256229742;10326.22553308505;10430.478476076241;10433.530491127918;10469.68590942273;37647;38016;38043.8097809512;38260.23479530422;38571.807140964396;2865.169100960719;2868.942621147586;2889.3787835615444;2889.956650650242;3266.6896644818703;24990.625140622724;26125.346866328302;26371.604425933627;26820.731792682214;27163.592546111824;2163.437506248371;2173.880436575988;2195.5718634866207;2217.1796435318875;2243.461569223391;274181;277619;278703;280523;280714;51299.74350128225;52898.206526902126;59428.70285648544;59982.40017599768;65868.67065664641;59035.704821475614;59213.703931480064;59950.40049599448;60014.39985600176;60052.69973650104;15363.769543456858;15476.690466190614;15504.139503259681;15507.06957582526;15661.765073523678;12424.316662583644;12476.75046499065;12516.624501264794;12522.937385313015;12545.12184147101;19112.617747645247;19336.516587085436;19351;19487.22051117968;19556.706649400272;8175.427720059658;8276.255137037695;8283.420160588701;8345.833083338299;8468.491890486468;798.6246464161835;820.7742870710603;837.417994493821;867.8394497018072;903.263839970422;23217.419564511023;23237.7676223239;23383;23428.18001369944;23481.17815876436;873.9344549158839;933.8179055084194;960.2030314838806;963.1909196275162;970.1075010989906;11616.651500455;11876.168668193144;12529;12609.873901261053;12680.746385072247;239320;244404;245654;245743;246603;45806.08387832291;46570.534294656616;48825;49461.50538494569;56644;1303.687115092371;1329.1559859489294;1343.7446885091802;1351.2297990145523;1360.571420002696;22551;23670.408239794142;23695.170669026502;23909;23919.52160956806;44908.550914490435;45842.770786145855;51895;52920.47079529309;53001.4699853012;261168;262887;266282;268409;268928;30628.234294142825;30658;31240.062798116094;31317.53023704601;31398.215044624067;39109.21781564296;39558.80220598879;40218.798906005286;40825.387619185145;41488.1702365957;32651;33911.83044084764;34061.31877362489;34279.657203428644;34382.31235375329;34015.319693606485;34037.82981085079;34390.65609343975;34723.30553388969;38751.41872871853;38990.6100938987;39088.6091139085;39161.804190978866;39290;39616.80191599139;35920;37049.25901482009;37208.81395593005;37447.25105497929;37640.43539346857;30502.847485762428;30936.53595196119;31000;32254.35491290208;32441 06:14:40 INFO - 2015-11-24 06:14:40,530 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.6098803411974;332.7703884319819;332.9400707872582;333.120561717067;343.13701041879676;13916.443342266322;14128.364223609937;15842.603934901634;16193.190340482974;17149.828501714994;13895.930520347409;14650.780238296435;17082.31670733169;17139;17345.47963561095;4948.010397920403;5035.144025515653;5052.722100284501;5113.207452844815;5120.667156634825;3855.267499175162;4889.413270407556;4987.775550100254;5089.46560611136;5094.490550944913;3903.8243279052513;5498.835034948958;5588.6646801192055;5661.433856614347;5665.065264231397;5438.945610543923;5555.638883472561;5568.49883510484;5606.2151298818;5623.297087863996;4833.154198015333;4853.514648535153;4881.511848815126;4908.092002979461;4909.754512274408;20124.899375503028;20206.090725917224;20376.490587735276;20444;20612.629547602068;1930.420873737873;1932.1401976120633;1999.4701404127918;2027.8276346510565;2037.9592408151755;12705.61883143498;12940.35298235094;13006;13098.47606095755;13236.470541178342;1543.8764898808067;1622.3105180298444;1639.8934069285458;1647.3163637090593;1698.9806116330226;56153.43846561523;57157.428425715625;57356.42643573553;57410;58137;9027.909720902839;9121.498317592463;9531.237500999903;9568.76078098053;9607.90392096084;11771.293722376684;11781.175317727848;11781.705457363634;11854.466549005316;11950.820737688942;7782.844343113219;7799.337056350274;7807.726729564438;7859.056913170456;7882.251186137308;8000.159983201796;8001.279884810395;8015.83968320642;8064.55644939534;8150.510969341858;5563.332400112013;5610.663360198401;5616.157576363496;5662.886742265132;5770.798022069292;1536.508317338441;1608.557646647158;1648.077076836975;1648.5054483655094;1652.4959887234509;343.6134348857535;346.73687018112366;820.6635279535362;924.4360939826701;953.4374718915873;9244.399114057565;9402.213579419888;9406.38858474197;9461.52692365379;9545;334.7439209005113;354.0952865428803;378.5646506517472;379.2774764074443;386.2044188970729;4899.387576552931;4960.975195124001;5019.372578427697;5085.567726743268;5237.580993520509;516178;520169;521707;541025;554271;67647.66176169187;70853.64573177102;71767.2823271771;72589;73409.6329518349;399.9480067591253;402.25984189092213;403.49966042107576;406.21803029168734;407.8103681787983;8954.373193876367;8963.417377870417;9005.864912026194;9030.322725795722;9041.954790226007;31278.374432510765;31704.524432133076;32837.67162328346;33129.17177070593;33139.83430082931;40521;42884.57115428806;43634;46446.30330545112;46752.7662361686;5664.405237450009;5669.85825354353;5743.971280143573;5759.654420734601;5773.364929857797;10928.890711092787;11268.323900565993;11328.433578320886;11329.830052549383;11393.943030285127;9649.710508684751;9664.081912218327;9827.557759900965;9933.15568176713;10005.799884002425;9489.85765213536;9554.952225238829;9600.807983840145;9780.462074585967;9809.019098090133;9417.717468475958;9909.603615855285;10019.649312274036;10060.044295791888;10133.08802207805;5652.095664693629;5714.200011998407;5724;5746.482816546531;5752.223449834219;9658.323917325719;9666.371685840399;9800.754981125243;9883.061109194616;9895.950520247641 06:14:40 INFO - 2015-11-24 06:14:40,531 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1268.8477382714075;1358.463406954253;1379.5033787836383;1666.80831704354;1743.6861364954311;6756.2905894881005;7413.51812132211;7417.7403790867265;7435.553866767991;7510.324070833624;7291.927080729204;7619.961900190491;7641.1976742442075;7666.386689064875;7725.343345815612;2093.5080256139795;2111.5565731196466;2112.9366119016454;2122.7134336864556;2126.447123747821;2123.4903623130413;2158.5467051919118;2162.145952348821;2171.250918433138;2181.182056728727;2087.217293514932;2118.046878904491;2124.468882779305;2153.7092492513466;2167.0898222746405;2119.8092171704543;2152.494163871489;2158.84888057836;2163.8593491423007;2181.8472706910525;2078.511549785799;2110.6306396380573;2116.619008578455;2116.9153233870625;2125.0543508138885;6744.393004629607;7403.962980185119;7489.475736698433;7512.248775122499;7567.886481702779;4142.730722503027;4418.8453404130705;4524.524924882873;4542.727436353829;4567.862964111082;2793.413383189533;2810.8875644974382;2829.4199689063694;2852.2013836125916;2906.157214407819;801.2028032108032;811.1037303779298;829.2205326992607;847.4025811802665;858.1161403754144;9978.30151889368;9981.700548983616;9994.700158995242;10092.990700929922;10096.040876116756;4085.59144085595;4108.897277568085;4110.116324990141;4150.91698166035;4172.18642364742;8821.647134114692;8860.689875854314;8920.420172688755;8924.55377231136;8955.328350373748;4448.421705178306;4451.421315229064;4497.168023915586;4507.549245075532;4516.435445569304;4095.24238015968;4097.692673049533;4097.85657501986;4101.85643502476;4107.835686572564;3451.81015044175;3481.9303613927577;3482.669146431085;3504.0889368763796;3535.063208249816;1081.221520505235;1103.2442776697987;1107.634480621393;1121.9775604488027;1124.0782558302114;965.478641533564;977.7897751983357;984.6799790068256;1034.2191645307744;1202.2365797718337;6813;6813.931860681429;6888.311168883171;6896.069030680894;6907.585544867324;411.31926661375473;419.55108034402895;421.8755467137202;426.43710302401155;428.6356596892616;5154.92267615986;5223.921641175385;5226.97386513065;5291.365036195682;5291.550218231417;8126.674933002732;8760.4305720128;8802.911970880337;8818.559072046372;8820.779480513038;8783.121687831293;8818.911810881937;8911.643534258686;8923.152300531568;8938.240249578728;7006.75476358325;7112.288771122846;7126.465515086389;7156.821079473055;7208.3152100551415;6691;6990.720371185299;7024.086868707035;7027.613481258375;7047.154341479055;7787.260210280015;7856.09654889695;7965.601719914097;7981.361491080584;8011.799705007188;7983.8802417964935;8228.382871284797;8229.83540329202;8249.587520624065;8277.006759188695;6635.104260924713;6737.59574425536;6754.18949726036;6758.155230596176;6809.148856392951;7219.783406497813;7243.927560724536;7262.201157872735;7265.273472652692;7320.231375705474;6581.3747693969;6678.899816502659;6761.188657361148;6813.250542440229;6842.076319696777;6583.44040756541;6604.966975165094;6686.632235227109;6714.865702685821;6736.225334086446;6335.176427064452;6465.224173099258;6531.379518945692;6841.965790171216;6871.896921546081;5657.575681823797;5713.428657134254;5718.25662663851;5769.249997500298;5801.796937107181;5773.91339129905;5796.449337312949;5809.970950145223;5824.301083869963;5849.327327357409 06:14:40 INFO - 2015-11-24 06:14:40,535 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.8302642033671;306.2924644072193;316.4541166487809;317.4270441852456;324.3205484509954;5734.79928202513;5739.626924249921;5774.162746401769;5777.913331300028;5777.971110144444;5672.886542269152;5677.772889084432;5704.743286552105;5708.029634962056;5766.740496677649;4403;4415.20526305265;4419.580139886713;4439.511653718105;4486.618637415807;4236.9576304237025;4302.849400270991;4423.093265880487;4465.620422264112;4506.121306345264;3802.505674262342;4201.978990105061;4245.299525578276;4294.67789915756;4301.612854843063;4240.745555266694;4298.957010429903;4312.9433288844275;4327.978360108211;4331.4152589400655;3616.4032934565766;3628.673419392241;3659.3779057560278;3659.963400365989;3667.5598928128798;5436.510714035756;5447.6459030163305;5519.724013799294;5532.695701736403;5588.161775733632;4867.756612169377;4917.754112294407;4929.531694489017;4944.208926571767;4957.082939656175;5953.13679516472;5982.7906023289415;6016.639001659914;6019.067044608093;6038.124471951543;3899.415087736834;4029.1740193260603;4066.1867626474527;4066.6136717011836;4086.0193553547233;6284.277308109535;6351.87296254077;6367.586106903036;6417.550771446001;6417.935820641827;4155.376693495939;4172.415861779354;4209.158168366339;4218.514870789837;4226.746395216297;4241.575842415734;4254.340577210537;4255.936160957588;4298.032942587955;4306.547812479645;4809.831655892027;4925.088858561177;4972;4977.104121258209;4992.2511623256805;5994.6403215807195;6003.6397816131175;6063.999440092335;6084.969575152096;6093.786717464956;1511.048039734982;1515.50746007548;1517.5143953934635;1528.465037236958;1532.578540901261;977.1938151025432;978.8822600018963;987.274353350287;987.8863930647924;992.925530585209;5704.144378343199;5709.25779648643;5752.741126649311;5767.538596912237;5774.769009239583;6249.812505624838;6314.684265786692;6327.905081423783;6336.049592561153;6360.204974378203;5756.02147634903;5767.798127065533;5771.85570360736;5804.390538993429;5808.796692115756;3362.176266814646;3449.7585169037925;3477;3484.790912545255;3498.2129020970588;6366.331535188739;6378.904316435257;6397.168368112209;6399.9040014399825;6401.551891367652;6233.563650544418;6340.048992651047;6412.39082287182;6437.2275326960125;6444.162258906406;6264.718087686065;6278.340774218733;6305.747770089237;6352.968235158794;6392.392722691244;6231.626102433687;6256.530760192913;6263.154474145932;6265.686715664289;6296.590721603081;5948.434898684618;6101.542384321282;6163.599366041193;6189.164462797645;6208.410201030895;6413.967930160319;6427.55007149495;6450.677466126581;6454.967725161344;6461.289258181502;4053.250148722496;4080.7959602019187;4086.162336720906;4094.488188976378;4104.0970986382945;6179.3820617937845;6305.495560355253;6320.399562041599;6356.491480681442;6375.4262116409745;6090.756369745161;6104.725287361991;6164.7842325518395;6172.351903050115;6174.043023331391;6095.994160963392;6103.145559621746;6120.816375508742;6166.845828854314;6175.289841668266;5820.883582328414;5980.222571065908;6028;6039.78860739872;6053.182820319201;6176.474999625082;6187.288461826947;6199.5970261934635;6206.286277078194;6217.036359364306;5993;6033.909491357545;6037.366076561898;6062.484688801501;6078.848028799139 06:14:40 INFO - 2015-11-24 06:14:40,535 DEBUG : BROWSER_OUTPUT: |5;yui.html;716.6345163966375;717.6662851773928;722.7940037089427;734.5078797205872;741.5217184915728;12966.351682415876;13133.67165820855;13229.073964822466;13256.46974121034;13269;13161.802572961413;13401.396937137828;13523.661908452268;13533.255670938119;13544;674.7874419557849;822.4489591973362;823.9093699693029;826.2728798657204;833.954132522711;686.8523267497487;833.2708879730236;844.6494704697543;849.3672214200429;850.8766228896807;850.1795767084762;863.4948555095277;865.7922098696331;875.8248350329927;877.2543338162575;685.6571714142929;691.7233106757287;849.9320054395633;862.3273846399818;876.0888675777184;628.71707731521;628.9937100628981;629.4083561452265;632.5414074795736;642.9003504456816;12876.420561074774;12968.675783105404;12969.481220751253;12977.156484828456;12990.935045324808;9135;9140.314476414296;9178.954105229497;9536.2371010319;9760.365576237522;7911.564863932482;8222.712205072854;8231.382646301552;8838.072002439716;8968.955155224246;2646.4971655385416;2663.6803583569904;2670.519306524825;2678.5714285714193;2695.7439043290856;45509.54490455119;45591.77204113958;46563.767181164214;46672.76663616694;46684.899179537;6341.651209183447;6359.8092057238355;6516.674166291667;6577.046328282372;6965.233824279325;11907.226030308002;11919.582814601446;11928.880711192951;12055.095867809949;12084.335361555199;5744.109663002241;6020.608660437058;6037.184980027728;6075.149479072845;6145.569810113249;3481.599616044137;3551.6448355164275;3584.1039740064984;3593.389123848952;3616.222512159898;2511.6609257750333;2545.7963362930923;2552.3363925379535;2552.4895020995873;2582;388.03186050803424;389.2099038950934;393.4904298932889;395.6340385143788;397.85279446604943;448.4215362182813;462.3296220480317;463.12700559445017;505.88617561049205;525.8843054527998;7046.6476676165985;7186.425085993108;7230.349268565749;7393.186749457555;7397.741079062314;528.4292963599304;547.6713971617078;559.7285316621435;560.6776103740366;562.3195932921129;3390.5592273004845;3397.76215664906;3415.863365465403;3430.622631510532;3518.8240587971013;55714.80271474805;55946.160807587105;56051.15923261154;56081;56515;51062.744686277074;51241.23138152931;51244.74377628088;51305.7434712824;51365;47594;47613.5238647616;47854.9999999993;48244.517554824;48803.511964879894;6852.725890964505;6912.44700423975;6963.48164164019;6981.127359080115;7141.678624462015;35071.824640876635;35198.47202292019;35305.646943530235;35625.643743562236;35890.4616430759;42930.57069429391;45410.31884521801;46392.07215855731;46918.76540617275;47067.29399058948;6236.095766113979;6249.25008998923;6360.809175724736;6436.485081193587;6460.773872914426;9332.953335233551;9575.473348965596;9578.616855325708;9744.902550974683;9804.313698041355;8688.30493560501;8708.521031343336;9115.726528204164;9156.313276504423;9174.403663761834;8996;9024.639014439348;9137.269018478639;9333;9456.763580910532;9043.276537876822;9167.816643667224;9671.032896710272;9714.3199976001;9921.00789921002;8590.527520986405;8600.698975535826;8842.867356989522;8856.335774817044;8966.058563850702;8287.50274983503;8346.499210047174;8499.74500764978;8518.318534517348;8708.825823483368 06:14:40 INFO - 2015-11-24 06:14:40,536 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:14:40 INFO - 2015-11-24 06:14:40,536 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:14:40 INFO - 2015-11-24 06:14:40,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 06:14:40 INFO - 2015-11-24 06:14:40,537 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:14:40 INFO - 2015-11-24 06:14:40,537 DEBUG : BROWSER_OUTPUT: __startTimestamp1448374480522__endTimestamp 06:14:40 INFO - 2015-11-24 06:14:40,537 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,537 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:14:40 INFO - 2015-11-24 06:14:40,537 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:14:40 INFO - 2015-11-24 06:14:40,538 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,538 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5042.28 Median:5207.53 stddev:542.00 (10.4%) stddev-sans-first:519.21 06:14:40 INFO - 2015-11-24 06:14:40,539 DEBUG : BROWSER_OUTPUT: Values: 2990.4 3020.6 3024.8 3121.3 3195.7 4957.6 5047.0 5051.7 5086.0 5094.3 5032.3 5110.6 5142.8 5144.8 5181.6 4518.6 4651.0 4654.0 4778.3 4792.5 4552.0 4564.6 4570.0 4589.3 4592.2 4582.4 4599.7 4612.9 4617.4 4622.6 4500.6 4597.0 4602.6 4662.6 4683.6 4714.9 4717.4 4734.7 4775.2 4824.2 4847.8 5078.2 5104.5 5120.1 5236.7 5149.0 5223.1 5234.6 5253.2 5329.9 5414.5 5526.4 5585.9 5606.7 5614.7 4945.9 5017.9 5141.9 5189.1 5194.1 5416.3 5489.6 5599.8 5611.4 5672.5 5277.9 5298.1 5298.6 5309.8 5333.9 5245.8 5362.5 5431.3 5470.1 5544.7 5208.3 5300.8 5348.4 5354.0 5382.0 5217.1 5228.9 5264.8 5284.1 5295.3 4081.0 4083.6 4086.0 4095.3 4156.4 3720.2 3787.5 3814.9 3821.2 3839.4 5088.6 5112.2 5144.1 5149.0 5153.7 5237.2 5355.4 5541.4 5585.9 5626.4 4884.1 5037.2 5138.2 5143.7 5176.8 4849.3 4853.5 4874.9 4898.8 4922.1 5327.8 5476.0 5601.6 5616.5 5621.0 5246.7 5323.4 5326.1 5405.2 5466.3 5512.7 5525.4 5526.1 5536.0 5541.1 5186.7 5300.4 5436.4 5442.7 5447.7 5359.4 5391.9 5455.0 5456.3 5474.8 5227.8 5392.4 5419.3 5422.1 5432.9 4982.9 5098.9 5411.8 5424.7 5445.8 5072.1 5170.8 5180.7 5207.5 5209.1 5301.7 5374.7 5401.6 5412.4 5453.0 5103.9 5243.1 5290.4 5323.9 5338.5 06:14:40 INFO - 2015-11-24 06:14:40,539 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,539 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43488.86 Median:31942.60 stddev:68503.26 (214.5%) stddev-sans-first:68619.49 06:14:40 INFO - 2015-11-24 06:14:40,541 DEBUG : BROWSER_OUTPUT: Values: 529.5 532.6 540.4 556.5 562.7 30737.1 31630.8 37903.4 38224.0 38757.8 39638.8 40055.2 40067.0 40174.2 40652.0 7935.8 8514.1 8696.3 8719.7 8739.3 8090.9 10368.5 10595.2 10649.0 10696.9 10302.1 10386.1 10419.6 10469.8 10475.9 8167.7 8351.0 10403.2 10510.0 10585.5 10143.6 10326.2 10430.5 10433.5 10469.7 37647.0 38016.0 38043.8 38260.2 38571.8 2865.2 2868.9 2889.4 2890.0 3266.7 24990.6 26125.3 26371.6 26820.7 27163.6 2163.4 2173.9 2195.6 2217.2 2243.5 274181.0 277619.0 278703.0 280523.0 280714.0 51299.7 52898.2 59428.7 59982.4 65868.7 59035.7 59213.7 59950.4 60014.4 60052.7 15363.8 15476.7 15504.1 15507.1 15661.8 12424.3 12476.8 12516.6 12522.9 12545.1 19112.6 19336.5 19351.0 19487.2 19556.7 8175.4 8276.3 8283.4 8345.8 8468.5 798.6 820.8 837.4 867.8 903.3 23217.4 23237.8 23383.0 23428.2 23481.2 873.9 933.8 960.2 963.2 970.1 11616.7 11876.2 12529.0 12609.9 12680.7 239320.0 244404.0 245654.0 245743.0 246603.0 45806.1 46570.5 48825.0 49461.5 56644.0 1303.7 1329.2 1343.7 1351.2 1360.6 22551.0 23670.4 23695.2 23909.0 23919.5 44908.6 45842.8 51895.0 52920.5 53001.5 261168.0 262887.0 266282.0 268409.0 268928.0 30628.2 30658.0 31240.1 31317.5 31398.2 39109.2 39558.8 40218.8 40825.4 41488.2 32651.0 33911.8 34061.3 34279.7 34382.3 34015.3 34037.8 34390.7 34723.3 38751.4 38990.6 39088.6 39161.8 39290.0 39616.8 35920.0 37049.3 37208.8 37447.3 37640.4 30502.8 30936.5 31000.0 32254.4 32441.0 06:14:40 INFO - 2015-11-24 06:14:40,541 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,541 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26694.88 Median:5069.14 stddev:86828.77 (1712.9%) stddev-sans-first:87049.78 06:14:40 INFO - 2015-11-24 06:14:40,541 DEBUG : BROWSER_OUTPUT: Values: 330.6 332.8 332.9 333.1 343.1 13916.4 14128.4 15842.6 16193.2 17149.8 13895.9 14650.8 17082.3 17139.0 17345.5 4948.0 5035.1 5052.7 5113.2 5120.7 3855.3 4889.4 4987.8 5089.5 5094.5 3903.8 5498.8 5588.7 5661.4 5665.1 5438.9 5555.6 5568.5 5606.2 5623.3 4833.2 4853.5 4881.5 4908.1 4909.8 20124.9 20206.1 20376.5 20444.0 20612.6 1930.4 1932.1 1999.5 2027.8 2038.0 12705.6 12940.4 13006.0 13098.5 13236.5 1543.9 1622.3 1639.9 1647.3 1699.0 56153.4 57157.4 57356.4 57410.0 58137.0 9027.9 9121.5 9531.2 9568.8 9607.9 11771.3 11781.2 11781.7 11854.5 11950.8 7782.8 7799.3 7807.7 7859.1 7882.3 8000.2 8001.3 8015.8 8064.6 8150.5 5563.3 5610.7 5616.2 5662.9 5770.8 1536.5 1608.6 1648.1 1648.5 1652.5 343.6 346.7 820.7 924.4 953.4 9244.4 9402.2 9406.4 9461.5 9545.0 334.7 354.1 378.6 379.3 386.2 4899.4 4961.0 5019.4 5085.6 5237.6 516178.0 520169.0 521707.0 541025.0 554271.0 67647.7 70853.6 71767.3 72589.0 73409.6 399.9 402.3 403.5 406.2 407.8 8954.4 8963.4 9005.9 9030.3 9042.0 31278.4 31704.5 32837.7 33129.2 33139.8 40521.0 42884.6 43634.0 46446.3 46752.8 5664.4 5669.9 5744.0 5759.7 5773.4 10928.9 11268.3 11328.4 11329.8 11393.9 9649.7 9664.1 9827.6 9933.2 10005.8 9489.9 9555.0 9600.8 9780.5 9809.0 9417.7 9909.6 10019.6 10060.0 10133.1 5652.1 5714.2 5724.0 5746.5 5752.2 9658.3 9666.4 9800.8 9883.1 9896.0 06:14:40 INFO - 2015-11-24 06:14:40,541 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,542 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5154.85 Median:6498.30 stddev:2726.52 (42.0%) stddev-sans-first:2718.52 06:14:40 INFO - 2015-11-24 06:14:40,543 DEBUG : BROWSER_OUTPUT: Values: 1268.8 1358.5 1379.5 1666.8 1743.7 6756.3 7413.5 7417.7 7435.6 7510.3 7291.9 7620.0 7641.2 7666.4 7725.3 2093.5 2111.6 2112.9 2122.7 2126.4 2123.5 2158.5 2162.1 2171.3 2181.2 2087.2 2118.0 2124.5 2153.7 2167.1 2119.8 2152.5 2158.8 2163.9 2181.8 2078.5 2110.6 2116.6 2116.9 2125.1 6744.4 7404.0 7489.5 7512.2 7567.9 4142.7 4418.8 4524.5 4542.7 4567.9 2793.4 2810.9 2829.4 2852.2 2906.2 801.2 811.1 829.2 847.4 858.1 9978.3 9981.7 9994.7 10093.0 10096.0 4085.6 4108.9 4110.1 4150.9 4172.2 8821.6 8860.7 8920.4 8924.6 8955.3 4448.4 4451.4 4497.2 4507.5 4516.4 4095.2 4097.7 4097.9 4101.9 4107.8 3451.8 3481.9 3482.7 3504.1 3535.1 1081.2 1103.2 1107.6 1122.0 1124.1 965.5 977.8 984.7 1034.2 1202.2 6813.0 6813.9 6888.3 6896.1 6907.6 411.3 419.6 421.9 426.4 428.6 5154.9 5223.9 5227.0 5291.4 5291.6 8126.7 8760.4 8802.9 8818.6 8820.8 8783.1 8818.9 8911.6 8923.2 8938.2 7006.8 7112.3 7126.5 7156.8 7208.3 6691.0 6990.7 7024.1 7027.6 7047.2 7787.3 7856.1 7965.6 7981.4 8011.8 7983.9 8228.4 8229.8 8249.6 8277.0 6635.1 6737.6 6754.2 6758.2 6809.1 7219.8 7243.9 7262.2 7265.3 7320.2 6581.4 6678.9 6761.2 6813.3 6842.1 6583.4 6605.0 6686.6 6714.9 6736.2 6335.2 6465.2 6531.4 6842.0 6871.9 5657.6 5713.4 5718.3 5769.2 5801.8 5773.9 5796.4 5810.0 5824.3 5849.3 06:14:40 INFO - 2015-11-24 06:14:40,543 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,543 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5044.29 Median:5776.34 stddev:1547.71 (26.8%) stddev-sans-first:1510.63 06:14:40 INFO - 2015-11-24 06:14:40,545 DEBUG : BROWSER_OUTPUT: Values: 305.8 306.3 316.5 317.4 324.3 5734.8 5739.6 5774.2 5777.9 5778.0 5672.9 5677.8 5704.7 5708.0 5766.7 4403.0 4415.2 4419.6 4439.5 4486.6 4237.0 4302.8 4423.1 4465.6 4506.1 3802.5 4202.0 4245.3 4294.7 4301.6 4240.7 4299.0 4312.9 4328.0 4331.4 3616.4 3628.7 3659.4 3660.0 3667.6 5436.5 5447.6 5519.7 5532.7 5588.2 4867.8 4917.8 4929.5 4944.2 4957.1 5953.1 5982.8 6016.6 6019.1 6038.1 3899.4 4029.2 4066.2 4066.6 4086.0 6284.3 6351.9 6367.6 6417.6 6417.9 4155.4 4172.4 4209.2 4218.5 4226.7 4241.6 4254.3 4255.9 4298.0 4306.5 4809.8 4925.1 4972.0 4977.1 4992.3 5994.6 6003.6 6064.0 6085.0 6093.8 1511.0 1515.5 1517.5 1528.5 1532.6 977.2 978.9 987.3 987.9 992.9 5704.1 5709.3 5752.7 5767.5 5774.8 6249.8 6314.7 6327.9 6336.0 6360.2 5756.0 5767.8 5771.9 5804.4 5808.8 3362.2 3449.8 3477.0 3484.8 3498.2 6366.3 6378.9 6397.2 6399.9 6401.6 6233.6 6340.0 6412.4 6437.2 6444.2 6264.7 6278.3 6305.7 6353.0 6392.4 6231.6 6256.5 6263.2 6265.7 6296.6 5948.4 6101.5 6163.6 6189.2 6208.4 6414.0 6427.6 6450.7 6455.0 6461.3 4053.3 4080.8 4086.2 4094.5 4104.1 6179.4 6305.5 6320.4 6356.5 6375.4 6090.8 6104.7 6164.8 6172.4 6174.0 6096.0 6103.1 6120.8 6166.8 6175.3 5820.9 5980.2 6028.0 6039.8 6053.2 6176.5 6187.3 6199.6 6206.3 6217.0 5993.0 6033.9 6037.4 6062.5 6078.8 06:14:40 INFO - 2015-11-24 06:14:40,545 DEBUG : BROWSER_OUTPUT: 06:14:40 INFO - 2015-11-24 06:14:40,545 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12720.20 Median:6242.67 stddev:16133.54 (258.4%) stddev-sans-first:16153.62 06:14:40 INFO - 2015-11-24 06:14:40,545 DEBUG : BROWSER_OUTPUT: Values: 716.6 717.7 722.8 734.5 741.5 12966.4 13133.7 13229.1 13256.5 13269.0 13161.8 13401.4 13523.7 13533.3 13544.0 674.8 822.4 823.9 826.3 834.0 686.9 833.3 844.6 849.4 850.9 850.2 863.5 865.8 875.8 877.3 685.7 691.7 849.9 862.3 876.1 628.7 629.0 629.4 632.5 642.9 12876.4 12968.7 12969.5 12977.2 12990.9 9135.0 9140.3 9179.0 9536.2 9760.4 7911.6 8222.7 8231.4 8838.1 8969.0 2646.5 2663.7 2670.5 2678.6 2695.7 45509.5 45591.8 46563.8 46672.8 46684.9 6341.7 6359.8 6516.7 6577.0 6965.2 11907.2 11919.6 11928.9 12055.1 12084.3 5744.1 6020.6 6037.2 6075.1 6145.6 3481.6 3551.6 3584.1 3593.4 3616.2 2511.7 2545.8 2552.3 2552.5 2582.0 388.0 389.2 393.5 395.6 397.9 448.4 462.3 463.1 505.9 525.9 7046.6 7186.4 7230.3 7393.2 7397.7 528.4 547.7 559.7 560.7 562.3 3390.6 3397.8 3415.9 3430.6 3518.8 55714.8 55946.2 56051.2 56081.0 56515.0 51062.7 51241.2 51244.7 51305.7 51365.0 47594.0 47613.5 47855.0 48244.5 48803.5 6852.7 6912.4 6963.5 6981.1 7141.7 35071.8 35198.5 35305.6 35625.6 35890.5 42930.6 45410.3 46392.1 46918.8 47067.3 6236.1 6249.3 6360.8 6436.5 6460.8 9333.0 9575.5 9578.6 9744.9 9804.3 8688.3 8708.5 9115.7 9156.3 9174.4 8996.0 9024.6 9137.3 9333.0 9456.8 9043.3 9167.8 9671.0 9714.3 9921.0 8590.5 8600.7 8842.9 8856.3 8966.1 8287.5 8346.5 8499.7 8518.3 8708.8 06:14:40 INFO - 2015-11-24 06:14:40,546 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:14:40 INFO - 2015-11-24 06:14:40,546 DEBUG : BROWSER_OUTPUT: 06:14:41 INFO - 2015-11-24 06:14:41,183 INFO : Browser exited with error code: 0 06:14:41 INFO - 2015-11-24 06:14:41,213 INFO : Completed test dromaeo_css (00:18:33) 06:14:41 INFO - 2015-11-24 06:14:41,213 INFO : Starting test kraken 06:14:41 INFO - 2015-11-24 06:14:41,213 DEBUG : operating with platform_type : mac_ 06:14:41 INFO - 2015-11-24 06:14:41,213 INFO : Initialising browser for kraken test... 06:14:41 INFO - 2015-11-24 06:14:41,229 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpLPISa0/profile http://localhost:50018/getInfo.html 06:14:43 INFO - 2015-11-24 06:14:43,554 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:14:43 INFO - 2015-11-24 06:14:43,555 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:14:43 INFO - 2015-11-24 06:14:43,555 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:14:43 INFO - 2015-11-24 06:14:43,555 DEBUG : BROWSER_OUTPUT: __metrics 06:14:43 INFO - 2015-11-24 06:14:43,565 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:44 INFO - 2015-11-24 06:14:44,242 INFO : Browser initialized. 06:14:44 INFO - 2015-11-24 06:14:44,242 INFO : Running cycle 1/1 for kraken test... 06:14:44 INFO - 2015-11-24 06:14:44,242 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpLPISa0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:14:56 INFO - 2015-11-24 06:14:56,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 199528448 06:14:56 INFO - 2015-11-24 06:14:56,188 DEBUG : BROWSER_OUTPUT: 06:14:58 INFO - 2015-11-24 06:14:58,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50018/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:59 INFO - 2015-11-24 06:14:59,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 263204864 06:14:59 INFO - 2015-11-24 06:14:59,353 DEBUG : BROWSER_OUTPUT: 06:15:02 INFO - 2015-11-24 06:15:02,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50018/tests/kraken/driver.html?testName=audio-dft) 06:15:02 INFO - 2015-11-24 06:15:02,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 276508672 06:15:02 INFO - 2015-11-24 06:15:02,653 DEBUG : BROWSER_OUTPUT: 06:15:05 INFO - 2015-11-24 06:15:05,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50018/tests/kraken/driver.html?testName=audio-fft) 06:15:06 INFO - 2015-11-24 06:15:06,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 264364032 06:15:06 INFO - 2015-11-24 06:15:06,205 DEBUG : BROWSER_OUTPUT: 06:15:08 INFO - 2015-11-24 06:15:08,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50018/tests/kraken/driver.html?testName=audio-oscillator) 06:15:08 INFO - 2015-11-24 06:15:08,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 265461760 06:15:08 INFO - 2015-11-24 06:15:08,869 DEBUG : BROWSER_OUTPUT: 06:15:11 INFO - 2015-11-24 06:15:11,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:15:11 INFO - 2015-11-24 06:15:11,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 265129984 06:15:11 INFO - 2015-11-24 06:15:11,798 DEBUG : BROWSER_OUTPUT: 06:15:15 INFO - 2015-11-24 06:15:15,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50018/tests/kraken/driver.html?testName=imaging-darkroom) 06:15:15 INFO - 2015-11-24 06:15:15,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 263852032 06:15:15 INFO - 2015-11-24 06:15:15,605 DEBUG : BROWSER_OUTPUT: 06:15:18 INFO - 2015-11-24 06:15:18,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50018/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:19 INFO - 2015-11-24 06:15:19,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 266072064 06:15:19 INFO - 2015-11-24 06:15:19,482 DEBUG : BROWSER_OUTPUT: 06:15:22 INFO - 2015-11-24 06:15:22,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50018/tests/kraken/driver.html?testName=json-parse-financial) 06:15:23 INFO - 2015-11-24 06:15:23,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 265986048 06:15:23 INFO - 2015-11-24 06:15:23,118 DEBUG : BROWSER_OUTPUT: 06:15:24 INFO - 2015-11-24 06:15:24,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:25 INFO - 2015-11-24 06:15:25,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 298242048 06:15:25 INFO - 2015-11-24 06:15:25,352 DEBUG : BROWSER_OUTPUT: 06:15:27 INFO - 2015-11-24 06:15:27,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:27 INFO - 2015-11-24 06:15:27,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 301199360 06:15:27 INFO - 2015-11-24 06:15:27,868 DEBUG : BROWSER_OUTPUT: 06:15:30 INFO - 2015-11-24 06:15:30,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:30 INFO - 2015-11-24 06:15:30,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 305606656 06:15:30 INFO - 2015-11-24 06:15:30,612 DEBUG : BROWSER_OUTPUT: 06:15:33 INFO - 2015-11-24 06:15:33,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:33 INFO - 2015-11-24 06:15:33,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 309370880 06:15:33 INFO - 2015-11-24 06:15:33,891 DEBUG : BROWSER_OUTPUT: 06:15:36 INFO - 2015-11-24 06:15:36,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:37 INFO - 2015-11-24 06:15:37,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 308125696 06:15:37 INFO - 2015-11-24 06:15:37,162 DEBUG : BROWSER_OUTPUT: 06:15:38 INFO - 2015-11-24 06:15:38,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50018/tests/kraken/driver.html?testName=ai-astar) 06:15:39 INFO - 2015-11-24 06:15:39,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 367955968 06:15:39 INFO - 2015-11-24 06:15:39,217 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,217 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;110;112;113;116;99;114;109;107 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;128;161;157;131;153;134;177;165;133 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;168;173;173;175;174;175;175;174;174 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;82;87;127;72;78;77;77;118;71 06:15:39 INFO - 2015-11-24 06:15:39,218 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;105;147;95;97;97;144;101;103;165 06:15:39 INFO - 2015-11-24 06:15:39,219 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;130;124;136;126;130;124;134;134;130;130 06:15:39 INFO - 2015-11-24 06:15:39,219 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;133;135;140;135;135;134;134;140;136;135 06:15:39 INFO - 2015-11-24 06:15:39,219 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;106;112;114;114;109;113;113;113;111;108 06:15:39 INFO - 2015-11-24 06:15:39,219 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;64;65;66;68;67;67;78;64;64 06:15:39 INFO - 2015-11-24 06:15:39,219 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;70;66;71;72;73;75;76;75;73 06:15:39 INFO - 2015-11-24 06:15:39,219 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;85;88;92;93;93;92;88;90;93 06:15:39 INFO - 2015-11-24 06:15:39,219 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;131;136;130;143;131;130;130;136;137 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;146;163;163;160;154;162;155;147;157 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;75;74;76;78;78;77;74;74 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,892 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: __startTimestamp1448374539211__endTimestamp 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,220 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.50 stddev:4.68 (4.2%) stddev-sans-first:4.96 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 112.0 113.0 116.0 99.0 114.0 109.0 107.0 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:156.00 stddev:16.81 (10.8%) stddev-sans-first:17.71 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: Values: 155.0 128.0 161.0 157.0 131.0 153.0 134.0 177.0 165.0 133.0 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,221 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:172.30 Median:174.00 stddev:4.16 (2.4%) stddev-sans-first:2.19 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: Values: 162.0 168.0 173.0 173.0 175.0 174.0 175.0 175.0 174.0 174.0 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.80 Median:77.50 stddev:19.47 (25.1%) stddev-sans-first:20.45 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: Values: 79.0 82.0 87.0 127.0 72.0 78.0 77.0 77.0 118.0 71.0 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:115.90 Median:156.00 stddev:25.70 (16.5%) stddev-sans-first:26.96 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: Values: 105.0 105.0 147.0 95.0 97.0 97.0 144.0 101.0 103.0 165.0 06:15:39 INFO - 2015-11-24 06:15:39,222 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:129.80 Median:130.00 stddev:4.16 (3.2%) stddev-sans-first:4.41 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: Values: 130.0 124.0 136.0 126.0 130.0 124.0 134.0 134.0 130.0 130.0 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:135.70 Median:135.00 stddev:2.41 (1.8%) stddev-sans-first:2.35 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: Values: 133.0 135.0 140.0 135.0 135.0 134.0 134.0 140.0 136.0 135.0 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:111.30 Median:113.00 stddev:2.75 (2.4%) stddev-sans-first:2.15 06:15:39 INFO - 2015-11-24 06:15:39,223 DEBUG : BROWSER_OUTPUT: Values: 106.0 112.0 114.0 114.0 109.0 113.0 113.0 113.0 111.0 108.0 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.50 stddev:4.69 (7.1%) stddev-sans-first:4.39 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: Values: 60.0 64.0 65.0 66.0 68.0 67.0 67.0 78.0 64.0 64.0 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:73.00 stddev:2.94 (4.0%) stddev-sans-first:3.08 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 66.0 71.0 72.0 73.0 75.0 76.0 75.0 73.0 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:92.00 stddev:2.92 (3.2%) stddev-sans-first:2.88 06:15:39 INFO - 2015-11-24 06:15:39,224 DEBUG : BROWSER_OUTPUT: Values: 87.0 85.0 88.0 92.0 93.0 93.0 92.0 88.0 90.0 93.0 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:136.00 stddev:4.38 (3.2%) stddev-sans-first:4.52 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: Values: 137.0 131.0 136.0 130.0 143.0 131.0 130.0 130.0 136.0 137.0 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:158.50 stddev:6.34 (4.0%) stddev-sans-first:6.48 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: Values: 151.0 146.0 163.0 163.0 160.0 154.0 162.0 155.0 147.0 157.0 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,225 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:75.50 stddev:2.71 (3.6%) stddev-sans-first:2.28 06:15:39 INFO - 2015-11-24 06:15:39,226 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 75.0 74.0 76.0 78.0 78.0 77.0 74.0 74.0 06:15:39 INFO - 2015-11-24 06:15:39,226 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:15:39 INFO - 2015-11-24 06:15:39,226 DEBUG : BROWSER_OUTPUT: 06:15:39 INFO - 2015-11-24 06:15:39,901 INFO : Browser exited with error code: 0 06:15:39 INFO - 2015-11-24 06:15:39,953 INFO : Completed test kraken (00:00:58) 06:15:39 INFO - 2015-11-24 06:15:39,953 INFO : Starting test v8_7 06:15:39 INFO - 2015-11-24 06:15:39,953 DEBUG : operating with platform_type : mac_ 06:15:39 INFO - 2015-11-24 06:15:39,953 INFO : Initialising browser for v8_7 test... 06:15:39 INFO - 2015-11-24 06:15:39,969 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpbcJSty/profile http://localhost:50018/getInfo.html 06:15:42 INFO - 2015-11-24 06:15:42,357 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:15:42 INFO - 2015-11-24 06:15:42,358 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:15:42 INFO - 2015-11-24 06:15:42,358 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:15:42 INFO - 2015-11-24 06:15:42,358 DEBUG : BROWSER_OUTPUT: __metrics 06:15:42 INFO - 2015-11-24 06:15:42,373 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:15:43 INFO - 2015-11-24 06:15:43,045 INFO : Browser initialized. 06:15:43 INFO - 2015-11-24 06:15:43,046 INFO : Running cycle 1/1 for v8_7 test... 06:15:43 INFO - 2015-11-24 06:15:43,046 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/tmpbcJSty/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:15:54 INFO - 2015-11-24 06:15:54,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 200400896 06:15:54 INFO - 2015-11-24 06:15:54,995 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50018/tests/v8_7/run.html (next: http://localhost:50018/tests/v8_7/run.html) 06:16:16 INFO - 2015-11-24 06:16:16,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 567132160 06:16:16 INFO - 2015-11-24 06:16:16,702 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,702 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:16:16 INFO - 2015-11-24 06:16:16,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:16:16 INFO - 2015-11-24 06:16:16,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:16:16 INFO - 2015-11-24 06:16:16,703 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:16:16 INFO - 2015-11-24 06:16:16,703 DEBUG : BROWSER_OUTPUT: |0;Richards;170.15484090522375 06:16:16 INFO - 2015-11-24 06:16:16,703 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.62142584826535 06:16:16 INFO - 2015-11-24 06:16:16,703 DEBUG : BROWSER_OUTPUT: |2;Encrypt;355.6187766714082 06:16:16 INFO - 2015-11-24 06:16:16,703 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6179.0123456790125 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1097.694840834248 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: |5;Earley;734.7538574577517 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: |6;Boyer;13466.666666666666 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: |7;RegExp;31656.25 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: |8;Splay;685.8710562414266 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6211.180124223602 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: __startTimestamp1448374576700__endTimestamp 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:16:16 INFO - 2015-11-24 06:16:16,704 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.15 Median:170.15 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: Values: 170.2 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.62 Median:190.62 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: Values: 190.6 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:355.62 Median:355.62 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: Values: 355.6 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6179.01 Median:6179.01 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: Values: 6179.0 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,705 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: Values: 1097.7 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:734.75 Median:734.75 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: Values: 734.8 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13466.67 Median:13466.67 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: Values: 13466.7 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31656.25 Median:31656.25 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: Values: 31656.3 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:685.87 Median:685.87 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: Values: 685.9 06:16:16 INFO - 2015-11-24 06:16:16,706 DEBUG : BROWSER_OUTPUT: 06:16:16 INFO - 2015-11-24 06:16:16,707 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6211.18 Median:6211.18 stddev:0.00 (0.0%) 06:16:16 INFO - 2015-11-24 06:16:16,707 DEBUG : BROWSER_OUTPUT: Values: 6211.2 06:16:16 INFO - 2015-11-24 06:16:16,707 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:16:16 INFO - 2015-11-24 06:16:16,707 DEBUG : BROWSER_OUTPUT: 06:16:17 INFO - 2015-11-24 06:16:17,368 INFO : Browser exited with error code: 0 06:16:17 INFO - 2015-11-24 06:16:17,389 INFO : Completed test v8_7 (00:00:37) 06:16:17 INFO - 2015-11-24 06:16:17,812 INFO : Completed test suite (00:20:10) 06:16:17 INFO - 2015-11-24 06:16:17,812 DEBUG : Working with test: dromaeo_css 06:16:17 INFO - 2015-11-24 06:16:17,812 DEBUG : Generating results file: dromaeo_css 06:16:17 INFO - 2015-11-24 06:16:17,813 DEBUG : Working with test: kraken 06:16:17 INFO - 2015-11-24 06:16:17,813 DEBUG : Generating results file: kraken 06:16:17 INFO - 2015-11-24 06:16:17,813 INFO : javascript benchmark 06:16:17 INFO - 2015-11-24 06:16:17,813 DEBUG : Working with test: v8_7 06:16:17 INFO - 2015-11-24 06:16:17,813 DEBUG : Generating results file: v8_7 06:16:17 INFO - 2015-11-24 06:16:17,814 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:16:17 INFO - 2015-11-24 06:16:17,889 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 06:16:17 INFO - 2015-11-24 06:16:17,889 DEBUG : process_Request line: dromaeo_css 6342.98 graph.html#tests=[[72,52,55]] 06:16:17 INFO - 2015-11-24 06:16:17,889 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:16:17 INFO - 2015-11-24 06:16:17,943 DEBUG : process_Request line: kraken 1604.50 graph.html#tests=[[232,52,55]] 06:16:17 INFO - 2015-11-24 06:16:17,943 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:16:18 INFO - 2015-11-24 06:16:18,053 DEBUG : process_Request line: v8_7 18966.06 graph.html#tests=[[230,52,55]] 06:16:18 INFO - 2015-11-24 06:16:18,054 INFO : javascript benchmark 06:16:18 INFO - 2015-11-24 06:16:18,056 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [330.6098803411974, 332.7703884319819, 332.9400707872582, 333.120561717067, 343.13701041879676, 13916.443342266322, 14128.364223609937, 15842.603934901634, 16193.190340482974, 17149.828501714994, 13895.930520347409, 14650.780238296435, 17082.31670733169, 17139.0, 17345.47963561095, 4948.010397920403, 5035.144025515653, 5052.722100284501, 5113.207452844815, 5120.667156634825, 3855.267499175162, 4889.413270407556, 4987.775550100254, 5089.46560611136, 5094.490550944913, 3903.8243279052513, 5498.835034948958, 5588.6646801192055, 5661.433856614347, 5665.065264231397, 5438.945610543923, 5555.638883472561, 5568.49883510484, 5606.2151298818, 5623.297087863996, 4833.154198015333, 4853.514648535153, 4881.511848815126, 4908.092002979461, 4909.754512274408, 20124.899375503028, 20206.090725917224, 20376.490587735276, 20444.0, 20612.629547602068, 1930.420873737873, 1932.1401976120633, 1999.4701404127918, 2027.8276346510565, 2037.9592408151755, 12705.61883143498, 12940.35298235094, 13006.0, 13098.47606095755, 13236.470541178342, 1543.8764898808067, 1622.3105180298444, 1639.8934069285458, 1647.3163637090593, 1698.9806116330226, 56153.43846561523, 57157.428425715625, 57356.42643573553, 57410.0, 58137.0, 9027.909720902839, 9121.498317592463, 9531.237500999903, 9568.76078098053, 9607.90392096084, 11771.293722376684, 11781.175317727848, 11781.705457363634, 11854.466549005316, 11950.820737688942, 7782.844343113219, 7799.337056350274, 7807.726729564438, 7859.056913170456, 7882.251186137308, 8000.159983201796, 8001.279884810395, 8015.83968320642, 8064.55644939534, 8150.510969341858, 5563.332400112013, 5610.663360198401, 5616.157576363496, 5662.886742265132, 5770.798022069292, 1536.508317338441, 1608.557646647158, 1648.077076836975, 1648.5054483655094, 1652.4959887234509, 343.6134348857535, 346.73687018112366, 820.6635279535362, 924.4360939826701, 953.4374718915873, 9244.399114057565, 9402.213579419888, 9406.38858474197, 9461.52692365379, 9545.0, 334.7439209005113, 354.0952865428803, 378.5646506517472, 379.2774764074443, 386.2044188970729, 4899.387576552931, 4960.975195124001, 5019.372578427697, 5085.567726743268, 5237.580993520509, 516178.0, 520169.0, 521707.0, 541025.0, 554271.0, 67647.66176169187, 70853.64573177102, 71767.2823271771, 72589.0, 73409.6329518349, 399.9480067591253, 402.25984189092213, 403.49966042107576, 406.21803029168734, 407.8103681787983, 8954.373193876367, 8963.417377870417, 9005.864912026194, 9030.322725795722, 9041.954790226007, 31278.374432510765, 31704.524432133076, 32837.67162328346, 33129.17177070593, 33139.83430082931, 40521.0, 42884.57115428806, 43634.0, 46446.30330545112, 46752.7662361686, 5664.405237450009, 5669.85825354353, 5743.971280143573, 5759.654420734601, 5773.364929857797, 10928.890711092787, 11268.323900565993, 11328.433578320886, 11329.830052549383, 11393.943030285127, 9649.710508684751, 9664.081912218327, 9827.557759900965, 9933.15568176713, 10005.799884002425, 9489.85765213536, 9554.952225238829, 9600.807983840145, 9780.462074585967, 9809.019098090133, 9417.717468475958, 9909.603615855285, 10019.649312274036, 10060.044295791888, 10133.08802207805, 5652.095664693629, 5714.200011998407, 5724.0, 5746.482816546531, 5752.223449834219, 9658.323917325719, 9666.371685840399, 9800.754981125243, 9883.061109194616, 9895.950520247641], "dojo.html": [2990.3869706710125, 3020.6375234971806, 3024.8185108893467, 3121.3445176512932, 3195.744340452764, 4957.5968732997535, 5046.974765126179, 5051.67164134332, 5085.982803439313, 5094.312267843845, 5032.320636714043, 5110.616703747215, 5142.845714628567, 5144.819931302396, 5181.6113791465605, 4518.570735780112, 4651.000034992476, 4653.976730116353, 4778.307145463906, 4792.472827988919, 4552.0, 4564.589186973171, 4570.040291538764, 4589.265717485203, 4592.15045216636, 4582.427196600425, 4599.747013914233, 4612.861614151564, 4617.445906491226, 4622.560856718606, 4500.5949464548185, 4596.954030459703, 4602.562756538124, 4662.580367766917, 4683.555062269079, 4714.905701885943, 4717.433907931036, 4734.739589322586, 4775.164346239394, 4824.179889418807, 4847.830325938575, 5078.187490001619, 5104.489551044903, 5120.129577971717, 5236.6857988520815, 5149.047426226122, 5223.138182199932, 5234.6335756497065, 5253.238280449314, 5329.866753331159, 5414.458554144593, 5526.364468086182, 5585.916211256835, 5606.6636001840025, 5614.719264036782, 4945.901081978341, 5017.9247311290355, 5141.922871156936, 5189.143791274473, 5194.142966410575, 5416.322959630046, 5489.560835133179, 5599.80400685974, 5611.382747897728, 5672.546196304285, 5277.894442111136, 5298.125809241509, 5298.6290959633225, 5309.840704778863, 5333.946660533423, 5245.816396426183, 5362.490563396471, 5431.321084864392, 5470.124780035176, 5544.695041772741, 5208.348956380452, 5300.814471493479, 5348.358197016383, 5353.9732301338245, 5382.03123437785, 5217.113090774577, 5228.9477105229225, 5264.763085661154, 5284.07528682479, 5295.285136506599, 4080.959190408117, 4083.612056854594, 4085.9795701021303, 4095.3037983542868, 4156.355764856452, 3720.2373513429684, 3787.5454945406727, 3814.904627384282, 3821.178446633987, 3839.4432807242792, 5088.643794934393, 5112.156494178419, 5144.125498665236, 5149.0, 5153.690778553224, 5237.214417837355, 5355.357357117171, 5541.362743284493, 5585.888282234332, 5626.35296940857, 4884.12085824555, 5037.244413338029, 5138.203578445347, 5143.717095559706, 5176.818811341585, 4849.2968519564465, 4853.49038350968, 4874.878128046827, 4898.779554920037, 4922.138625740481, 5327.760250788801, 5476.014317422902, 5601.6358936668985, 5616.494515493625, 5621.0, 5246.737663116905, 5323.3878104016985, 5326.09456392422, 5405.162199859028, 5466.34403871522, 5512.6968016759465, 5525.392206857162, 5526.088195447706, 5536.0, 5541.113421852484, 5186.688798671941, 5300.443453437488, 5436.374816896107, 5442.727863606883, 5447.673139611636, 5359.356877174608, 5391.865203369947, 5455.045367060828, 5456.263404440349, 5474.753636086306, 5227.790888364575, 5392.352917649907, 5419.3225846769155, 5422.132458806572, 5432.945670543244, 4982.8754281143265, 5098.923516147187, 5411.810586629449, 5424.701641409761, 5445.754941027584, 5072.1123803335, 5170.793168273227, 5180.715060671549, 5207.531322181022, 5209.114450543341, 5301.655392399482, 5374.6506477078865, 5401.621886468067, 5412.350517937715, 5453.04571699943, 5103.87240318995, 5243.108671525926, 5290.365156181283, 5323.866903327448, 5338.466153384786], "mootools.html": [1268.8477382714075, 1358.463406954253, 1379.5033787836383, 1666.80831704354, 1743.6861364954311, 6756.2905894881005, 7413.51812132211, 7417.7403790867265, 7435.553866767991, 7510.324070833624, 7291.927080729204, 7619.961900190491, 7641.1976742442075, 7666.386689064875, 7725.343345815612, 2093.5080256139795, 2111.5565731196466, 2112.9366119016454, 2122.7134336864556, 2126.447123747821, 2123.4903623130413, 2158.5467051919118, 2162.145952348821, 2171.250918433138, 2181.182056728727, 2087.217293514932, 2118.046878904491, 2124.468882779305, 2153.7092492513466, 2167.0898222746405, 2119.8092171704543, 2152.494163871489, 2158.84888057836, 2163.8593491423007, 2181.8472706910525, 2078.511549785799, 2110.6306396380573, 2116.619008578455, 2116.9153233870625, 2125.0543508138885, 6744.393004629607, 7403.962980185119, 7489.475736698433, 7512.248775122499, 7567.886481702779, 4142.730722503027, 4418.8453404130705, 4524.524924882873, 4542.727436353829, 4567.862964111082, 2793.413383189533, 2810.8875644974382, 2829.4199689063694, 2852.2013836125916, 2906.157214407819, 801.2028032108032, 811.1037303779298, 829.2205326992607, 847.4025811802665, 858.1161403754144, 9978.30151889368, 9981.700548983616, 9994.700158995242, 10092.990700929922, 10096.040876116756, 4085.59144085595, 4108.897277568085, 4110.116324990141, 4150.91698166035, 4172.18642364742, 8821.647134114692, 8860.689875854314, 8920.420172688755, 8924.55377231136, 8955.328350373748, 4448.421705178306, 4451.421315229064, 4497.168023915586, 4507.549245075532, 4516.435445569304, 4095.24238015968, 4097.692673049533, 4097.85657501986, 4101.85643502476, 4107.835686572564, 3451.81015044175, 3481.9303613927577, 3482.669146431085, 3504.0889368763796, 3535.063208249816, 1081.221520505235, 1103.2442776697987, 1107.634480621393, 1121.9775604488027, 1124.0782558302114, 965.478641533564, 977.7897751983357, 984.6799790068256, 1034.2191645307744, 1202.2365797718337, 6813.0, 6813.931860681429, 6888.311168883171, 6896.069030680894, 6907.585544867324, 411.31926661375473, 419.55108034402895, 421.8755467137202, 426.43710302401155, 428.6356596892616, 5154.92267615986, 5223.921641175385, 5226.97386513065, 5291.365036195682, 5291.550218231417, 8126.674933002732, 8760.4305720128, 8802.911970880337, 8818.559072046372, 8820.779480513038, 8783.121687831293, 8818.911810881937, 8911.643534258686, 8923.152300531568, 8938.240249578728, 7006.75476358325, 7112.288771122846, 7126.465515086389, 7156.821079473055, 7208.3152100551415, 6691.0, 6990.720371185299, 7024.086868707035, 7027.613481258375, 7047.154341479055, 7787.260210280015, 7856.09654889695, 7965.601719914097, 7981.361491080584, 8011.799705007188, 7983.8802417964935, 8228.382871284797, 8229.83540329202, 8249.587520624065, 8277.006759188695, 6635.104260924713, 6737.59574425536, 6754.18949726036, 6758.155230596176, 6809.148856392951, 7219.783406497813, 7243.927560724536, 7262.201157872735, 7265.273472652692, 7320.231375705474, 6581.3747693969, 6678.899816502659, 6761.188657361148, 6813.250542440229, 6842.076319696777, 6583.44040756541, 6604.966975165094, 6686.632235227109, 6714.865702685821, 6736.225334086446, 6335.176427064452, 6465.224173099258, 6531.379518945692, 6841.965790171216, 6871.896921546081, 5657.575681823797, 5713.428657134254, 5718.25662663851, 5769.249997500298, 5801.796937107181, 5773.91339129905, 5796.449337312949, 5809.970950145223, 5824.301083869963, 5849.327327357409], "ext.html": [529.489043073434, 532.5526557691538, 540.3785646506515, 556.457453982367, 562.7242651100962, 30737.077887663378, 31630.84184579077, 37903.43144852826, 38224.0, 38757.806210968905, 39638.80180599093, 40055.19889602206, 40067.0, 40174.19651606966, 40652.0, 7935.801604959865, 8514.063453020148, 8696.26081783046, 8719.694810681627, 8739.257163141141, 8090.878636820453, 10368.53341599626, 10595.205359598023, 10649.0, 10696.946515267451, 10302.072813446788, 10386.065254127127, 10419.583216671363, 10469.79060418795, 10475.947620261888, 8167.714130005481, 8351.039630442456, 10403.167746580293, 10510.00154985279, 10585.523651435627, 10143.594256229742, 10326.22553308505, 10430.478476076241, 10433.530491127918, 10469.68590942273, 37647.0, 38016.0, 38043.8097809512, 38260.23479530422, 38571.807140964396, 2865.169100960719, 2868.942621147586, 2889.3787835615444, 2889.956650650242, 3266.6896644818703, 24990.625140622724, 26125.346866328302, 26371.604425933627, 26820.731792682214, 27163.592546111824, 2163.437506248371, 2173.880436575988, 2195.5718634866207, 2217.1796435318875, 2243.461569223391, 274181.0, 277619.0, 278703.0, 280523.0, 280714.0, 51299.74350128225, 52898.206526902126, 59428.70285648544, 59982.40017599768, 65868.67065664641, 59035.704821475614, 59213.703931480064, 59950.40049599448, 60014.39985600176, 60052.69973650104, 15363.769543456858, 15476.690466190614, 15504.139503259681, 15507.06957582526, 15661.765073523678, 12424.316662583644, 12476.75046499065, 12516.624501264794, 12522.937385313015, 12545.12184147101, 19112.617747645247, 19336.516587085436, 19351.0, 19487.22051117968, 19556.706649400272, 8175.427720059658, 8276.255137037695, 8283.420160588701, 8345.833083338299, 8468.491890486468, 798.6246464161835, 820.7742870710603, 837.417994493821, 867.8394497018072, 903.263839970422, 23217.419564511023, 23237.7676223239, 23383.0, 23428.18001369944, 23481.17815876436, 873.9344549158839, 933.8179055084194, 960.2030314838806, 963.1909196275162, 970.1075010989906, 11616.651500455, 11876.168668193144, 12529.0, 12609.873901261053, 12680.746385072247, 239320.0, 244404.0, 245654.0, 245743.0, 246603.0, 45806.08387832291, 46570.534294656616, 48825.0, 49461.50538494569, 56644.0, 1303.687115092371, 1329.1559859489294, 1343.7446885091802, 1351.2297990145523, 1360.571420002696, 22551.0, 23670.408239794142, 23695.170669026502, 23909.0, 23919.52160956806, 44908.550914490435, 45842.770786145855, 51895.0, 52920.47079529309, 53001.4699853012, 261168.0, 262887.0, 266282.0, 268409.0, 268928.0, 30628.234294142825, 30658.0, 31240.062798116094, 31317.53023704601, 31398.215044624067, 39109.21781564296, 39558.80220598879, 40218.798906005286, 40825.387619185145, 41488.1702365957, 32651.0, 33911.83044084764, 34061.31877362489, 34279.657203428644, 34382.31235375329, 34015.319693606485, 34037.82981085079, 34390.65609343975, 34723.30553388969, 38751.41872871853, 38990.6100938987, 39088.6091139085, 39161.804190978866, 39290.0, 39616.80191599139, 35920.0, 37049.25901482009, 37208.81395593005, 37447.25105497929, 37640.43539346857, 30502.847485762428, 30936.53595196119, 31000.0, 32254.35491290208, 32441.0], "prototype.html": [305.8302642033671, 306.2924644072193, 316.4541166487809, 317.4270441852456, 324.3205484509954, 5734.79928202513, 5739.626924249921, 5774.162746401769, 5777.913331300028, 5777.971110144444, 5672.886542269152, 5677.772889084432, 5704.743286552105, 5708.029634962056, 5766.740496677649, 4403.0, 4415.20526305265, 4419.580139886713, 4439.511653718105, 4486.618637415807, 4236.9576304237025, 4302.849400270991, 4423.093265880487, 4465.620422264112, 4506.121306345264, 3802.505674262342, 4201.978990105061, 4245.299525578276, 4294.67789915756, 4301.612854843063, 4240.745555266694, 4298.957010429903, 4312.9433288844275, 4327.978360108211, 4331.4152589400655, 3616.4032934565766, 3628.673419392241, 3659.3779057560278, 3659.963400365989, 3667.5598928128798, 5436.510714035756, 5447.6459030163305, 5519.724013799294, 5532.695701736403, 5588.161775733632, 4867.756612169377, 4917.754112294407, 4929.531694489017, 4944.208926571767, 4957.082939656175, 5953.13679516472, 5982.7906023289415, 6016.639001659914, 6019.067044608093, 6038.124471951543, 3899.415087736834, 4029.1740193260603, 4066.1867626474527, 4066.6136717011836, 4086.0193553547233, 6284.277308109535, 6351.87296254077, 6367.586106903036, 6417.550771446001, 6417.935820641827, 4155.376693495939, 4172.415861779354, 4209.158168366339, 4218.514870789837, 4226.746395216297, 4241.575842415734, 4254.340577210537, 4255.936160957588, 4298.032942587955, 4306.547812479645, 4809.831655892027, 4925.088858561177, 4972.0, 4977.104121258209, 4992.2511623256805, 5994.6403215807195, 6003.6397816131175, 6063.999440092335, 6084.969575152096, 6093.786717464956, 1511.048039734982, 1515.50746007548, 1517.5143953934635, 1528.465037236958, 1532.578540901261, 977.1938151025432, 978.8822600018963, 987.274353350287, 987.8863930647924, 992.925530585209, 5704.144378343199, 5709.25779648643, 5752.741126649311, 5767.538596912237, 5774.769009239583, 6249.812505624838, 6314.684265786692, 6327.905081423783, 6336.049592561153, 6360.204974378203, 5756.02147634903, 5767.798127065533, 5771.85570360736, 5804.390538993429, 5808.796692115756, 3362.176266814646, 3449.7585169037925, 3477.0, 3484.790912545255, 3498.2129020970588, 6366.331535188739, 6378.904316435257, 6397.168368112209, 6399.9040014399825, 6401.551891367652, 6233.563650544418, 6340.048992651047, 6412.39082287182, 6437.2275326960125, 6444.162258906406, 6264.718087686065, 6278.340774218733, 6305.747770089237, 6352.968235158794, 6392.392722691244, 6231.626102433687, 6256.530760192913, 6263.154474145932, 6265.686715664289, 6296.590721603081, 5948.434898684618, 6101.542384321282, 6163.599366041193, 6189.164462797645, 6208.410201030895, 6413.967930160319, 6427.55007149495, 6450.677466126581, 6454.967725161344, 6461.289258181502, 4053.250148722496, 4080.7959602019187, 4086.162336720906, 4094.488188976378, 4104.0970986382945, 6179.3820617937845, 6305.495560355253, 6320.399562041599, 6356.491480681442, 6375.4262116409745, 6090.756369745161, 6104.725287361991, 6164.7842325518395, 6172.351903050115, 6174.043023331391, 6095.994160963392, 6103.145559621746, 6120.816375508742, 6166.845828854314, 6175.289841668266, 5820.883582328414, 5980.222571065908, 6028.0, 6039.78860739872, 6053.182820319201, 6176.474999625082, 6187.288461826947, 6199.5970261934635, 6206.286277078194, 6217.036359364306, 5993.0, 6033.909491357545, 6037.366076561898, 6062.484688801501, 6078.848028799139], "yui.html": [716.6345163966375, 717.6662851773928, 722.7940037089427, 734.5078797205872, 741.5217184915728, 12966.351682415876, 13133.67165820855, 13229.073964822466, 13256.46974121034, 13269.0, 13161.802572961413, 13401.396937137828, 13523.661908452268, 13533.255670938119, 13544.0, 674.7874419557849, 822.4489591973362, 823.9093699693029, 826.2728798657204, 833.954132522711, 686.8523267497487, 833.2708879730236, 844.6494704697543, 849.3672214200429, 850.8766228896807, 850.1795767084762, 863.4948555095277, 865.7922098696331, 875.8248350329927, 877.2543338162575, 685.6571714142929, 691.7233106757287, 849.9320054395633, 862.3273846399818, 876.0888675777184, 628.71707731521, 628.9937100628981, 629.4083561452265, 632.5414074795736, 642.9003504456816, 12876.420561074774, 12968.675783105404, 12969.481220751253, 12977.156484828456, 12990.935045324808, 9135.0, 9140.314476414296, 9178.954105229497, 9536.2371010319, 9760.365576237522, 7911.564863932482, 8222.712205072854, 8231.382646301552, 8838.072002439716, 8968.955155224246, 2646.4971655385416, 2663.6803583569904, 2670.519306524825, 2678.5714285714193, 2695.7439043290856, 45509.54490455119, 45591.77204113958, 46563.767181164214, 46672.76663616694, 46684.899179537, 6341.651209183447, 6359.8092057238355, 6516.674166291667, 6577.046328282372, 6965.233824279325, 11907.226030308002, 11919.582814601446, 11928.880711192951, 12055.095867809949, 12084.335361555199, 5744.109663002241, 6020.608660437058, 6037.184980027728, 6075.149479072845, 6145.569810113249, 3481.599616044137, 3551.6448355164275, 3584.1039740064984, 3593.389123848952, 3616.222512159898, 2511.6609257750333, 2545.7963362930923, 2552.3363925379535, 2552.4895020995873, 2582.0, 388.03186050803424, 389.2099038950934, 393.4904298932889, 395.6340385143788, 397.85279446604943, 448.4215362182813, 462.3296220480317, 463.12700559445017, 505.88617561049205, 525.8843054527998, 7046.6476676165985, 7186.425085993108, 7230.349268565749, 7393.186749457555, 7397.741079062314, 528.4292963599304, 547.6713971617078, 559.7285316621435, 560.6776103740366, 562.3195932921129, 3390.5592273004845, 3397.76215664906, 3415.863365465403, 3430.622631510532, 3518.8240587971013, 55714.80271474805, 55946.160807587105, 56051.15923261154, 56081.0, 56515.0, 51062.744686277074, 51241.23138152931, 51244.74377628088, 51305.7434712824, 51365.0, 47594.0, 47613.5238647616, 47854.9999999993, 48244.517554824, 48803.511964879894, 6852.725890964505, 6912.44700423975, 6963.48164164019, 6981.127359080115, 7141.678624462015, 35071.824640876635, 35198.47202292019, 35305.646943530235, 35625.643743562236, 35890.4616430759, 42930.57069429391, 45410.31884521801, 46392.07215855731, 46918.76540617275, 47067.29399058948, 6236.095766113979, 6249.25008998923, 6360.809175724736, 6436.485081193587, 6460.773872914426, 9332.953335233551, 9575.473348965596, 9578.616855325708, 9744.902550974683, 9804.313698041355, 8688.30493560501, 8708.521031343336, 9115.726528204164, 9156.313276504423, 9174.403663761834, 8996.0, 9024.639014439348, 9137.269018478639, 9333.0, 9456.763580910532, 9043.276537876822, 9167.816643667224, 9671.032896710272, 9714.3199976001, 9921.00789921002, 8590.527520986405, 8600.698975535826, 8842.867356989522, 8856.335774817044, 8966.058563850702, 8287.50274983503, 8346.499210047174, 8499.74500764978, 8518.318534517348, 8708.825823483368]}, "summary": {"suite": 6342.978568329204, "subtests": {"jquery.html": {"filtered": 7192.621807678395, "value": 7192.621807678395}, "dojo.html": {"filtered": 5008.579342131596, "value": 5008.579342131596}, "mootools.html": {"filtered": 4120.334190318754, "value": 4120.334190318754}, "ext.html": {"filtered": 17807.43979235999, "value": 17807.43979235999}, "prototype.html": {"filtered": 4537.214936022872, "value": 4537.214936022872}, "yui.html": {"filtered": 5429.910134632828, "value": 5429.910134632828}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0017"}, "testrun": {"date": 1448373367, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151124042330", "branch": "Mozilla-Aurora", "revision": "337f0ed43821944b9ba77dd4b98083192413a765"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 168.0, 173.0, 173.0, 175.0, 174.0, 175.0, 175.0, 174.0, 174.0], "ai-astar": [110.0, 111.0, 110.0, 112.0, 113.0, 116.0, 99.0, 114.0, 109.0, 107.0], "imaging-gaussian-blur": [130.0, 124.0, 136.0, 126.0, 130.0, 124.0, 134.0, 134.0, 130.0, 130.0], "audio-beat-detection": [155.0, 128.0, 161.0, 157.0, 131.0, 153.0, 134.0, 177.0, 165.0, 133.0], "json-stringify-tinderbox": [71.0, 70.0, 66.0, 71.0, 72.0, 73.0, 75.0, 76.0, 75.0, 73.0], "stanford-crypto-pbkdf2": [151.0, 146.0, 163.0, 163.0, 160.0, 154.0, 162.0, 155.0, 147.0, 157.0], "json-parse-financial": [60.0, 64.0, 65.0, 66.0, 68.0, 67.0, 67.0, 78.0, 64.0, 64.0], "stanford-crypto-sha256-iterative": [70.0, 71.0, 75.0, 74.0, 76.0, 78.0, 78.0, 77.0, 74.0, 74.0], "audio-fft": [79.0, 82.0, 87.0, 127.0, 72.0, 78.0, 77.0, 77.0, 118.0, 71.0], "imaging-darkroom": [133.0, 135.0, 140.0, 135.0, 135.0, 134.0, 134.0, 140.0, 136.0, 135.0], "stanford-crypto-ccm": [137.0, 131.0, 136.0, 130.0, 143.0, 131.0, 130.0, 130.0, 136.0, 137.0], "audio-oscillator": [105.0, 105.0, 147.0, 95.0, 97.0, 97.0, 144.0, 101.0, 103.0, 165.0], "stanford-crypto-aes": [87.0, 85.0, 88.0, 92.0, 93.0, 93.0, 92.0, 88.0, 90.0, 93.0], "imaging-desaturate": [106.0, 112.0, 114.0, 114.0, 109.0, 113.0, 113.0, 113.0, 111.0, 108.0]}, "summary": {"suite": 1604.4999999999998, "subtests": {"audio-fft": {"filtered": 86.8, "value": 86.8}, "stanford-crypto-pbkdf2": {"filtered": 155.8, "value": 155.8}, "audio-beat-detection": {"filtered": 149.4, "value": 149.4}, "stanford-crypto-ccm": {"filtered": 134.1, "value": 134.1}, "imaging-darkroom": {"filtered": 135.7, "value": 135.7}, "json-parse-financial": {"filtered": 66.3, "value": 66.3}, "audio-oscillator": {"filtered": 115.9, "value": 115.9}, "ai-astar": {"filtered": 110.1, "value": 110.1}, "audio-dft": {"filtered": 172.3, "value": 172.3}, "stanford-crypto-sha256-iterative": {"filtered": 74.7, "value": 74.7}, "json-stringify-tinderbox": {"filtered": 72.2, "value": 72.2}, "imaging-gaussian-blur": {"filtered": 129.8, "value": 129.8}, "stanford-crypto-aes": {"filtered": 90.1, "value": 90.1}, "imaging-desaturate": {"filtered": 111.3, "value": 111.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0017"}, "testrun": {"date": 1448373367, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151124042330", "branch": "Mozilla-Aurora", "revision": "337f0ed43821944b9ba77dd4b98083192413a765"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.62142584826535], "Encrypt": [355.6187766714082], "NavierStokes": [6211.180124223602], "Decrypt": [6179.0123456790125], "Splay": [685.8710562414266], "Richards": [170.15484090522375], "RegExp": [31656.25], "Earley": [734.7538574577517], "Boyer": [13466.666666666666], "RayTrace": [1097.694840834248]}, "summary": {"suite": 18966.06106426058, "subtests": {"DeltaBlue": {"filtered": 346.8550280000001, "value": 346.8550280000001}, "Encrypt": {"filtered": 748.500972, "value": 748.500972}, "NavierStokes": {"filtered": 238.92400000000015, "value": 238.92400000000015}, "Decrypt": {"filtered": 43.078243756243715, "value": 43.078243756243715}, "Splay": {"filtered": 118.81387800000003, "value": 118.81387800000003}, "RegExp": {"filtered": 28.777413622902287, "value": 28.777413622902287}, "Richards": {"filtered": 207.46985400000003, "value": 207.46985400000003}, "Earley": {"filtered": 907.0561430000002, "value": 907.0561430000002}, "Boyer": {"filtered": 49.489826732673265, "value": 49.489826732673265}, "RayTrace": {"filtered": 674.1299790000003, "value": 674.1299790000003}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0017"}, "testrun": {"date": 1448373367, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151124042330", "branch": "Mozilla-Aurora", "revision": "337f0ed43821944b9ba77dd4b98083192413a765"}}] 06:16:18 INFO - RETURN: dromaeo_css: 6342.98 06:16:18 INFO - RETURN: kraken: 1604.50 06:16:18 INFO - RETURN: v8_7: 18966.06 06:16:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18966.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1604.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6342.98"}}} 06:16:18 INFO - Return code: 0 06:16:18 INFO - # TBPL SUCCESS # 06:16:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:16:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:16:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:16:18 INFO - 2015-11-24 06:16:18.157 screenresolution[2249:18062] starting screenresolution argv=screenresolution get 06:16:18 INFO - 2015-11-24 06:16:18.160 screenresolution[2249:18062] Display 0: 1600x1200x32@60 06:16:18 INFO - 2015-11-24 06:16:18.167 screenresolution[2250:18065] starting screenresolution argv=screenresolution list 06:16:18 INFO - Available Modes on Display 0 06:16:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:16:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:16:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:16:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:16:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:16:18 INFO - Intel HD Graphics 3000: 06:16:18 INFO - Chipset Model: Intel HD Graphics 3000 06:16:18 INFO - Type: GPU 06:16:18 INFO - Bus: Built-In 06:16:18 INFO - VRAM (Total): 512 MB 06:16:18 INFO - VRAM (Dynamic, Max): 10 06:16:18 INFO - Vendor: Intel (0x8086) 06:16:18 INFO - Device ID: 0x0116 06:16:18 INFO - Revision ID: 0x0009 06:16:18 INFO - Displays: 06:16:18 INFO - Display: 06:16:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:16:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:16:18 INFO - Display Serial Number: 1600x1200 60 06:16:18 INFO - Main Display: Yes 06:16:18 INFO - Mirror: Off 06:16:18 INFO - Online: Yes 06:16:18 INFO - Rotation: Supported 06:16:18 INFO - Return code: 0 06:16:18 INFO - Running post-action listener: _resource_record_post_action 06:16:18 INFO - Running post-run listener: _resource_record_post_run 06:16:19 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 331776; Write bytes: 688359424; Read time: 417; Write time: 59750 06:16:19 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 335565312; Write bytes: 334006272; Read time: 33534; Write time: 6678 06:16:19 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 331776; Write bytes: 343248896; Read time: 417; Write time: 52098 06:16:19 INFO - Running post-run listener: _upload_blobber_files 06:16:19 INFO - Blob upload gear active. 06:16:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:16:19 INFO - Copying logs to upload dir... 06:16:19 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1304.131245 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-24 06:16:19.559672) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:16:19.562946) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009963 build_url: 'https://queue.taskcluster.net/v1/task/jfmWgj01S3moPVT1CCe-Sg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:16:19.585507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:16:19.586184) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nRhx2Kk9ia/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.n5aVHde9nI/Listeners TMPDIR=/var/folders/39/xmx7vk895wzdssnchq4b_8l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005162 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:16:19.637603) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 06:16:19.637994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 06:16:19.638612) ========= ========= Total master_lag: 0.21 =========