builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0072 starttime: 1446815346.44 results: success (0) buildid: 20151106032135 builduid: 831987405d0347129ddfd0cb51e0d836 revision: b918dbd0c3a02030769ecc9bc71e5024c748ac90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:06.436095) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:06.436604) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:06.436930) ========= 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.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/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.006145 basedir: '/builds/slave/test' ========= master_lag: 0.59 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.035402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.035770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.281385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.284739) ========= 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.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/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.036491 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.342365) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.342685) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.343065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.343371) ========= 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.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-06 05:09:07-- 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, 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% 9.45M=0.001s 2015-11-06 05:09:07 (9.45 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164830 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.563074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.563417) ========= 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.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/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.147272 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.729132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:07.729504) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b918dbd0c3a02030769ecc9bc71e5024c748ac90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b918dbd0c3a02030769ecc9bc71e5024c748ac90 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-06 05:09:07,821 truncating revision to first 12 chars 2015-11-06 05:09:07,822 Setting DEBUG logging. 2015-11-06 05:09:07,822 attempt 1/10 2015-11-06 05:09:07,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b918dbd0c3a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-06 05:09:08,223 unpacking tar archive at: mozilla-central-b918dbd0c3a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668372 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:08.444009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:08.444479) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:08.460243) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:08.460975) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 05:09:08.461943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2015-11-06 05:09:08.462614) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:09:08 INFO - MultiFileLogger online at 20151106 05:09:08 in /builds/slave/test 05:09:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:09:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:08 INFO - {'append_to_log': False, 05:09:08 INFO - 'base_work_dir': '/builds/slave/test', 05:09:08 INFO - 'blob_upload_branch': 'Firefox', 05:09:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:08 INFO - 'branch': 'Firefox', 05:09:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:08 INFO - 'config_files': ('talos/mac_config.py',), 05:09:08 INFO - 'default_actions': ('clobber', 05:09:08 INFO - 'read-buildbot-config', 05:09:08 INFO - 'download-and-extract', 05:09:08 INFO - 'populate-webroot', 05:09:08 INFO - 'create-virtualenv', 05:09:08 INFO - 'install', 05:09:08 INFO - 'run-tests'), 05:09:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:08 INFO - 'download_minidump_stackwalk': True, 05:09:08 INFO - 'download_symbols': 'ondemand', 05:09:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:08 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:08 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:08 INFO - 'installer_path': 'installer.exe', 05:09:08 INFO - 'log_level': 'info', 05:09:08 INFO - 'log_name': 'talos', 05:09:08 INFO - 'log_to_console': True, 05:09:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:09:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:09:08 INFO - 'opt_config_files': (), 05:09:08 INFO - 'pip_index': False, 05:09:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:08 INFO - 'cmd': ('bash', 05:09:08 INFO - '-c', 05:09:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:08 INFO - 'enabled': True, 05:09:08 INFO - 'halt_on_failure': False, 05:09:08 INFO - 'name': 'check_screen_resolution'},), 05:09:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:08 INFO - 'cmd': ('bash', 05:09:08 INFO - '-c', 05:09:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:08 INFO - 'enabled': True, 05:09:08 INFO - 'halt_on_failure': False, 05:09:08 INFO - 'name': 'check_screen_resolution'},), 05:09:08 INFO - 'run_cmd_checks_enabled': True, 05:09:08 INFO - 'sps_profile': False, 05:09:08 INFO - 'sps_profile_interval': 0, 05:09:08 INFO - 'suite': 'dromaeojs', 05:09:08 INFO - 'system_bits': '64', 05:09:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:08 INFO - 'title': 't-yosemite-r5-0072', 05:09:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:08 INFO - 'use_talos_json': True, 05:09:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:08 INFO - 'work_dir': 'build'} 05:09:08 INFO - ##### 05:09:08 INFO - ##### Running clobber step. 05:09:08 INFO - ##### 05:09:08 INFO - Running pre-action listener: _resource_record_pre_action 05:09:08 INFO - Running main action method: clobber 05:09:08 INFO - rmtree: /builds/slave/test/build 05:09:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:12 INFO - Running post-action listener: _resource_record_post_action 05:09:12 INFO - ##### 05:09:12 INFO - ##### Running read-buildbot-config step. 05:09:12 INFO - ##### 05:09:12 INFO - Running pre-action listener: _resource_record_pre_action 05:09:12 INFO - Running main action method: read_buildbot_config 05:09:12 INFO - Using buildbot properties: 05:09:12 INFO - { 05:09:12 INFO - "properties": { 05:09:12 INFO - "buildnumber": 553, 05:09:12 INFO - "product": "firefox", 05:09:12 INFO - "script_repo_revision": "production", 05:09:12 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 05:09:12 INFO - "repository": "", 05:09:12 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 05:09:12 INFO - "buildid": "20151106032135", 05:09:12 INFO - "slavename": "t-yosemite-r5-0072", 05:09:12 INFO - "pgo_build": "False", 05:09:12 INFO - "basedir": "/builds/slave/test", 05:09:12 INFO - "project": "", 05:09:12 INFO - "platform": "yosemite", 05:09:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:09:12 INFO - "slavebuilddir": "test", 05:09:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:09:12 INFO - "branch": "mozilla-central", 05:09:12 INFO - "repo_path": "mozilla-central", 05:09:12 INFO - "stage_platform": "macosx64", 05:09:12 INFO - "builduid": "831987405d0347129ddfd0cb51e0d836", 05:09:12 INFO - "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90" 05:09:12 INFO - }, 05:09:12 INFO - "sourcestamp": { 05:09:12 INFO - "repository": "", 05:09:12 INFO - "hasPatch": false, 05:09:12 INFO - "project": "", 05:09:12 INFO - "branch": "mozilla-central-macosx64-talos", 05:09:12 INFO - "changes": [ 05:09:12 INFO - { 05:09:12 INFO - "category": null, 05:09:12 INFO - "files": [ 05:09:12 INFO - { 05:09:12 INFO - "url": null, 05:09:12 INFO - "name": "https://queue.taskcluster.net/v1/task/4zorGl6mSIi2ZHKtY5pufg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:09:12 INFO - } 05:09:12 INFO - ], 05:09:12 INFO - "repository": "", 05:09:12 INFO - "rev": "1a44749d8135fcee582049cf490e6a30bfab19d4", 05:09:12 INFO - "who": "cbook@mozilla.com", 05:09:12 INFO - "when": 1446814462, 05:09:12 INFO - "number": 6630087, 05:09:12 INFO - "comments": "Bumping manifests a=b2g-bump", 05:09:12 INFO - "project": "", 05:09:12 INFO - "at": "Fri 06 Nov 2015 04:54:22", 05:09:12 INFO - "branch": "mozilla-central-macosx64-talos", 05:09:12 INFO - "revlink": "", 05:09:12 INFO - "properties": [ 05:09:12 INFO - [ 05:09:12 INFO - "buildid", 05:09:12 INFO - "20151106031435", 05:09:12 INFO - "Change" 05:09:12 INFO - ], 05:09:12 INFO - [ 05:09:12 INFO - "builduid", 05:09:12 INFO - "cb031c4d8bac4213bb2575377aa5ac9b", 05:09:12 INFO - "Change" 05:09:12 INFO - ], 05:09:12 INFO - [ 05:09:12 INFO - "pgo_build", 05:09:12 INFO - "False", 05:09:12 INFO - "Change" 05:09:12 INFO - ] 05:09:12 INFO - ], 05:09:12 INFO - "revision": "1a44749d8135fcee582049cf490e6a30bfab19d4" 05:09:12 INFO - }, 05:09:12 INFO - { 05:09:12 INFO - "category": null, 05:09:12 INFO - "files": [ 05:09:12 INFO - { 05:09:12 INFO - "url": null, 05:09:12 INFO - "name": "https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:09:12 INFO - } 05:09:12 INFO - ], 05:09:12 INFO - "repository": "", 05:09:12 INFO - "rev": "b918dbd0c3a02030769ecc9bc71e5024c748ac90", 05:09:12 INFO - "who": "cbook@mozilla.com", 05:09:12 INFO - "when": 1446814777, 05:09:12 INFO - "number": 6630101, 05:09:12 INFO - "comments": "merge fx-team to mozilla-central a=merge", 05:09:12 INFO - "project": "", 05:09:12 INFO - "at": "Fri 06 Nov 2015 04:59:37", 05:09:12 INFO - "branch": "mozilla-central-macosx64-talos", 05:09:12 INFO - "revlink": "", 05:09:12 INFO - "properties": [ 05:09:12 INFO - [ 05:09:12 INFO - "buildid", 05:09:12 INFO - "20151106032135", 05:09:12 INFO - "Change" 05:09:12 INFO - ], 05:09:12 INFO - [ 05:09:12 INFO - "builduid", 05:09:12 INFO - "831987405d0347129ddfd0cb51e0d836", 05:09:12 INFO - "Change" 05:09:12 INFO - ], 05:09:12 INFO - [ 05:09:12 INFO - "pgo_build", 05:09:12 INFO - "False", 05:09:12 INFO - "Change" 05:09:12 INFO - ] 05:09:12 INFO - ], 05:09:12 INFO - "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90" 05:09:12 INFO - } 05:09:12 INFO - ], 05:09:12 INFO - "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90" 05:09:12 INFO - } 05:09:12 INFO - } 05:09:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:09:12 INFO - Running post-action listener: _resource_record_post_action 05:09:12 INFO - ##### 05:09:12 INFO - ##### Running download-and-extract step. 05:09:12 INFO - ##### 05:09:12 INFO - Running pre-action listener: _resource_record_pre_action 05:09:12 INFO - Running main action method: download_and_extract 05:09:12 INFO - mkdir: /builds/slave/test/build/tests 05:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:12 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json 05:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json 05:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:09:15 INFO - Downloaded 1149 bytes. 05:09:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:09:15 INFO - Using the following test package requirements: 05:09:15 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:15 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:09:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:15 INFO - u'jsshell-mac.zip'], 05:09:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:15 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:09:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:15 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:09:15 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:15 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:09:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:15 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:09:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:15 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:09:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:15 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:18 INFO - Downloaded 17462093 bytes. 05:09:18 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 05:09:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:09:23 INFO - Return code: 0 05:09:23 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 05:09: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')]} 05:09:23 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:24 INFO - Downloaded 17462093 bytes. 05:09:24 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 05:09:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:09:29 INFO - Return code: 0 05:09: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')]} 05:09:30 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:31 INFO - Downloaded 11131450 bytes. 05:09:31 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 05:09:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:09:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:09:32 INFO - Return code: 0 05:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:32 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:42 INFO - Downloaded 108690706 bytes. 05:09:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:42 INFO - mkdir: /builds/slave/test/properties 05:09:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:42 INFO - Contents: 05:09:42 INFO - build_url:https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:09:42 INFO - Running post-action listener: _resource_record_post_action 05:09:42 INFO - Running post-action listener: set_extra_try_arguments 05:09:42 INFO - ##### 05:09:42 INFO - ##### Running populate-webroot step. 05:09:42 INFO - ##### 05:09:42 INFO - Running pre-action listener: _resource_record_pre_action 05:09:42 INFO - Running main action method: populate_webroot 05:09:42 INFO - Guessing talos json url... 05:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:42 INFO - https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YxfheNFJRfS9-vBX2KQ9lw/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 05:09:43 INFO - Downloaded 99 bytes. 05:09:43 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:09:43 INFO - Contents: 05:09:43 INFO - 20151106032135 05:09:43 INFO - https://hg.mozilla.org/mozilla-central/rev/b918dbd0c3a02030769ecc9bc71e5024c748ac90 05:09: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')]} 05:09:43 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/b918dbd0c3/testing/talos/talos.json 05:09:43 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/b918dbd0c3/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/b918dbd0c3/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:09:43 INFO - Downloaded 4264 bytes. 05:09:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:09:43 INFO - '../fennec_ids.txt'], 05:09:43 INFO - 'tests': ['tcheck2']}, 05:09:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:43 INFO - '--tppagecycles', 05:09:43 INFO - '7'], 05:09:43 INFO - 'tests': ['tsvgm']}}, 05:09:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:09:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'tests': ['damp', 'tps']}, 05:09:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['damp', 'tps']}, 05:09:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:09:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:43 INFO - 'other': {'tests': ['a11yr', 05:09:43 INFO - 'ts_paint', 05:09:43 INFO - 'tpaint', 05:09:43 INFO - 'sessionrestore', 05:09:43 INFO - 'sessionrestore_no_auto_restore']}, 05:09:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['a11yr', 05:09:43 INFO - 'ts_paint', 05:09:43 INFO - 'tpaint', 05:09:43 INFO - 'sessionrestore', 05:09:43 INFO - 'sessionrestore_no_auto_restore']}, 05:09:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['a11yr', 05:09:43 INFO - 'ts_paint', 05:09:43 INFO - 'tpaint', 05:09:43 INFO - 'sessionrestore', 05:09:43 INFO - 'sessionrestore_no_auto_restore']}, 05:09:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['a11yr', 05:09:43 INFO - 'ts_paint', 05:09:43 INFO - 'tpaint', 05:09:43 INFO - 'sessionrestore', 05:09:43 INFO - 'sessionrestore_no_auto_restore']}, 05:09:43 INFO - 'other_l64': {'tests': ['a11yr', 05:09:43 INFO - 'ts_paint', 05:09:43 INFO - 'tpaint', 05:09:43 INFO - 'sessionrestore', 05:09:43 INFO - 'sessionrestore_no_auto_restore']}, 05:09:43 INFO - 'other_nol64': {'tests': ['a11yr', 05:09:43 INFO - 'ts_paint', 05:09:43 INFO - 'tpaint', 05:09:43 INFO - 'sessionrestore', 05:09:43 INFO - 'sessionrestore_no_auto_restore']}, 05:09:43 INFO - 'svgr': {'tests': ['tsvgx', 05:09:43 INFO - 'tsvgr_opacity', 05:09:43 INFO - 'tart', 05:09:43 INFO - 'tscrollx', 05:09:43 INFO - 'cart']}, 05:09:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['tsvgx', 05:09:43 INFO - 'tsvgr_opacity', 05:09:43 INFO - 'tart', 05:09:43 INFO - 'tscrollx', 05:09:43 INFO - 'cart']}, 05:09:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'tests': ['tp5o']}, 05:09:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'talos_options': ['--e10s'], 05:09:43 INFO - 'tests': ['tp5o']}, 05:09:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'talos_options': ['--xperf_path', 05:09:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:43 INFO - 'tests': ['tp5n']}, 05:09:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:43 INFO - 'talos_options': ['--e10s', 05:09:43 INFO - '--xperf_path', 05:09:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:09:43 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:09:43 INFO - 'tests': ['tp5n']}}, 05:09:43 INFO - 'talos.zip': {'path': '', 05:09:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:43 INFO - Running post-action listener: _resource_record_post_action 05:09:43 INFO - ##### 05:09:43 INFO - ##### Running create-virtualenv step. 05:09:43 INFO - ##### 05:09:43 INFO - Running pre-action listener: _resource_record_pre_action 05:09:43 INFO - Running main action method: create_virtualenv 05:09:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:09:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:44 INFO - Using real prefix '/tools/python27' 05:09:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:48 INFO - Installing pip.................done. 05:09:48 INFO - Return code: 0 05:09:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:48 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 0x100853a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793d32570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, '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.ugbqwZFJvx/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.wTdvazxbmC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:48 INFO - 'HOME': '/Users/cltbld', 05:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:48 INFO - 'LOGNAME': 'cltbld', 05:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:48 INFO - 'MOZ_NO_REMOTE': '1', 05:09:48 INFO - 'NO_EM_RESTART': '1', 05:09:48 INFO - 'PAGER': '/bin/cat', 05:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:48 INFO - 'PWD': '/builds/slave/test', 05:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:48 INFO - 'SHELL': '/bin/bash', 05:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:09:48 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:48 INFO - 'USER': 'cltbld', 05:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:48 INFO - 'XPC_FLAGS': '0x0', 05:09:48 INFO - 'XPC_SERVICE_NAME': '0', 05:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:09:49 INFO - Cleaning up... 05:09:49 INFO - Return code: 0 05:09:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:49 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 0x100853a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793d32570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, '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.ugbqwZFJvx/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.wTdvazxbmC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:49 INFO - 'HOME': '/Users/cltbld', 05:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:49 INFO - 'LOGNAME': 'cltbld', 05:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:49 INFO - 'MOZ_NO_REMOTE': '1', 05:09:49 INFO - 'NO_EM_RESTART': '1', 05:09:49 INFO - 'PAGER': '/bin/cat', 05:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:49 INFO - 'PWD': '/builds/slave/test', 05:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:49 INFO - 'SHELL': '/bin/bash', 05:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:09:49 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:49 INFO - 'USER': 'cltbld', 05:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:49 INFO - 'XPC_FLAGS': '0x0', 05:09:49 INFO - 'XPC_SERVICE_NAME': '0', 05:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:49 INFO - Downloading/unpacking psutil>=0.7.1 05:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:09:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:54 INFO - Installing collected packages: psutil 05:09:54 INFO - Running setup.py install for psutil 05:09:54 INFO - building 'psutil._psutil_osx' extension 05:09:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:09:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:09:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:09:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:09:57 INFO - building 'psutil._psutil_posix' extension 05:09:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:09:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:09:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:09:57 INFO - ^ 05:09:57 INFO - 1 warning generated. 05:09:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:09:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:57 INFO - Successfully installed psutil 05:09:57 INFO - Cleaning up... 05:09:57 INFO - Return code: 0 05:09:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:57 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 0x100853a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793d32570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, '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.ugbqwZFJvx/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.wTdvazxbmC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:57 INFO - 'HOME': '/Users/cltbld', 05:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:57 INFO - 'LOGNAME': 'cltbld', 05:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:57 INFO - 'MOZ_NO_REMOTE': '1', 05:09:57 INFO - 'NO_EM_RESTART': '1', 05:09:57 INFO - 'PAGER': '/bin/cat', 05:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:57 INFO - 'PWD': '/builds/slave/test', 05:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:57 INFO - 'SHELL': '/bin/bash', 05:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:09:57 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:57 INFO - 'USER': 'cltbld', 05:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:57 INFO - 'XPC_FLAGS': '0x0', 05:09:57 INFO - 'XPC_SERVICE_NAME': '0', 05:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:10:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:10:01 INFO - Installing collected packages: mozsystemmonitor 05:10:01 INFO - Running setup.py install for mozsystemmonitor 05:10:01 INFO - Successfully installed mozsystemmonitor 05:10:01 INFO - Cleaning up... 05:10:01 INFO - Return code: 0 05:10:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:01 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 0x100853a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793d32570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, '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.ugbqwZFJvx/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.wTdvazxbmC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:01 INFO - 'HOME': '/Users/cltbld', 05:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:01 INFO - 'LOGNAME': 'cltbld', 05:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:01 INFO - 'MOZ_NO_REMOTE': '1', 05:10:01 INFO - 'NO_EM_RESTART': '1', 05:10:01 INFO - 'PAGER': '/bin/cat', 05:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:01 INFO - 'PWD': '/builds/slave/test', 05:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:01 INFO - 'SHELL': '/bin/bash', 05:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:10:01 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:01 INFO - 'USER': 'cltbld', 05:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:01 INFO - 'XPC_FLAGS': '0x0', 05:10:01 INFO - 'XPC_SERVICE_NAME': '0', 05:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:06 INFO - Downloading docopt-0.6.1.tar.gz 05:10:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:06 INFO - Running setup.py install for blobuploader 05:10:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:06 INFO - Running setup.py install for requests 05:10:06 INFO - Running setup.py install for docopt 05:10:07 INFO - Successfully installed blobuploader requests docopt 05:10:07 INFO - Cleaning up... 05:10:07 INFO - Return code: 0 05:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:07 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 0x100853a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793d32570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, '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.ugbqwZFJvx/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.wTdvazxbmC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:07 INFO - 'HOME': '/Users/cltbld', 05:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:07 INFO - 'LOGNAME': 'cltbld', 05:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:07 INFO - 'MOZ_NO_REMOTE': '1', 05:10:07 INFO - 'NO_EM_RESTART': '1', 05:10:07 INFO - 'PAGER': '/bin/cat', 05:10:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:07 INFO - 'PWD': '/builds/slave/test', 05:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:07 INFO - 'SHELL': '/bin/bash', 05:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:10:07 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:07 INFO - 'USER': 'cltbld', 05:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:07 INFO - 'XPC_FLAGS': '0x0', 05:10:07 INFO - 'XPC_SERVICE_NAME': '0', 05:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:07 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-Qabz8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:07 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-T5evsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:07 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-krroSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:07 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-4s9ZbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:08 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-sYWwVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:08 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-axZbH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:08 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-_j7kyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:08 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-Elfbwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:08 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-wC_rm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:08 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-rS1N72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:08 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-64SCyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:09 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-Q5bcKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:09 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-R9haJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:09 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-e_TdMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:09 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-Xpidn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:09 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-dZ_w5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:09 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-H2PmQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:09 INFO - Running setup.py install for manifestparser 05:10:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Running setup.py install for mozcrash 05:10:10 INFO - Running setup.py install for mozdebug 05:10:10 INFO - Running setup.py install for mozdevice 05:10:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Running setup.py install for mozfile 05:10:10 INFO - Running setup.py install for mozhttpd 05:10:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:10 INFO - Running setup.py install for mozinfo 05:10:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for mozInstall 05:10:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for mozleak 05:10:11 INFO - Running setup.py install for mozlog 05:10:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for moznetwork 05:10:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:11 INFO - Running setup.py install for mozprocess 05:10:12 INFO - Running setup.py install for mozprofile 05:10:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Running setup.py install for mozrunner 05:10:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:12 INFO - Running setup.py install for mozscreenshot 05:10:12 INFO - Running setup.py install for moztest 05:10:12 INFO - Running setup.py install for mozversion 05:10:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:13 INFO - Cleaning up... 05:10:13 INFO - Return code: 0 05:10:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:13 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 0x100853a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793d32570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, '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.ugbqwZFJvx/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.wTdvazxbmC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:13 INFO - 'HOME': '/Users/cltbld', 05:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:13 INFO - 'LOGNAME': 'cltbld', 05:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:13 INFO - 'MOZ_NO_REMOTE': '1', 05:10:13 INFO - 'NO_EM_RESTART': '1', 05:10:13 INFO - 'PAGER': '/bin/cat', 05:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:13 INFO - 'PWD': '/builds/slave/test', 05:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:13 INFO - 'SHELL': '/bin/bash', 05:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:10:13 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:13 INFO - 'USER': 'cltbld', 05:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:13 INFO - 'XPC_FLAGS': '0x0', 05:10:13 INFO - 'XPC_SERVICE_NAME': '0', 05:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:13 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-WfsyO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:13 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-8ySwHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:13 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-o1a7LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:13 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-kRFjEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:13 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)) 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:13 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-jT8BkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-PvPsXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-DkiXcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:14 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)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-NYaN2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-7y8Jsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-8NGd4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-Eu7xVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-5H9lNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:14 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-BcX8eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:15 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-0iNMO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:15 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-ZwB_ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:15 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-QGiuZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:15 INFO - Running setup.py (path:/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/pip-Pezn0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:15 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)) 05:10:15 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)) 05:10:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:18 INFO - Downloading blessings-1.5.1.tar.gz 05:10:18 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:18 INFO - Installing collected packages: blessings 05:10:18 INFO - Running setup.py install for blessings 05:10:18 INFO - Successfully installed blessings 05:10:18 INFO - Cleaning up... 05:10:18 INFO - Return code: 0 05:10:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:18 INFO - Reading from file tmpfile_stdout 05:10:18 INFO - Current package versions: 05:10:18 INFO - blessings == 1.5.1 05:10:18 INFO - blobuploader == 1.2.4 05:10:18 INFO - docopt == 0.6.1 05:10:18 INFO - manifestparser == 1.1 05:10:18 INFO - mozInstall == 1.12 05:10:18 INFO - mozcrash == 0.16 05:10:18 INFO - mozdebug == 0.1 05:10:18 INFO - mozdevice == 0.47 05:10:18 INFO - mozfile == 1.2 05:10:18 INFO - mozhttpd == 0.7 05:10:18 INFO - mozinfo == 0.9 05:10:18 INFO - mozleak == 0.1 05:10:18 INFO - mozlog == 3.0 05:10:18 INFO - moznetwork == 0.27 05:10:18 INFO - mozprocess == 0.22 05:10:18 INFO - mozprofile == 0.27 05:10:18 INFO - mozrunner == 6.11 05:10:18 INFO - mozscreenshot == 0.1 05:10:18 INFO - mozsystemmonitor == 0.0 05:10:18 INFO - moztest == 0.7 05:10:18 INFO - mozversion == 1.4 05:10:18 INFO - psutil == 3.1.1 05:10:18 INFO - requests == 1.2.3 05:10:18 INFO - wsgiref == 0.1.2 05:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:18 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 0x100853a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa793d32570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, '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.ugbqwZFJvx/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.wTdvazxbmC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:10:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:18 INFO - 'HOME': '/Users/cltbld', 05:10:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:18 INFO - 'LOGNAME': 'cltbld', 05:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:18 INFO - 'MOZ_NO_REMOTE': '1', 05:10:18 INFO - 'NO_EM_RESTART': '1', 05:10:18 INFO - 'PAGER': '/bin/cat', 05:10:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:18 INFO - 'PWD': '/builds/slave/test', 05:10:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:18 INFO - 'SHELL': '/bin/bash', 05:10:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:10:18 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:10:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:18 INFO - 'USER': 'cltbld', 05:10:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:18 INFO - 'XPC_FLAGS': '0x0', 05:10:18 INFO - 'XPC_SERVICE_NAME': '0', 05:10:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:10: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:19 INFO - Cleaning up... 05:10:19 INFO - Return code: 0 05:10:19 INFO - Running post-action listener: _resource_record_post_action 05:10:19 INFO - Running post-action listener: _start_resource_monitoring 05:10:19 INFO - Starting resource monitoring. 05:10:19 INFO - ##### 05:10:19 INFO - ##### Running install step. 05:10:19 INFO - ##### 05:10:19 INFO - Running pre-action listener: _resource_record_pre_action 05:10:19 INFO - Running main action method: install 05:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:19 INFO - Reading from file tmpfile_stdout 05:10:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:19 INFO - Reading from file tmpfile_stdout 05:10:19 INFO - Output received: 05:10:19 INFO - Usage: mozinstall [options] installer 05:10:19 INFO - Options: 05:10:19 INFO - -h, --help show this help message and exit 05:10:19 INFO - -d DEST, --destination=DEST 05:10:19 INFO - Directory to install application into. [default: 05:10:19 INFO - "/builds/slave/test"] 05:10:19 INFO - --app=APP Application being installed. [default: firefox] 05:10:19 INFO - mkdir: /builds/slave/test/build/application 05:10:19 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'] 05:10:19 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 05:11:00 INFO - Reading from file tmpfile_stdout 05:11:00 INFO - Output received: 05:11:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:11:00 INFO - Running post-action listener: _resource_record_post_action 05:11:00 INFO - ##### 05:11:00 INFO - ##### Running run-tests step. 05:11:00 INFO - ##### 05:11:00 INFO - Running pre-action listener: _resource_record_pre_action 05:11:00 INFO - Running main action method: run_tests 05:11:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:00 INFO - 2015-11-06 05:11:00.082 screenresolution[1626:7639] starting screenresolution argv=screenresolution get 05:11:00 INFO - 2015-11-06 05:11:00.085 screenresolution[1626:7639] Display 0: 1600x1200x32@60 05:11:00 INFO - 2015-11-06 05:11:00.093 screenresolution[1627:7641] starting screenresolution argv=screenresolution list 05:11:00 INFO - Available Modes on Display 0 05:11:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:00 INFO - Intel HD Graphics 3000: 05:11:00 INFO - Chipset Model: Intel HD Graphics 3000 05:11:00 INFO - Type: GPU 05:11:00 INFO - Bus: Built-In 05:11:00 INFO - VRAM (Total): 512 MB 05:11:00 INFO - VRAM (Dynamic, Max): 10 05:11:00 INFO - Vendor: Intel (0x8086) 05:11:00 INFO - Device ID: 0x0116 05:11:00 INFO - Revision ID: 0x0009 05:11:00 INFO - Displays: 05:11:00 INFO - Display: 05:11:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:00 INFO - Display Serial Number: 1600x1200 60 05:11:00 INFO - Main Display: Yes 05:11:00 INFO - Mirror: Off 05:11:00 INFO - Online: Yes 05:11:00 INFO - Rotation: Supported 05:11:00 INFO - Return code: 0 05:11:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:00 INFO - Python 2.7.3 05:11:00 INFO - Return code: 0 05:11:00 INFO - grabbing minidump binary from tooltool 05:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:00 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 0x1008089f0>, '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 0x100567cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007d2990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:11:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:11:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:00 INFO - Return code: 0 05:11:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:11:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:11:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0072', '--webServer', 'localhost'] in /builds/slave/test/build 05:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0072 --webServer localhost 05:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ugbqwZFJvx/Render', 05:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:00 INFO - 'HOME': '/Users/cltbld', 05:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:00 INFO - 'LOGNAME': 'cltbld', 05:11:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:00 INFO - 'MOZ_NO_REMOTE': '1', 05:11:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:00 INFO - 'NO_EM_RESTART': '1', 05:11:00 INFO - 'PAGER': '/bin/cat', 05:11:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:00 INFO - 'PWD': '/builds/slave/test', 05:11:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:00 INFO - 'SHELL': '/bin/bash', 05:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTdvazxbmC/Listeners', 05:11:00 INFO - 'TMPDIR': '/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/', 05:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:00 INFO - 'USER': 'cltbld', 05:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:00 INFO - 'XPC_FLAGS': '0x0', 05:11:00 INFO - 'XPC_SERVICE_NAME': '0', 05:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:11:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0072', '--webServer', 'localhost'] with output_timeout 3600 05:11:00 INFO - mozversion INFO | application_buildid: 20151106032135 05:11:00 INFO - mozversion INFO | application_changeset: b918dbd0c3a02030769ecc9bc71e5024c748ac90 05:11:00 INFO - mozversion INFO | application_display_name: Nightly 05:11:00 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:00 INFO - mozversion INFO | application_name: Firefox 05:11:00 INFO - mozversion INFO | application_remotingname: firefox 05:11:00 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:11:00 INFO - mozversion INFO | application_vendor: Mozilla 05:11:00 INFO - mozversion INFO | application_version: 45.0a1 05:11:00 INFO - mozversion INFO | platform_buildid: 20151106032135 05:11:00 INFO - mozversion INFO | platform_changeset: b918dbd0c3a02030769ecc9bc71e5024c748ac90 05:11:00 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:11:00 INFO - mozversion INFO | platform_version: 45.0a1 05:11:00 INFO - 2015-11-06 05:11:00,808 DEBUG : using testdate: 1446815460 05:11:00 INFO - 2015-11-06 05:11:00,808 DEBUG : actual date: 1446815460 05:11:00 INFO - 2015-11-06 05:11:00,892 INFO : starting webserver on 'localhost:49278' 05:11:00 INFO - 2015-11-06 05:11:00,893 INFO : Starting test suite t-yosemite-r5-0072 05:11:00 INFO - 2015-11-06 05:11:00,893 INFO : Starting test dromaeo_css 05:11:00 INFO - 2015-11-06 05:11:00,893 DEBUG : operating with platform_type : mac_ 05:11:00 INFO - 2015-11-06 05:11:00,894 INFO : Initialising browser for dromaeo_css test... 05:11:00 INFO - 2015-11-06 05:11:00,928 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/tmpHPlobc/profile http://localhost:49278/getInfo.html 05:11:03 INFO - 2015-11-06 05:11:03,950 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:03 INFO - 2015-11-06 05:11:03,950 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:03 INFO - 2015-11-06 05:11:03,950 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:11:03 INFO - 2015-11-06 05:11:03,950 DEBUG : BROWSER_OUTPUT: __metrics 05:11:03 INFO - 2015-11-06 05:11:03,971 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:04 INFO - 2015-11-06 05:11:04,728 INFO : Browser initialized. 05:11:04 INFO - 2015-11-06 05:11:04,729 INFO : Running cycle 1/1 for dromaeo_css test... 05:11:04 INFO - 2015-11-06 05:11:04,729 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/tmpHPlobc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:16 INFO - 2015-11-06 05:11:16,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 224604160 05:11:16 INFO - 2015-11-06 05:11:16,740 DEBUG : BROWSER_OUTPUT: 05:12:07 INFO - 2015-11-06 05:12:07,729 DEBUG : BROWSER_OUTPUT: 1446815527728 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:14:18 INFO - 2015-11-06 05:14:18,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:14:20 INFO - 2015-11-06 05:14:20,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 324698112 05:14:20 INFO - 2015-11-06 05:14:20,056 DEBUG : BROWSER_OUTPUT: 05:17:22 INFO - 2015-11-06 05:17:22,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:17:23 INFO - 2015-11-06 05:17:23,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 358809600 05:17:23 INFO - 2015-11-06 05:17:23,325 DEBUG : BROWSER_OUTPUT: 05:20:25 INFO - 2015-11-06 05:20:25,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:20:26 INFO - 2015-11-06 05:20:26,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 320921600 05:20:26 INFO - 2015-11-06 05:20:26,326 DEBUG : BROWSER_OUTPUT: 05:23:28 INFO - 2015-11-06 05:23:28,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 05:23:29 INFO - 2015-11-06 05:23:29,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 311955456 05:23:29 INFO - 2015-11-06 05:23:29,069 DEBUG : BROWSER_OUTPUT: 05:26:32 INFO - 2015-11-06 05:26:32,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:26:32 INFO - 2015-11-06 05:26:32,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 314937344 05:26:32 INFO - 2015-11-06 05:26:32,688 DEBUG : BROWSER_OUTPUT: 05:29:35 INFO - 2015-11-06 05:29:35,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:29:35 INFO - 2015-11-06 05:29:35,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 360673280 05:29:35 INFO - 2015-11-06 05:29:35,990 DEBUG : BROWSER_OUTPUT: 05:29:35 INFO - 2015-11-06 05:29:35,990 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:35 INFO - 2015-11-06 05:29:35,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:35 INFO - 2015-11-06 05:29:35,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:35 INFO - 2015-11-06 05:29:35,991 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:35 INFO - 2015-11-06 05:29:35,991 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2762.212769360732;2817.619621351117;2825.47728670196;2840.815347002446;2854.5860850176723;4507.72953622782;4639.420072490939;4651.7441540715245;4699.647526435522;4782.282657601361;4626.86119416418;4646.674732768707;4656.138614356338;4759.214729569626;4806.855794326176;4231.788410579474;4289.914201715964;4318.956810431887;4320.200762858865;4323.178596066753;4433.423654924855;4433.866983990485;4440.356148358486;4468.731876087445;4475.619572336339;4203.789810509493;4249.46881639795;4310.956890431118;4395.406620106277;4512.34570987205;4390.934135987963;4398.516163222043;4403.977980110111;4421.6904816662845;4448.266036104039;4363.585459381354;4379.43067401239;4396.78016099197;4403.295472724349;4413.44831896013;4421.9336709949375;4534.7052441591195;4556.931646025312;4600.677952543323;4726.574608285271;5009.799608015675;5047.49525047496;5049.419316778581;5121.027004869063;5138.614603904722;5088.185890257578;5102.744862756847;5111.948880511184;5162.664426812245;5226.843194704165;4563.361129441914;4692.835750748707;4755.5719985201495;4756.833510827105;4851.248056551241;5178.145605974972;5182.24857395683;5190.065788158167;5191.299174611379;5274.235235890775;4978.32792572998;4987.900241995212;5001.57486613642;5022.246663000579;5047.041062198171;4821.445533763592;4932.136876046678;4937.11131996237;5021.623378246573;5147.40804807452;4958.305837182797;4971.502849715;4991.700497970133;5014.172661510883;5034.622403319766;4954.628402869799;4981.526754958273;4983.875403114951;4986.177280748709;5012.624053196025;3759.398496240643;3957.3470377387985;3965.6827453803626;3974.4634474345594;4011.3982902564267;3519.225770330523;3634.818259087035;3644.3804553226014;3658.579263384745;3659.2315613721416;4703.905921881543;4715.056988602225;4733.337332773414;4736.478987311393;4756.524347565216;5083.059633967728;5085.542301192836;5095.847124586268;5119;5147.356580427447;4604.355390245369;4733.242681170997;4755.595774359149;4778.522147785263;4797.784099715521;4327.956720432819;4417.734935903856;4417.955820441754;4432.601065904084;4434.623057040188;5143.794248230029;5198.168293073166;5201.453847345974;5207.557357624644;5251.6061295403;4887.169181239126;5088.59291256706;5095.286659867696;5102.566281866083;5116.30929824469;5109.412417571878;5130.58955283569;5133.460986596354;5198.142306519382;5218.373795144607;4938.703677779345;4948.430930443045;4949.950500494949;4967.552920237196;5025.3718285214345;4958.826441074545;4985.6011519077665;4990.8253211137435;5022.321986531918;5041.4454410015605;4760.714357138583;4891.046245981999;4907.165781817028;4924.482929292372;4940.258961155855;4896.828610998598;4902.60779137661;4918.803247870045;4923.655344125877;4965.4041515018425;4600.240960241523;4752.025834703808;4810.855674329776;4859.781309840995;4889.657723959289;4849.224124140121;4866.78099485531;4986.601071914166;5019.121653710513;5057.519535644108;4855.878603034952;4866.343043689057;4877.658563900635;4884.218525036119;4941 05:29:35 INFO - 2015-11-06 05:29:35,991 DEBUG : BROWSER_OUTPUT: |1;ext.html;492.27635375997284;498.15065313640247;499.97250151241667;507.69269131985146;522.8640553456103;27902.302442438922;35186.12034699134;35863.64136358639;36216;36244.81877590608;38527;39032.414513782314;39450.605493945055;39451;39550;7257.129144502641;7328.047353843993;8069.193080691928;8219.917800822004;8365.916340836606;9525.761855953588;9600.711978640617;9636.036396360343;9672;9723.854142187873;9537.666181683642;9571.377860439085;9576.138147566717;9645.565949532287;9670.274729395289;7053.717851285943;7372.520786148883;9528.285378596598;9541.761455963588;9633.181179599742;9472.242220622402;9581.61673533058;9595.42427454355;9643.08390702882;9706.90293097074;35907.4613880792;35919.102022449384;35968;36107.4583881242;36540.45189322162;2709.905153319644;2718.904838330649;2800.103966730647;2890;3090.9536356954663;25091.874540627363;25162.874185628956;25411.61882571763;25876.094336698312;26123.73876261232;2085.5411809401908;2107.2203284784573;2111.3771437425844;2117.428294360514;2223.2552095048177;279411;280885;282417;282424;282552;50446.495535044916;51909;55242.44757552454;58800.70599646975;61398;56168.438315616324;56443.71778141083;56581;57113;57181.714091430105;13427.060105792696;13537.1200871943;13559.728805423836;13630.795538066937;13676.452941882413;10015.549300281506;10117.241206909512;10150;10190.949045254727;10258.846117308247;17870.642587148184;17908.28366865337;17912.462626121236;17985.820141798675;18084.728729069073;7528.51064680794;7736.7292144774665;7785.571793551409;7794.9220507795335;7850.175731548105;817.9918200818034;834.470111479203;897.2059727141396;929.9027147965465;952.7522844060594;25392.111276105246;25872.223833285032;25974.87012564925;26024.219273421826;26087;956.3066776586919;1029.9742506437399;1070.641335152717;1100.9339439633648;1107.7064577886867;13275.203487790763;13341.916553138592;13417.731645367234;13428.93285533566;13436.93281533586;272470;277664;278555;279333;281187;49824.50175498271;49948.75025624849;50014.24978625323;50438.243426348636;50484.74757626262;1204.3255776764865;1211.2550781269456;1211.8727533609197;1212.4665147335145;1221.9572314969112;25279.11523096683;25519.87240063788;25618.359541011625;25750.356241094123;25814.225573232834;43884.561154388044;44165.558344416146;44352.556474434845;44638.55361446474;44768.55231447774;250724;252611;253858;254941;255160;24463.633045503975;24673.62989555122;27867.303317417227;28557.143285701462;29392.26519337034;37734.43398349082;37997.620023799405;38092.428613570264;38688.80655596704;38769.4184587237;31307.84346078346;31465.37069258648;32100.518492222167;32327.676723233406;32619;26084.61034970379;30695.079147625605;30750;31362.529562057043;31590.210244744067;28474.145775626763;30177;30193.396132077676;30575.388492230475;30580.235494112825;25123.497530049663;25592.488150236517;26454.735452645225;26834.865825670746;26896;21107.472313192295;21366.78633213648;21717.56564868662;21719.457013574785;21949.780502194775 05:29:35 INFO - 2015-11-06 05:29:35,995 DEBUG : BROWSER_OUTPUT: |2;jquery.html;294.5802231819658;294.6405385429775;298.1695976704877;302.30922342447496;305.36179385085177;14785.778213326796;15353.923230383847;15779.053256804586;16143.112128832909;16196.109213993226;12763.106582539203;12957.546485872996;13086.214827110356;13156.539521116763;15541.22293885304;4656.115338085761;4784.5933095686905;4823.20417131173;4840.540148685886;4852.733099679534;4732.02993386355;4732.124556956974;4735.73953432561;4759.452662943754;4765.90468190636;3857.864974725885;3874.302625527418;3891.2801131790566;4153.958460415402;4730.172219861528;4704.952950470502;4741.075490279397;4804.711717296938;4808.855734327975;4809.302651115586;4051.7163798534116;4100.220958017967;4148.813303401324;4154.252234597771;4217.051163488221;19364.903175484033;19366.225350986086;19405.4178374649;19415;19579.21683132673;1764.056229917001;1856.860735444847;1884.8397886179691;1934.806519348068;1986.6424043672134;11933.40332983356;12148.635540933787;12164.08769342303;12425.93787031059;12545;1455.65064384548;1456.2573087725336;1475.085447022842;1504.9021813582192;1522.3529999750062;40757.59242407568;43088.78455607702;47184.764076179745;50099.49900501021;52257.216141757905;7572;8349.916500835036;8472.025717042496;8563.100874408223;8616.224539791323;9985.750356241153;10034.74913127163;10040.34737742059;10246.795064098826;10253.948730256301;6522.869542609121;6543.476521878239;6659.567128136752;6709.127813384229;6829.146356705412;6803.149606299213;6838.589684618939;6884.896726549106;6886.552374095668;6905.37851593359;5116.258142569307;5190.55880250183;5191.8182863599595;5195.714235716996;5242.397124330751;1475.7972252614086;1488.1071357185817;1490.6571488557477;1502.5417247739326;1528.510876519503;351.11518972189936;356.84120566348247;360.7763186824186;806.487880196068;861.1259571534897;8502.404831661848;9097.363184577016;9144.039875813078;9311.580978855967;9530.618775248913;358.23695528524075;362.1778562662741;366.40459253712714;374.66841844966854;375.94548790425233;4627.1439783640135;4669.2062349400685;4729.929051064168;4901.950980490221;5060.974695126501;498904;505488;515388;519998;528159;61276;61701.38298617046;61763.38236617666;62021.379786202466;62287.68856155781;366.2893985667796;367.59564479072804;373.5666626713;374.0536442799721;376.47669739062724;8580.742577722678;8591.742247732578;8603.913960860562;8618.267447267053;8629.784255393666;28881.711182887902;29228.561571576018;29413.411731765675;29626.851865740533;30402.391952161277;38707.6129238704;39685.60314396819;39759.80120099381;39844.2031159381;40123.598764011986;5358.115910874662;5453.563714902878;5459.235707001102;5530.198121272312;5530.7511161997;9914.652987145415;10358.482075896325;10365.84451233217;10480.213983951082;10489.423081730578;8349.749507514784;8638.56807159652;8913.37606367574;9006.774830629287;9054.773630659287;7906.248906353887;8793.757591814046;8794.42836215644;8899.555022248991;8914.955425222832;9214.953925230331;9359.204467620057;9406.717798466058;9424.811503770023;9481.573329200064;5408.0806262936185;5421.186821976735;5444.8366549003595;5525.917111243415;5577.74900129487;8877.422967507091;9037.141471560191;9065.13881181313;9147.313951453802;9168.495732734764 05:29:35 INFO - 2015-11-06 05:29:35,996 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1135.73310272086;1532.4253404973133;1553.9223038848054;1603.4147536149305;1610.6295552023034;5907.970460147704;6164.321924588292;6511.381418765216;6665.666716664159;6676.9332306676915;6611.768588099418;6707.832304192385;6755.054292399068;6803.149606299213;6819.1135152430115;1689.763433119358;1734.453647101159;1873.1009115624508;1896.0614495824518;1921.077882616338;1901.5246188452886;1936.457791818286;1939.2049259803484;1941.9998700669166;1961.1959096770327;1857.6099019205983;1890.6124244529908;1898.1742941820282;1923.2114832918505;1954.5504533957198;1893.867429279951;1911.8183772541656;1921.2795201799324;1921.9519512012312;1929.8938558379284;1886.4906475251605;1916.865819392643;1917.3672688012923;1919.2418994497234;1947.2308438166986;6538.640374779386;6619.801405957829;6621.139251897271;6621.867562648768;6714.664266786641;3934.488516492838;4008.7594744315143;4016.9957510622344;4028.939565906514;4053.250148722496;2354.9274455295604;2421.1041914491575;2438.231956933578;2487.315988103268;2497.6003839385794;627.5105417774143;640.3308542573022;701.9298070192991;714.9821254468628;721.8844984802458;8726.69456569017;8787.0773568775;8794.34042446819;8856.822863542693;8881.511516866569;3706.314331848617;3713.9442908356395;3757.342465068602;3788.886333410002;3794.6395092466173;7699.960505331708;7712.575808330484;7724.6523906424345;7725.266099720518;7745.8450830983065;4186.706930514834;4186.874393768192;4190.182914331676;4228.154369126187;4250.808713607895;3837.654611085016;3842.4044273137706;3849.7690138591774;3850.268448994682;3862.748921320105;3183.3951549205576;3193.393255281489;3212.084555901557;3213.517972304173;3236.9028929132164;988.7182153086336;994.3337963564429;999.3953658036928;1004.9547770350351;1011.6661501704419;946.7112530678072;971.1065819446127;976.3507267666922;1008.5562352564848;1170.9238899471507;6391.776287829996;6404.199475065617;6414.037894315797;6420.036994450869;6424.550281480251;370.13757943990436;370.2982847503965;378.96210378962434;393.84639990403764;397.6818545163857;5055.570276526463;5111.97444012785;5116.846494605168;5121.641485096007;5165.715885626327;7402.925970740223;7826.608669566499;7864.331531819859;8012.1186669466315;8032.959835200787;7575.166731659513;7705.9229407706325;7850.489718168301;7858.685652573833;7975.082865470546;6232.3144454110015;6330.050492426173;6337.6197428154455;6346.365363463709;6439.9696048631995;6150.50795936333;6284.057391391328;6286.119943208046;6350.047492876106;6356;7053.506254562131;7139.500234983501;7142.428605711634;7174.67713952863;7267.236940121211;7146.3568278855155;7270.636468176675;7282.4902256841515;7304.890426643711;7407.259274072765;5870.354261031198;5912.260967379078;5934.109883517507;5937.703114844327;5996.67018313997;6405.391487808651;6467.935320646921;6506.837329066811;6517.641529715722;6525.543211975116;5824.213731146241;5969;5978.163057171912;6087.026075828024;6089.086637004308;5916.201312822886;5918.526517878646;5925.496332811759;5974.820755377345;6097.695115244309;5913.763449461973;5968.850778730566;5971.4327138921735;5990;6030.638161710312;5503.862403439786;5521.171824226398;5559.19391688211;5560.193771903132;5579.4420557945505;5594.272744543184;5637.154426836008;5637.633553818989;5657.660540367591;5672.14917762339 05:29:36 INFO - 2015-11-06 05:29:36,000 DEBUG : BROWSER_OUTPUT: |4;prototype.html;260.23101734374916;269.37908121779304;274.0381261771183;274.8076346557409;277.5919398484229;5239.24031015503;5255.579553635709;5294.841154765359;5306.893862122755;5311.309529761131;5108.924911867808;5248.02911461379;5268.236105764671;5270.683758974455;5307.389650190229;3860.092878173634;3903.1217975955324;3904.726669133162;3916.667083297923;3959.6634286085573;3914.53025636924;3999.3401088820456;4003.1793482336197;4011.59884011598;4013.919721605581;3816.255830113129;3933.4886464759543;3971.543272523668;3999.2201520703475;4019.356902895537;3881.3207688654516;3930.6855451563806;3950.8419663213435;3955.46601208836;4017.2367250222364;3427.108951672583;3429.0398688367295;3447.500112483701;3489.65103489649;3496.8251587420527;5064.088464076464;5068.797248110071;5102.897942041139;5117.462666420047;5137.48625137487;4477.104579084164;4480.910381792379;4504.301833215857;4506.166359223522;4517.186906356855;5363.839084827461;5419.972900135514;5437.537809286176;5472.480114389166;5476.67139971603;3677.1726361568435;3682.042668906077;3728.664420202195;3731.4029755239303;3739.9252014959548;5664.376918538957;5689.459501347365;5691.686957217351;5720.8283751487525;5725.942740572583;3643.8178091095338;3738.1776009277914;3739.5886452490204;3754.305453491113;3776.4524143998965;3659.5425571803526;3758.8120593970193;3768.9811550942068;3779.263043706506;3822.522184726909;4456.108778244364;4456.197884380777;4456.732596044183;4507.323901414814;4509.346144808985;5499.945000550023;5528.391876893538;5570.972145139248;5573.331200255995;5575.581831362664;1340.9195448273135;1365.9453621855214;1367.4940272099386;1368.3226802732513;1386.334559411468;859.686214531704;882.6469412235028;884.7390019944132;894.088030209183;895.9686410975585;5215.921761173586;5228.032813929435;5228.63399562027;5243.2659427680155;5292.100342941709;5727.427257274323;5740.282464691913;5748.223989761329;5800.651960882361;5824.359320474744;5201.505856943584;5222.190560463135;5229.241759944786;5282.867928301746;5287.9471205287455;2999.640043194787;3046.6800985896607;3169.2869104451315;3185.569948057029;3186.9043928682177;5815.883682326415;5826.2134611827705;5829.679367634821;5896.3219229788265;5900.1739756434135;5839.036558967808;5853.268341457318;5856.238688970492;5882.499987501024;5883.264591926009;5741.13882917574;5777.422257774189;5845.912311315334;5870.119482077637;5892.027815410409;5745;5749.051406517878;5766.077427611562;5818.389069147678;5832.766689332379;5613.129964855454;5631.718414079198;5688.232088667977;5691.089425691869;5699.202111704448;5851.063829787214;5869.236999190078;5890.410958904075;5896.3514013457625;5928;3668.9816550918144;3711.981440092782;3745.47563341127;3765.4351847223134;3768.1898391845884;5645.943540564706;5647.463490968352;5704.543636508986;5707.258056452634;5708;5518.917216241679;5522.088855338985;5531.778728850801;5597.384287728265;5599.412061733459;5390;5477.233187353694;5558.138488534284;5563.582731295088;5605.1872478491205;5410.053240682943;5419.214213939035;5459.235707000944;5459.317585301837;5503;5542.445755424425;5614.63504872182;5616.550675945833;5622.409646987007;5627.774889004558;5301.655392399482;5401.162819762943;5416.214648875812;5437.048516509516;5478.808241711521 05:29:36 INFO - 2015-11-06 05:29:36,000 DEBUG : BROWSER_OUTPUT: |5;yui.html;663.1809715001968;672.1530871102411;687.5599616245606;688.4286042584655;725.1334655087171;11616;11977.461014254357;12016.399180040995;12054.819177712341;12179.20835145715;10766.35401875888;11306.547738090487;11483.540658373655;11519.308841469518;12297.815532767016;785.3677789379533;801.3308887079296;802.0455657767238;802.450321529751;812.9634166462523;804.9758507244762;809.7449303469389;813.7518056992615;814.8736945773385;826.4462809917339;846.919542643451;849.3078141314809;849.5752123938031;850.1158794853345;851.0468275531414;844.0293662288386;845.5518575155178;846;849.0363437498422;857.6526506764739;615.7998650438625;627.2316412394825;628.5694299404877;629.7795771479991;631.2425089892148;11883.227590206609;12004.51981920731;12007.759844803055;12021.459034343388;12028.879711202864;9798.804023919552;10036.498175091216;10060.893301736804;10430.322029068162;10798.73003174919;8125.959370203171;8308.335333173332;8327.750167494985;8425.789355266106;8515.701950431767;2875.5542890851953;2915.11089117819;2995.5656429817554;3039.924001899948;3098.891538796154;35832;37816.43275350872;40042;40260.39609405861;41989.1602167958;7776.300132988058;7824.921750782533;7883.566403847729;8049.678012879536;8279.50322980623;15781.842181578268;15784.36862525509;15791.526254212393;15949.282282297325;15977.121258330902;6016.097585362143;6037.45662890342;6045.637261764308;6052.788152414732;6328;3368.781029233141;3373.4433818420175;3405.2338223899424;3414.214730611973;3425.8972230833115;2496.288557761066;2498.350428888502;2507.7241503434607;2518.4711210645605;2531.974680253211;386.8297948902474;391.10046892147943;393.7047214589058;394.82035673768365;399.4208397823168;478.0749250200803;506.79981407344627;510.7267611827654;530.9044372012997;536.9114096174166;6391.456726178327;6617.581036185676;6776.864462710817;6845.281245469154;6848.246692863781;484.22765688726423;513.3352308760165;516.9069567477815;533.0671325180933;542.3166809819655;3166.841657917095;3202.583664123649;3210.7912985655857;3217.8069315840658;3219.3400352927592;53012.469875300754;53364.19953700698;53375.45992641159;53876;54066.72966635141;37967.24065518674;37988;46094.30858537125;47057.76471117691;47077.764611176724;37000.81499592485;40784.79607601943;40862.38706419406;41396.79301603533;41519.58480415157;7041.014258003986;7041.5422997505;7053.365197132282;7316.341529262392;7505.6997720090585;30201.395972080874;30299.848500757354;31094.689053110083;32022.519662205552;32170;35322.470162947066;35616;39432.21135577215;40249.798751006056;43026.569734303506;6769.966150169218;6795;6818.147731533559;6882.931170688229;7129.251428599922;9572.856407154037;9642.132208101304;9779.951100244452;9904.702858914245;9948.303618746619;9352.438853668802;9440.10319019692;9487.241020718187;9556.23550116003;9564.234861210947;9006.684766033157;9178.908210918073;9208.861867071866;9511.809763804547;9629.32594718363;9151.86272205904;9234.122758337948;9451.385659932082;9468.715938521855;9555.856662150212;7686.07767067933;7766.766996990099;7836.697320753142;8035.276825085771;8338.666453341799;6265.373462653881;6582;6686.197656281277;6752.426043786333;6757.594544327356 05:29:36 INFO - 2015-11-06 05:29:36,000 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:36 INFO - 2015-11-06 05:29:36,000 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:29:36 INFO - 2015-11-06 05:29:36,001 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1586 05:29:36 INFO - 2015-11-06 05:29:36,001 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:29:36 INFO - 2015-11-06 05:29:36,001 DEBUG : BROWSER_OUTPUT: __startTimestamp1446816575986__endTimestamp 05:29:36 INFO - 2015-11-06 05:29:36,001 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:36 INFO - 2015-11-06 05:29:36,003 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:29:36 INFO - 2015-11-06 05:29:36,003 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,003 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4699.07 Median:4859.78 stddev:495.99 (10.2%) stddev-sans-first:473.66 05:29:36 INFO - 2015-11-06 05:29:36,003 DEBUG : BROWSER_OUTPUT: Values: 2762.2 2817.6 2825.5 2840.8 2854.6 4507.7 4639.4 4651.7 4699.6 4782.3 4626.9 4646.7 4656.1 4759.2 4806.9 4231.8 4289.9 4319.0 4320.2 4323.2 4433.4 4433.9 4440.4 4468.7 4475.6 4203.8 4249.5 4311.0 4395.4 4512.3 4390.9 4398.5 4404.0 4421.7 4448.3 4363.6 4379.4 4396.8 4403.3 4413.4 4421.9 4534.7 4556.9 4600.7 4726.6 5009.8 5047.5 5049.4 5121.0 5138.6 5088.2 5102.7 5111.9 5162.7 5226.8 4563.4 4692.8 4755.6 4756.8 4851.2 5178.1 5182.2 5190.1 5191.3 5274.2 4978.3 4987.9 5001.6 5022.2 5047.0 4821.4 4932.1 4937.1 5021.6 5147.4 4958.3 4971.5 4991.7 5014.2 5034.6 4954.6 4981.5 4983.9 4986.2 5012.6 3759.4 3957.3 3965.7 3974.5 4011.4 3519.2 3634.8 3644.4 3658.6 3659.2 4703.9 4715.1 4733.3 4736.5 4756.5 5083.1 5085.5 5095.8 5119.0 5147.4 4604.4 4733.2 4755.6 4778.5 4797.8 4328.0 4417.7 4418.0 4432.6 4434.6 5143.8 5198.2 5201.5 5207.6 5251.6 4887.2 5088.6 5095.3 5102.6 5116.3 5109.4 5130.6 5133.5 5198.1 5218.4 4938.7 4948.4 4950.0 4967.6 5025.4 4958.8 4985.6 4990.8 5022.3 5041.4 4760.7 4891.0 4907.2 4924.5 4940.3 4896.8 4902.6 4918.8 4923.7 4965.4 4600.2 4752.0 4810.9 4859.8 4889.7 4849.2 4866.8 4986.6 5019.1 5057.5 4855.9 4866.3 4877.7 4884.2 4941.0 05:29:36 INFO - 2015-11-06 05:29:36,003 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,003 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42443.06 Median:30722.54 stddev:70932.48 (230.9%) stddev-sans-first:71061.53 05:29:36 INFO - 2015-11-06 05:29:36,005 DEBUG : BROWSER_OUTPUT: Values: 492.3 498.2 500.0 507.7 522.9 27902.3 35186.1 35863.6 36216.0 36244.8 38527.0 39032.4 39450.6 39451.0 39550.0 7257.1 7328.0 8069.2 8219.9 8365.9 9525.8 9600.7 9636.0 9672.0 9723.9 9537.7 9571.4 9576.1 9645.6 9670.3 7053.7 7372.5 9528.3 9541.8 9633.2 9472.2 9581.6 9595.4 9643.1 9706.9 35907.5 35919.1 35968.0 36107.5 36540.5 2709.9 2718.9 2800.1 2890.0 3091.0 25091.9 25162.9 25411.6 25876.1 26123.7 2085.5 2107.2 2111.4 2117.4 2223.3 279411.0 280885.0 282417.0 282424.0 282552.0 50446.5 51909.0 55242.4 58800.7 61398.0 56168.4 56443.7 56581.0 57113.0 57181.7 13427.1 13537.1 13559.7 13630.8 13676.5 10015.5 10117.2 10150.0 10190.9 10258.8 17870.6 17908.3 17912.5 17985.8 18084.7 7528.5 7736.7 7785.6 7794.9 7850.2 818.0 834.5 897.2 929.9 952.8 25392.1 25872.2 25974.9 26024.2 26087.0 956.3 1030.0 1070.6 1100.9 1107.7 13275.2 13341.9 13417.7 13428.9 13436.9 272470.0 277664.0 278555.0 279333.0 281187.0 49824.5 49948.8 50014.2 50438.2 50484.7 1204.3 1211.3 1211.9 1212.5 1222.0 25279.1 25519.9 25618.4 25750.4 25814.2 43884.6 44165.6 44352.6 44638.6 44768.6 250724.0 252611.0 253858.0 254941.0 255160.0 24463.6 24673.6 27867.3 28557.1 29392.3 37734.4 37997.6 38092.4 38688.8 38769.4 31307.8 31465.4 32100.5 32327.7 32619.0 26084.6 30695.1 30750.0 31362.5 31590.2 28474.1 30177.0 30193.4 30575.4 30580.2 25123.5 25592.5 26454.7 26834.9 26896.0 21107.5 21366.8 21717.6 21719.5 21949.8 05:29:36 INFO - 2015-11-06 05:29:36,005 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,005 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24939.84 Median:4733.93 stddev:83894.87 (1772.2%) stddev-sans-first:84109.81 05:29:36 INFO - 2015-11-06 05:29:36,006 DEBUG : BROWSER_OUTPUT: Values: 294.6 294.6 298.2 302.3 305.4 14785.8 15353.9 15779.1 16143.1 16196.1 12763.1 12957.5 13086.2 13156.5 15541.2 4656.1 4784.6 4823.2 4840.5 4852.7 4732.0 4732.1 4735.7 4759.5 4765.9 3857.9 3874.3 3891.3 4154.0 4730.2 4705.0 4741.1 4804.7 4808.9 4809.3 4051.7 4100.2 4148.8 4154.3 4217.1 19364.9 19366.2 19405.4 19415.0 19579.2 1764.1 1856.9 1884.8 1934.8 1986.6 11933.4 12148.6 12164.1 12425.9 12545.0 1455.7 1456.3 1475.1 1504.9 1522.4 40757.6 43088.8 47184.8 50099.5 52257.2 7572.0 8349.9 8472.0 8563.1 8616.2 9985.8 10034.7 10040.3 10246.8 10253.9 6522.9 6543.5 6659.6 6709.1 6829.1 6803.1 6838.6 6884.9 6886.6 6905.4 5116.3 5190.6 5191.8 5195.7 5242.4 1475.8 1488.1 1490.7 1502.5 1528.5 351.1 356.8 360.8 806.5 861.1 8502.4 9097.4 9144.0 9311.6 9530.6 358.2 362.2 366.4 374.7 375.9 4627.1 4669.2 4729.9 4902.0 5061.0 498904.0 505488.0 515388.0 519998.0 528159.0 61276.0 61701.4 61763.4 62021.4 62287.7 366.3 367.6 373.6 374.1 376.5 8580.7 8591.7 8603.9 8618.3 8629.8 28881.7 29228.6 29413.4 29626.9 30402.4 38707.6 39685.6 39759.8 39844.2 40123.6 5358.1 5453.6 5459.2 5530.2 5530.8 9914.7 10358.5 10365.8 10480.2 10489.4 8349.7 8638.6 8913.4 9006.8 9054.8 7906.2 8793.8 8794.4 8899.6 8915.0 9215.0 9359.2 9406.7 9424.8 9481.6 5408.1 5421.2 5444.8 5525.9 5577.7 8877.4 9037.1 9065.1 9147.3 9168.5 05:29:36 INFO - 2015-11-06 05:29:36,007 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,007 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4653.99 Median:5922.01 stddev:2420.42 (40.9%) stddev-sans-first:2412.76 05:29:36 INFO - 2015-11-06 05:29:36,008 DEBUG : BROWSER_OUTPUT: Values: 1135.7 1532.4 1553.9 1603.4 1610.6 5908.0 6164.3 6511.4 6665.7 6676.9 6611.8 6707.8 6755.1 6803.1 6819.1 1689.8 1734.5 1873.1 1896.1 1921.1 1901.5 1936.5 1939.2 1942.0 1961.2 1857.6 1890.6 1898.2 1923.2 1954.6 1893.9 1911.8 1921.3 1922.0 1929.9 1886.5 1916.9 1917.4 1919.2 1947.2 6538.6 6619.8 6621.1 6621.9 6714.7 3934.5 4008.8 4017.0 4028.9 4053.3 2354.9 2421.1 2438.2 2487.3 2497.6 627.5 640.3 701.9 715.0 721.9 8726.7 8787.1 8794.3 8856.8 8881.5 3706.3 3713.9 3757.3 3788.9 3794.6 7700.0 7712.6 7724.7 7725.3 7745.8 4186.7 4186.9 4190.2 4228.2 4250.8 3837.7 3842.4 3849.8 3850.3 3862.7 3183.4 3193.4 3212.1 3213.5 3236.9 988.7 994.3 999.4 1005.0 1011.7 946.7 971.1 976.4 1008.6 1170.9 6391.8 6404.2 6414.0 6420.0 6424.6 370.1 370.3 379.0 393.8 397.7 5055.6 5112.0 5116.8 5121.6 5165.7 7402.9 7826.6 7864.3 8012.1 8033.0 7575.2 7705.9 7850.5 7858.7 7975.1 6232.3 6330.1 6337.6 6346.4 6440.0 6150.5 6284.1 6286.1 6350.0 6356.0 7053.5 7139.5 7142.4 7174.7 7267.2 7146.4 7270.6 7282.5 7304.9 7407.3 5870.4 5912.3 5934.1 5937.7 5996.7 6405.4 6467.9 6506.8 6517.6 6525.5 5824.2 5969.0 5978.2 6087.0 6089.1 5916.2 5918.5 5925.5 5974.8 6097.7 5913.8 5968.9 5971.4 5990.0 6030.6 5503.9 5521.2 5559.2 5560.2 5579.4 5594.3 5637.2 5637.6 5657.7 5672.1 05:29:36 INFO - 2015-11-06 05:29:36,009 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,009 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4595.70 Median:5293.47 stddev:1414.14 (26.7%) stddev-sans-first:1380.16 05:29:36 INFO - 2015-11-06 05:29:36,010 DEBUG : BROWSER_OUTPUT: Values: 260.2 269.4 274.0 274.8 277.6 5239.2 5255.6 5294.8 5306.9 5311.3 5108.9 5248.0 5268.2 5270.7 5307.4 3860.1 3903.1 3904.7 3916.7 3959.7 3914.5 3999.3 4003.2 4011.6 4013.9 3816.3 3933.5 3971.5 3999.2 4019.4 3881.3 3930.7 3950.8 3955.5 4017.2 3427.1 3429.0 3447.5 3489.7 3496.8 5064.1 5068.8 5102.9 5117.5 5137.5 4477.1 4480.9 4504.3 4506.2 4517.2 5363.8 5420.0 5437.5 5472.5 5476.7 3677.2 3682.0 3728.7 3731.4 3739.9 5664.4 5689.5 5691.7 5720.8 5725.9 3643.8 3738.2 3739.6 3754.3 3776.5 3659.5 3758.8 3769.0 3779.3 3822.5 4456.1 4456.2 4456.7 4507.3 4509.3 5499.9 5528.4 5571.0 5573.3 5575.6 1340.9 1365.9 1367.5 1368.3 1386.3 859.7 882.6 884.7 894.1 896.0 5215.9 5228.0 5228.6 5243.3 5292.1 5727.4 5740.3 5748.2 5800.7 5824.4 5201.5 5222.2 5229.2 5282.9 5287.9 2999.6 3046.7 3169.3 3185.6 3186.9 5815.9 5826.2 5829.7 5896.3 5900.2 5839.0 5853.3 5856.2 5882.5 5883.3 5741.1 5777.4 5845.9 5870.1 5892.0 5745.0 5749.1 5766.1 5818.4 5832.8 5613.1 5631.7 5688.2 5691.1 5699.2 5851.1 5869.2 5890.4 5896.4 5928.0 3669.0 3712.0 3745.5 3765.4 3768.2 5645.9 5647.5 5704.5 5707.3 5708.0 5518.9 5522.1 5531.8 5597.4 5599.4 5390.0 5477.2 5558.1 5563.6 5605.2 5410.1 5419.2 5459.2 5459.3 5503.0 5542.4 5614.6 5616.6 5622.4 5627.8 5301.7 5401.2 5416.2 5437.0 5478.8 05:29:36 INFO - 2015-11-06 05:29:36,010 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,010 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11707.28 Median:6041.55 stddev:14048.71 (232.5%) stddev-sans-first:14063.64 05:29:36 INFO - 2015-11-06 05:29:36,011 DEBUG : BROWSER_OUTPUT: Values: 663.2 672.2 687.6 688.4 725.1 11616.0 11977.5 12016.4 12054.8 12179.2 10766.4 11306.5 11483.5 11519.3 12297.8 785.4 801.3 802.0 802.5 813.0 805.0 809.7 813.8 814.9 826.4 846.9 849.3 849.6 850.1 851.0 844.0 845.6 846.0 849.0 857.7 615.8 627.2 628.6 629.8 631.2 11883.2 12004.5 12007.8 12021.5 12028.9 9798.8 10036.5 10060.9 10430.3 10798.7 8126.0 8308.3 8327.8 8425.8 8515.7 2875.6 2915.1 2995.6 3039.9 3098.9 35832.0 37816.4 40042.0 40260.4 41989.2 7776.3 7824.9 7883.6 8049.7 8279.5 15781.8 15784.4 15791.5 15949.3 15977.1 6016.1 6037.5 6045.6 6052.8 6328.0 3368.8 3373.4 3405.2 3414.2 3425.9 2496.3 2498.4 2507.7 2518.5 2532.0 386.8 391.1 393.7 394.8 399.4 478.1 506.8 510.7 530.9 536.9 6391.5 6617.6 6776.9 6845.3 6848.2 484.2 513.3 516.9 533.1 542.3 3166.8 3202.6 3210.8 3217.8 3219.3 53012.5 53364.2 53375.5 53876.0 54066.7 37967.2 37988.0 46094.3 47057.8 47077.8 37000.8 40784.8 40862.4 41396.8 41519.6 7041.0 7041.5 7053.4 7316.3 7505.7 30201.4 30299.8 31094.7 32022.5 32170.0 35322.5 35616.0 39432.2 40249.8 43026.6 6770.0 6795.0 6818.1 6882.9 7129.3 9572.9 9642.1 9780.0 9904.7 9948.3 9352.4 9440.1 9487.2 9556.2 9564.2 9006.7 9178.9 9208.9 9511.8 9629.3 9151.9 9234.1 9451.4 9468.7 9555.9 7686.1 7766.8 7836.7 8035.3 8338.7 6265.4 6582.0 6686.2 6752.4 6757.6 05:29:36 INFO - 2015-11-06 05:29:36,012 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:36 INFO - 2015-11-06 05:29:36,012 DEBUG : BROWSER_OUTPUT: 05:29:36 INFO - 2015-11-06 05:29:36,695 INFO : Browser exited with error code: 0 05:29:36 INFO - 2015-11-06 05:29:36,726 INFO : Completed test dromaeo_css (00:18:35) 05:29:36 INFO - 2015-11-06 05:29:36,726 INFO : Starting test kraken 05:29:36 INFO - 2015-11-06 05:29:36,726 DEBUG : operating with platform_type : mac_ 05:29:36 INFO - 2015-11-06 05:29:36,726 INFO : Initialising browser for kraken test... 05:29:36 INFO - 2015-11-06 05:29:36,740 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/tmpUUYzde/profile http://localhost:49278/getInfo.html 05:29:39 INFO - 2015-11-06 05:29:39,157 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:39 INFO - 2015-11-06 05:29:39,157 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:39 INFO - 2015-11-06 05:29:39,158 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:29:39 INFO - 2015-11-06 05:29:39,158 DEBUG : BROWSER_OUTPUT: __metrics 05:29:39 INFO - 2015-11-06 05:29:39,178 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:39 INFO - 2015-11-06 05:29:39,928 INFO : Browser initialized. 05:29:39 INFO - 2015-11-06 05:29:39,928 INFO : Running cycle 1/1 for kraken test... 05:29:39 INFO - 2015-11-06 05:29:39,928 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/tmpUUYzde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:51 INFO - 2015-11-06 05:29:51,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 221507584 05:29:51 INFO - 2015-11-06 05:29:51,928 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-11-06 05:29:54,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:55 INFO - 2015-11-06 05:29:55,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 280170496 05:29:55 INFO - 2015-11-06 05:29:55,375 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-06 05:29:58,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:29:58 INFO - 2015-11-06 05:29:58,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 289914880 05:29:58 INFO - 2015-11-06 05:29:58,912 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-06 05:30:02,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:30:02 INFO - 2015-11-06 05:30:02,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 270688256 05:30:02 INFO - 2015-11-06 05:30:02,759 DEBUG : BROWSER_OUTPUT: 05:30:04 INFO - 2015-11-06 05:30:04,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:30:05 INFO - 2015-11-06 05:30:05,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 272551936 05:30:05 INFO - 2015-11-06 05:30:05,566 DEBUG : BROWSER_OUTPUT: 05:30:07 INFO - 2015-11-06 05:30:07,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:08 INFO - 2015-11-06 05:30:08,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 274436096 05:30:08 INFO - 2015-11-06 05:30:08,535 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-06 05:30:11,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:12 INFO - 2015-11-06 05:30:12,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 274341888 05:30:12 INFO - 2015-11-06 05:30:12,508 DEBUG : BROWSER_OUTPUT: 05:30:16 INFO - 2015-11-06 05:30:16,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:16 INFO - 2015-11-06 05:30:16,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 272121856 05:30:16 INFO - 2015-11-06 05:30:16,594 DEBUG : BROWSER_OUTPUT: 05:30:19 INFO - 2015-11-06 05:30:19,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:30:20 INFO - 2015-11-06 05:30:20,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 271990784 05:30:20 INFO - 2015-11-06 05:30:20,364 DEBUG : BROWSER_OUTPUT: 05:30:22 INFO - 2015-11-06 05:30:22,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:22 INFO - 2015-11-06 05:30:22,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 309526528 05:30:22 INFO - 2015-11-06 05:30:22,623 DEBUG : BROWSER_OUTPUT: 05:30:24 INFO - 2015-11-06 05:30:24,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:25 INFO - 2015-11-06 05:30:25,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 310157312 05:30:25 INFO - 2015-11-06 05:30:25,209 DEBUG : BROWSER_OUTPUT: 05:30:27 INFO - 2015-11-06 05:30:27,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:28 INFO - 2015-11-06 05:30:28,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 317571072 05:30:28 INFO - 2015-11-06 05:30:28,092 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-11-06 05:30:30,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:31 INFO - 2015-11-06 05:30:31,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 318664704 05:30:31 INFO - 2015-11-06 05:30:31,547 DEBUG : BROWSER_OUTPUT: 05:30:34 INFO - 2015-11-06 05:30:34,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:34 INFO - 2015-11-06 05:30:34,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 317779968 05:30:34 INFO - 2015-11-06 05:30:34,977 DEBUG : BROWSER_OUTPUT: 05:30:36 INFO - 2015-11-06 05:30:36,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:30:37 INFO - 2015-11-06 05:30:37,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 377823232 05:30:37 INFO - 2015-11-06 05:30:37,116 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,117 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:37 INFO - 2015-11-06 05:30:37,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:37 INFO - 2015-11-06 05:30:37,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:37 INFO - 2015-11-06 05:30:37,117 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:37 INFO - 2015-11-06 05:30:37,117 DEBUG : BROWSER_OUTPUT: |0;ai-astar;120;126;121;127;121;120;126;128;118;121 05:30:37 INFO - 2015-11-06 05:30:37,117 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;178;152;175;192;147;173;171;141;191;149 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |2;audio-dft;179;188;186;182;182;188;184;181;181;189 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;94;97;99;80;80;81;88;90;76 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;108;115;158;104;100;99;148;104;104;152 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;135;136;142;133;130;135;133;130;134 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;147;147;144;141;147;147;141;147;146 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;117;119;117;118;114;119;117;119;117;114 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;64;64;66;67;67;69;76;66;63 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;75;76;79;80;80;79;76;76;77 05:30:37 INFO - 2015-11-06 05:30:37,118 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;100;100;101;101;98;96;97;102;101 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;148;154;140;153;143;145;149;150;153 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;164;178;174;158;169;174;181;175;156;157 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;79;79;85;84;83;84;83;81;79 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,934 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:37 INFO - 2015-11-06 05:30:37,119 DEBUG : BROWSER_OUTPUT: __startTimestamp1446816637116__endTimestamp 05:30:37 INFO - 2015-11-06 05:30:37,120 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:37 INFO - 2015-11-06 05:30:37,121 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:30:37 INFO - 2015-11-06 05:30:37,121 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,122 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.80 Median:123.50 stddev:3.55 (2.9%) stddev-sans-first:3.62 05:30:37 INFO - 2015-11-06 05:30:37,122 DEBUG : BROWSER_OUTPUT: Values: 120.0 126.0 121.0 127.0 121.0 120.0 126.0 128.0 118.0 121.0 05:30:37 INFO - 2015-11-06 05:30:37,122 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,123 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:166.90 Median:174.00 stddev:18.45 (10.6%) stddev-sans-first:19.12 05:30:37 INFO - 2015-11-06 05:30:37,123 DEBUG : BROWSER_OUTPUT: Values: 178.0 152.0 175.0 192.0 147.0 173.0 171.0 141.0 191.0 149.0 05:30:37 INFO - 2015-11-06 05:30:37,124 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,124 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:184.00 Median:185.00 stddev:3.53 (1.9%) stddev-sans-first:3.24 05:30:37 INFO - 2015-11-06 05:30:37,124 DEBUG : BROWSER_OUTPUT: Values: 179.0 188.0 186.0 182.0 182.0 188.0 184.0 181.0 181.0 189.0 05:30:37 INFO - 2015-11-06 05:30:37,124 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,124 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.30 Median:89.00 stddev:8.39 (9.4%) stddev-sans-first:8.35 05:30:37 INFO - 2015-11-06 05:30:37,124 DEBUG : BROWSER_OUTPUT: Values: 78.0 94.0 97.0 99.0 80.0 80.0 81.0 88.0 90.0 76.0 05:30:37 INFO - 2015-11-06 05:30:37,125 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,125 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.20 Median:131.50 stddev:23.63 (18.0%) stddev-sans-first:24.71 05:30:37 INFO - 2015-11-06 05:30:37,125 DEBUG : BROWSER_OUTPUT: Values: 108.0 115.0 158.0 104.0 100.0 99.0 148.0 104.0 104.0 152.0 05:30:37 INFO - 2015-11-06 05:30:37,125 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,125 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.30 Median:135.00 stddev:3.40 (2.5%) stddev-sans-first:3.60 05:30:37 INFO - 2015-11-06 05:30:37,125 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 136.0 142.0 133.0 130.0 135.0 133.0 130.0 134.0 05:30:37 INFO - 2015-11-06 05:30:37,126 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,126 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.80 Median:147.00 stddev:2.78 (1.9%) stddev-sans-first:2.59 05:30:37 INFO - 2015-11-06 05:30:37,126 DEBUG : BROWSER_OUTPUT: Values: 141.0 147.0 147.0 144.0 141.0 147.0 147.0 141.0 147.0 146.0 05:30:37 INFO - 2015-11-06 05:30:37,126 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.10 Median:117.50 stddev:1.85 (1.6%) stddev-sans-first:1.96 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: Values: 117.0 119.0 117.0 118.0 114.0 119.0 117.0 119.0 117.0 114.0 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:3.98 (6.0%) stddev-sans-first:3.89 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 64.0 66.0 67.0 67.0 69.0 76.0 66.0 63.0 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:78.00 stddev:2.77 (3.5%) stddev-sans-first:1.94 05:30:37 INFO - 2015-11-06 05:30:37,127 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 76.0 79.0 80.0 80.0 79.0 76.0 76.0 77.0 05:30:37 INFO - 2015-11-06 05:30:37,128 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,128 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:99.00 Median:98.00 stddev:2.62 (2.7%) stddev-sans-first:2.07 05:30:37 INFO - 2015-11-06 05:30:37,128 DEBUG : BROWSER_OUTPUT: Values: 94.0 100.0 100.0 101.0 101.0 98.0 96.0 97.0 102.0 101.0 05:30:37 INFO - 2015-11-06 05:30:37,128 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,128 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:149.50 stddev:4.77 (3.2%) stddev-sans-first:4.85 05:30:37 INFO - 2015-11-06 05:30:37,128 DEBUG : BROWSER_OUTPUT: Values: 144.0 148.0 154.0 140.0 153.0 143.0 145.0 149.0 150.0 153.0 05:30:37 INFO - 2015-11-06 05:30:37,129 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,129 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:174.00 stddev:9.24 (5.3%) stddev-sans-first:9.65 05:30:37 INFO - 2015-11-06 05:30:37,130 DEBUG : BROWSER_OUTPUT: Values: 164.0 178.0 174.0 158.0 169.0 174.0 181.0 175.0 156.0 157.0 05:30:37 INFO - 2015-11-06 05:30:37,130 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,130 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.40 Median:83.00 stddev:2.76 (3.3%) stddev-sans-first:2.42 05:30:37 INFO - 2015-11-06 05:30:37,130 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 79.0 85.0 84.0 83.0 84.0 83.0 81.0 79.0 05:30:37 INFO - 2015-11-06 05:30:37,130 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:37 INFO - 2015-11-06 05:30:37,131 DEBUG : BROWSER_OUTPUT: 05:30:37 INFO - 2015-11-06 05:30:37,862 INFO : Browser exited with error code: 0 05:30:37 INFO - 2015-11-06 05:30:37,914 INFO : Completed test kraken (00:01:01) 05:30:37 INFO - 2015-11-06 05:30:37,914 INFO : Starting test v8_7 05:30:37 INFO - 2015-11-06 05:30:37,914 DEBUG : operating with platform_type : mac_ 05:30:37 INFO - 2015-11-06 05:30:37,914 INFO : Initialising browser for v8_7 test... 05:30:37 INFO - 2015-11-06 05:30:37,928 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/tmpPmxu2L/profile http://localhost:49278/getInfo.html 05:30:40 INFO - 2015-11-06 05:30:40,522 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:40 INFO - 2015-11-06 05:30:40,522 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:40 INFO - 2015-11-06 05:30:40,522 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:30:40 INFO - 2015-11-06 05:30:40,522 DEBUG : BROWSER_OUTPUT: __metrics 05:30:40 INFO - 2015-11-06 05:30:40,539 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:41 INFO - 2015-11-06 05:30:41,280 INFO : Browser initialized. 05:30:41 INFO - 2015-11-06 05:30:41,280 INFO : Running cycle 1/1 for v8_7 test... 05:30:41 INFO - 2015-11-06 05:30:41,281 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/T/tmpPmxu2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:53 INFO - 2015-11-06 05:30:53,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 221634560 05:30:53 INFO - 2015-11-06 05:30:53,278 DEBUG : BROWSER_OUTPUT: 05:31:15 INFO - 2015-11-06 05:31:15,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/v8_7/run.html (next: http://localhost:49278/tests/v8_7/run.html) 05:31:16 INFO - 2015-11-06 05:31:16,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 642138112 05:31:16 INFO - 2015-11-06 05:31:16,136 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,137 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:16 INFO - 2015-11-06 05:31:16,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:16 INFO - 2015-11-06 05:31:16,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:16 INFO - 2015-11-06 05:31:16,137 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:16 INFO - 2015-11-06 05:31:16,137 DEBUG : BROWSER_OUTPUT: |0;Richards;189.25056775170324 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;229.9908003679853 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |2;Encrypt;360.75036075036076 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6863.013698630137 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2366.4302600472815 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |5;Earley;1025.6410256410256 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |6;Boyer;14300 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |7;RegExp;32758.064516129034 05:31:16 INFO - 2015-11-06 05:31:16,138 DEBUG : BROWSER_OUTPUT: |8;Splay;795.5449482895783 05:31:16 INFO - 2015-11-06 05:31:16,139 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6562.091503267974 05:31:16 INFO - 2015-11-06 05:31:16,139 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:16 INFO - 2015-11-06 05:31:16,139 DEBUG : BROWSER_OUTPUT: __startTimestamp1446816676136__endTimestamp 05:31:16 INFO - 2015-11-06 05:31:16,139 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,139 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:16 INFO - 2015-11-06 05:31:16,140 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:31:16 INFO - 2015-11-06 05:31:16,141 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,141 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.25 Median:189.25 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,141 DEBUG : BROWSER_OUTPUT: Values: 189.3 05:31:16 INFO - 2015-11-06 05:31:16,141 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,141 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:229.99 Median:229.99 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,141 DEBUG : BROWSER_OUTPUT: Values: 230.0 05:31:16 INFO - 2015-11-06 05:31:16,141 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,142 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:360.75 Median:360.75 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,142 DEBUG : BROWSER_OUTPUT: Values: 360.8 05:31:16 INFO - 2015-11-06 05:31:16,142 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,142 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6863.01 Median:6863.01 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,142 DEBUG : BROWSER_OUTPUT: Values: 6863.0 05:31:16 INFO - 2015-11-06 05:31:16,142 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,143 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2366.43 Median:2366.43 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,143 DEBUG : BROWSER_OUTPUT: Values: 2366.4 05:31:16 INFO - 2015-11-06 05:31:16,143 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,143 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1025.64 Median:1025.64 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,143 DEBUG : BROWSER_OUTPUT: Values: 1025.6 05:31:16 INFO - 2015-11-06 05:31:16,143 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,143 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14300.00 Median:14300.00 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: Values: 14300.0 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32758.06 Median:32758.06 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: Values: 32758.1 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: Values: 795.5 05:31:16 INFO - 2015-11-06 05:31:16,144 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,145 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6562.09 Median:6562.09 stddev:0.00 (0.0%) 05:31:16 INFO - 2015-11-06 05:31:16,145 DEBUG : BROWSER_OUTPUT: Values: 6562.1 05:31:16 INFO - 2015-11-06 05:31:16,145 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:16 INFO - 2015-11-06 05:31:16,145 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-06 05:31:16,867 INFO : Browser exited with error code: 0 05:31:16 INFO - 2015-11-06 05:31:16,889 INFO : Completed test v8_7 (00:00:38) 05:31:17 INFO - 2015-11-06 05:31:17,160 INFO : Completed test suite (00:20:16) 05:31:17 INFO - 2015-11-06 05:31:17,160 DEBUG : Working with test: dromaeo_css 05:31:17 INFO - 2015-11-06 05:31:17,160 DEBUG : Generating results file: dromaeo_css 05:31:17 INFO - 2015-11-06 05:31:17,161 DEBUG : Working with test: kraken 05:31:17 INFO - 2015-11-06 05:31:17,161 DEBUG : Generating results file: kraken 05:31:17 INFO - 2015-11-06 05:31:17,161 INFO : javascript benchmark 05:31:17 INFO - 2015-11-06 05:31:17,161 DEBUG : Working with test: v8_7 05:31:17 INFO - 2015-11-06 05:31:17,161 DEBUG : Generating results file: v8_7 05:31:17 INFO - 2015-11-06 05:31:17,162 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:17 INFO - 2015-11-06 05:31:17,226 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 05:31:17 INFO - 2015-11-06 05:31:17,226 DEBUG : process_Request line: dromaeo_css 5885.02 graph.html#tests=[[72,1,55]] 05:31:17 INFO - 2015-11-06 05:31:17,226 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:17 INFO - 2015-11-06 05:31:17,270 DEBUG : process_Request line: kraken 1715.60 graph.html#tests=[[232,1,55]] 05:31:17 INFO - 2015-11-06 05:31:17,270 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:17 INFO - 2015-11-06 05:31:17,305 DEBUG : process_Request line: v8_7 15820.66 graph.html#tests=[[230,1,55]] 05:31:17 INFO - 2015-11-06 05:31:17,306 INFO : javascript benchmark 05:31:17 INFO - 2015-11-06 05:31:17,308 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [294.5802231819658, 294.6405385429775, 298.1695976704877, 302.30922342447496, 305.36179385085177, 14785.778213326796, 15353.923230383847, 15779.053256804586, 16143.112128832909, 16196.109213993226, 12763.106582539203, 12957.546485872996, 13086.214827110356, 13156.539521116763, 15541.22293885304, 4656.115338085761, 4784.5933095686905, 4823.20417131173, 4840.540148685886, 4852.733099679534, 4732.02993386355, 4732.124556956974, 4735.73953432561, 4759.452662943754, 4765.90468190636, 3857.864974725885, 3874.302625527418, 3891.2801131790566, 4153.958460415402, 4730.172219861528, 4704.952950470502, 4741.075490279397, 4804.711717296938, 4808.855734327975, 4809.302651115586, 4051.7163798534116, 4100.220958017967, 4148.813303401324, 4154.252234597771, 4217.051163488221, 19364.903175484033, 19366.225350986086, 19405.4178374649, 19415.0, 19579.21683132673, 1764.056229917001, 1856.860735444847, 1884.8397886179691, 1934.806519348068, 1986.6424043672134, 11933.40332983356, 12148.635540933787, 12164.08769342303, 12425.93787031059, 12545.0, 1455.65064384548, 1456.2573087725336, 1475.085447022842, 1504.9021813582192, 1522.3529999750062, 40757.59242407568, 43088.78455607702, 47184.764076179745, 50099.49900501021, 52257.216141757905, 7572.0, 8349.916500835036, 8472.025717042496, 8563.100874408223, 8616.224539791323, 9985.750356241153, 10034.74913127163, 10040.34737742059, 10246.795064098826, 10253.948730256301, 6522.869542609121, 6543.476521878239, 6659.567128136752, 6709.127813384229, 6829.146356705412, 6803.149606299213, 6838.589684618939, 6884.896726549106, 6886.552374095668, 6905.37851593359, 5116.258142569307, 5190.55880250183, 5191.8182863599595, 5195.714235716996, 5242.397124330751, 1475.7972252614086, 1488.1071357185817, 1490.6571488557477, 1502.5417247739326, 1528.510876519503, 351.11518972189936, 356.84120566348247, 360.7763186824186, 806.487880196068, 861.1259571534897, 8502.404831661848, 9097.363184577016, 9144.039875813078, 9311.580978855967, 9530.618775248913, 358.23695528524075, 362.1778562662741, 366.40459253712714, 374.66841844966854, 375.94548790425233, 4627.1439783640135, 4669.2062349400685, 4729.929051064168, 4901.950980490221, 5060.974695126501, 498904.0, 505488.0, 515388.0, 519998.0, 528159.0, 61276.0, 61701.38298617046, 61763.38236617666, 62021.379786202466, 62287.68856155781, 366.2893985667796, 367.59564479072804, 373.5666626713, 374.0536442799721, 376.47669739062724, 8580.742577722678, 8591.742247732578, 8603.913960860562, 8618.267447267053, 8629.784255393666, 28881.711182887902, 29228.561571576018, 29413.411731765675, 29626.851865740533, 30402.391952161277, 38707.6129238704, 39685.60314396819, 39759.80120099381, 39844.2031159381, 40123.598764011986, 5358.115910874662, 5453.563714902878, 5459.235707001102, 5530.198121272312, 5530.7511161997, 9914.652987145415, 10358.482075896325, 10365.84451233217, 10480.213983951082, 10489.423081730578, 8349.749507514784, 8638.56807159652, 8913.37606367574, 9006.774830629287, 9054.773630659287, 7906.248906353887, 8793.757591814046, 8794.42836215644, 8899.555022248991, 8914.955425222832, 9214.953925230331, 9359.204467620057, 9406.717798466058, 9424.811503770023, 9481.573329200064, 5408.0806262936185, 5421.186821976735, 5444.8366549003595, 5525.917111243415, 5577.74900129487, 8877.422967507091, 9037.141471560191, 9065.13881181313, 9147.313951453802, 9168.495732734764], "dojo.html": [2762.212769360732, 2817.619621351117, 2825.47728670196, 2840.815347002446, 2854.5860850176723, 4507.72953622782, 4639.420072490939, 4651.7441540715245, 4699.647526435522, 4782.282657601361, 4626.86119416418, 4646.674732768707, 4656.138614356338, 4759.214729569626, 4806.855794326176, 4231.788410579474, 4289.914201715964, 4318.956810431887, 4320.200762858865, 4323.178596066753, 4433.423654924855, 4433.866983990485, 4440.356148358486, 4468.731876087445, 4475.619572336339, 4203.789810509493, 4249.46881639795, 4310.956890431118, 4395.406620106277, 4512.34570987205, 4390.934135987963, 4398.516163222043, 4403.977980110111, 4421.6904816662845, 4448.266036104039, 4363.585459381354, 4379.43067401239, 4396.78016099197, 4403.295472724349, 4413.44831896013, 4421.9336709949375, 4534.7052441591195, 4556.931646025312, 4600.677952543323, 4726.574608285271, 5009.799608015675, 5047.49525047496, 5049.419316778581, 5121.027004869063, 5138.614603904722, 5088.185890257578, 5102.744862756847, 5111.948880511184, 5162.664426812245, 5226.843194704165, 4563.361129441914, 4692.835750748707, 4755.5719985201495, 4756.833510827105, 4851.248056551241, 5178.145605974972, 5182.24857395683, 5190.065788158167, 5191.299174611379, 5274.235235890775, 4978.32792572998, 4987.900241995212, 5001.57486613642, 5022.246663000579, 5047.041062198171, 4821.445533763592, 4932.136876046678, 4937.11131996237, 5021.623378246573, 5147.40804807452, 4958.305837182797, 4971.502849715, 4991.700497970133, 5014.172661510883, 5034.622403319766, 4954.628402869799, 4981.526754958273, 4983.875403114951, 4986.177280748709, 5012.624053196025, 3759.398496240643, 3957.3470377387985, 3965.6827453803626, 3974.4634474345594, 4011.3982902564267, 3519.225770330523, 3634.818259087035, 3644.3804553226014, 3658.579263384745, 3659.2315613721416, 4703.905921881543, 4715.056988602225, 4733.337332773414, 4736.478987311393, 4756.524347565216, 5083.059633967728, 5085.542301192836, 5095.847124586268, 5119.0, 5147.356580427447, 4604.355390245369, 4733.242681170997, 4755.595774359149, 4778.522147785263, 4797.784099715521, 4327.956720432819, 4417.734935903856, 4417.955820441754, 4432.601065904084, 4434.623057040188, 5143.794248230029, 5198.168293073166, 5201.453847345974, 5207.557357624644, 5251.6061295403, 4887.169181239126, 5088.59291256706, 5095.286659867696, 5102.566281866083, 5116.30929824469, 5109.412417571878, 5130.58955283569, 5133.460986596354, 5198.142306519382, 5218.373795144607, 4938.703677779345, 4948.430930443045, 4949.950500494949, 4967.552920237196, 5025.3718285214345, 4958.826441074545, 4985.6011519077665, 4990.8253211137435, 5022.321986531918, 5041.4454410015605, 4760.714357138583, 4891.046245981999, 4907.165781817028, 4924.482929292372, 4940.258961155855, 4896.828610998598, 4902.60779137661, 4918.803247870045, 4923.655344125877, 4965.4041515018425, 4600.240960241523, 4752.025834703808, 4810.855674329776, 4859.781309840995, 4889.657723959289, 4849.224124140121, 4866.78099485531, 4986.601071914166, 5019.121653710513, 5057.519535644108, 4855.878603034952, 4866.343043689057, 4877.658563900635, 4884.218525036119, 4941.0], "mootools.html": [1135.73310272086, 1532.4253404973133, 1553.9223038848054, 1603.4147536149305, 1610.6295552023034, 5907.970460147704, 6164.321924588292, 6511.381418765216, 6665.666716664159, 6676.9332306676915, 6611.768588099418, 6707.832304192385, 6755.054292399068, 6803.149606299213, 6819.1135152430115, 1689.763433119358, 1734.453647101159, 1873.1009115624508, 1896.0614495824518, 1921.077882616338, 1901.5246188452886, 1936.457791818286, 1939.2049259803484, 1941.9998700669166, 1961.1959096770327, 1857.6099019205983, 1890.6124244529908, 1898.1742941820282, 1923.2114832918505, 1954.5504533957198, 1893.867429279951, 1911.8183772541656, 1921.2795201799324, 1921.9519512012312, 1929.8938558379284, 1886.4906475251605, 1916.865819392643, 1917.3672688012923, 1919.2418994497234, 1947.2308438166986, 6538.640374779386, 6619.801405957829, 6621.139251897271, 6621.867562648768, 6714.664266786641, 3934.488516492838, 4008.7594744315143, 4016.9957510622344, 4028.939565906514, 4053.250148722496, 2354.9274455295604, 2421.1041914491575, 2438.231956933578, 2487.315988103268, 2497.6003839385794, 627.5105417774143, 640.3308542573022, 701.9298070192991, 714.9821254468628, 721.8844984802458, 8726.69456569017, 8787.0773568775, 8794.34042446819, 8856.822863542693, 8881.511516866569, 3706.314331848617, 3713.9442908356395, 3757.342465068602, 3788.886333410002, 3794.6395092466173, 7699.960505331708, 7712.575808330484, 7724.6523906424345, 7725.266099720518, 7745.8450830983065, 4186.706930514834, 4186.874393768192, 4190.182914331676, 4228.154369126187, 4250.808713607895, 3837.654611085016, 3842.4044273137706, 3849.7690138591774, 3850.268448994682, 3862.748921320105, 3183.3951549205576, 3193.393255281489, 3212.084555901557, 3213.517972304173, 3236.9028929132164, 988.7182153086336, 994.3337963564429, 999.3953658036928, 1004.9547770350351, 1011.6661501704419, 946.7112530678072, 971.1065819446127, 976.3507267666922, 1008.5562352564848, 1170.9238899471507, 6391.776287829996, 6404.199475065617, 6414.037894315797, 6420.036994450869, 6424.550281480251, 370.13757943990436, 370.2982847503965, 378.96210378962434, 393.84639990403764, 397.6818545163857, 5055.570276526463, 5111.97444012785, 5116.846494605168, 5121.641485096007, 5165.715885626327, 7402.925970740223, 7826.608669566499, 7864.331531819859, 8012.1186669466315, 8032.959835200787, 7575.166731659513, 7705.9229407706325, 7850.489718168301, 7858.685652573833, 7975.082865470546, 6232.3144454110015, 6330.050492426173, 6337.6197428154455, 6346.365363463709, 6439.9696048631995, 6150.50795936333, 6284.057391391328, 6286.119943208046, 6350.047492876106, 6356.0, 7053.506254562131, 7139.500234983501, 7142.428605711634, 7174.67713952863, 7267.236940121211, 7146.3568278855155, 7270.636468176675, 7282.4902256841515, 7304.890426643711, 7407.259274072765, 5870.354261031198, 5912.260967379078, 5934.109883517507, 5937.703114844327, 5996.67018313997, 6405.391487808651, 6467.935320646921, 6506.837329066811, 6517.641529715722, 6525.543211975116, 5824.213731146241, 5969.0, 5978.163057171912, 6087.026075828024, 6089.086637004308, 5916.201312822886, 5918.526517878646, 5925.496332811759, 5974.820755377345, 6097.695115244309, 5913.763449461973, 5968.850778730566, 5971.4327138921735, 5990.0, 6030.638161710312, 5503.862403439786, 5521.171824226398, 5559.19391688211, 5560.193771903132, 5579.4420557945505, 5594.272744543184, 5637.154426836008, 5637.633553818989, 5657.660540367591, 5672.14917762339], "ext.html": [492.27635375997284, 498.15065313640247, 499.97250151241667, 507.69269131985146, 522.8640553456103, 27902.302442438922, 35186.12034699134, 35863.64136358639, 36216.0, 36244.81877590608, 38527.0, 39032.414513782314, 39450.605493945055, 39451.0, 39550.0, 7257.129144502641, 7328.047353843993, 8069.193080691928, 8219.917800822004, 8365.916340836606, 9525.761855953588, 9600.711978640617, 9636.036396360343, 9672.0, 9723.854142187873, 9537.666181683642, 9571.377860439085, 9576.138147566717, 9645.565949532287, 9670.274729395289, 7053.717851285943, 7372.520786148883, 9528.285378596598, 9541.761455963588, 9633.181179599742, 9472.242220622402, 9581.61673533058, 9595.42427454355, 9643.08390702882, 9706.90293097074, 35907.4613880792, 35919.102022449384, 35968.0, 36107.4583881242, 36540.45189322162, 2709.905153319644, 2718.904838330649, 2800.103966730647, 2890.0, 3090.9536356954663, 25091.874540627363, 25162.874185628956, 25411.61882571763, 25876.094336698312, 26123.73876261232, 2085.5411809401908, 2107.2203284784573, 2111.3771437425844, 2117.428294360514, 2223.2552095048177, 279411.0, 280885.0, 282417.0, 282424.0, 282552.0, 50446.495535044916, 51909.0, 55242.44757552454, 58800.70599646975, 61398.0, 56168.438315616324, 56443.71778141083, 56581.0, 57113.0, 57181.714091430105, 13427.060105792696, 13537.1200871943, 13559.728805423836, 13630.795538066937, 13676.452941882413, 10015.549300281506, 10117.241206909512, 10150.0, 10190.949045254727, 10258.846117308247, 17870.642587148184, 17908.28366865337, 17912.462626121236, 17985.820141798675, 18084.728729069073, 7528.51064680794, 7736.7292144774665, 7785.571793551409, 7794.9220507795335, 7850.175731548105, 817.9918200818034, 834.470111479203, 897.2059727141396, 929.9027147965465, 952.7522844060594, 25392.111276105246, 25872.223833285032, 25974.87012564925, 26024.219273421826, 26087.0, 956.3066776586919, 1029.9742506437399, 1070.641335152717, 1100.9339439633648, 1107.7064577886867, 13275.203487790763, 13341.916553138592, 13417.731645367234, 13428.93285533566, 13436.93281533586, 272470.0, 277664.0, 278555.0, 279333.0, 281187.0, 49824.50175498271, 49948.75025624849, 50014.24978625323, 50438.243426348636, 50484.74757626262, 1204.3255776764865, 1211.2550781269456, 1211.8727533609197, 1212.4665147335145, 1221.9572314969112, 25279.11523096683, 25519.87240063788, 25618.359541011625, 25750.356241094123, 25814.225573232834, 43884.561154388044, 44165.558344416146, 44352.556474434845, 44638.55361446474, 44768.55231447774, 250724.0, 252611.0, 253858.0, 254941.0, 255160.0, 24463.633045503975, 24673.62989555122, 27867.303317417227, 28557.143285701462, 29392.26519337034, 37734.43398349082, 37997.620023799405, 38092.428613570264, 38688.80655596704, 38769.4184587237, 31307.84346078346, 31465.37069258648, 32100.518492222167, 32327.676723233406, 32619.0, 26084.61034970379, 30695.079147625605, 30750.0, 31362.529562057043, 31590.210244744067, 28474.145775626763, 30177.0, 30193.396132077676, 30575.388492230475, 30580.235494112825, 25123.497530049663, 25592.488150236517, 26454.735452645225, 26834.865825670746, 26896.0, 21107.472313192295, 21366.78633213648, 21717.56564868662, 21719.457013574785, 21949.780502194775], "prototype.html": [260.23101734374916, 269.37908121779304, 274.0381261771183, 274.8076346557409, 277.5919398484229, 5239.24031015503, 5255.579553635709, 5294.841154765359, 5306.893862122755, 5311.309529761131, 5108.924911867808, 5248.02911461379, 5268.236105764671, 5270.683758974455, 5307.389650190229, 3860.092878173634, 3903.1217975955324, 3904.726669133162, 3916.667083297923, 3959.6634286085573, 3914.53025636924, 3999.3401088820456, 4003.1793482336197, 4011.59884011598, 4013.919721605581, 3816.255830113129, 3933.4886464759543, 3971.543272523668, 3999.2201520703475, 4019.356902895537, 3881.3207688654516, 3930.6855451563806, 3950.8419663213435, 3955.46601208836, 4017.2367250222364, 3427.108951672583, 3429.0398688367295, 3447.500112483701, 3489.65103489649, 3496.8251587420527, 5064.088464076464, 5068.797248110071, 5102.897942041139, 5117.462666420047, 5137.48625137487, 4477.104579084164, 4480.910381792379, 4504.301833215857, 4506.166359223522, 4517.186906356855, 5363.839084827461, 5419.972900135514, 5437.537809286176, 5472.480114389166, 5476.67139971603, 3677.1726361568435, 3682.042668906077, 3728.664420202195, 3731.4029755239303, 3739.9252014959548, 5664.376918538957, 5689.459501347365, 5691.686957217351, 5720.8283751487525, 5725.942740572583, 3643.8178091095338, 3738.1776009277914, 3739.5886452490204, 3754.305453491113, 3776.4524143998965, 3659.5425571803526, 3758.8120593970193, 3768.9811550942068, 3779.263043706506, 3822.522184726909, 4456.108778244364, 4456.197884380777, 4456.732596044183, 4507.323901414814, 4509.346144808985, 5499.945000550023, 5528.391876893538, 5570.972145139248, 5573.331200255995, 5575.581831362664, 1340.9195448273135, 1365.9453621855214, 1367.4940272099386, 1368.3226802732513, 1386.334559411468, 859.686214531704, 882.6469412235028, 884.7390019944132, 894.088030209183, 895.9686410975585, 5215.921761173586, 5228.032813929435, 5228.63399562027, 5243.2659427680155, 5292.100342941709, 5727.427257274323, 5740.282464691913, 5748.223989761329, 5800.651960882361, 5824.359320474744, 5201.505856943584, 5222.190560463135, 5229.241759944786, 5282.867928301746, 5287.9471205287455, 2999.640043194787, 3046.6800985896607, 3169.2869104451315, 3185.569948057029, 3186.9043928682177, 5815.883682326415, 5826.2134611827705, 5829.679367634821, 5896.3219229788265, 5900.1739756434135, 5839.036558967808, 5853.268341457318, 5856.238688970492, 5882.499987501024, 5883.264591926009, 5741.13882917574, 5777.422257774189, 5845.912311315334, 5870.119482077637, 5892.027815410409, 5745.0, 5749.051406517878, 5766.077427611562, 5818.389069147678, 5832.766689332379, 5613.129964855454, 5631.718414079198, 5688.232088667977, 5691.089425691869, 5699.202111704448, 5851.063829787214, 5869.236999190078, 5890.410958904075, 5896.3514013457625, 5928.0, 3668.9816550918144, 3711.981440092782, 3745.47563341127, 3765.4351847223134, 3768.1898391845884, 5645.943540564706, 5647.463490968352, 5704.543636508986, 5707.258056452634, 5708.0, 5518.917216241679, 5522.088855338985, 5531.778728850801, 5597.384287728265, 5599.412061733459, 5390.0, 5477.233187353694, 5558.138488534284, 5563.582731295088, 5605.1872478491205, 5410.053240682943, 5419.214213939035, 5459.235707000944, 5459.317585301837, 5503.0, 5542.445755424425, 5614.63504872182, 5616.550675945833, 5622.409646987007, 5627.774889004558, 5301.655392399482, 5401.162819762943, 5416.214648875812, 5437.048516509516, 5478.808241711521], "yui.html": [663.1809715001968, 672.1530871102411, 687.5599616245606, 688.4286042584655, 725.1334655087171, 11616.0, 11977.461014254357, 12016.399180040995, 12054.819177712341, 12179.20835145715, 10766.35401875888, 11306.547738090487, 11483.540658373655, 11519.308841469518, 12297.815532767016, 785.3677789379533, 801.3308887079296, 802.0455657767238, 802.450321529751, 812.9634166462523, 804.9758507244762, 809.7449303469389, 813.7518056992615, 814.8736945773385, 826.4462809917339, 846.919542643451, 849.3078141314809, 849.5752123938031, 850.1158794853345, 851.0468275531414, 844.0293662288386, 845.5518575155178, 846.0, 849.0363437498422, 857.6526506764739, 615.7998650438625, 627.2316412394825, 628.5694299404877, 629.7795771479991, 631.2425089892148, 11883.227590206609, 12004.51981920731, 12007.759844803055, 12021.459034343388, 12028.879711202864, 9798.804023919552, 10036.498175091216, 10060.893301736804, 10430.322029068162, 10798.73003174919, 8125.959370203171, 8308.335333173332, 8327.750167494985, 8425.789355266106, 8515.701950431767, 2875.5542890851953, 2915.11089117819, 2995.5656429817554, 3039.924001899948, 3098.891538796154, 35832.0, 37816.43275350872, 40042.0, 40260.39609405861, 41989.1602167958, 7776.300132988058, 7824.921750782533, 7883.566403847729, 8049.678012879536, 8279.50322980623, 15781.842181578268, 15784.36862525509, 15791.526254212393, 15949.282282297325, 15977.121258330902, 6016.097585362143, 6037.45662890342, 6045.637261764308, 6052.788152414732, 6328.0, 3368.781029233141, 3373.4433818420175, 3405.2338223899424, 3414.214730611973, 3425.8972230833115, 2496.288557761066, 2498.350428888502, 2507.7241503434607, 2518.4711210645605, 2531.974680253211, 386.8297948902474, 391.10046892147943, 393.7047214589058, 394.82035673768365, 399.4208397823168, 478.0749250200803, 506.79981407344627, 510.7267611827654, 530.9044372012997, 536.9114096174166, 6391.456726178327, 6617.581036185676, 6776.864462710817, 6845.281245469154, 6848.246692863781, 484.22765688726423, 513.3352308760165, 516.9069567477815, 533.0671325180933, 542.3166809819655, 3166.841657917095, 3202.583664123649, 3210.7912985655857, 3217.8069315840658, 3219.3400352927592, 53012.469875300754, 53364.19953700698, 53375.45992641159, 53876.0, 54066.72966635141, 37967.24065518674, 37988.0, 46094.30858537125, 47057.76471117691, 47077.764611176724, 37000.81499592485, 40784.79607601943, 40862.38706419406, 41396.79301603533, 41519.58480415157, 7041.014258003986, 7041.5422997505, 7053.365197132282, 7316.341529262392, 7505.6997720090585, 30201.395972080874, 30299.848500757354, 31094.689053110083, 32022.519662205552, 32170.0, 35322.470162947066, 35616.0, 39432.21135577215, 40249.798751006056, 43026.569734303506, 6769.966150169218, 6795.0, 6818.147731533559, 6882.931170688229, 7129.251428599922, 9572.856407154037, 9642.132208101304, 9779.951100244452, 9904.702858914245, 9948.303618746619, 9352.438853668802, 9440.10319019692, 9487.241020718187, 9556.23550116003, 9564.234861210947, 9006.684766033157, 9178.908210918073, 9208.861867071866, 9511.809763804547, 9629.32594718363, 9151.86272205904, 9234.122758337948, 9451.385659932082, 9468.715938521855, 9555.856662150212, 7686.07767067933, 7766.766996990099, 7836.697320753142, 8035.276825085771, 8338.666453341799, 6265.373462653881, 6582.0, 6686.197656281277, 6752.426043786333, 6757.594544327356]}, "summary": {"suite": 5885.018665359798, "subtests": {"jquery.html": {"filtered": 6537.997767300298, "value": 6537.997767300298}, "dojo.html": {"filtered": 4668.479771839075, "value": 4668.479771839075}, "mootools.html": {"filtered": 3730.686435331308, "value": 3730.686435331308}, "ext.html": {"filtered": 16691.600076451417, "value": 16691.600076451417}, "prototype.html": {"filtered": 4125.380456448835, "value": 4125.380456448835}, "yui.html": {"filtered": 5297.485156319094, "value": 5297.485156319094}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0072"}, "testrun": {"date": 1446815460, "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": "20151106032135", "branch": "Firefox", "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90"}}, {"talos_counters": {}, "results": {"audio-dft": [179.0, 188.0, 186.0, 182.0, 182.0, 188.0, 184.0, 181.0, 181.0, 189.0], "ai-astar": [120.0, 126.0, 121.0, 127.0, 121.0, 120.0, 126.0, 128.0, 118.0, 121.0], "imaging-gaussian-blur": [135.0, 135.0, 136.0, 142.0, 133.0, 130.0, 135.0, 133.0, 130.0, 134.0], "audio-beat-detection": [178.0, 152.0, 175.0, 192.0, 147.0, 173.0, 171.0, 141.0, 191.0, 149.0], "json-stringify-tinderbox": [71.0, 75.0, 76.0, 79.0, 80.0, 80.0, 79.0, 76.0, 76.0, 77.0], "stanford-crypto-pbkdf2": [164.0, 178.0, 174.0, 158.0, 169.0, 174.0, 181.0, 175.0, 156.0, 157.0], "json-parse-financial": [62.0, 64.0, 64.0, 66.0, 67.0, 67.0, 69.0, 76.0, 66.0, 63.0], "stanford-crypto-sha256-iterative": [77.0, 79.0, 79.0, 85.0, 84.0, 83.0, 84.0, 83.0, 81.0, 79.0], "audio-fft": [78.0, 94.0, 97.0, 99.0, 80.0, 80.0, 81.0, 88.0, 90.0, 76.0], "imaging-darkroom": [141.0, 147.0, 147.0, 144.0, 141.0, 147.0, 147.0, 141.0, 147.0, 146.0], "stanford-crypto-ccm": [144.0, 148.0, 154.0, 140.0, 153.0, 143.0, 145.0, 149.0, 150.0, 153.0], "audio-oscillator": [108.0, 115.0, 158.0, 104.0, 100.0, 99.0, 148.0, 104.0, 104.0, 152.0], "stanford-crypto-aes": [94.0, 100.0, 100.0, 101.0, 101.0, 98.0, 96.0, 97.0, 102.0, 101.0], "imaging-desaturate": [117.0, 119.0, 117.0, 118.0, 114.0, 119.0, 117.0, 119.0, 117.0, 114.0]}, "summary": {"suite": 1715.6000000000001, "subtests": {"audio-fft": {"filtered": 86.3, "value": 86.3}, "stanford-crypto-pbkdf2": {"filtered": 168.6, "value": 168.6}, "audio-beat-detection": {"filtered": 166.9, "value": 166.9}, "stanford-crypto-ccm": {"filtered": 147.9, "value": 147.9}, "imaging-darkroom": {"filtered": 144.8, "value": 144.8}, "json-parse-financial": {"filtered": 66.4, "value": 66.4}, "audio-oscillator": {"filtered": 119.2, "value": 119.2}, "ai-astar": {"filtered": 122.8, "value": 122.8}, "audio-dft": {"filtered": 184.0, "value": 184.0}, "stanford-crypto-sha256-iterative": {"filtered": 81.4, "value": 81.4}, "json-stringify-tinderbox": {"filtered": 76.9, "value": 76.9}, "imaging-gaussian-blur": {"filtered": 134.3, "value": 134.3}, "stanford-crypto-aes": {"filtered": 99.0, "value": 99.0}, "imaging-desaturate": {"filtered": 117.1, "value": 117.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0072"}, "testrun": {"date": 1446815460, "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": "20151106032135", "branch": "Firefox", "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90"}}, {"talos_counters": {}, "results": {"DeltaBlue": [229.9908003679853], "Encrypt": [360.75036075036076], "NavierStokes": [6562.091503267974], "Decrypt": [6863.013698630137], "Splay": [795.5449482895783], "Richards": [189.25056775170324], "RegExp": [32758.064516129034], "Earley": [1025.6410256410256], "Boyer": [14300.0], "RayTrace": [2366.4302600472815]}, "summary": {"suite": 15820.663759528725, "subtests": {"DeltaBlue": {"filtered": 287.4810639999999, "value": 287.4810639999999}, "Encrypt": {"filtered": 737.8537319999999, "value": 737.8537319999999}, "NavierStokes": {"filtered": 226.14741035856582, "value": 226.14741035856582}, "Decrypt": {"filtered": 38.78485628742515, "value": 38.78485628742515}, "Splay": {"filtered": 102.43418700000001, "value": 102.43418700000001}, "RegExp": {"filtered": 27.809487936976844, "value": 27.809487936976844}, "Richards": {"filtered": 186.53576800000008, "value": 186.53576800000008}, "Earley": {"filtered": 649.801425, "value": 649.801425}, "Boyer": {"filtered": 46.60580419580419, "value": 46.60580419580419}, "RayTrace": {"filtered": 312.7026443556444, "value": 312.7026443556444}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0072"}, "testrun": {"date": 1446815460, "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": "20151106032135", "branch": "Firefox", "revision": "b918dbd0c3a02030769ecc9bc71e5024c748ac90"}}] 05:31:17 INFO - RETURN: dromaeo_css: 5885.02 05:31:17 INFO - RETURN: kraken: 1715.60 05:31:17 INFO - RETURN: v8_7: 15820.66 05:31:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "15820.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1715.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5885.02"}}} 05:31:17 INFO - Return code: 0 05:31:17 INFO - # TBPL SUCCESS # 05:31:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:17 INFO - 2015-11-06 05:31:17.425 screenresolution[1654:9921] starting screenresolution argv=screenresolution get 05:31:17 INFO - 2015-11-06 05:31:17.429 screenresolution[1654:9921] Display 0: 1600x1200x32@60 05:31:17 INFO - 2015-11-06 05:31:17.435 screenresolution[1655:9924] starting screenresolution argv=screenresolution list 05:31:17 INFO - Available Modes on Display 0 05:31:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:17 INFO - Intel HD Graphics 3000: 05:31:17 INFO - Chipset Model: Intel HD Graphics 3000 05:31:17 INFO - Type: GPU 05:31:17 INFO - Bus: Built-In 05:31:17 INFO - VRAM (Total): 512 MB 05:31:17 INFO - VRAM (Dynamic, Max): 10 05:31:17 INFO - Vendor: Intel (0x8086) 05:31:17 INFO - Device ID: 0x0116 05:31:17 INFO - Revision ID: 0x0009 05:31:17 INFO - Displays: 05:31:17 INFO - Display: 05:31:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:17 INFO - Display Serial Number: 1600x1200 60 05:31:17 INFO - Main Display: Yes 05:31:17 INFO - Mirror: Off 05:31:17 INFO - Online: Yes 05:31:17 INFO - Rotation: Supported 05:31:17 INFO - Return code: 0 05:31:17 INFO - Running post-action listener: _resource_record_post_action 05:31:17 INFO - Running post-run listener: _resource_record_post_run 05:31:18 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 39285760; Write bytes: 684687360; Read time: 4755; Write time: 58337 05:31:18 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 337031680; Write bytes: 334399488; Read time: 35203; Write time: 6690 05:31:18 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 38208512; Write bytes: 339929088; Read time: 4535; Write time: 50636 05:31:18 INFO - Running post-run listener: _upload_blobber_files 05:31:18 INFO - Blob upload gear active. 05:31:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:31:18 INFO - Copying logs to upload dir... 05:31:18 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1330.362875 ========= master_lag: 2.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2015-11-06 05:31:21.441941) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:31:21.446881) ========= 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.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/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/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010115 build_url: 'https://queue.taskcluster.net/v1/task/YxfheNFJRfS9-vBX2KQ9lw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-06 05:31:21.494611) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:31:21.494935) ========= 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.ugbqwZFJvx/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.wTdvazxbmC/Listeners TMPDIR=/var/folders/c7/rng87zdx47sbp151m0gp_7r400000w/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.005267 ========= master_lag: 0.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 05:31:22.023205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 05:31:22.026553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 05:31:22.027769) ========= ========= Total master_lag: 3.91 =========