builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0023 starttime: 1446254004.79 results: success (0) buildid: 20151030165830 builduid: 482aee3ee76748f6a1d9df6187087147 revision: cd4108f41872a9e1dc50ea3dcac84ab208d1f199 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.791836) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.792332) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.792663) ========= 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.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.005842 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.846785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.847214) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.897637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.898024) ========= 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.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.025715 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.947792) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.948145) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.948587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:24.948917) ========= 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.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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-10-30 18:13:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.1M=0s 2015-10-30 18:13:25 (41.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.177900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.178320) ========= 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.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.064758 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.258665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.259080) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev cd4108f41872a9e1dc50ea3dcac84ab208d1f199 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev cd4108f41872a9e1dc50ea3dcac84ab208d1f199 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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-10-30 18:13:25,354 truncating revision to first 12 chars 2015-10-30 18:13:25,354 Setting DEBUG logging. 2015-10-30 18:13:25,354 attempt 1/10 2015-10-30 18:13:25,355 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/cd4108f41872?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-30 18:13:25,613 unpacking tar archive at: mozilla-inbound-cd4108f41872/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546452 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.823606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.824017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.840358) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.840788) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 18:13:25.841330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-10-30 18:13:25.841664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:13:26 INFO - MultiFileLogger online at 20151030 18:13:26 in /builds/slave/test 18:13:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:13:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:13:26 INFO - {'append_to_log': False, 18:13:26 INFO - 'base_work_dir': '/builds/slave/test', 18:13:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:13:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:13:26 INFO - 'branch': 'Mozilla-Inbound', 18:13:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:13:26 INFO - 'config_files': ('talos/mac_config.py',), 18:13:26 INFO - 'default_actions': ('clobber', 18:13:26 INFO - 'read-buildbot-config', 18:13:26 INFO - 'download-and-extract', 18:13:26 INFO - 'populate-webroot', 18:13:26 INFO - 'create-virtualenv', 18:13:26 INFO - 'install', 18:13:26 INFO - 'run-tests'), 18:13:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:13:26 INFO - 'download_minidump_stackwalk': True, 18:13:26 INFO - 'download_symbols': 'ondemand', 18:13:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:13:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:13:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:13:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:13:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:13:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:13:26 INFO - 'installer_path': 'installer.exe', 18:13:26 INFO - 'log_level': 'info', 18:13:26 INFO - 'log_name': 'talos', 18:13:26 INFO - 'log_to_console': True, 18:13:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:13:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:13:26 INFO - 'opt_config_files': (), 18:13:26 INFO - 'pip_index': False, 18:13:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:13:26 INFO - 'cmd': ('bash', 18:13:26 INFO - '-c', 18:13:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:13:26 INFO - 'enabled': True, 18:13:26 INFO - 'halt_on_failure': False, 18:13:26 INFO - 'name': 'check_screen_resolution'},), 18:13:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:13:26 INFO - 'cmd': ('bash', 18:13:26 INFO - '-c', 18:13:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:13:26 INFO - 'enabled': True, 18:13:26 INFO - 'halt_on_failure': False, 18:13:26 INFO - 'name': 'check_screen_resolution'},), 18:13:26 INFO - 'run_cmd_checks_enabled': True, 18:13:26 INFO - 'sps_profile': False, 18:13:26 INFO - 'sps_profile_interval': 0, 18:13:26 INFO - 'suite': 'dromaeojs', 18:13:26 INFO - 'system_bits': '64', 18:13:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:13:26 INFO - 'title': 't-yosemite-r5-0023', 18:13:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:13:26 INFO - 'use_talos_json': True, 18:13:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:13:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:13:26 INFO - 'work_dir': 'build'} 18:13:26 INFO - ##### 18:13:26 INFO - ##### Running clobber step. 18:13:26 INFO - ##### 18:13:26 INFO - Running pre-action listener: _resource_record_pre_action 18:13:26 INFO - Running main action method: clobber 18:13:26 INFO - rmtree: /builds/slave/test/build 18:13:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:13:29 INFO - Running post-action listener: _resource_record_post_action 18:13:29 INFO - ##### 18:13:29 INFO - ##### Running read-buildbot-config step. 18:13:29 INFO - ##### 18:13:29 INFO - Running pre-action listener: _resource_record_pre_action 18:13:29 INFO - Running main action method: read_buildbot_config 18:13:29 INFO - Using buildbot properties: 18:13:29 INFO - { 18:13:29 INFO - "properties": { 18:13:29 INFO - "buildnumber": 3216, 18:13:29 INFO - "product": "firefox", 18:13:29 INFO - "script_repo_revision": "production", 18:13:29 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 18:13:29 INFO - "repository": "", 18:13:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 18:13:29 INFO - "buildid": "20151030165830", 18:13:29 INFO - "slavename": "t-yosemite-r5-0023", 18:13:29 INFO - "pgo_build": "False", 18:13:29 INFO - "basedir": "/builds/slave/test", 18:13:29 INFO - "project": "", 18:13:29 INFO - "platform": "yosemite", 18:13:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:13:29 INFO - "slavebuilddir": "test", 18:13:29 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 18:13:29 INFO - "branch": "mozilla-inbound", 18:13:29 INFO - "repo_path": "integration/mozilla-inbound", 18:13:29 INFO - "stage_platform": "macosx64", 18:13:29 INFO - "builduid": "482aee3ee76748f6a1d9df6187087147", 18:13:29 INFO - "revision": "cd4108f41872a9e1dc50ea3dcac84ab208d1f199" 18:13:29 INFO - }, 18:13:29 INFO - "sourcestamp": { 18:13:29 INFO - "repository": "", 18:13:29 INFO - "hasPatch": false, 18:13:29 INFO - "project": "", 18:13:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 18:13:29 INFO - "changes": [ 18:13:29 INFO - { 18:13:29 INFO - "category": null, 18:13:29 INFO - "files": [ 18:13:29 INFO - { 18:13:29 INFO - "url": null, 18:13:29 INFO - "name": "https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:13:29 INFO - } 18:13:29 INFO - ], 18:13:29 INFO - "repository": "", 18:13:29 INFO - "rev": "cd4108f41872a9e1dc50ea3dcac84ab208d1f199", 18:13:29 INFO - "who": "kwierso@gmail.com", 18:13:29 INFO - "when": 1446253959, 18:13:29 INFO - "number": 6603169, 18:13:29 INFO - "comments": "Merge m-c to inbound, a=merge", 18:13:29 INFO - "project": "", 18:13:29 INFO - "at": "Fri 30 Oct 2015 18:12:39", 18:13:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 18:13:29 INFO - "revlink": "", 18:13:29 INFO - "properties": [ 18:13:29 INFO - [ 18:13:29 INFO - "buildid", 18:13:29 INFO - "20151030165830", 18:13:29 INFO - "Change" 18:13:29 INFO - ], 18:13:29 INFO - [ 18:13:29 INFO - "builduid", 18:13:29 INFO - "482aee3ee76748f6a1d9df6187087147", 18:13:29 INFO - "Change" 18:13:29 INFO - ], 18:13:29 INFO - [ 18:13:29 INFO - "pgo_build", 18:13:29 INFO - "False", 18:13:29 INFO - "Change" 18:13:29 INFO - ] 18:13:29 INFO - ], 18:13:29 INFO - "revision": "cd4108f41872a9e1dc50ea3dcac84ab208d1f199" 18:13:29 INFO - } 18:13:29 INFO - ], 18:13:29 INFO - "revision": "cd4108f41872a9e1dc50ea3dcac84ab208d1f199" 18:13:29 INFO - } 18:13:29 INFO - } 18:13:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:13:29 INFO - Running post-action listener: _resource_record_post_action 18:13:29 INFO - ##### 18:13:29 INFO - ##### Running download-and-extract step. 18:13:29 INFO - ##### 18:13:29 INFO - Running pre-action listener: _resource_record_pre_action 18:13:29 INFO - Running main action method: download_and_extract 18:13:29 INFO - mkdir: /builds/slave/test/build/tests 18:13:29 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')]} 18:13:29 INFO - https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:13:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/test_packages.json 18:13:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/test_packages.json 18:13:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:13:30 INFO - Downloaded 1149 bytes. 18:13:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:13:30 INFO - Using the following test package requirements: 18:13:30 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:13:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:13:30 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:13:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:13:30 INFO - u'jsshell-mac.zip'], 18:13:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:13:30 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:13:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:13:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:13:30 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:13:30 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:13:30 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:13:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:13:30 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:13:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:13:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:13:30 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:13:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:13:30 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')]} 18:13:30 INFO - https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:13:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:13:31 INFO - Downloaded 17452930 bytes. 18:13:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:13:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:13:37 INFO - Return code: 0 18:13:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:13: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')]} 18:13:37 INFO - https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:13:38 INFO - Downloaded 17452930 bytes. 18:13:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:13:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:13:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:13:43 INFO - Return code: 0 18:13:43 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')]} 18:13:43 INFO - https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:13:45 INFO - Downloaded 11131307 bytes. 18:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 18:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:13:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:13:46 INFO - Return code: 0 18:13:46 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')]} 18:13:46 INFO - https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 18:13:49 INFO - Downloaded 108524820 bytes. 18:13:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:13:49 INFO - mkdir: /builds/slave/test/properties 18:13:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:13:49 INFO - Writing to file /builds/slave/test/properties/build_url 18:13:49 INFO - Contents: 18:13:49 INFO - build_url:https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:13:49 INFO - Running post-action listener: _resource_record_post_action 18:13:49 INFO - Running post-action listener: set_extra_try_arguments 18:13:49 INFO - ##### 18:13:49 INFO - ##### Running populate-webroot step. 18:13:49 INFO - ##### 18:13:49 INFO - Running pre-action listener: _resource_record_pre_action 18:13:49 INFO - Running main action method: populate_webroot 18:13:49 INFO - Guessing talos json url... 18:13:49 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')]} 18:13:49 INFO - https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 18:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 18:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 18:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 18:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 18:13:50 INFO - Downloaded 111 bytes. 18:13:50 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 18:13:50 INFO - Contents: 18:13:50 INFO - 20151030165830 18:13:50 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/cd4108f41872a9e1dc50ea3dcac84ab208d1f199 18:13:50 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')]} 18:13:50 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/cd4108f418/testing/talos/talos.json 18:13:50 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/cd4108f418/testing/talos/talos.json to /builds/slave/test/build/talos.json 18:13:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/cd4108f418/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 18:13:50 INFO - Downloaded 4264 bytes. 18:13:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:13:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:13:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:13:50 INFO - '../fennec_ids.txt'], 18:13:50 INFO - 'tests': ['tcheck2']}, 18:13:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:13:50 INFO - '--tppagecycles', 18:13:50 INFO - '7'], 18:13:50 INFO - 'tests': ['tsvgm']}}, 18:13:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:13:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:13:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:13:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:13:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'tests': ['damp', 'tps']}, 18:13:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['damp', 'tps']}, 18:13:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:13:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:13:50 INFO - 'other': {'tests': ['a11yr', 18:13:50 INFO - 'ts_paint', 18:13:50 INFO - 'tpaint', 18:13:50 INFO - 'sessionrestore', 18:13:50 INFO - 'sessionrestore_no_auto_restore']}, 18:13:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['a11yr', 18:13:50 INFO - 'ts_paint', 18:13:50 INFO - 'tpaint', 18:13:50 INFO - 'sessionrestore', 18:13:50 INFO - 'sessionrestore_no_auto_restore']}, 18:13:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['a11yr', 18:13:50 INFO - 'ts_paint', 18:13:50 INFO - 'tpaint', 18:13:50 INFO - 'sessionrestore', 18:13:50 INFO - 'sessionrestore_no_auto_restore']}, 18:13:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['a11yr', 18:13:50 INFO - 'ts_paint', 18:13:50 INFO - 'tpaint', 18:13:50 INFO - 'sessionrestore', 18:13:50 INFO - 'sessionrestore_no_auto_restore']}, 18:13:50 INFO - 'other_l64': {'tests': ['a11yr', 18:13:50 INFO - 'ts_paint', 18:13:50 INFO - 'tpaint', 18:13:50 INFO - 'sessionrestore', 18:13:50 INFO - 'sessionrestore_no_auto_restore']}, 18:13:50 INFO - 'other_nol64': {'tests': ['a11yr', 18:13:50 INFO - 'ts_paint', 18:13:50 INFO - 'tpaint', 18:13:50 INFO - 'sessionrestore', 18:13:50 INFO - 'sessionrestore_no_auto_restore']}, 18:13:50 INFO - 'svgr': {'tests': ['tsvgx', 18:13:50 INFO - 'tsvgr_opacity', 18:13:50 INFO - 'tart', 18:13:50 INFO - 'tscrollx', 18:13:50 INFO - 'cart']}, 18:13:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['tsvgx', 18:13:50 INFO - 'tsvgr_opacity', 18:13:50 INFO - 'tart', 18:13:50 INFO - 'tscrollx', 18:13:50 INFO - 'cart']}, 18:13:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'tests': ['tp5o']}, 18:13:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'talos_options': ['--e10s'], 18:13:50 INFO - 'tests': ['tp5o']}, 18:13:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'talos_options': ['--xperf_path', 18:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:13:50 INFO - 'tests': ['tp5n']}, 18:13:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:13:50 INFO - 'talos_options': ['--e10s', 18:13:50 INFO - '--xperf_path', 18:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 18:13:50 INFO - 'C:/slave/talos-data/talos/xperf.config'], 18:13:50 INFO - 'tests': ['tp5n']}}, 18:13:50 INFO - 'talos.zip': {'path': '', 18:13:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:13:50 INFO - Running post-action listener: _resource_record_post_action 18:13:50 INFO - ##### 18:13:50 INFO - ##### Running create-virtualenv step. 18:13:50 INFO - ##### 18:13:50 INFO - Running pre-action listener: _resource_record_pre_action 18:13:50 INFO - Running main action method: create_virtualenv 18:13:50 INFO - Creating virtualenv /builds/slave/test/build/venv 18:13:50 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 18:13:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:13:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:13:50 INFO - Using real prefix '/tools/python27' 18:13:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:13:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:13:55 INFO - Installing pip.................done. 18:13:55 INFO - Return code: 0 18:13:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:13:55 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')]} 18:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:55 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')]} 18:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:55 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 0x104d4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30e05810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, '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.12LQhzuwY8/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.GZbC6NQGxt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:13:55 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 18:13:55 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 18:13:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:13:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:55 INFO - 'HOME': '/Users/cltbld', 18:13:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:55 INFO - 'LOGNAME': 'cltbld', 18:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:55 INFO - 'MOZ_NO_REMOTE': '1', 18:13:55 INFO - 'NO_EM_RESTART': '1', 18:13:55 INFO - 'PAGER': '/bin/cat', 18:13:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:55 INFO - 'PWD': '/builds/slave/test', 18:13:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:55 INFO - 'SHELL': '/bin/bash', 18:13:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:13:55 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:13:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:55 INFO - 'USER': 'cltbld', 18:13:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:55 INFO - 'XPC_FLAGS': '0x0', 18:13:55 INFO - 'XPC_SERVICE_NAME': '0', 18:13:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:56 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 18:13:56 INFO - Cleaning up... 18:13:56 INFO - Return code: 0 18:13:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:13:56 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')]} 18:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:56 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')]} 18:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:56 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 0x104d4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30e05810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, '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.12LQhzuwY8/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.GZbC6NQGxt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:13:56 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 18:13:56 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 18:13:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:13:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:56 INFO - 'HOME': '/Users/cltbld', 18:13:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:56 INFO - 'LOGNAME': 'cltbld', 18:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:56 INFO - 'MOZ_NO_REMOTE': '1', 18:13:56 INFO - 'NO_EM_RESTART': '1', 18:13:56 INFO - 'PAGER': '/bin/cat', 18:13:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:56 INFO - 'PWD': '/builds/slave/test', 18:13:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:56 INFO - 'SHELL': '/bin/bash', 18:13:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:13:56 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:13:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:56 INFO - 'USER': 'cltbld', 18:13:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:56 INFO - 'XPC_FLAGS': '0x0', 18:13:56 INFO - 'XPC_SERVICE_NAME': '0', 18:13:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:56 INFO - Downloading/unpacking psutil>=0.7.1 18:13:56 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 18:13:56 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 18:13:56 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 18:13:56 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 18:13:56 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 18:13:56 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 18:13:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:13:59 INFO - Installing collected packages: psutil 18:13:59 INFO - Running setup.py install for psutil 18:13:59 INFO - building 'psutil._psutil_osx' extension 18:13:59 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 18:14:01 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 18:14:01 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 18:14:01 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 18:14:02 INFO - building 'psutil._psutil_posix' extension 18:14:02 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 18:14:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:14:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:14:02 INFO - ^ 18:14:02 INFO - 1 warning generated. 18:14:02 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 18:14:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:02 INFO - Successfully installed psutil 18:14:02 INFO - Cleaning up... 18:14:02 INFO - Return code: 0 18:14:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:14:02 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')]} 18:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:02 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')]} 18:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:02 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 0x104d4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30e05810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, '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.12LQhzuwY8/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.GZbC6NQGxt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:14:02 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 18:14:02 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 18:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:02 INFO - 'HOME': '/Users/cltbld', 18:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:02 INFO - 'LOGNAME': 'cltbld', 18:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:02 INFO - 'MOZ_NO_REMOTE': '1', 18:14:02 INFO - 'NO_EM_RESTART': '1', 18:14:02 INFO - 'PAGER': '/bin/cat', 18:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:02 INFO - 'PWD': '/builds/slave/test', 18:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:02 INFO - 'SHELL': '/bin/bash', 18:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:14:02 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:02 INFO - 'USER': 'cltbld', 18:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:02 INFO - 'XPC_FLAGS': '0x0', 18:14:02 INFO - 'XPC_SERVICE_NAME': '0', 18:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:14:02 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 18:14:02 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 18:14:02 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 18:14:02 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 18:14:02 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 18:14:02 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 18:14:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:14:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:14:05 INFO - Installing collected packages: mozsystemmonitor 18:14:05 INFO - Running setup.py install for mozsystemmonitor 18:14:05 INFO - Successfully installed mozsystemmonitor 18:14:05 INFO - Cleaning up... 18:14:05 INFO - Return code: 0 18:14:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:14:05 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')]} 18:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 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')]} 18:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 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 0x104d4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30e05810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, '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.12LQhzuwY8/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.GZbC6NQGxt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:14:05 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 18:14:05 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 18:14:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:14:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:05 INFO - 'HOME': '/Users/cltbld', 18:14:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:05 INFO - 'LOGNAME': 'cltbld', 18:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:05 INFO - 'MOZ_NO_REMOTE': '1', 18:14:05 INFO - 'NO_EM_RESTART': '1', 18:14:05 INFO - 'PAGER': '/bin/cat', 18:14:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:05 INFO - 'PWD': '/builds/slave/test', 18:14:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:05 INFO - 'SHELL': '/bin/bash', 18:14:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:14:05 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:14:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:05 INFO - 'USER': 'cltbld', 18:14:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:05 INFO - 'XPC_FLAGS': '0x0', 18:14:05 INFO - 'XPC_SERVICE_NAME': '0', 18:14:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:06 INFO - Downloading/unpacking blobuploader==1.2.4 18:14:06 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 18:14:06 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 18:14:06 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 18:14:06 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 18:14:06 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 18:14:06 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 18:14:08 INFO - Downloading blobuploader-1.2.4.tar.gz 18:14:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:14:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:14:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:14:09 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 18:14:09 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 18:14:09 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 18:14:09 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 18:14:09 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 18:14:09 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 18:14:10 INFO - Downloading docopt-0.6.1.tar.gz 18:14:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:14:10 INFO - Installing collected packages: blobuploader, requests, docopt 18:14:10 INFO - Running setup.py install for blobuploader 18:14:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:14:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:14:10 INFO - Running setup.py install for requests 18:14:11 INFO - Running setup.py install for docopt 18:14:11 INFO - Successfully installed blobuploader requests docopt 18:14:11 INFO - Cleaning up... 18:14:11 INFO - Return code: 0 18:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:11 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 0x104d4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30e05810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, '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.12LQhzuwY8/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.GZbC6NQGxt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:14:11 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 18:14:11 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 18:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:11 INFO - 'HOME': '/Users/cltbld', 18:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:11 INFO - 'LOGNAME': 'cltbld', 18:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:11 INFO - 'MOZ_NO_REMOTE': '1', 18:14:11 INFO - 'NO_EM_RESTART': '1', 18:14:11 INFO - 'PAGER': '/bin/cat', 18:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:11 INFO - 'PWD': '/builds/slave/test', 18:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:11 INFO - 'SHELL': '/bin/bash', 18:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:14:11 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:11 INFO - 'USER': 'cltbld', 18:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:11 INFO - 'XPC_FLAGS': '0x0', 18:14:11 INFO - 'XPC_SERVICE_NAME': '0', 18:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:11 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-6kdbrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:11 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-eADEcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:11 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-2nRMX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-NZlkrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-NydqtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-qDhHVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-X_LrM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-ot_Pk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-ktESaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-uJCnxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:12 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-I6ECso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:13 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-lcqEHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:13 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-KuA_Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:13 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-r2pPUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:13 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-dqTtIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:13 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-_OzgHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:13 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-oOebhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:14:13 INFO - Running setup.py install for manifestparser 18:14:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:14:14 INFO - Running setup.py install for mozcrash 18:14:14 INFO - Running setup.py install for mozdebug 18:14:14 INFO - Running setup.py install for mozdevice 18:14:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:14:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:14:14 INFO - Running setup.py install for mozfile 18:14:14 INFO - Running setup.py install for mozhttpd 18:14:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Running setup.py install for mozinfo 18:14:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Running setup.py install for mozInstall 18:14:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Running setup.py install for mozleak 18:14:15 INFO - Running setup.py install for mozlog 18:14:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Running setup.py install for moznetwork 18:14:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:14:15 INFO - Running setup.py install for mozprocess 18:14:16 INFO - Running setup.py install for mozprofile 18:14:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:14:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:14:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:14:16 INFO - Running setup.py install for mozrunner 18:14:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:14:16 INFO - Running setup.py install for mozscreenshot 18:14:16 INFO - Running setup.py install for moztest 18:14:16 INFO - Running setup.py install for mozversion 18:14:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:14:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:14:17 INFO - Cleaning up... 18:14:17 INFO - Return code: 0 18:14:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:17 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')]} 18:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:17 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')]} 18:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:17 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 0x104d4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30e05810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, '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.12LQhzuwY8/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.GZbC6NQGxt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:14:17 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 18:14:17 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 18:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:17 INFO - 'HOME': '/Users/cltbld', 18:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:17 INFO - 'LOGNAME': 'cltbld', 18:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:17 INFO - 'MOZ_NO_REMOTE': '1', 18:14:17 INFO - 'NO_EM_RESTART': '1', 18:14:17 INFO - 'PAGER': '/bin/cat', 18:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:17 INFO - 'PWD': '/builds/slave/test', 18:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:17 INFO - 'SHELL': '/bin/bash', 18:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:14:17 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:17 INFO - 'USER': 'cltbld', 18:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:17 INFO - 'XPC_FLAGS': '0x0', 18:14:17 INFO - 'XPC_SERVICE_NAME': '0', 18:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:17 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-T4TQdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:17 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)) 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:17 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-Pu2x_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:17 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)) 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:17 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-fCgbTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:17 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)) 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:17 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-puVpqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:18 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-JkSyXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:18 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)) 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:18 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-pI64mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:18 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)) 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:18 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-hmKAAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:18 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-Ped1wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:18 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)) 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:18 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-9HRgkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:18 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)) 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:18 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-fCaje4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:18 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)) 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:18 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-XUhwmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:19 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)) 18:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:19 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-WqSF31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:19 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)) 18:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:19 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-PmoPni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:19 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)) 18:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:19 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-7gcSp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:19 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)) 18:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:19 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-9sUAT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:19 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)) 18:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:19 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-PPEccw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:19 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)) 18:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:19 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-r45Xa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:19 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)) 18:14:19 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)) 18:14:19 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)) 18:14:19 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)) 18:14:19 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:14:19 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:14:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:14:19 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 18:14:19 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 18:14:19 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 18:14:19 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 18:14:19 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 18:14:19 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 18:14:22 INFO - Downloading blessings-1.5.1.tar.gz 18:14:22 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 18:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:14:22 INFO - Installing collected packages: blessings 18:14:22 INFO - Running setup.py install for blessings 18:14:22 INFO - Successfully installed blessings 18:14:22 INFO - Cleaning up... 18:14:22 INFO - Return code: 0 18:14:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:14:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:23 INFO - Reading from file tmpfile_stdout 18:14:23 INFO - Current package versions: 18:14:23 INFO - blessings == 1.5.1 18:14:23 INFO - blobuploader == 1.2.4 18:14:23 INFO - docopt == 0.6.1 18:14:23 INFO - manifestparser == 1.1 18:14:23 INFO - mozInstall == 1.12 18:14:23 INFO - mozcrash == 0.16 18:14:23 INFO - mozdebug == 0.1 18:14:23 INFO - mozdevice == 0.47 18:14:23 INFO - mozfile == 1.2 18:14:23 INFO - mozhttpd == 0.7 18:14:23 INFO - mozinfo == 0.9 18:14:23 INFO - mozleak == 0.1 18:14:23 INFO - mozlog == 3.0 18:14:23 INFO - moznetwork == 0.27 18:14:23 INFO - mozprocess == 0.22 18:14:23 INFO - mozprofile == 0.27 18:14:23 INFO - mozrunner == 6.11 18:14:23 INFO - mozscreenshot == 0.1 18:14:23 INFO - mozsystemmonitor == 0.0 18:14:23 INFO - moztest == 0.7 18:14:23 INFO - mozversion == 1.4 18:14:23 INFO - psutil == 3.1.1 18:14:23 INFO - requests == 1.2.3 18:14:23 INFO - wsgiref == 0.1.2 18:14:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:23 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')]} 18:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:23 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')]} 18:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:23 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 0x104d4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30e05810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, '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.12LQhzuwY8/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.GZbC6NQGxt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:14:23 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 18:14:23 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 18:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:23 INFO - 'HOME': '/Users/cltbld', 18:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:23 INFO - 'LOGNAME': 'cltbld', 18:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:23 INFO - 'MOZ_NO_REMOTE': '1', 18:14:23 INFO - 'NO_EM_RESTART': '1', 18:14:23 INFO - 'PAGER': '/bin/cat', 18:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:23 INFO - 'PWD': '/builds/slave/test', 18:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:23 INFO - 'SHELL': '/bin/bash', 18:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:14:23 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:23 INFO - 'USER': 'cltbld', 18:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:23 INFO - 'XPC_FLAGS': '0x0', 18:14:23 INFO - 'XPC_SERVICE_NAME': '0', 18:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 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)) 18:14:23 INFO - Cleaning up... 18:14:23 INFO - Return code: 0 18:14:23 INFO - Running post-action listener: _resource_record_post_action 18:14:23 INFO - Running post-action listener: _start_resource_monitoring 18:14:23 INFO - Starting resource monitoring. 18:14:23 INFO - ##### 18:14:23 INFO - ##### Running install step. 18:14:23 INFO - ##### 18:14:23 INFO - Running pre-action listener: _resource_record_pre_action 18:14:23 INFO - Running main action method: install 18:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:24 INFO - Reading from file tmpfile_stdout 18:14:24 INFO - Detecting whether we're running mozinstall >=1.0... 18:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:14:24 INFO - Reading from file tmpfile_stdout 18:14:24 INFO - Output received: 18:14:24 INFO - Usage: mozinstall [options] installer 18:14:24 INFO - Options: 18:14:24 INFO - -h, --help show this help message and exit 18:14:24 INFO - -d DEST, --destination=DEST 18:14:24 INFO - Directory to install application into. [default: 18:14:24 INFO - "/builds/slave/test"] 18:14:24 INFO - --app=APP Application being installed. [default: firefox] 18:14:24 INFO - mkdir: /builds/slave/test/build/application 18:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:15:05 INFO - Reading from file tmpfile_stdout 18:15:05 INFO - Output received: 18:15:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:15:05 INFO - Running post-action listener: _resource_record_post_action 18:15:05 INFO - ##### 18:15:05 INFO - ##### Running run-tests step. 18:15:05 INFO - ##### 18:15:05 INFO - Running pre-action listener: _resource_record_pre_action 18:15:05 INFO - Running main action method: run_tests 18:15:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:15:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:15:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:15:05 INFO - 2015-10-30 18:15:05.355 screenresolution[1628:7582] starting screenresolution argv=screenresolution get 18:15:05 INFO - 2015-10-30 18:15:05.358 screenresolution[1628:7582] Display 0: 1600x1200x32@60 18:15:05 INFO - 2015-10-30 18:15:05.365 screenresolution[1629:7584] starting screenresolution argv=screenresolution list 18:15:05 INFO - Available Modes on Display 0 18:15:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:15:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:15:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:15:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:15:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:15:05 INFO - Intel HD Graphics 3000: 18:15:05 INFO - Chipset Model: Intel HD Graphics 3000 18:15:05 INFO - Type: GPU 18:15:05 INFO - Bus: Built-In 18:15:05 INFO - VRAM (Total): 512 MB 18:15:05 INFO - VRAM (Dynamic, Max): 10 18:15:05 INFO - Vendor: Intel (0x8086) 18:15:05 INFO - Device ID: 0x0116 18:15:05 INFO - Revision ID: 0x0009 18:15:05 INFO - Displays: 18:15:05 INFO - Display: 18:15:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:15:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:15:05 INFO - Display Serial Number: 1600x1200 60 18:15:05 INFO - Main Display: Yes 18:15:05 INFO - Mirror: Off 18:15:05 INFO - Online: Yes 18:15:05 INFO - Rotation: Supported 18:15:05 INFO - Return code: 0 18:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:15:05 INFO - Python 2.7.3 18:15:05 INFO - Return code: 0 18:15:05 INFO - grabbing minidump binary from tooltool 18:15:05 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')]} 18:15:05 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 0x104d009f0>, '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 0x104a5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cca990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:15:05 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 18:15:05 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 18:15:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:15:05 INFO - Return code: 0 18:15:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:15:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:15:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:15:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:15:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] in /builds/slave/test/build 18:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0023 --webServer localhost 18:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12LQhzuwY8/Render', 18:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:05 INFO - 'HOME': '/Users/cltbld', 18:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:05 INFO - 'LOGNAME': 'cltbld', 18:15:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:15:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:05 INFO - 'MOZ_NO_REMOTE': '1', 18:15:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:15:05 INFO - 'NO_EM_RESTART': '1', 18:15:05 INFO - 'PAGER': '/bin/cat', 18:15:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:05 INFO - 'PWD': '/builds/slave/test', 18:15:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:05 INFO - 'SHELL': '/bin/bash', 18:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZbC6NQGxt/Listeners', 18:15:05 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:05 INFO - 'USER': 'cltbld', 18:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:05 INFO - 'XPC_FLAGS': '0x0', 18:15:05 INFO - 'XPC_SERVICE_NAME': '0', 18:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:15:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] with output_timeout 3600 18:15:06 INFO - mozversion INFO | application_buildid: 20151030165830 18:15:06 INFO - mozversion INFO | application_changeset: cd4108f41872a9e1dc50ea3dcac84ab208d1f199 18:15:06 INFO - mozversion INFO | application_display_name: Nightly 18:15:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:15:06 INFO - mozversion INFO | application_name: Firefox 18:15:06 INFO - mozversion INFO | application_remotingname: firefox 18:15:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:15:06 INFO - mozversion INFO | application_vendor: Mozilla 18:15:06 INFO - mozversion INFO | application_version: 45.0a1 18:15:06 INFO - mozversion INFO | platform_buildid: 20151030165830 18:15:06 INFO - mozversion INFO | platform_changeset: cd4108f41872a9e1dc50ea3dcac84ab208d1f199 18:15:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:15:06 INFO - mozversion INFO | platform_version: 45.0a1 18:15:06 INFO - 2015-10-30 18:15:06,125 DEBUG : using testdate: 1446254106 18:15:06 INFO - 2015-10-30 18:15:06,126 DEBUG : actual date: 1446254106 18:15:09 INFO - 2015-10-30 18:15:09,509 INFO : starting webserver on 'localhost:49269' 18:15:09 INFO - 2015-10-30 18:15:09,510 INFO : Starting test suite t-yosemite-r5-0023 18:15:09 INFO - 2015-10-30 18:15:09,510 INFO : Starting test dromaeo_css 18:15:09 INFO - 2015-10-30 18:15:09,510 DEBUG : operating with platform_type : mac_ 18:15:09 INFO - 2015-10-30 18:15:09,511 INFO : Initialising browser for dromaeo_css test... 18:15:09 INFO - 2015-10-30 18:15:09,590 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpvrbrEy/profile http://localhost:49269/getInfo.html 18:15:12 INFO - 2015-10-30 18:15:12,629 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:15:12 INFO - 2015-10-30 18:15:12,629 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:15:12 INFO - 2015-10-30 18:15:12,629 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:15:12 INFO - 2015-10-30 18:15:12,629 DEBUG : BROWSER_OUTPUT: __metrics 18:15:12 INFO - 2015-10-30 18:15:12,647 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:15:13 INFO - 2015-10-30 18:15:13,431 INFO : Browser initialized. 18:15:13 INFO - 2015-10-30 18:15:13,431 INFO : Running cycle 1/1 for dromaeo_css test... 18:15:13 INFO - 2015-10-30 18:15:13,431 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpvrbrEy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:15:25 INFO - 2015-10-30 18:15:25,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 221245440 18:15:25 INFO - 2015-10-30 18:15:25,452 DEBUG : BROWSER_OUTPUT: 18:16:17 INFO - 2015-10-30 18:16:17,475 DEBUG : BROWSER_OUTPUT: 1446254177472 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] 18:18:27 INFO - 2015-10-30 18:18:27,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 18:18:28 INFO - 2015-10-30 18:18:28,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 322293760 18:18:28 INFO - 2015-10-30 18:18:28,908 DEBUG : BROWSER_OUTPUT: 18:21:31 INFO - 2015-10-30 18:21:31,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 18:21:32 INFO - 2015-10-30 18:21:32,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 356683776 18:21:32 INFO - 2015-10-30 18:21:32,374 DEBUG : BROWSER_OUTPUT: 18:24:34 INFO - 2015-10-30 18:24:34,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 18:24:35 INFO - 2015-10-30 18:24:35,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 322744320 18:24:35 INFO - 2015-10-30 18:24:35,229 DEBUG : BROWSER_OUTPUT: 18:27:37 INFO - 2015-10-30 18:27:37,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 18:27:37 INFO - 2015-10-30 18:27:37,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 312492032 18:27:37 INFO - 2015-10-30 18:27:37,983 DEBUG : BROWSER_OUTPUT: 18:30:41 INFO - 2015-10-30 18:30:41,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 18:30:41 INFO - 2015-10-30 18:30:41,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 311857152 18:30:41 INFO - 2015-10-30 18:30:41,940 DEBUG : BROWSER_OUTPUT: 18:33:44 INFO - 2015-10-30 18:33:44,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 18:33:45 INFO - 2015-10-30 18:33:45,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 577953792 18:33:45 INFO - 2015-10-30 18:33:45,007 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,007 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:33:45 INFO - 2015-10-30 18:33:45,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:33:45 INFO - 2015-10-30 18:33:45,008 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:33:45 INFO - 2015-10-30 18:33:45,008 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:33:45 INFO - 2015-10-30 18:33:45,008 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2745.286225581349;2810.2833777386763;2841.5737639354093;2846.886124555018;2848.515752322105;4527.275635898257;4599.977000114995;4686.179918514264;4738.933739908523;4776.402949631296;4552.749598772066;4605.401297831286;4658.813647454098;4714.4106986626675;4753.1681955657705;4357.607815296623;4479.126570318789;4499.910001799962;4517.457905051382;4520.412346394964;4554.111948170108;4574.0394517151435;4577.954220457803;4579.793909274091;4627.884302892421;4227.4292970448905;4335.241332766753;4368.847090351823;4499.437570303696;4511.593956543894;4296.269634162169;4405.185040767468;4417.3815665806815;4422.5577442255835;4453.55464453552;4388.846390376321;4402.691811573191;4455.509893911667;4464.799084041226;4526.34368016639;4701.929471057937;4714.363560919266;4753.191957367256;4769.070031343889;4773.140834649762;4802.087603355351;4858.489858564871;4917.50824917509;4984.40187177541;5013.548780609726;5065.240213967897;5082.059818933472;5087;5092.439831618519;5121.641485096045;4690.343351930733;4722.574968252874;4726.361941137937;4769.475357710649;4802.567768900781;4979.3526841510375;5046;5088.338515992971;5157.252198431282;5219.765110570033;4701.95298047022;4830.66185367028;4886.291487734258;4942.308076869242;4995.650304478651;4994.200927851526;4998.625103117208;5015.749212539358;5067.493250674903;5085.480519609909;4791.089692958327;4847.975760121177;4868.9756551217015;4913.778879950411;4923.679960802537;4904.901901961941;4931.728754918514;4938.061768264019;4979.377577802775;4984.825531106394;3862.497875276252;3865.381538953754;3871.690264778811;3895.902602434962;3905;3439.466882633196;3442.621311655716;3542.1144713821545;3570.232400034005;3570.2680950405106;4634.86095417138;4724.43306803179;4724.645651576146;4737.597304229179;4758.547937945889;5076.44159142494;5112.309838171799;5121.4622464641425;5123.487651234921;5226.764795584208;4476.306172543261;4592.471865735416;4596.149712303235;4610.308453731967;4693.20215563355;4349.13017396522;4369.388285640013;4378.365137055109;4387.934180987288;4427.911441771146;4970.552650261494;5031.069252188357;5032.094223039888;5079.796808127633;5155.690658560424;4874.5856602189215;4921.163402221559;4944.208926571875;4972.428170760264;5056.469070747666;5105.387353517602;5119.769610367468;5123.846284611468;5136;5181.844544663666;4961.8015279389865;4966.627502937222;5019.447860735243;5027.773750181177;5041.168207245763;4822.300766388784;4939.456659767495;5089.465606111453;5134.383873935002;5146.511081447256;4879.731614761222;4884.63365247615;4935.728534930469;4936.777844997056;4946.307516947702;4871.683340582851;4872.6832755870755;4879.365682461257;4926.162552366035;4956.77694503741;4625.838095666635;4753.358296629911;4762.285657151455;4807.086653535817;4888.388951381077;4947.208446648519;4989.55094041538;4997.325361076353;4999.10016197088;5010.874728131826;4864.343313652612;4870.09903167915;4883.536064073907;4889.437714662717;4998.300237966615 18:33:45 INFO - 2015-10-30 18:33:45,008 DEBUG : BROWSER_OUTPUT: |1;ext.html;471.96696231263803;485.2842057964503;485.7134290768446;492.3328889354924;509.99021936565623;25999.87000065002;27099.5935060974;33058.66941330589;33954;34250.8287458563;35741;35830.283394332095;35878;36353.636463635354;36385.81807090968;6951.826204344881;7756.069271687391;7849.489783164105;7870.134285228621;7975.680972761083;7133.072700548922;8998.460092394478;9176.908230917672;9187.402818816789;9319.06809319066;9254.6298148074;9294.070592940685;9327.906720932806;9410.90589094107;9420.764480887998;7061.187963384225;7254.129504459499;9240.491772952484;9277.118673725985;9329.673461428885;9130.680426185052;9192.63229470827;9254.86117708235;9332.813343733087;9342.813143737087;32449;32768.50847237293;32804.6719532804;33207.16982075443;33288.6671133288;2427.6115821468657;2440.804735621146;2666.320088377451;2795.1474800185933;2983.820970741741;23497.7650223499;23773.286801395985;24018.159364422336;24243.151489697953;24529;2002.0890494824966;2093.3301343570065;2102.4848912016655;2124.182189856916;2227.643577027668;232251;235504;237836;238562;239325;46622.76688616603;47689.04621907612;48235;51985;52143.47856521386;58310.708446457495;58849.70575147097;59455;59511.70244148838;60305;13891.79162312566;14299.64250893736;14336.641583960276;14507.637309067357;14526.24001439723;10947.890521094847;10963.177761667906;11005.944970275097;11041.171912106463;11103.44482775858;16821.41125060617;17000.149992500326;17001.914990424968;17020.95748510162;17030.233639486254;7426.2945020223;7645.082590089225;7694.192109828499;7707.922920770833;7742.341900938483;784.1061190243128;818.4066551749934;828.9253967142986;898.0929261445856;942.3689889331026;23721.88139059294;24045;24089.397765056015;24371.268861933815;24454.51090978206;896.1173244354305;905.9501727404925;940.4827344960245;948.5020364308655;986.063239922077;12384.690382740504;12513.249205047727;12750.553730619384;13210.867891320964;13839.723205536035;331221;333149.67676777527;334635;335590;339603;48326.27510587344;48431.5156848427;48683.51316486861;48868.02263954701;49211.75394123006;1153.140910022039;1160.802663547199;1176.2707121584672;1176.6352430746497;1178.3872386359217;24661.71126362838;25132;25158.49683006366;25283.367915802253;25469;35359.82320088383;36098.45852312165;39535;41332;41381.58618413898;214146;216763;218898;218978;220008;22375;22565.09739610397;26113.086041988438;26440.8677956609;26885.327866802705;26312.8684356577;32609.673903261613;32831.343373131924;33126.503102453;33668.48491817825;27578.862105689343;28425;28528.286792830346;28579.571306430837;28598.571021435113;28175.295617609725;28289.858550707115;28398.290042749097;28504;28532.714672853836;27992.30019249535;28024.719752803026;28485.572716409686;28966.13101606955;29095.563566546094;24732.876335618206;25547.23358299254;25740;25786.87106564455;25804.612930805677;19580.510487237934;19640.214391424182;19717.60564788725;19822.90088549548;19870 18:33:45 INFO - 2015-10-30 18:33:45,008 DEBUG : BROWSER_OUTPUT: |2;jquery.html;290.9810862293951;291.8176139912555;292.16732312908226;295.57437290301965;303.31602236955666;12225.327606981635;12556.623301300953;14680.632984175387;14880.181590012546;15223.619409514753;12642.241465512076;14476.927615361908;15013.474528391509;15339.84660153401;15388.769168462482;4570.56579624936;4666.463356713987;4710.246360582308;4745.881352966187;4811.951880481185;3287.424700677384;3452.0679416557514;3467.1852114753137;4693.319468677039;4727.881802954937;4971.4034315882145;5153.330067091273;5167.689938603677;5169.663971841837;5209.32278803755;4996.900061998776;5025.12060389434;5115.744212789365;5137.871553211162;5192.818251361203;4486.484054333728;4490.7530085845265;4499.730016199006;4529.139463501924;4541.545845415432;17873.7318940216;17924;18362.540936476562;18370.540736481562;18501.352452664225;1655.7764701765227;1739.1304347826087;1921.7405650237179;2041.0917141871873;2146.8819214943173;11326.15053870963;11408.486618102206;11746.353950532717;11914.582989595408;12008.63974080779;1493.8282097558701;1525.8169019717704;1540.5224380441987;1557.7118233126907;1604.6389562348495;50530.242046369334;50747.23879141816;51811.74094129543;52168.73915630398;53411.732941335045;14280.357383917748;14320.427182912566;14329.211893345966;14382.28088595566;14402.063865848895;20404.285849995475;21600.13599456004;21727.456813579473;21728.456788580414;21753.45616359572;8763.737087887373;8771.16673915977;8838.248748856291;8869.467831929976;8958.820823583492;7540.981967434436;7559.962200188964;7617.27635874591;7684.577348245788;7708.190639982833;6997.580145191305;7097.645117744092;7111.679974401164;7148.857022859514;7165.390941769903;2410.8071354291615;2847.6440444944383;2851.5580085086845;2855.6858745537975;2873.3534954635456;359.8920323902871;364.86864728697645;365.6617628693448;391.3132452545764;412.91535235276694;10061.899381006097;10107.949460252652;10348.689539313833;10426.161748775672;10612.257141999986;394.49701630420867;399.2215180398235;400.4833764443835;410.91781643671385;413.2190160596475;5339.359276886798;5427.0773968425465;5442.482964118402;5528.917066244009;5543.1408131739645;282171;288473;307779;470195;493149;59609.403905961255;61839.6908015457;63084;63419.6829015852;63428.68285658542;424.34650638017723;435.3926272849421;435.5165765999738;436.2627160099422;436.50892745661133;7922.4850384724805;9322.207612353026;9371.484568348806;9429.292803039936;9592.36929721935;28385.574216387184;28914.421711566072;29230.26924326909;29864.850675746482;30037.5494367589;38069.619303806605;38532.605435238525;38884.2223155541;39000;39040.2191956165;5340.465953404629;5355.4644535547695;5367.248585197997;5375.354957405137;5422.13245880673;10055.69832905014;10291.691249262534;10342.069213770797;10438.58245670195;10452.216083793593;8617.65529378843;8627.6980305689;8916.420432672116;8923.286137109146;9027.729168124966;8348.666053357798;8546;8549.957250213709;8601.053884072622;8847;8787.956060219914;8912.955435222782;9062.139096785795;9070.18368346852;9081.409708368936;5268.920966185434;5382.461753824743;5389.218563308376;5400.918986215132;5405.567554595545;8607.225349718556;8692.095510297744;8810.559472026245;8832.205101540892;8922.643094276156 18:33:45 INFO - 2015-10-30 18:33:45,009 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1074.5970261152067;1217.5860207529438;1333.9461825158126;1448.8406275309717;1567.1850637668413;6229.813105606833;6441.259255185655;6703.899441508369;6801.761938332159;6815.38661520463;6780.96609516953;6887.655617219131;6951.582905025702;6955.2001519825235;7011.053507776449;1672.5902153972295;1701.174930158872;1934.796846331136;1937.4962509747427;1965.8722183058128;1767.7436771668101;1872.6254749050245;1934.8065193480609;1935.5741736817947;1939.6702560564738;1850.4263678259783;1865.9923641233718;1870.7474490943684;1879.6522643310964;1881.2192939929912;1902.296150424338;1924.9326273580427;1929.4790406590141;1933.3619905431315;1934.35199208264;1876.408931186672;1880.887146771198;1881.708335208045;1882.2941396976134;1945.8540609454205;6835.282295358966;6909.689063992132;6923.965380173117;6949.617771022592;6950.478714096463;4035.717499775017;4099.118689481776;4105.794710264475;4106.281400754856;4142.46148000761;2544.0714139339193;2598.9870050649624;2641.973580264192;2644.1803041057333;2646.259047466712;652.7519542573791;787.4291138924291;796.4026979765176;799.908010578785;811.5617566514076;8974.326925480615;8999.550022498914;8999.999999999935;9001.594928228245;9109.134632209929;3716.219593885314;3807.0292075520565;3858.6334298241622;3863.5363756349416;3904;8019.599020048974;8020.639071241808;8033.076196237391;8121.634526446324;8122.7157049502985;4188.32986722123;4244.363345498138;4245.490541135084;4247.702660813713;4259.339802330582;3875.9806200968815;3884.514435695538;3885.2229554089295;3889.6110388961442;3917.4711413958753;3127.2807254331633;3191.5531825544444;3211.550382946389;3223.854926528312;3225.306559089807;956.4309236004566;994.1152374386802;999.1656966432964;999.3404353126901;1003.9698809035741;1109.3011402816335;1131.4173200801595;1137.2721458266717;1137.38581166171;1177.5289884046279;6507.7071531781185;6553.508486863504;6594.439472644879;6596.208454985433;6607.834804129839;394.7611694924587;401.7388697346748;402.0692097793598;405.14514374669426;406.5710675237594;5063.49365063498;5119.206522988943;5129.435762066169;5131.1277082895995;5149.871253218699;7647.808804779814;7886.684532618631;7938.603069846485;8118.918810811934;8133.674653013932;7688;7710.34462070719;7720.3051725344985;7804.024496937883;7804.063512378438;6497.285298617148;6515.12045873801;6528.151340325822;6541.247756507967;6551.639659818756;6342.302346741762;6441.194850643669;6447.451966582893;6454.774082907075;6480.351964803482;7328.853422931618;7340.302671246223;7369.410447164321;7385.889211661937;7407.370373518312;7364.742234021784;7489.363404110493;7491.10106787189;7542.132654744774;7626;6098.786542470993;6198.566100372931;6207.410296021871;6207.441330280116;6217.658028808459;6346.079818426395;6631.767888123893;6685.331466853276;6700.731970721116;6783.796486105425;6047.727852246571;6180.196574445294;6193;6257.124002639725;6278.529110316653;6051.304100028553;6066.7269972850445;6100.6339619621185;6145.539084568586;6149.2620885494025;6224;6258.530610204162;6261.592996455216;6264.749410023548;6266.310705822447;5463.4536546346635;5664.291963504562;5672.376038635664;5675.687837168995;5677.971610141923;5744.712764361849;5767.68277744728;5768.798092066758;5769.91345129815;5775.826725198251 18:33:45 INFO - 2015-10-30 18:33:45,013 DEBUG : BROWSER_OUTPUT: |4;prototype.html;265.30490115896356;266.9452762183751;268.5220307852024;271.51263482049717;275.05244432928566;5120.948790512094;5209.088409528336;5278.5513231375335;5287.735613219338;5313.601479889009;5061.620378471611;5078.822241221558;5205.765740541675;5216.9478305217035;5218.634695571312;3896.9088655176456;4026.7583944963394;4031.6169963853386;4060.593940605945;4105.794710264489;3954.6440820326166;4033.455483509718;4061.776602286873;4072.9185416291657;4107.445494858186;3982.1040265940223;3995.3008223560905;3999.9600004000026;4047.392891066334;4069.572694867041;3998.4602078719436;4015.7188996770237;4024.7786371749544;4042.8584999524874;4044.413560033793;3468.063622821849;3478.1826270826336;3488.1977145256733;3507.5440192774777;3518.2435776308216;4959.70241785494;4993.550580447777;5091.363579552556;5111.437741848394;5175.171972484422;4470.82116715331;4471.8434854779925;4477.574630410106;4494.70784399013;4542.295944128666;5214;5399.865003374908;5440.183972404131;5491.176323551459;5493.2034854946205;3650.3976843820737;3685.2261025184744;3699.963000370016;3723.6462536059303;3763.397856342972;5577;5589.55283577321;5589.944100559023;5595.160725891108;5661.5187709044785;3793.260314238752;3796.620337966181;3805.7145714071557;3822.885313440546;3832.562788954142;3834.2331533692814;3836.6547010769164;3849.634284742945;3862.517185351831;3876.1666241758157;4341.848035318749;4472.105578884236;4483.19302525542;4505.234110201273;4528.162289976365;5437.972810135924;5470.617056805985;5473.425290344457;5523.751431185607;5535.723213839292;1391.5407915387898;1402.5722154742698;1404.5505438259863;1407.0924253856206;1407.429990853706;862.7325529086004;884.5135175653494;893.7363477774072;895.0735988252128;920.8664743612138;5178.223266510054;5181.1969144782615;5187.170052791535;5207.427183009866;5236.423993360727;5661.631993920382;5667.631603945731;5706.942930570641;5724.427557244242;5731.0543760279925;5179.04187725272;5195.220716892496;5242.947570524246;5246.554042906396;5255.421903590602;3029.1972627253353;3103.596532450812;3137.748980081588;3153.731932785693;3178.570892929425;5751.166080918327;5761.740721667535;5797.623154494944;5804.042333015005;5806.82579522615;5711.7144142792695;5800.738966746507;5825.563082768809;5867.882642347215;5869.266341707286;5594.944050559605;5754.884902302014;5756.33802112754;5771.105478650816;5794.391588883191;5639.069553523623;5677.432256774289;5693.4875861172695;5696.914546281892;5784.681842498703;5376.156048425395;5481.095619222783;5547.362053363915;5560.916586251128;5607.411221821813;5720.170575266647;5720.971395142998;5743.56923230751;5744.425557444222;5751.626144300607;3822.369309063973;3834.8082595869537;3866.052817059726;3877.5346958365176;3881.7670939742575;5483.122700367922;5646.3788983212635;5659.886802264014;5716.771329146787;5749.310082790092;5592.2170896075395;5612.298462692163;5648.604597678287;5650.0959846424375;5662.518685911579;5541.889162216814;5556;5574.275344205227;5624;5631.549476041825;5446.019716450918;5473.480019398151;5503.752331145028;5512.173174023928;5520;5444.972775136099;5559.916601251065;5570.053090974463;5639.069553523623;5646.520045796154;5430;5450.482204190595;5466.753996070266;5495.450454954473;5502.367227768857 18:33:45 INFO - 2015-10-30 18:33:45,013 DEBUG : BROWSER_OUTPUT: |5;yui.html;570.4466667332689;610.841181292864;658.2002866517181;664.3024823934869;675.0448115915979;10762.838557421645;10995.34027958321;11540.307581545114;11966.880331196697;12053.939730301347;9853;11975.10186735994;12139.57511487098;12179.695507612314;12236.082293827954;580.0545111468322;737.0676094740159;749.9437542184359;750.081150590525;758.8899609556611;602.6835911146661;744.8957145999537;754.5736658787768;754.8452567223706;755.0335570469807;765.1659690936877;786.6499407763547;786.8937693411402;787.0869791042392;787.2993036197788;775.0776575874692;775.9068911730571;775.9107702614215;776.0919723923024;776.3866545429104;560.349994006954;560.5375565158761;568.5139205978911;568.5451638689074;572.1817800545218;11662.76674466506;11692.47383867728;11707.53169873204;11854.40727963607;11858.940705296418;8241.95879020607;8340.207680270365;8529.445586036949;8660.783480412978;8795.604197811113;7440.73957411488;7466.141393739736;7559.017327747358;7586.165521792598;7969.123396426388;2466.925992220218;2486.8010559155223;2520.8361456505268;2586.4956333514974;2614.0850702254247;40774.184516309506;40855.7957210215;41191.38212926809;41333.586664133276;41562.58437415618;5676.318841739017;5753.108268218432;5798.82603521895;5823.388544202882;5932.881342373128;10247.84628230577;10273.794524109477;10283.177345812317;10401.791964160675;10456.63401780934;5415.702136382458;5422.05114105038;5440.347158341025;5520.199571062173;5530.267069727917;3084.4602194615854;3168.2712976015646;3246.7240284575605;3351.5307856900054;3431.3137372525593;2355.6937598112136;2388.8924998375114;2405.891734871935;2406.9037238510264;2417.782399584046;353.6993555477823;371.8995871114784;371.92933342664804;372.8005517048366;407.5109868158222;425.8722383285002;491.5453205784635;495.07174048658766;509.5388673250714;511.2229411294811;6335.619862808247;6621.768238111643;6634.933650663432;6636.32972771354;7080.327368899946;395.6676391830876;420.81273833143956;421.65635007468813;494.2067980890691;525.4587774592176;3235.7573182010974;3236.757243206769;3347.7991320520846;3352.094934367707;3365.512000759876;46017;46275;46422.5357746425;46581.5341846584;51501.48498515042;40637.123545174174;40869.79565102215;41308.1738365231;42696.35955460671;45136.3229551557;40405.79797100995;40608.79695601562;41356.79321603373;41431.1713765729;41449.58550414517;6747.865042699021;7020.7542736004;7190.568565886064;7211;7394;28198.295042624097;28227;28744.712552874204;28847.85576072106;28864.855675722327;34841.651583484854;35037.82481087578;37227.813860930524;37752.622473776006;37854.810725947296;9024.86462703073;9115.589798458952;9169.128932751379;9487.715368538955;9720.708378748648;9308.767280818034;9469.810603788024;9547.809043818947;9565.713028609152;9585.281103917374;8838.55807209624;8987;8987.955060224656;9175.587098580447;9748;8976.685815996409;8981.506017169118;8988.730338089868;9579.952100239454;9586.856197156909;6256;8404;9216;9406.200472959601;9704.70885873425;7182.174049984319;7353.926460735324;7373.668184931798;8186.2292739560535;8294.626741796754;6871.9656401717675;7119.394851437686;7246.311600397954;7256.346928776436;8292.04641466239 18:33:45 INFO - 2015-10-30 18:33:45,013 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:33:45 INFO - 2015-10-30 18:33:45,014 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:33:45 INFO - 2015-10-30 18:33:45,014 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 18:33:45 INFO - 2015-10-30 18:33:45,014 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:33:45 INFO - 2015-10-30 18:33:45,014 DEBUG : BROWSER_OUTPUT: __startTimestamp1446255225000__endTimestamp 18:33:45 INFO - 2015-10-30 18:33:45,014 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,015 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:33:45 INFO - 2015-10-30 18:33:45,015 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:33:45 INFO - 2015-10-30 18:33:45,015 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,015 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4685.02 Median:4822.30 stddev:485.50 (10.1%) stddev-sans-first:462.52 18:33:45 INFO - 2015-10-30 18:33:45,017 DEBUG : BROWSER_OUTPUT: Values: 2745.3 2810.3 2841.6 2846.9 2848.5 4527.3 4600.0 4686.2 4738.9 4776.4 4552.7 4605.4 4658.8 4714.4 4753.2 4357.6 4479.1 4499.9 4517.5 4520.4 4554.1 4574.0 4578.0 4579.8 4627.9 4227.4 4335.2 4368.8 4499.4 4511.6 4296.3 4405.2 4417.4 4422.6 4453.6 4388.8 4402.7 4455.5 4464.8 4526.3 4701.9 4714.4 4753.2 4769.1 4773.1 4802.1 4858.5 4917.5 4984.4 5013.5 5065.2 5082.1 5087.0 5092.4 5121.6 4690.3 4722.6 4726.4 4769.5 4802.6 4979.4 5046.0 5088.3 5157.3 5219.8 4702.0 4830.7 4886.3 4942.3 4995.7 4994.2 4998.6 5015.7 5067.5 5085.5 4791.1 4848.0 4869.0 4913.8 4923.7 4904.9 4931.7 4938.1 4979.4 4984.8 3862.5 3865.4 3871.7 3895.9 3905.0 3439.5 3442.6 3542.1 3570.2 3570.3 4634.9 4724.4 4724.6 4737.6 4758.5 5076.4 5112.3 5121.5 5123.5 5226.8 4476.3 4592.5 4596.1 4610.3 4693.2 4349.1 4369.4 4378.4 4387.9 4427.9 4970.6 5031.1 5032.1 5079.8 5155.7 4874.6 4921.2 4944.2 4972.4 5056.5 5105.4 5119.8 5123.8 5136.0 5181.8 4961.8 4966.6 5019.4 5027.8 5041.2 4822.3 4939.5 5089.5 5134.4 5146.5 4879.7 4884.6 4935.7 4936.8 4946.3 4871.7 4872.7 4879.4 4926.2 4956.8 4625.8 4753.4 4762.3 4807.1 4888.4 4947.2 4989.6 4997.3 4999.1 5010.9 4864.3 4870.1 4883.5 4889.4 4998.3 18:33:45 INFO - 2015-10-30 18:33:45,017 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,017 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40558.49 Median:29030.85 stddev:70447.25 (242.7%) stddev-sans-first:70580.57 18:33:45 INFO - 2015-10-30 18:33:45,018 DEBUG : BROWSER_OUTPUT: Values: 472.0 485.3 485.7 492.3 510.0 25999.9 27099.6 33058.7 33954.0 34250.8 35741.0 35830.3 35878.0 36353.6 36385.8 6951.8 7756.1 7849.5 7870.1 7975.7 7133.1 8998.5 9176.9 9187.4 9319.1 9254.6 9294.1 9327.9 9410.9 9420.8 7061.2 7254.1 9240.5 9277.1 9329.7 9130.7 9192.6 9254.9 9332.8 9342.8 32449.0 32768.5 32804.7 33207.2 33288.7 2427.6 2440.8 2666.3 2795.1 2983.8 23497.8 23773.3 24018.2 24243.2 24529.0 2002.1 2093.3 2102.5 2124.2 2227.6 232251.0 235504.0 237836.0 238562.0 239325.0 46622.8 47689.0 48235.0 51985.0 52143.5 58310.7 58849.7 59455.0 59511.7 60305.0 13891.8 14299.6 14336.6 14507.6 14526.2 10947.9 10963.2 11005.9 11041.2 11103.4 16821.4 17000.1 17001.9 17021.0 17030.2 7426.3 7645.1 7694.2 7707.9 7742.3 784.1 818.4 828.9 898.1 942.4 23721.9 24045.0 24089.4 24371.3 24454.5 896.1 906.0 940.5 948.5 986.1 12384.7 12513.2 12750.6 13210.9 13839.7 331221.0 333149.7 334635.0 335590.0 339603.0 48326.3 48431.5 48683.5 48868.0 49211.8 1153.1 1160.8 1176.3 1176.6 1178.4 24661.7 25132.0 25158.5 25283.4 25469.0 35359.8 36098.5 39535.0 41332.0 41381.6 214146.0 216763.0 218898.0 218978.0 220008.0 22375.0 22565.1 26113.1 26440.9 26885.3 26312.9 32609.7 32831.3 33126.5 33668.5 27578.9 28425.0 28528.3 28579.6 28598.6 28175.3 28289.9 28398.3 28504.0 28532.7 27992.3 28024.7 28485.6 28966.1 29095.6 24732.9 25547.2 25740.0 25786.9 25804.6 19580.5 19640.2 19717.6 19822.9 19870.0 18:33:45 INFO - 2015-10-30 18:33:45,019 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,019 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21674.41 Median:2461.50 stddev:62292.83 (2530.7%) stddev-sans-first:62446.88 18:33:45 INFO - 2015-10-30 18:33:45,019 DEBUG : BROWSER_OUTPUT: Values: 291.0 291.8 292.2 295.6 303.3 12225.3 12556.6 14680.6 14880.2 15223.6 12642.2 14476.9 15013.5 15339.8 15388.8 4570.6 4666.5 4710.2 4745.9 4812.0 3287.4 3452.1 3467.2 4693.3 4727.9 4971.4 5153.3 5167.7 5169.7 5209.3 4996.9 5025.1 5115.7 5137.9 5192.8 4486.5 4490.8 4499.7 4529.1 4541.5 17873.7 17924.0 18362.5 18370.5 18501.4 1655.8 1739.1 1921.7 2041.1 2146.9 11326.2 11408.5 11746.4 11914.6 12008.6 1493.8 1525.8 1540.5 1557.7 1604.6 50530.2 50747.2 51811.7 52168.7 53411.7 14280.4 14320.4 14329.2 14382.3 14402.1 20404.3 21600.1 21727.5 21728.5 21753.5 8763.7 8771.2 8838.2 8869.5 8958.8 7541.0 7560.0 7617.3 7684.6 7708.2 6997.6 7097.6 7111.7 7148.9 7165.4 2410.8 2847.6 2851.6 2855.7 2873.4 359.9 364.9 365.7 391.3 412.9 10061.9 10107.9 10348.7 10426.2 10612.3 394.5 399.2 400.5 410.9 413.2 5339.4 5427.1 5442.5 5528.9 5543.1 282171.0 288473.0 307779.0 470195.0 493149.0 59609.4 61839.7 63084.0 63419.7 63428.7 424.3 435.4 435.5 436.3 436.5 7922.5 9322.2 9371.5 9429.3 9592.4 28385.6 28914.4 29230.3 29864.9 30037.5 38069.6 38532.6 38884.2 39000.0 39040.2 5340.5 5355.5 5367.2 5375.4 5422.1 10055.7 10291.7 10342.1 10438.6 10452.2 8617.7 8627.7 8916.4 8923.3 9027.7 8348.7 8546.0 8550.0 8601.1 8847.0 8788.0 8913.0 9062.1 9070.2 9081.4 5268.9 5382.5 5389.2 5400.9 5405.6 8607.2 8692.1 8810.6 8832.2 8922.6 18:33:45 INFO - 2015-10-30 18:33:45,019 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,020 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4761.02 Median:6123.09 stddev:2494.49 (40.7%) stddev-sans-first:2486.09 18:33:45 INFO - 2015-10-30 18:33:45,021 DEBUG : BROWSER_OUTPUT: Values: 1074.6 1217.6 1333.9 1448.8 1567.2 6229.8 6441.3 6703.9 6801.8 6815.4 6781.0 6887.7 6951.6 6955.2 7011.1 1672.6 1701.2 1934.8 1937.5 1965.9 1767.7 1872.6 1934.8 1935.6 1939.7 1850.4 1866.0 1870.7 1879.7 1881.2 1902.3 1924.9 1929.5 1933.4 1934.4 1876.4 1880.9 1881.7 1882.3 1945.9 6835.3 6909.7 6924.0 6949.6 6950.5 4035.7 4099.1 4105.8 4106.3 4142.5 2544.1 2599.0 2642.0 2644.2 2646.3 652.8 787.4 796.4 799.9 811.6 8974.3 8999.6 9000.0 9001.6 9109.1 3716.2 3807.0 3858.6 3863.5 3904.0 8019.6 8020.6 8033.1 8121.6 8122.7 4188.3 4244.4 4245.5 4247.7 4259.3 3876.0 3884.5 3885.2 3889.6 3917.5 3127.3 3191.6 3211.6 3223.9 3225.3 956.4 994.1 999.2 999.3 1004.0 1109.3 1131.4 1137.3 1137.4 1177.5 6507.7 6553.5 6594.4 6596.2 6607.8 394.8 401.7 402.1 405.1 406.6 5063.5 5119.2 5129.4 5131.1 5149.9 7647.8 7886.7 7938.6 8118.9 8133.7 7688.0 7710.3 7720.3 7804.0 7804.1 6497.3 6515.1 6528.2 6541.2 6551.6 6342.3 6441.2 6447.5 6454.8 6480.4 7328.9 7340.3 7369.4 7385.9 7407.4 7364.7 7489.4 7491.1 7542.1 7626.0 6098.8 6198.6 6207.4 6207.4 6217.7 6346.1 6631.8 6685.3 6700.7 6783.8 6047.7 6180.2 6193.0 6257.1 6278.5 6051.3 6066.7 6100.6 6145.5 6149.3 6224.0 6258.5 6261.6 6264.7 6266.3 5463.5 5664.3 5672.4 5675.7 5678.0 5744.7 5767.7 5768.8 5769.9 5775.8 18:33:45 INFO - 2015-10-30 18:33:45,021 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,022 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4589.98 Median:5244.75 stddev:1384.06 (26.4%) stddev-sans-first:1349.34 18:33:45 INFO - 2015-10-30 18:33:45,022 DEBUG : BROWSER_OUTPUT: Values: 265.3 266.9 268.5 271.5 275.1 5120.9 5209.1 5278.6 5287.7 5313.6 5061.6 5078.8 5205.8 5216.9 5218.6 3896.9 4026.8 4031.6 4060.6 4105.8 3954.6 4033.5 4061.8 4072.9 4107.4 3982.1 3995.3 4000.0 4047.4 4069.6 3998.5 4015.7 4024.8 4042.9 4044.4 3468.1 3478.2 3488.2 3507.5 3518.2 4959.7 4993.6 5091.4 5111.4 5175.2 4470.8 4471.8 4477.6 4494.7 4542.3 5214.0 5399.9 5440.2 5491.2 5493.2 3650.4 3685.2 3700.0 3723.6 3763.4 5577.0 5589.6 5589.9 5595.2 5661.5 3793.3 3796.6 3805.7 3822.9 3832.6 3834.2 3836.7 3849.6 3862.5 3876.2 4341.8 4472.1 4483.2 4505.2 4528.2 5438.0 5470.6 5473.4 5523.8 5535.7 1391.5 1402.6 1404.6 1407.1 1407.4 862.7 884.5 893.7 895.1 920.9 5178.2 5181.2 5187.2 5207.4 5236.4 5661.6 5667.6 5706.9 5724.4 5731.1 5179.0 5195.2 5242.9 5246.6 5255.4 3029.2 3103.6 3137.7 3153.7 3178.6 5751.2 5761.7 5797.6 5804.0 5806.8 5711.7 5800.7 5825.6 5867.9 5869.3 5594.9 5754.9 5756.3 5771.1 5794.4 5639.1 5677.4 5693.5 5696.9 5784.7 5376.2 5481.1 5547.4 5560.9 5607.4 5720.2 5721.0 5743.6 5744.4 5751.6 3822.4 3834.8 3866.1 3877.5 3881.8 5483.1 5646.4 5659.9 5716.8 5749.3 5592.2 5612.3 5648.6 5650.1 5662.5 5541.9 5556.0 5574.3 5624.0 5631.5 5446.0 5473.5 5503.8 5512.2 5520.0 5445.0 5559.9 5570.1 5639.1 5646.5 5430.0 5450.5 5466.8 5495.5 5502.4 18:33:45 INFO - 2015-10-30 18:33:45,022 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,023 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11138.72 Median:3118.43 stddev:13438.50 (430.9%) stddev-sans-first:13452.76 18:33:45 INFO - 2015-10-30 18:33:45,024 DEBUG : BROWSER_OUTPUT: Values: 570.4 610.8 658.2 664.3 675.0 10762.8 10995.3 11540.3 11966.9 12053.9 9853.0 11975.1 12139.6 12179.7 12236.1 580.1 737.1 749.9 750.1 758.9 602.7 744.9 754.6 754.8 755.0 765.2 786.6 786.9 787.1 787.3 775.1 775.9 775.9 776.1 776.4 560.3 560.5 568.5 568.5 572.2 11662.8 11692.5 11707.5 11854.4 11858.9 8242.0 8340.2 8529.4 8660.8 8795.6 7440.7 7466.1 7559.0 7586.2 7969.1 2466.9 2486.8 2520.8 2586.5 2614.1 40774.2 40855.8 41191.4 41333.6 41562.6 5676.3 5753.1 5798.8 5823.4 5932.9 10247.8 10273.8 10283.2 10401.8 10456.6 5415.7 5422.1 5440.3 5520.2 5530.3 3084.5 3168.3 3246.7 3351.5 3431.3 2355.7 2388.9 2405.9 2406.9 2417.8 353.7 371.9 371.9 372.8 407.5 425.9 491.5 495.1 509.5 511.2 6335.6 6621.8 6634.9 6636.3 7080.3 395.7 420.8 421.7 494.2 525.5 3235.8 3236.8 3347.8 3352.1 3365.5 46017.0 46275.0 46422.5 46581.5 51501.5 40637.1 40869.8 41308.2 42696.4 45136.3 40405.8 40608.8 41356.8 41431.2 41449.6 6747.9 7020.8 7190.6 7211.0 7394.0 28198.3 28227.0 28744.7 28847.9 28864.9 34841.7 35037.8 37227.8 37752.6 37854.8 9024.9 9115.6 9169.1 9487.7 9720.7 9308.8 9469.8 9547.8 9565.7 9585.3 8838.6 8987.0 8988.0 9175.6 9748.0 8976.7 8981.5 8988.7 9580.0 9586.9 6256.0 8404.0 9216.0 9406.2 9704.7 7182.2 7353.9 7373.7 8186.2 8294.6 6872.0 7119.4 7246.3 7256.3 8292.0 18:33:45 INFO - 2015-10-30 18:33:45,024 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:33:45 INFO - 2015-10-30 18:33:45,024 DEBUG : BROWSER_OUTPUT: 18:33:45 INFO - 2015-10-30 18:33:45,821 INFO : Browser exited with error code: 0 18:33:45 INFO - 2015-10-30 18:33:45,854 INFO : Completed test dromaeo_css (00:18:36) 18:33:45 INFO - 2015-10-30 18:33:45,855 INFO : Starting test kraken 18:33:45 INFO - 2015-10-30 18:33:45,855 DEBUG : operating with platform_type : mac_ 18:33:45 INFO - 2015-10-30 18:33:45,855 INFO : Initialising browser for kraken test... 18:33:45 INFO - 2015-10-30 18:33:45,871 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpry9Xq0/profile http://localhost:49269/getInfo.html 18:33:48 INFO - 2015-10-30 18:33:48,336 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:33:48 INFO - 2015-10-30 18:33:48,337 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:33:48 INFO - 2015-10-30 18:33:48,337 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:33:48 INFO - 2015-10-30 18:33:48,337 DEBUG : BROWSER_OUTPUT: __metrics 18:33:48 INFO - 2015-10-30 18:33:48,353 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:33:49 INFO - 2015-10-30 18:33:49,118 INFO : Browser initialized. 18:33:49 INFO - 2015-10-30 18:33:49,118 INFO : Running cycle 1/1 for kraken test... 18:33:49 INFO - 2015-10-30 18:33:49,119 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpry9Xq0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:34:01 INFO - 2015-10-30 18:34:01,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 220647424 18:34:01 INFO - 2015-10-30 18:34:01,153 DEBUG : BROWSER_OUTPUT: 18:34:04 INFO - 2015-10-30 18:34:04,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 18:34:04 INFO - 2015-10-30 18:34:04,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 278847488 18:34:04 INFO - 2015-10-30 18:34:04,621 DEBUG : BROWSER_OUTPUT: 18:34:07 INFO - 2015-10-30 18:34:07,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 18:34:08 INFO - 2015-10-30 18:34:08,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 290717696 18:34:08 INFO - 2015-10-30 18:34:08,210 DEBUG : BROWSER_OUTPUT: 18:34:11 INFO - 2015-10-30 18:34:11,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 18:34:12 INFO - 2015-10-30 18:34:12,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 276525056 18:34:12 INFO - 2015-10-30 18:34:12,122 DEBUG : BROWSER_OUTPUT: 18:34:14 INFO - 2015-10-30 18:34:14,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 18:34:14 INFO - 2015-10-30 18:34:14,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 277458944 18:34:14 INFO - 2015-10-30 18:34:14,992 DEBUG : BROWSER_OUTPUT: 18:34:17 INFO - 2015-10-30 18:34:17,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:34:18 INFO - 2015-10-30 18:34:18,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 277393408 18:34:18 INFO - 2015-10-30 18:34:18,006 DEBUG : BROWSER_OUTPUT: 18:34:21 INFO - 2015-10-30 18:34:21,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 18:34:22 INFO - 2015-10-30 18:34:22,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 278507520 18:34:22 INFO - 2015-10-30 18:34:22,039 DEBUG : BROWSER_OUTPUT: 18:34:25 INFO - 2015-10-30 18:34:25,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 18:34:26 INFO - 2015-10-30 18:34:26,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 273993728 18:34:26 INFO - 2015-10-30 18:34:26,159 DEBUG : BROWSER_OUTPUT: 18:34:29 INFO - 2015-10-30 18:34:29,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 18:34:29 INFO - 2015-10-30 18:34:29,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 275734528 18:34:29 INFO - 2015-10-30 18:34:29,990 DEBUG : BROWSER_OUTPUT: 18:34:31 INFO - 2015-10-30 18:34:31,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:34:32 INFO - 2015-10-30 18:34:32,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 311533568 18:34:32 INFO - 2015-10-30 18:34:32,256 DEBUG : BROWSER_OUTPUT: 18:34:34 INFO - 2015-10-30 18:34:34,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:34:34 INFO - 2015-10-30 18:34:34,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 312614912 18:34:34 INFO - 2015-10-30 18:34:34,885 DEBUG : BROWSER_OUTPUT: 18:34:37 INFO - 2015-10-30 18:34:37,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:34:37 INFO - 2015-10-30 18:34:37,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 319303680 18:34:37 INFO - 2015-10-30 18:34:37,798 DEBUG : BROWSER_OUTPUT: 18:34:40 INFO - 2015-10-30 18:34:40,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:34:41 INFO - 2015-10-30 18:34:41,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 319582208 18:34:41 INFO - 2015-10-30 18:34:41,340 DEBUG : BROWSER_OUTPUT: 18:34:44 INFO - 2015-10-30 18:34:44,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:34:44 INFO - 2015-10-30 18:34:44,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 320430080 18:34:44 INFO - 2015-10-30 18:34:44,895 DEBUG : BROWSER_OUTPUT: 18:34:46 INFO - 2015-10-30 18:34:46,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 18:34:47 INFO - 2015-10-30 18:34:47,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 379023360 18:34:47 INFO - 2015-10-30 18:34:47,098 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,098 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:34:47 INFO - 2015-10-30 18:34:47,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:34:47 INFO - 2015-10-30 18:34:47,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:34:47 INFO - 2015-10-30 18:34:47,098 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:34:47 INFO - 2015-10-30 18:34:47,098 DEBUG : BROWSER_OUTPUT: |0;ai-astar;123;126;117;125;128;127;120;130;119;124 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;181;157;182;203;149;173;169;153;200;150 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;188;189;187;186;187;189;190;189;188 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |3;audio-fft;87;96;105;99;85;86;85;95;98;78 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;114;112;158;103;111;108;150;104;102;154 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;143;142;141;135;135;148;137;136;135 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;148;154;149;148;147;147;147;148 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;118;124;119;118;120;118;123;121;117 18:34:47 INFO - 2015-10-30 18:34:47,099 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;68;64;67;67;68;68;77;68;67 18:34:47 INFO - 2015-10-30 18:34:47,100 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;79;78;82;78;79;80;79;79;78 18:34:47 INFO - 2015-10-30 18:34:47,100 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;99;99;99;104;105;102;100;100;100;100 18:34:47 INFO - 2015-10-30 18:34:47,100 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;151;152;150;158;152;158;162;153;162 18:34:47 INFO - 2015-10-30 18:34:47,100 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;179;181;181;185;187;169;181;179;182;169 18:34:47 INFO - 2015-10-30 18:34:47,100 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;83;83;85;84;84;88;87;86;83 18:34:47 INFO - 2015-10-30 18:34:47,101 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:34:47 INFO - 2015-10-30 18:34:47,101 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:34:47 INFO - 2015-10-30 18:34:47,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 18:34:47 INFO - 2015-10-30 18:34:47,101 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:34:47 INFO - 2015-10-30 18:34:47,101 DEBUG : BROWSER_OUTPUT: __startTimestamp1446255287095__endTimestamp 18:34:47 INFO - 2015-10-30 18:34:47,101 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,102 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:34:47 INFO - 2015-10-30 18:34:47,102 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:34:47 INFO - 2015-10-30 18:34:47,102 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,102 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:123.90 Median:125.50 stddev:4.18 (3.3%) stddev-sans-first:4.42 18:34:47 INFO - 2015-10-30 18:34:47,103 DEBUG : BROWSER_OUTPUT: Values: 123.0 126.0 117.0 125.0 128.0 127.0 120.0 130.0 119.0 124.0 18:34:47 INFO - 2015-10-30 18:34:47,103 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,104 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:171.70 Median:177.00 stddev:19.82 (11.2%) stddev-sans-first:20.73 18:34:47 INFO - 2015-10-30 18:34:47,104 DEBUG : BROWSER_OUTPUT: Values: 181.0 157.0 182.0 203.0 149.0 173.0 169.0 153.0 200.0 150.0 18:34:47 INFO - 2015-10-30 18:34:47,104 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,105 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:187.70 Median:188.50 stddev:1.77 (0.9%) stddev-sans-first:1.27 18:34:47 INFO - 2015-10-30 18:34:47,105 DEBUG : BROWSER_OUTPUT: Values: 184.0 188.0 189.0 187.0 186.0 187.0 189.0 190.0 189.0 188.0 18:34:47 INFO - 2015-10-30 18:34:47,105 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,105 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.40 Median:91.00 stddev:8.37 (9.2%) stddev-sans-first:8.72 18:34:47 INFO - 2015-10-30 18:34:47,105 DEBUG : BROWSER_OUTPUT: Values: 87.0 96.0 105.0 99.0 85.0 86.0 85.0 95.0 98.0 78.0 18:34:47 INFO - 2015-10-30 18:34:47,105 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,106 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.60 Median:113.00 stddev:22.78 (20.2%) stddev-sans-first:23.99 18:34:47 INFO - 2015-10-30 18:34:47,106 DEBUG : BROWSER_OUTPUT: Values: 114.0 112.0 158.0 103.0 111.0 108.0 150.0 104.0 102.0 154.0 18:34:47 INFO - 2015-10-30 18:34:47,106 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,106 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:139.40 Median:141.50 stddev:4.45 (3.1%) stddev-sans-first:4.62 18:34:47 INFO - 2015-10-30 18:34:47,106 DEBUG : BROWSER_OUTPUT: Values: 142.0 143.0 142.0 141.0 135.0 135.0 148.0 137.0 136.0 135.0 18:34:47 INFO - 2015-10-30 18:34:47,106 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,107 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:2.11 (1.4%) stddev-sans-first:2.19 18:34:47 INFO - 2015-10-30 18:34:47,107 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 154.0 149.0 148.0 147.0 147.0 147.0 148.0 18:34:47 INFO - 2015-10-30 18:34:47,107 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,107 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:119.60 Median:119.50 stddev:2.37 (2.0%) stddev-sans-first:2.44 18:34:47 INFO - 2015-10-30 18:34:47,107 DEBUG : BROWSER_OUTPUT: Values: 118.0 118.0 124.0 119.0 118.0 120.0 118.0 123.0 121.0 117.0 18:34:47 INFO - 2015-10-30 18:34:47,108 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,109 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.20 Median:68.00 stddev:3.33 (4.9%) stddev-sans-first:3.53 18:34:47 INFO - 2015-10-30 18:34:47,109 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 64.0 67.0 67.0 68.0 68.0 77.0 68.0 67.0 18:34:47 INFO - 2015-10-30 18:34:47,109 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,109 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:79.00 stddev:2.27 (2.9%) stddev-sans-first:1.27 18:34:47 INFO - 2015-10-30 18:34:47,109 DEBUG : BROWSER_OUTPUT: Values: 73.0 79.0 78.0 82.0 78.0 79.0 80.0 79.0 79.0 78.0 18:34:47 INFO - 2015-10-30 18:34:47,109 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,109 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:100.80 Median:104.50 stddev:2.15 (2.1%) stddev-sans-first:2.18 18:34:47 INFO - 2015-10-30 18:34:47,110 DEBUG : BROWSER_OUTPUT: Values: 99.0 99.0 99.0 104.0 105.0 102.0 100.0 100.0 100.0 100.0 18:34:47 INFO - 2015-10-30 18:34:47,110 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,110 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:155.50 stddev:5.92 (3.8%) stddev-sans-first:4.72 18:34:47 INFO - 2015-10-30 18:34:47,110 DEBUG : BROWSER_OUTPUT: Values: 143.0 151.0 152.0 150.0 158.0 152.0 158.0 162.0 153.0 162.0 18:34:47 INFO - 2015-10-30 18:34:47,110 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,111 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:181.00 stddev:5.96 (3.3%) stddev-sans-first:6.32 18:34:47 INFO - 2015-10-30 18:34:47,111 DEBUG : BROWSER_OUTPUT: Values: 179.0 181.0 181.0 185.0 187.0 169.0 181.0 179.0 182.0 169.0 18:34:47 INFO - 2015-10-30 18:34:47,111 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,111 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.30 Median:84.50 stddev:2.31 (2.7%) stddev-sans-first:1.86 18:34:47 INFO - 2015-10-30 18:34:47,111 DEBUG : BROWSER_OUTPUT: Values: 80.0 83.0 83.0 85.0 84.0 84.0 88.0 87.0 86.0 83.0 18:34:47 INFO - 2015-10-30 18:34:47,111 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:34:47 INFO - 2015-10-30 18:34:47,111 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-10-30 18:34:47,825 INFO : Browser exited with error code: 0 18:34:47 INFO - 2015-10-30 18:34:47,881 INFO : Completed test kraken (00:01:02) 18:34:47 INFO - 2015-10-30 18:34:47,882 INFO : Starting test v8_7 18:34:47 INFO - 2015-10-30 18:34:47,882 DEBUG : operating with platform_type : mac_ 18:34:47 INFO - 2015-10-30 18:34:47,882 INFO : Initialising browser for v8_7 test... 18:34:47 INFO - 2015-10-30 18:34:47,897 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpknUhRt/profile http://localhost:49269/getInfo.html 18:34:50 INFO - 2015-10-30 18:34:50,293 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:34:50 INFO - 2015-10-30 18:34:50,293 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:34:50 INFO - 2015-10-30 18:34:50,293 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:34:50 INFO - 2015-10-30 18:34:50,293 DEBUG : BROWSER_OUTPUT: __metrics 18:34:50 INFO - 2015-10-30 18:34:50,313 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:34:51 INFO - 2015-10-30 18:34:51,140 INFO : Browser initialized. 18:34:51 INFO - 2015-10-30 18:34:51,140 INFO : Running cycle 1/1 for v8_7 test... 18:34:51 INFO - 2015-10-30 18:34:51,141 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpknUhRt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:35:03 INFO - 2015-10-30 18:35:03,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 221581312 18:35:03 INFO - 2015-10-30 18:35:03,195 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 18:35:26 INFO - 2015-10-30 18:35:26,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 755834880 18:35:26 INFO - 2015-10-30 18:35:26,356 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,356 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:35:26 INFO - 2015-10-30 18:35:26,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:35:26 INFO - 2015-10-30 18:35:26,358 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:35:26 INFO - 2015-10-30 18:35:26,358 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:35:26 INFO - 2015-10-30 18:35:26,358 DEBUG : BROWSER_OUTPUT: |0;Richards;192.7153594141453 18:35:26 INFO - 2015-10-30 18:35:26,358 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;223.91401701746528 18:35:26 INFO - 2015-10-30 18:35:26,358 DEBUG : BROWSER_OUTPUT: |2;Encrypt;370.78235076010384 18:35:26 INFO - 2015-10-30 18:35:26,359 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6655.6291390728475 18:35:26 INFO - 2015-10-30 18:35:26,359 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2383.3333333333335 18:35:26 INFO - 2015-10-30 18:35:26,359 DEBUG : BROWSER_OUTPUT: |5;Earley;1055.9662090813094 18:35:26 INFO - 2015-10-30 18:35:26,359 DEBUG : BROWSER_OUTPUT: |6;Boyer;14608.695652173914 18:35:26 INFO - 2015-10-30 18:35:26,359 DEBUG : BROWSER_OUTPUT: |7;RegExp;34440.67796610169 18:35:26 INFO - 2015-10-30 18:35:26,359 DEBUG : BROWSER_OUTPUT: |8;Splay;722.543352601156 18:35:26 INFO - 2015-10-30 18:35:26,359 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6724.832214765101 18:35:26 INFO - 2015-10-30 18:35:26,360 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:35:26 INFO - 2015-10-30 18:35:26,360 DEBUG : BROWSER_OUTPUT: __startTimestamp1446255326356__endTimestamp 18:35:26 INFO - 2015-10-30 18:35:26,360 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,360 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:35:26 INFO - 2015-10-30 18:35:26,360 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:35:26 INFO - 2015-10-30 18:35:26,360 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,361 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:192.72 Median:192.72 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,361 DEBUG : BROWSER_OUTPUT: Values: 192.7 18:35:26 INFO - 2015-10-30 18:35:26,361 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,361 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:223.91 Median:223.91 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,361 DEBUG : BROWSER_OUTPUT: Values: 223.9 18:35:26 INFO - 2015-10-30 18:35:26,361 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,361 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:370.78 Median:370.78 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,362 DEBUG : BROWSER_OUTPUT: Values: 370.8 18:35:26 INFO - 2015-10-30 18:35:26,362 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,362 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6655.63 Median:6655.63 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,362 DEBUG : BROWSER_OUTPUT: Values: 6655.6 18:35:26 INFO - 2015-10-30 18:35:26,362 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,363 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2383.33 Median:2383.33 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,363 DEBUG : BROWSER_OUTPUT: Values: 2383.3 18:35:26 INFO - 2015-10-30 18:35:26,363 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,363 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,363 DEBUG : BROWSER_OUTPUT: Values: 1056.0 18:35:26 INFO - 2015-10-30 18:35:26,363 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,364 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14608.70 Median:14608.70 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,364 DEBUG : BROWSER_OUTPUT: Values: 14608.7 18:35:26 INFO - 2015-10-30 18:35:26,364 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,364 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34440.68 Median:34440.68 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,364 DEBUG : BROWSER_OUTPUT: Values: 34440.7 18:35:26 INFO - 2015-10-30 18:35:26,365 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,365 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:722.54 Median:722.54 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,365 DEBUG : BROWSER_OUTPUT: Values: 722.5 18:35:26 INFO - 2015-10-30 18:35:26,365 DEBUG : BROWSER_OUTPUT: 18:35:26 INFO - 2015-10-30 18:35:26,367 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6724.83 Median:6724.83 stddev:0.00 (0.0%) 18:35:26 INFO - 2015-10-30 18:35:26,367 DEBUG : BROWSER_OUTPUT: Values: 6724.8 18:35:26 INFO - 2015-10-30 18:35:26,367 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:35:26 INFO - 2015-10-30 18:35:26,367 DEBUG : BROWSER_OUTPUT: 18:35:27 INFO - 2015-10-30 18:35:27,126 INFO : Browser exited with error code: 0 18:35:27 INFO - 2015-10-30 18:35:27,149 INFO : Completed test v8_7 (00:00:39) 18:35:27 INFO - 2015-10-30 18:35:27,538 INFO : Completed test suite (00:20:18) 18:35:27 INFO - 2015-10-30 18:35:27,539 DEBUG : Working with test: dromaeo_css 18:35:27 INFO - 2015-10-30 18:35:27,539 DEBUG : Generating results file: dromaeo_css 18:35:27 INFO - 2015-10-30 18:35:27,540 DEBUG : Working with test: kraken 18:35:27 INFO - 2015-10-30 18:35:27,540 DEBUG : Generating results file: kraken 18:35:27 INFO - 2015-10-30 18:35:27,540 INFO : javascript benchmark 18:35:27 INFO - 2015-10-30 18:35:27,540 DEBUG : Working with test: v8_7 18:35:27 INFO - 2015-10-30 18:35:27,540 DEBUG : Generating results file: v8_7 18:35:27 INFO - 2015-10-30 18:35:27,540 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:35:27 INFO - 2015-10-30 18:35:27,678 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 18:35:27 INFO - 2015-10-30 18:35:27,678 DEBUG : process_Request line: dromaeo_css 5859.44 graph.html#tests=[[72,63,55]] 18:35:27 INFO - 2015-10-30 18:35:27,678 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:35:27 INFO - 2015-10-30 18:35:27,708 DEBUG : process_Request line: kraken 1768.80 graph.html#tests=[[232,63,55]] 18:35:27 INFO - 2015-10-30 18:35:27,708 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:35:27 INFO - 2015-10-30 18:35:27,741 DEBUG : process_Request line: v8_7 15783.69 graph.html#tests=[[230,63,55]] 18:35:27 INFO - 2015-10-30 18:35:27,742 INFO : javascript benchmark 18:35:27 INFO - 2015-10-30 18:35:27,744 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [290.9810862293951, 291.8176139912555, 292.16732312908226, 295.57437290301965, 303.31602236955666, 12225.327606981635, 12556.623301300953, 14680.632984175387, 14880.181590012546, 15223.619409514753, 12642.241465512076, 14476.927615361908, 15013.474528391509, 15339.84660153401, 15388.769168462482, 4570.56579624936, 4666.463356713987, 4710.246360582308, 4745.881352966187, 4811.951880481185, 3287.424700677384, 3452.0679416557514, 3467.1852114753137, 4693.319468677039, 4727.881802954937, 4971.4034315882145, 5153.330067091273, 5167.689938603677, 5169.663971841837, 5209.32278803755, 4996.900061998776, 5025.12060389434, 5115.744212789365, 5137.871553211162, 5192.818251361203, 4486.484054333728, 4490.7530085845265, 4499.730016199006, 4529.139463501924, 4541.545845415432, 17873.7318940216, 17924.0, 18362.540936476562, 18370.540736481562, 18501.352452664225, 1655.7764701765227, 1739.1304347826087, 1921.7405650237179, 2041.0917141871873, 2146.8819214943173, 11326.15053870963, 11408.486618102206, 11746.353950532717, 11914.582989595408, 12008.63974080779, 1493.8282097558701, 1525.8169019717704, 1540.5224380441987, 1557.7118233126907, 1604.6389562348495, 50530.242046369334, 50747.23879141816, 51811.74094129543, 52168.73915630398, 53411.732941335045, 14280.357383917748, 14320.427182912566, 14329.211893345966, 14382.28088595566, 14402.063865848895, 20404.285849995475, 21600.13599456004, 21727.456813579473, 21728.456788580414, 21753.45616359572, 8763.737087887373, 8771.16673915977, 8838.248748856291, 8869.467831929976, 8958.820823583492, 7540.981967434436, 7559.962200188964, 7617.27635874591, 7684.577348245788, 7708.190639982833, 6997.580145191305, 7097.645117744092, 7111.679974401164, 7148.857022859514, 7165.390941769903, 2410.8071354291615, 2847.6440444944383, 2851.5580085086845, 2855.6858745537975, 2873.3534954635456, 359.8920323902871, 364.86864728697645, 365.6617628693448, 391.3132452545764, 412.91535235276694, 10061.899381006097, 10107.949460252652, 10348.689539313833, 10426.161748775672, 10612.257141999986, 394.49701630420867, 399.2215180398235, 400.4833764443835, 410.91781643671385, 413.2190160596475, 5339.359276886798, 5427.0773968425465, 5442.482964118402, 5528.917066244009, 5543.1408131739645, 282171.0, 288473.0, 307779.0, 470195.0, 493149.0, 59609.403905961255, 61839.6908015457, 63084.0, 63419.6829015852, 63428.68285658542, 424.34650638017723, 435.3926272849421, 435.5165765999738, 436.2627160099422, 436.50892745661133, 7922.4850384724805, 9322.207612353026, 9371.484568348806, 9429.292803039936, 9592.36929721935, 28385.574216387184, 28914.421711566072, 29230.26924326909, 29864.850675746482, 30037.5494367589, 38069.619303806605, 38532.605435238525, 38884.2223155541, 39000.0, 39040.2191956165, 5340.465953404629, 5355.4644535547695, 5367.248585197997, 5375.354957405137, 5422.13245880673, 10055.69832905014, 10291.691249262534, 10342.069213770797, 10438.58245670195, 10452.216083793593, 8617.65529378843, 8627.6980305689, 8916.420432672116, 8923.286137109146, 9027.729168124966, 8348.666053357798, 8546.0, 8549.957250213709, 8601.053884072622, 8847.0, 8787.956060219914, 8912.955435222782, 9062.139096785795, 9070.18368346852, 9081.409708368936, 5268.920966185434, 5382.461753824743, 5389.218563308376, 5400.918986215132, 5405.567554595545, 8607.225349718556, 8692.095510297744, 8810.559472026245, 8832.205101540892, 8922.643094276156], "dojo.html": [2745.286225581349, 2810.2833777386763, 2841.5737639354093, 2846.886124555018, 2848.515752322105, 4527.275635898257, 4599.977000114995, 4686.179918514264, 4738.933739908523, 4776.402949631296, 4552.749598772066, 4605.401297831286, 4658.813647454098, 4714.4106986626675, 4753.1681955657705, 4357.607815296623, 4479.126570318789, 4499.910001799962, 4517.457905051382, 4520.412346394964, 4554.111948170108, 4574.0394517151435, 4577.954220457803, 4579.793909274091, 4627.884302892421, 4227.4292970448905, 4335.241332766753, 4368.847090351823, 4499.437570303696, 4511.593956543894, 4296.269634162169, 4405.185040767468, 4417.3815665806815, 4422.5577442255835, 4453.55464453552, 4388.846390376321, 4402.691811573191, 4455.509893911667, 4464.799084041226, 4526.34368016639, 4701.929471057937, 4714.363560919266, 4753.191957367256, 4769.070031343889, 4773.140834649762, 4802.087603355351, 4858.489858564871, 4917.50824917509, 4984.40187177541, 5013.548780609726, 5065.240213967897, 5082.059818933472, 5087.0, 5092.439831618519, 5121.641485096045, 4690.343351930733, 4722.574968252874, 4726.361941137937, 4769.475357710649, 4802.567768900781, 4979.3526841510375, 5046.0, 5088.338515992971, 5157.252198431282, 5219.765110570033, 4701.95298047022, 4830.66185367028, 4886.291487734258, 4942.308076869242, 4995.650304478651, 4994.200927851526, 4998.625103117208, 5015.749212539358, 5067.493250674903, 5085.480519609909, 4791.089692958327, 4847.975760121177, 4868.9756551217015, 4913.778879950411, 4923.679960802537, 4904.901901961941, 4931.728754918514, 4938.061768264019, 4979.377577802775, 4984.825531106394, 3862.497875276252, 3865.381538953754, 3871.690264778811, 3895.902602434962, 3905.0, 3439.466882633196, 3442.621311655716, 3542.1144713821545, 3570.232400034005, 3570.2680950405106, 4634.86095417138, 4724.43306803179, 4724.645651576146, 4737.597304229179, 4758.547937945889, 5076.44159142494, 5112.309838171799, 5121.4622464641425, 5123.487651234921, 5226.764795584208, 4476.306172543261, 4592.471865735416, 4596.149712303235, 4610.308453731967, 4693.20215563355, 4349.13017396522, 4369.388285640013, 4378.365137055109, 4387.934180987288, 4427.911441771146, 4970.552650261494, 5031.069252188357, 5032.094223039888, 5079.796808127633, 5155.690658560424, 4874.5856602189215, 4921.163402221559, 4944.208926571875, 4972.428170760264, 5056.469070747666, 5105.387353517602, 5119.769610367468, 5123.846284611468, 5136.0, 5181.844544663666, 4961.8015279389865, 4966.627502937222, 5019.447860735243, 5027.773750181177, 5041.168207245763, 4822.300766388784, 4939.456659767495, 5089.465606111453, 5134.383873935002, 5146.511081447256, 4879.731614761222, 4884.63365247615, 4935.728534930469, 4936.777844997056, 4946.307516947702, 4871.683340582851, 4872.6832755870755, 4879.365682461257, 4926.162552366035, 4956.77694503741, 4625.838095666635, 4753.358296629911, 4762.285657151455, 4807.086653535817, 4888.388951381077, 4947.208446648519, 4989.55094041538, 4997.325361076353, 4999.10016197088, 5010.874728131826, 4864.343313652612, 4870.09903167915, 4883.536064073907, 4889.437714662717, 4998.300237966615], "mootools.html": [1074.5970261152067, 1217.5860207529438, 1333.9461825158126, 1448.8406275309717, 1567.1850637668413, 6229.813105606833, 6441.259255185655, 6703.899441508369, 6801.761938332159, 6815.38661520463, 6780.96609516953, 6887.655617219131, 6951.582905025702, 6955.2001519825235, 7011.053507776449, 1672.5902153972295, 1701.174930158872, 1934.796846331136, 1937.4962509747427, 1965.8722183058128, 1767.7436771668101, 1872.6254749050245, 1934.8065193480609, 1935.5741736817947, 1939.6702560564738, 1850.4263678259783, 1865.9923641233718, 1870.7474490943684, 1879.6522643310964, 1881.2192939929912, 1902.296150424338, 1924.9326273580427, 1929.4790406590141, 1933.3619905431315, 1934.35199208264, 1876.408931186672, 1880.887146771198, 1881.708335208045, 1882.2941396976134, 1945.8540609454205, 6835.282295358966, 6909.689063992132, 6923.965380173117, 6949.617771022592, 6950.478714096463, 4035.717499775017, 4099.118689481776, 4105.794710264475, 4106.281400754856, 4142.46148000761, 2544.0714139339193, 2598.9870050649624, 2641.973580264192, 2644.1803041057333, 2646.259047466712, 652.7519542573791, 787.4291138924291, 796.4026979765176, 799.908010578785, 811.5617566514076, 8974.326925480615, 8999.550022498914, 8999.999999999935, 9001.594928228245, 9109.134632209929, 3716.219593885314, 3807.0292075520565, 3858.6334298241622, 3863.5363756349416, 3904.0, 8019.599020048974, 8020.639071241808, 8033.076196237391, 8121.634526446324, 8122.7157049502985, 4188.32986722123, 4244.363345498138, 4245.490541135084, 4247.702660813713, 4259.339802330582, 3875.9806200968815, 3884.514435695538, 3885.2229554089295, 3889.6110388961442, 3917.4711413958753, 3127.2807254331633, 3191.5531825544444, 3211.550382946389, 3223.854926528312, 3225.306559089807, 956.4309236004566, 994.1152374386802, 999.1656966432964, 999.3404353126901, 1003.9698809035741, 1109.3011402816335, 1131.4173200801595, 1137.2721458266717, 1137.38581166171, 1177.5289884046279, 6507.7071531781185, 6553.508486863504, 6594.439472644879, 6596.208454985433, 6607.834804129839, 394.7611694924587, 401.7388697346748, 402.0692097793598, 405.14514374669426, 406.5710675237594, 5063.49365063498, 5119.206522988943, 5129.435762066169, 5131.1277082895995, 5149.871253218699, 7647.808804779814, 7886.684532618631, 7938.603069846485, 8118.918810811934, 8133.674653013932, 7688.0, 7710.34462070719, 7720.3051725344985, 7804.024496937883, 7804.063512378438, 6497.285298617148, 6515.12045873801, 6528.151340325822, 6541.247756507967, 6551.639659818756, 6342.302346741762, 6441.194850643669, 6447.451966582893, 6454.774082907075, 6480.351964803482, 7328.853422931618, 7340.302671246223, 7369.410447164321, 7385.889211661937, 7407.370373518312, 7364.742234021784, 7489.363404110493, 7491.10106787189, 7542.132654744774, 7626.0, 6098.786542470993, 6198.566100372931, 6207.410296021871, 6207.441330280116, 6217.658028808459, 6346.079818426395, 6631.767888123893, 6685.331466853276, 6700.731970721116, 6783.796486105425, 6047.727852246571, 6180.196574445294, 6193.0, 6257.124002639725, 6278.529110316653, 6051.304100028553, 6066.7269972850445, 6100.6339619621185, 6145.539084568586, 6149.2620885494025, 6224.0, 6258.530610204162, 6261.592996455216, 6264.749410023548, 6266.310705822447, 5463.4536546346635, 5664.291963504562, 5672.376038635664, 5675.687837168995, 5677.971610141923, 5744.712764361849, 5767.68277744728, 5768.798092066758, 5769.91345129815, 5775.826725198251], "ext.html": [471.96696231263803, 485.2842057964503, 485.7134290768446, 492.3328889354924, 509.99021936565623, 25999.87000065002, 27099.5935060974, 33058.66941330589, 33954.0, 34250.8287458563, 35741.0, 35830.283394332095, 35878.0, 36353.636463635354, 36385.81807090968, 6951.826204344881, 7756.069271687391, 7849.489783164105, 7870.134285228621, 7975.680972761083, 7133.072700548922, 8998.460092394478, 9176.908230917672, 9187.402818816789, 9319.06809319066, 9254.6298148074, 9294.070592940685, 9327.906720932806, 9410.90589094107, 9420.764480887998, 7061.187963384225, 7254.129504459499, 9240.491772952484, 9277.118673725985, 9329.673461428885, 9130.680426185052, 9192.63229470827, 9254.86117708235, 9332.813343733087, 9342.813143737087, 32449.0, 32768.50847237293, 32804.6719532804, 33207.16982075443, 33288.6671133288, 2427.6115821468657, 2440.804735621146, 2666.320088377451, 2795.1474800185933, 2983.820970741741, 23497.7650223499, 23773.286801395985, 24018.159364422336, 24243.151489697953, 24529.0, 2002.0890494824966, 2093.3301343570065, 2102.4848912016655, 2124.182189856916, 2227.643577027668, 232251.0, 235504.0, 237836.0, 238562.0, 239325.0, 46622.76688616603, 47689.04621907612, 48235.0, 51985.0, 52143.47856521386, 58310.708446457495, 58849.70575147097, 59455.0, 59511.70244148838, 60305.0, 13891.79162312566, 14299.64250893736, 14336.641583960276, 14507.637309067357, 14526.24001439723, 10947.890521094847, 10963.177761667906, 11005.944970275097, 11041.171912106463, 11103.44482775858, 16821.41125060617, 17000.149992500326, 17001.914990424968, 17020.95748510162, 17030.233639486254, 7426.2945020223, 7645.082590089225, 7694.192109828499, 7707.922920770833, 7742.341900938483, 784.1061190243128, 818.4066551749934, 828.9253967142986, 898.0929261445856, 942.3689889331026, 23721.88139059294, 24045.0, 24089.397765056015, 24371.268861933815, 24454.51090978206, 896.1173244354305, 905.9501727404925, 940.4827344960245, 948.5020364308655, 986.063239922077, 12384.690382740504, 12513.249205047727, 12750.553730619384, 13210.867891320964, 13839.723205536035, 331221.0, 333149.67676777527, 334635.0, 335590.0, 339603.0, 48326.27510587344, 48431.5156848427, 48683.51316486861, 48868.02263954701, 49211.75394123006, 1153.140910022039, 1160.802663547199, 1176.2707121584672, 1176.6352430746497, 1178.3872386359217, 24661.71126362838, 25132.0, 25158.49683006366, 25283.367915802253, 25469.0, 35359.82320088383, 36098.45852312165, 39535.0, 41332.0, 41381.58618413898, 214146.0, 216763.0, 218898.0, 218978.0, 220008.0, 22375.0, 22565.09739610397, 26113.086041988438, 26440.8677956609, 26885.327866802705, 26312.8684356577, 32609.673903261613, 32831.343373131924, 33126.503102453, 33668.48491817825, 27578.862105689343, 28425.0, 28528.286792830346, 28579.571306430837, 28598.571021435113, 28175.295617609725, 28289.858550707115, 28398.290042749097, 28504.0, 28532.714672853836, 27992.30019249535, 28024.719752803026, 28485.572716409686, 28966.13101606955, 29095.563566546094, 24732.876335618206, 25547.23358299254, 25740.0, 25786.87106564455, 25804.612930805677, 19580.510487237934, 19640.214391424182, 19717.60564788725, 19822.90088549548, 19870.0], "prototype.html": [265.30490115896356, 266.9452762183751, 268.5220307852024, 271.51263482049717, 275.05244432928566, 5120.948790512094, 5209.088409528336, 5278.5513231375335, 5287.735613219338, 5313.601479889009, 5061.620378471611, 5078.822241221558, 5205.765740541675, 5216.9478305217035, 5218.634695571312, 3896.9088655176456, 4026.7583944963394, 4031.6169963853386, 4060.593940605945, 4105.794710264489, 3954.6440820326166, 4033.455483509718, 4061.776602286873, 4072.9185416291657, 4107.445494858186, 3982.1040265940223, 3995.3008223560905, 3999.9600004000026, 4047.392891066334, 4069.572694867041, 3998.4602078719436, 4015.7188996770237, 4024.7786371749544, 4042.8584999524874, 4044.413560033793, 3468.063622821849, 3478.1826270826336, 3488.1977145256733, 3507.5440192774777, 3518.2435776308216, 4959.70241785494, 4993.550580447777, 5091.363579552556, 5111.437741848394, 5175.171972484422, 4470.82116715331, 4471.8434854779925, 4477.574630410106, 4494.70784399013, 4542.295944128666, 5214.0, 5399.865003374908, 5440.183972404131, 5491.176323551459, 5493.2034854946205, 3650.3976843820737, 3685.2261025184744, 3699.963000370016, 3723.6462536059303, 3763.397856342972, 5577.0, 5589.55283577321, 5589.944100559023, 5595.160725891108, 5661.5187709044785, 3793.260314238752, 3796.620337966181, 3805.7145714071557, 3822.885313440546, 3832.562788954142, 3834.2331533692814, 3836.6547010769164, 3849.634284742945, 3862.517185351831, 3876.1666241758157, 4341.848035318749, 4472.105578884236, 4483.19302525542, 4505.234110201273, 4528.162289976365, 5437.972810135924, 5470.617056805985, 5473.425290344457, 5523.751431185607, 5535.723213839292, 1391.5407915387898, 1402.5722154742698, 1404.5505438259863, 1407.0924253856206, 1407.429990853706, 862.7325529086004, 884.5135175653494, 893.7363477774072, 895.0735988252128, 920.8664743612138, 5178.223266510054, 5181.1969144782615, 5187.170052791535, 5207.427183009866, 5236.423993360727, 5661.631993920382, 5667.631603945731, 5706.942930570641, 5724.427557244242, 5731.0543760279925, 5179.04187725272, 5195.220716892496, 5242.947570524246, 5246.554042906396, 5255.421903590602, 3029.1972627253353, 3103.596532450812, 3137.748980081588, 3153.731932785693, 3178.570892929425, 5751.166080918327, 5761.740721667535, 5797.623154494944, 5804.042333015005, 5806.82579522615, 5711.7144142792695, 5800.738966746507, 5825.563082768809, 5867.882642347215, 5869.266341707286, 5594.944050559605, 5754.884902302014, 5756.33802112754, 5771.105478650816, 5794.391588883191, 5639.069553523623, 5677.432256774289, 5693.4875861172695, 5696.914546281892, 5784.681842498703, 5376.156048425395, 5481.095619222783, 5547.362053363915, 5560.916586251128, 5607.411221821813, 5720.170575266647, 5720.971395142998, 5743.56923230751, 5744.425557444222, 5751.626144300607, 3822.369309063973, 3834.8082595869537, 3866.052817059726, 3877.5346958365176, 3881.7670939742575, 5483.122700367922, 5646.3788983212635, 5659.886802264014, 5716.771329146787, 5749.310082790092, 5592.2170896075395, 5612.298462692163, 5648.604597678287, 5650.0959846424375, 5662.518685911579, 5541.889162216814, 5556.0, 5574.275344205227, 5624.0, 5631.549476041825, 5446.019716450918, 5473.480019398151, 5503.752331145028, 5512.173174023928, 5520.0, 5444.972775136099, 5559.916601251065, 5570.053090974463, 5639.069553523623, 5646.520045796154, 5430.0, 5450.482204190595, 5466.753996070266, 5495.450454954473, 5502.367227768857], "yui.html": [570.4466667332689, 610.841181292864, 658.2002866517181, 664.3024823934869, 675.0448115915979, 10762.838557421645, 10995.34027958321, 11540.307581545114, 11966.880331196697, 12053.939730301347, 9853.0, 11975.10186735994, 12139.57511487098, 12179.695507612314, 12236.082293827954, 580.0545111468322, 737.0676094740159, 749.9437542184359, 750.081150590525, 758.8899609556611, 602.6835911146661, 744.8957145999537, 754.5736658787768, 754.8452567223706, 755.0335570469807, 765.1659690936877, 786.6499407763547, 786.8937693411402, 787.0869791042392, 787.2993036197788, 775.0776575874692, 775.9068911730571, 775.9107702614215, 776.0919723923024, 776.3866545429104, 560.349994006954, 560.5375565158761, 568.5139205978911, 568.5451638689074, 572.1817800545218, 11662.76674466506, 11692.47383867728, 11707.53169873204, 11854.40727963607, 11858.940705296418, 8241.95879020607, 8340.207680270365, 8529.445586036949, 8660.783480412978, 8795.604197811113, 7440.73957411488, 7466.141393739736, 7559.017327747358, 7586.165521792598, 7969.123396426388, 2466.925992220218, 2486.8010559155223, 2520.8361456505268, 2586.4956333514974, 2614.0850702254247, 40774.184516309506, 40855.7957210215, 41191.38212926809, 41333.586664133276, 41562.58437415618, 5676.318841739017, 5753.108268218432, 5798.82603521895, 5823.388544202882, 5932.881342373128, 10247.84628230577, 10273.794524109477, 10283.177345812317, 10401.791964160675, 10456.63401780934, 5415.702136382458, 5422.05114105038, 5440.347158341025, 5520.199571062173, 5530.267069727917, 3084.4602194615854, 3168.2712976015646, 3246.7240284575605, 3351.5307856900054, 3431.3137372525593, 2355.6937598112136, 2388.8924998375114, 2405.891734871935, 2406.9037238510264, 2417.782399584046, 353.6993555477823, 371.8995871114784, 371.92933342664804, 372.8005517048366, 407.5109868158222, 425.8722383285002, 491.5453205784635, 495.07174048658766, 509.5388673250714, 511.2229411294811, 6335.619862808247, 6621.768238111643, 6634.933650663432, 6636.32972771354, 7080.327368899946, 395.6676391830876, 420.81273833143956, 421.65635007468813, 494.2067980890691, 525.4587774592176, 3235.7573182010974, 3236.757243206769, 3347.7991320520846, 3352.094934367707, 3365.512000759876, 46017.0, 46275.0, 46422.5357746425, 46581.5341846584, 51501.48498515042, 40637.123545174174, 40869.79565102215, 41308.1738365231, 42696.35955460671, 45136.3229551557, 40405.79797100995, 40608.79695601562, 41356.79321603373, 41431.1713765729, 41449.58550414517, 6747.865042699021, 7020.7542736004, 7190.568565886064, 7211.0, 7394.0, 28198.295042624097, 28227.0, 28744.712552874204, 28847.85576072106, 28864.855675722327, 34841.651583484854, 35037.82481087578, 37227.813860930524, 37752.622473776006, 37854.810725947296, 9024.86462703073, 9115.589798458952, 9169.128932751379, 9487.715368538955, 9720.708378748648, 9308.767280818034, 9469.810603788024, 9547.809043818947, 9565.713028609152, 9585.281103917374, 8838.55807209624, 8987.0, 8987.955060224656, 9175.587098580447, 9748.0, 8976.685815996409, 8981.506017169118, 8988.730338089868, 9579.952100239454, 9586.856197156909, 6256.0, 8404.0, 9216.0, 9406.200472959601, 9704.70885873425, 7182.174049984319, 7353.926460735324, 7373.668184931798, 8186.2292739560535, 8294.626741796754, 6871.9656401717675, 7119.394851437686, 7246.311600397954, 7256.346928776436, 8292.04641466239]}, "summary": {"suite": 5859.44287850253, "subtests": {"jquery.html": {"filtered": 7004.912524073944, "value": 7004.912524073944}, "dojo.html": {"filtered": 4655.205779443366, "value": 4655.205779443366}, "mootools.html": {"filtered": 3811.2156994142047, "value": 3811.2156994142047}, "ext.html": {"filtered": 15839.098744265415, "value": 15839.098744265415}, "prototype.html": {"filtered": 4129.571823147375, "value": 4129.571823147375}, "yui.html": {"filtered": 4977.978137076314, "value": 4977.978137076314}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0023"}, "testrun": {"date": 1446254106, "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": "45.0a1", "id": "20151030165830", "branch": "Mozilla-Inbound", "revision": "cd4108f41872a9e1dc50ea3dcac84ab208d1f199"}}, {"talos_counters": {}, "results": {"audio-dft": [184.0, 188.0, 189.0, 187.0, 186.0, 187.0, 189.0, 190.0, 189.0, 188.0], "ai-astar": [123.0, 126.0, 117.0, 125.0, 128.0, 127.0, 120.0, 130.0, 119.0, 124.0], "imaging-gaussian-blur": [142.0, 143.0, 142.0, 141.0, 135.0, 135.0, 148.0, 137.0, 136.0, 135.0], "audio-beat-detection": [181.0, 157.0, 182.0, 203.0, 149.0, 173.0, 169.0, 153.0, 200.0, 150.0], "json-stringify-tinderbox": [73.0, 79.0, 78.0, 82.0, 78.0, 79.0, 80.0, 79.0, 79.0, 78.0], "stanford-crypto-pbkdf2": [179.0, 181.0, 181.0, 185.0, 187.0, 169.0, 181.0, 179.0, 182.0, 169.0], "json-parse-financial": [68.0, 68.0, 64.0, 67.0, 67.0, 68.0, 68.0, 77.0, 68.0, 67.0], "stanford-crypto-sha256-iterative": [80.0, 83.0, 83.0, 85.0, 84.0, 84.0, 88.0, 87.0, 86.0, 83.0], "audio-fft": [87.0, 96.0, 105.0, 99.0, 85.0, 86.0, 85.0, 95.0, 98.0, 78.0], "imaging-darkroom": [147.0, 148.0, 148.0, 154.0, 149.0, 148.0, 147.0, 147.0, 147.0, 148.0], "stanford-crypto-ccm": [143.0, 151.0, 152.0, 150.0, 158.0, 152.0, 158.0, 162.0, 153.0, 162.0], "audio-oscillator": [114.0, 112.0, 158.0, 103.0, 111.0, 108.0, 150.0, 104.0, 102.0, 154.0], "stanford-crypto-aes": [99.0, 99.0, 99.0, 104.0, 105.0, 102.0, 100.0, 100.0, 100.0, 100.0], "imaging-desaturate": [118.0, 118.0, 124.0, 119.0, 118.0, 120.0, 118.0, 123.0, 121.0, 117.0]}, "summary": {"suite": 1768.7999999999997, "subtests": {"audio-fft": {"filtered": 91.4, "value": 91.4}, "stanford-crypto-pbkdf2": {"filtered": 179.3, "value": 179.3}, "audio-beat-detection": {"filtered": 171.7, "value": 171.7}, "stanford-crypto-ccm": {"filtered": 154.1, "value": 154.1}, "imaging-darkroom": {"filtered": 148.3, "value": 148.3}, "json-parse-financial": {"filtered": 68.2, "value": 68.2}, "audio-oscillator": {"filtered": 121.6, "value": 121.6}, "ai-astar": {"filtered": 123.9, "value": 123.9}, "audio-dft": {"filtered": 187.7, "value": 187.7}, "stanford-crypto-sha256-iterative": {"filtered": 84.3, "value": 84.3}, "json-stringify-tinderbox": {"filtered": 78.5, "value": 78.5}, "imaging-gaussian-blur": {"filtered": 139.4, "value": 139.4}, "stanford-crypto-aes": {"filtered": 100.8, "value": 100.8}, "imaging-desaturate": {"filtered": 119.6, "value": 119.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0023"}, "testrun": {"date": 1446254106, "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": "45.0a1", "id": "20151030165830", "branch": "Mozilla-Inbound", "revision": "cd4108f41872a9e1dc50ea3dcac84ab208d1f199"}}, {"talos_counters": {}, "results": {"DeltaBlue": [223.91401701746528], "Encrypt": [370.78235076010384], "NavierStokes": [6724.832214765101], "Decrypt": [6655.6291390728475], "Splay": [722.543352601156], "Richards": [192.7153594141453], "RegExp": [34440.67796610169], "Earley": [1055.9662090813094], "Boyer": [14608.695652173914], "RayTrace": [2383.3333333333335]}, "summary": {"suite": 15783.687513356068, "subtests": {"DeltaBlue": {"filtered": 295.2829880000001, "value": 295.2829880000001}, "Encrypt": {"filtered": 717.8901570000002, "value": 717.8901570000002}, "NavierStokes": {"filtered": 220.67465069860268, "value": 220.67465069860268}, "Decrypt": {"filtered": 39.99336417910451, "value": 39.99336417910451}, "Splay": {"filtered": 112.78354399999998, "value": 112.78354399999998}, "RegExp": {"filtered": 26.45084399606298, "value": 26.45084399606298}, "Richards": {"filtered": 183.182078, "value": 183.182078}, "Earley": {"filtered": 631.1404609999997, "value": 631.1404609999997}, "Boyer": {"filtered": 45.62097916666665, "value": 45.62097916666665}, "RayTrace": {"filtered": 310.484895104895, "value": 310.484895104895}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0023"}, "testrun": {"date": 1446254106, "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": "45.0a1", "id": "20151030165830", "branch": "Mozilla-Inbound", "revision": "cd4108f41872a9e1dc50ea3dcac84ab208d1f199"}}] 18:35:27 INFO - RETURN: dromaeo_css: 5859.44 18:35:27 INFO - RETURN: kraken: 1768.80 18:35:27 INFO - RETURN: v8_7: 15783.69 18:35:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15783.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1768.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5859.44"}}} 18:35:27 INFO - Return code: 0 18:35:27 INFO - # TBPL SUCCESS # 18:35:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:35:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:35:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:35:27 INFO - 2015-10-30 18:35:27.827 screenresolution[1656:9953] starting screenresolution argv=screenresolution get 18:35:27 INFO - 2015-10-30 18:35:27.830 screenresolution[1656:9953] Display 0: 1600x1200x32@60 18:35:27 INFO - 2015-10-30 18:35:27.837 screenresolution[1657:9956] starting screenresolution argv=screenresolution list 18:35:27 INFO - Available Modes on Display 0 18:35:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:35:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:35:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:35:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:35:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:35:28 INFO - Intel HD Graphics 3000: 18:35:28 INFO - Chipset Model: Intel HD Graphics 3000 18:35:28 INFO - Type: GPU 18:35:28 INFO - Bus: Built-In 18:35:28 INFO - VRAM (Total): 512 MB 18:35:28 INFO - VRAM (Dynamic, Max): 10 18:35:28 INFO - Vendor: Intel (0x8086) 18:35:28 INFO - Device ID: 0x0116 18:35:28 INFO - Revision ID: 0x0009 18:35:28 INFO - Displays: 18:35:28 INFO - Display: 18:35:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:35:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:35:28 INFO - Display Serial Number: 1600x1200 60 18:35:28 INFO - Main Display: Yes 18:35:28 INFO - Mirror: Off 18:35:28 INFO - Online: Yes 18:35:28 INFO - Rotation: Supported 18:35:28 INFO - Return code: 0 18:35:28 INFO - Running post-action listener: _resource_record_post_action 18:35:28 INFO - Running post-run listener: _resource_record_post_run 18:35:29 INFO - Total resource usage - Wall time: 1264s; CPU: 30.0%; Read bytes: 38470656; Write bytes: 685100032; Read time: 4691; Write time: 63023 18:35:29 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 336556544; Write bytes: 335175680; Read time: 36275; Write time: 6199 18:35:29 INFO - run-tests - Wall time: 1223s; CPU: 30.0%; Read bytes: 37352448; Write bytes: 339561472; Read time: 4156; Write time: 56078 18:35:29 INFO - Running post-run listener: _upload_blobber_files 18:35:29 INFO - Blob upload gear active. 18:35:29 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:35:29 INFO - Copying logs to upload dir... 18:35:29 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1323.400189 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-10-30 18:35:29.920972) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 18:35:29.927853) ========= 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.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010097 build_url: 'https://queue.taskcluster.net/v1/task/eeAd4Z7BQ0-NFrcI1IwrkQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.08 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 18:35:30.020520) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:35:30.020906) ========= 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.12LQhzuwY8/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.GZbC6NQGxt/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.005174 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:35:30.041448) ========= ========= Started reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-30 18:35:30.041805) ========= ========= Finished reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-30 18:35:31.941911) ========= ========= Total master_lag: 0.90 =========