builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0038 starttime: 1446596981.27 results: success (0) buildid: 20151103143036 builduid: 65c36d228dac4982a629ffd0f20d1f52 revision: 117a37db2aa519779cc813b79d860f1236fd1707 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.274550) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.274927) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.275209) ========= 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.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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.006099 basedir: '/builds/slave/test' ========= master_lag: 0.34 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.621843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.622111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.671816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.672086) ========= 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.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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.015077 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.721091) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.721359) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.721725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.722321) ========= 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.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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-03 16:29:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.9M=0s 2015-11-03 16:29:41 (33.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.231172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.974383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:41.974671) ========= 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.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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.123308 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:42.113440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:42.113787) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 117a37db2aa519779cc813b79d860f1236fd1707 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 117a37db2aa519779cc813b79d860f1236fd1707 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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-03 16:29:42,194 truncating revision to first 12 chars 2015-11-03 16:29:42,195 Setting DEBUG logging. 2015-11-03 16:29:42,195 attempt 1/10 2015-11-03 16:29:42,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/117a37db2aa5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-03 16:29:42,450 unpacking tar archive at: fx-team-117a37db2aa5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509604 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:42.639654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:42.639959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:42.655646) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:42.655919) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 16:29:42.656308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2015-11-03 16:29:42.656606) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:29:42 INFO - MultiFileLogger online at 20151103 16:29:42 in /builds/slave/test 16:29:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:29:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:29:42 INFO - {'append_to_log': False, 16:29:42 INFO - 'base_work_dir': '/builds/slave/test', 16:29:42 INFO - 'blob_upload_branch': 'Fx-Team', 16:29:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:29:42 INFO - 'branch': 'Fx-Team', 16:29:42 INFO - 'buildbot_json_path': 'buildprops.json', 16:29:42 INFO - 'config_files': ('talos/mac_config.py',), 16:29:42 INFO - 'default_actions': ('clobber', 16:29:42 INFO - 'read-buildbot-config', 16:29:42 INFO - 'download-and-extract', 16:29:42 INFO - 'populate-webroot', 16:29:42 INFO - 'create-virtualenv', 16:29:42 INFO - 'install', 16:29:42 INFO - 'run-tests'), 16:29:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:29:42 INFO - 'download_minidump_stackwalk': True, 16:29:42 INFO - 'download_symbols': 'ondemand', 16:29:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:29:42 INFO - 'tooltool.py': '/tools/tooltool.py', 16:29:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:29:42 INFO - '/tools/misc-python/virtualenv.py')}, 16:29:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:29:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:29:42 INFO - 'installer_path': 'installer.exe', 16:29:42 INFO - 'log_level': 'info', 16:29:42 INFO - 'log_name': 'talos', 16:29:42 INFO - 'log_to_console': True, 16:29:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:29:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:29:42 INFO - 'opt_config_files': (), 16:29:42 INFO - 'pip_index': False, 16:29:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:29:42 INFO - 'cmd': ('bash', 16:29:42 INFO - '-c', 16:29:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:29:42 INFO - 'enabled': True, 16:29:42 INFO - 'halt_on_failure': False, 16:29:42 INFO - 'name': 'check_screen_resolution'},), 16:29:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:29:42 INFO - 'cmd': ('bash', 16:29:42 INFO - '-c', 16:29:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:29:42 INFO - 'enabled': True, 16:29:42 INFO - 'halt_on_failure': False, 16:29:42 INFO - 'name': 'check_screen_resolution'},), 16:29:42 INFO - 'run_cmd_checks_enabled': True, 16:29:42 INFO - 'sps_profile': False, 16:29:42 INFO - 'sps_profile_interval': 0, 16:29:42 INFO - 'suite': 'dromaeojs', 16:29:42 INFO - 'system_bits': '64', 16:29:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:29:42 INFO - 'title': 't-yosemite-r5-0038', 16:29:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:29:42 INFO - 'use_talos_json': True, 16:29:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:29:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:29:42 INFO - 'work_dir': 'build'} 16:29:42 INFO - ##### 16:29:42 INFO - ##### Running clobber step. 16:29:42 INFO - ##### 16:29:42 INFO - Running pre-action listener: _resource_record_pre_action 16:29:42 INFO - Running main action method: clobber 16:29:42 INFO - rmtree: /builds/slave/test/build 16:29:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:29:47 INFO - Running post-action listener: _resource_record_post_action 16:29:47 INFO - ##### 16:29:47 INFO - ##### Running read-buildbot-config step. 16:29:47 INFO - ##### 16:29:47 INFO - Running pre-action listener: _resource_record_pre_action 16:29:47 INFO - Running main action method: read_buildbot_config 16:29:47 INFO - Using buildbot properties: 16:29:47 INFO - { 16:29:47 INFO - "properties": { 16:29:47 INFO - "buildnumber": 1192, 16:29:47 INFO - "product": "firefox", 16:29:47 INFO - "script_repo_revision": "production", 16:29:47 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 16:29:47 INFO - "repository": "", 16:29:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 16:29:47 INFO - "buildid": "20151103143036", 16:29:47 INFO - "slavename": "t-yosemite-r5-0038", 16:29:47 INFO - "pgo_build": "False", 16:29:47 INFO - "basedir": "/builds/slave/test", 16:29:47 INFO - "project": "", 16:29:47 INFO - "platform": "yosemite", 16:29:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:29:47 INFO - "slavebuilddir": "test", 16:29:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:29:47 INFO - "branch": "fx-team", 16:29:47 INFO - "repo_path": "integration/fx-team", 16:29:47 INFO - "stage_platform": "macosx64", 16:29:47 INFO - "builduid": "65c36d228dac4982a629ffd0f20d1f52", 16:29:47 INFO - "revision": "117a37db2aa519779cc813b79d860f1236fd1707" 16:29:47 INFO - }, 16:29:47 INFO - "sourcestamp": { 16:29:47 INFO - "repository": "", 16:29:47 INFO - "hasPatch": false, 16:29:47 INFO - "project": "", 16:29:47 INFO - "branch": "fx-team-macosx64-talos", 16:29:47 INFO - "changes": [ 16:29:47 INFO - { 16:29:47 INFO - "category": null, 16:29:47 INFO - "files": [ 16:29:47 INFO - { 16:29:47 INFO - "url": null, 16:29:47 INFO - "name": "https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:29:47 INFO - } 16:29:47 INFO - ], 16:29:47 INFO - "repository": "", 16:29:47 INFO - "rev": "117a37db2aa519779cc813b79d860f1236fd1707", 16:29:47 INFO - "who": "edilee@gmail.com", 16:29:47 INFO - "when": 1446596921, 16:29:47 INFO - "number": 6617434, 16:29:47 INFO - "comments": "Bug 1215487 - Fix Mozilla logo in Chrome for Loop Standalone [r=Mardak]", 16:29:47 INFO - "project": "", 16:29:47 INFO - "at": "Tue 03 Nov 2015 16:28:41", 16:29:47 INFO - "branch": "fx-team-macosx64-talos", 16:29:47 INFO - "revlink": "", 16:29:47 INFO - "properties": [ 16:29:47 INFO - [ 16:29:47 INFO - "buildid", 16:29:47 INFO - "20151103143036", 16:29:47 INFO - "Change" 16:29:47 INFO - ], 16:29:47 INFO - [ 16:29:47 INFO - "builduid", 16:29:47 INFO - "65c36d228dac4982a629ffd0f20d1f52", 16:29:47 INFO - "Change" 16:29:47 INFO - ], 16:29:47 INFO - [ 16:29:47 INFO - "pgo_build", 16:29:47 INFO - "False", 16:29:47 INFO - "Change" 16:29:47 INFO - ] 16:29:47 INFO - ], 16:29:47 INFO - "revision": "117a37db2aa519779cc813b79d860f1236fd1707" 16:29:47 INFO - } 16:29:47 INFO - ], 16:29:47 INFO - "revision": "117a37db2aa519779cc813b79d860f1236fd1707" 16:29:47 INFO - } 16:29:47 INFO - } 16:29:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:29:47 INFO - Running post-action listener: _resource_record_post_action 16:29:47 INFO - ##### 16:29:47 INFO - ##### Running download-and-extract step. 16:29:47 INFO - ##### 16:29:47 INFO - Running pre-action listener: _resource_record_pre_action 16:29:47 INFO - Running main action method: download_and_extract 16:29:47 INFO - mkdir: /builds/slave/test/build/tests 16:29:47 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')]} 16:29:47 INFO - https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:29:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/test_packages.json 16:29:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/test_packages.json 16:29:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:29:57 INFO - Downloaded 1149 bytes. 16:29:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:29:57 INFO - Using the following test package requirements: 16:29:57 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:29:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:29:57 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:29:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:29:57 INFO - u'jsshell-mac.zip'], 16:29:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:29:57 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:29:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:29:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:29:57 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:29:57 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:29:57 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:29:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:29:57 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:29:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:29:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:29:57 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:29:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:29: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')]} 16:29:57 INFO - https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:30:03 INFO - Downloaded 17452693 bytes. 16:30:03 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 16:30:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:30:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:30:08 INFO - Return code: 0 16:30:08 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 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:08 INFO - https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:30:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:30:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:30:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:30:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:30:09 INFO - Downloaded 17452693 bytes. 16:30:09 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 16:30:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:30:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:30:14 INFO - Return code: 0 16:30:14 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')]} 16:30:14 INFO - https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:30:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:30:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:30:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:30:16 INFO - Downloaded 11131307 bytes. 16:30:16 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 16:30:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:30:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:30:16 INFO - Return code: 0 16:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:16 INFO - https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:30:20 INFO - Downloaded 108627173 bytes. 16:30:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:30:20 INFO - mkdir: /builds/slave/test/properties 16:30:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:30:20 INFO - Writing to file /builds/slave/test/properties/build_url 16:30:20 INFO - Contents: 16:30:20 INFO - build_url:https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:30:20 INFO - Running post-action listener: _resource_record_post_action 16:30:20 INFO - Running post-action listener: set_extra_try_arguments 16:30:20 INFO - ##### 16:30:20 INFO - ##### Running populate-webroot step. 16:30:20 INFO - ##### 16:30:20 INFO - Running pre-action listener: _resource_record_pre_action 16:30:20 INFO - Running main action method: populate_webroot 16:30:20 INFO - Guessing talos json url... 16:30:20 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')]} 16:30:20 INFO - https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 16:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 16:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 16:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 16:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/htitLYdKR9i_y9A2278s3A/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 16:30:20 INFO - Downloaded 103 bytes. 16:30:20 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 16:30:21 INFO - Contents: 16:30:21 INFO - 20151103143036 16:30:21 INFO - https://hg.mozilla.org/integration/fx-team/rev/117a37db2aa519779cc813b79d860f1236fd1707 16:30:21 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')]} 16:30:21 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/117a37db2a/testing/talos/talos.json 16:30:21 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/117a37db2a/testing/talos/talos.json to /builds/slave/test/build/talos.json 16:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/117a37db2a/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 16:30:21 INFO - Downloaded 4264 bytes. 16:30:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:30:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:30:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:30:21 INFO - '../fennec_ids.txt'], 16:30:21 INFO - 'tests': ['tcheck2']}, 16:30:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:30:21 INFO - '--tppagecycles', 16:30:21 INFO - '7'], 16:30:21 INFO - 'tests': ['tsvgm']}}, 16:30:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:30:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:30:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:30:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:30:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'tests': ['damp', 'tps']}, 16:30:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['damp', 'tps']}, 16:30:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:30:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:30:21 INFO - 'other': {'tests': ['a11yr', 16:30:21 INFO - 'ts_paint', 16:30:21 INFO - 'tpaint', 16:30:21 INFO - 'sessionrestore', 16:30:21 INFO - 'sessionrestore_no_auto_restore']}, 16:30:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['a11yr', 16:30:21 INFO - 'ts_paint', 16:30:21 INFO - 'tpaint', 16:30:21 INFO - 'sessionrestore', 16:30:21 INFO - 'sessionrestore_no_auto_restore']}, 16:30:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['a11yr', 16:30:21 INFO - 'ts_paint', 16:30:21 INFO - 'tpaint', 16:30:21 INFO - 'sessionrestore', 16:30:21 INFO - 'sessionrestore_no_auto_restore']}, 16:30:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['a11yr', 16:30:21 INFO - 'ts_paint', 16:30:21 INFO - 'tpaint', 16:30:21 INFO - 'sessionrestore', 16:30:21 INFO - 'sessionrestore_no_auto_restore']}, 16:30:21 INFO - 'other_l64': {'tests': ['a11yr', 16:30:21 INFO - 'ts_paint', 16:30:21 INFO - 'tpaint', 16:30:21 INFO - 'sessionrestore', 16:30:21 INFO - 'sessionrestore_no_auto_restore']}, 16:30:21 INFO - 'other_nol64': {'tests': ['a11yr', 16:30:21 INFO - 'ts_paint', 16:30:21 INFO - 'tpaint', 16:30:21 INFO - 'sessionrestore', 16:30:21 INFO - 'sessionrestore_no_auto_restore']}, 16:30:21 INFO - 'svgr': {'tests': ['tsvgx', 16:30:21 INFO - 'tsvgr_opacity', 16:30:21 INFO - 'tart', 16:30:21 INFO - 'tscrollx', 16:30:21 INFO - 'cart']}, 16:30:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['tsvgx', 16:30:21 INFO - 'tsvgr_opacity', 16:30:21 INFO - 'tart', 16:30:21 INFO - 'tscrollx', 16:30:21 INFO - 'cart']}, 16:30:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'tests': ['tp5o']}, 16:30:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'talos_options': ['--e10s'], 16:30:21 INFO - 'tests': ['tp5o']}, 16:30:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'talos_options': ['--xperf_path', 16:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:21 INFO - 'tests': ['tp5n']}, 16:30:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:21 INFO - 'talos_options': ['--e10s', 16:30:21 INFO - '--xperf_path', 16:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 16:30:21 INFO - 'C:/slave/talos-data/talos/xperf.config'], 16:30:21 INFO - 'tests': ['tp5n']}}, 16:30:21 INFO - 'talos.zip': {'path': '', 16:30:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:30:21 INFO - Running post-action listener: _resource_record_post_action 16:30:21 INFO - ##### 16:30:21 INFO - ##### Running create-virtualenv step. 16:30:21 INFO - ##### 16:30:21 INFO - Running pre-action listener: _resource_record_pre_action 16:30:21 INFO - Running main action method: create_virtualenv 16:30:21 INFO - Creating virtualenv /builds/slave/test/build/venv 16:30:21 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 16:30:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:30:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:30:21 INFO - Using real prefix '/tools/python27' 16:30:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:30:22 INFO - Installing distribute.............................................................................................................................................................................................done. 16:30:26 INFO - Installing pip.................done. 16:30:26 INFO - Return code: 0 16:30:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:30:26 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')]} 16:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:26 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')]} 16:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:26 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 0x10def0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bb57edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, '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.lGaCpnNEcV/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.3MP2mPwByF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:30:26 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 16:30:26 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 16:30:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:30:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:26 INFO - 'HOME': '/Users/cltbld', 16:30:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:26 INFO - 'LOGNAME': 'cltbld', 16:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:26 INFO - 'MOZ_NO_REMOTE': '1', 16:30:26 INFO - 'NO_EM_RESTART': '1', 16:30:26 INFO - 'PAGER': '/bin/cat', 16:30:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:26 INFO - 'PWD': '/builds/slave/test', 16:30:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:26 INFO - 'SHELL': '/bin/bash', 16:30:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:30:26 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:30:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:26 INFO - 'USER': 'cltbld', 16:30:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:26 INFO - 'XPC_FLAGS': '0x0', 16:30:26 INFO - 'XPC_SERVICE_NAME': '0', 16:30:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:26 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 16:30:26 INFO - Cleaning up... 16:30:26 INFO - Return code: 0 16:30:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:30:26 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')]} 16:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:26 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')]} 16:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:26 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 0x10def0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bb57edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, '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.lGaCpnNEcV/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.3MP2mPwByF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:30:26 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 16:30:26 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 16:30:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:30:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:26 INFO - 'HOME': '/Users/cltbld', 16:30:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:26 INFO - 'LOGNAME': 'cltbld', 16:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:26 INFO - 'MOZ_NO_REMOTE': '1', 16:30:26 INFO - 'NO_EM_RESTART': '1', 16:30:26 INFO - 'PAGER': '/bin/cat', 16:30:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:26 INFO - 'PWD': '/builds/slave/test', 16:30:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:26 INFO - 'SHELL': '/bin/bash', 16:30:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:30:26 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:30:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:26 INFO - 'USER': 'cltbld', 16:30:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:26 INFO - 'XPC_FLAGS': '0x0', 16:30:26 INFO - 'XPC_SERVICE_NAME': '0', 16:30:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:27 INFO - Downloading/unpacking psutil>=0.7.1 16:30:27 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 16:30:27 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 16:30:27 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 16:30:27 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 16:30:27 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 16:30:27 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 16:30:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:30:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:30:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:29 INFO - Installing collected packages: psutil 16:30:29 INFO - Running setup.py install for psutil 16:30:29 INFO - building 'psutil._psutil_osx' extension 16:30:29 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 16:30:31 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 16:30:31 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 16:30:31 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 16:30:32 INFO - building 'psutil._psutil_posix' extension 16:30:32 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 16:30:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:30:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:30:32 INFO - ^ 16:30:32 INFO - 1 warning generated. 16:30:32 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 16:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:32 INFO - Successfully installed psutil 16:30:32 INFO - Cleaning up... 16:30:32 INFO - Return code: 0 16:30:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:30: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')]} 16:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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')]} 16:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:32 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 0x10def0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bb57edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, '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.lGaCpnNEcV/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.3MP2mPwByF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:30:32 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 16:30:32 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 16:30:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:30:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:32 INFO - 'HOME': '/Users/cltbld', 16:30:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:32 INFO - 'LOGNAME': 'cltbld', 16:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:32 INFO - 'MOZ_NO_REMOTE': '1', 16:30:32 INFO - 'NO_EM_RESTART': '1', 16:30:32 INFO - 'PAGER': '/bin/cat', 16:30:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:32 INFO - 'PWD': '/builds/slave/test', 16:30:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:32 INFO - 'SHELL': '/bin/bash', 16:30:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:30:32 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:30:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:32 INFO - 'USER': 'cltbld', 16:30:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:32 INFO - 'XPC_FLAGS': '0x0', 16:30:32 INFO - 'XPC_SERVICE_NAME': '0', 16:30:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:30:33 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 16:30:33 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 16:30:33 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 16:30:33 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 16:30:33 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 16:30:33 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 16:30:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:30:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:30:35 INFO - Installing collected packages: mozsystemmonitor 16:30:35 INFO - Running setup.py install for mozsystemmonitor 16:30:35 INFO - Successfully installed mozsystemmonitor 16:30:35 INFO - Cleaning up... 16:30:35 INFO - Return code: 0 16:30:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:30:35 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')]} 16:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:35 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')]} 16:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:35 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 0x10def0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bb57edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, '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.lGaCpnNEcV/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.3MP2mPwByF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:30:35 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 16:30:35 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 16:30:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:30:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:35 INFO - 'HOME': '/Users/cltbld', 16:30:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:35 INFO - 'LOGNAME': 'cltbld', 16:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:35 INFO - 'MOZ_NO_REMOTE': '1', 16:30:35 INFO - 'NO_EM_RESTART': '1', 16:30:35 INFO - 'PAGER': '/bin/cat', 16:30:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:35 INFO - 'PWD': '/builds/slave/test', 16:30:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:35 INFO - 'SHELL': '/bin/bash', 16:30:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:30:35 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:30:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:35 INFO - 'USER': 'cltbld', 16:30:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:35 INFO - 'XPC_FLAGS': '0x0', 16:30:35 INFO - 'XPC_SERVICE_NAME': '0', 16:30:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:36 INFO - Downloading/unpacking blobuploader==1.2.4 16:30:36 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 16:30:36 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 16:30:36 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 16:30:36 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 16:30:36 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 16:30:36 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 16:30:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:30:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:30:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:30:38 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 16:30:38 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 16:30:38 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 16:30:38 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 16:30:38 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 16:30:38 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 16:30:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:30:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:30:39 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 16:30:39 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 16:30:39 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 16:30:39 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 16:30:39 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 16:30:39 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 16:30:39 INFO - Downloading docopt-0.6.1.tar.gz 16:30:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:30:39 INFO - Installing collected packages: blobuploader, requests, docopt 16:30:39 INFO - Running setup.py install for blobuploader 16:30:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:30:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:30:39 INFO - Running setup.py install for requests 16:30:40 INFO - Running setup.py install for docopt 16:30:40 INFO - Successfully installed blobuploader requests docopt 16:30:40 INFO - Cleaning up... 16:30:40 INFO - Return code: 0 16:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:40 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')]} 16:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:40 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')]} 16:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:40 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 0x10def0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bb57edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, '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.lGaCpnNEcV/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.3MP2mPwByF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:30:40 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 16:30:40 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 16:30:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:30:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:40 INFO - 'HOME': '/Users/cltbld', 16:30:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:40 INFO - 'LOGNAME': 'cltbld', 16:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:40 INFO - 'MOZ_NO_REMOTE': '1', 16:30:40 INFO - 'NO_EM_RESTART': '1', 16:30:40 INFO - 'PAGER': '/bin/cat', 16:30:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:40 INFO - 'PWD': '/builds/slave/test', 16:30:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:40 INFO - 'SHELL': '/bin/bash', 16:30:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:30:40 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:30:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:40 INFO - 'USER': 'cltbld', 16:30:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:40 INFO - 'XPC_FLAGS': '0x0', 16:30:40 INFO - 'XPC_SERVICE_NAME': '0', 16:30:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-LYcNYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-QB_IyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-cvIGQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-sIg960-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-YBco3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-bdtVLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-Lr3ZqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-82_4SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:41 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-cUTwW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-POXyLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-YCh3SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-YxJz6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-X3BmHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-eyraR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-SDf5cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-KfrP5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:42 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-J9k9Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:30:43 INFO - Running setup.py install for manifestparser 16:30:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:30:43 INFO - Running setup.py install for mozcrash 16:30:43 INFO - Running setup.py install for mozdebug 16:30:43 INFO - Running setup.py install for mozdevice 16:30:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:30:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:30:43 INFO - Running setup.py install for mozfile 16:30:43 INFO - Running setup.py install for mozhttpd 16:30:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Running setup.py install for mozinfo 16:30:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Running setup.py install for mozInstall 16:30:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Running setup.py install for mozleak 16:30:44 INFO - Running setup.py install for mozlog 16:30:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Running setup.py install for moznetwork 16:30:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:30:44 INFO - Running setup.py install for mozprocess 16:30:45 INFO - Running setup.py install for mozprofile 16:30:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:30:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:30:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:30:45 INFO - Running setup.py install for mozrunner 16:30:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:30:45 INFO - Running setup.py install for mozscreenshot 16:30:45 INFO - Running setup.py install for moztest 16:30:45 INFO - Running setup.py install for mozversion 16:30:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:30:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:30:45 INFO - Cleaning up... 16:30:45 INFO - Return code: 0 16:30:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:45 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')]} 16:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:45 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')]} 16:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:45 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 0x10def0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bb57edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, '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.lGaCpnNEcV/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.3MP2mPwByF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:30:45 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 16:30:45 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 16:30:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:30:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:45 INFO - 'HOME': '/Users/cltbld', 16:30:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:45 INFO - 'LOGNAME': 'cltbld', 16:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:45 INFO - 'MOZ_NO_REMOTE': '1', 16:30:45 INFO - 'NO_EM_RESTART': '1', 16:30:45 INFO - 'PAGER': '/bin/cat', 16:30:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:45 INFO - 'PWD': '/builds/slave/test', 16:30:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:45 INFO - 'SHELL': '/bin/bash', 16:30:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:30:45 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:30:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:45 INFO - 'USER': 'cltbld', 16:30:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:45 INFO - 'XPC_FLAGS': '0x0', 16:30:45 INFO - 'XPC_SERVICE_NAME': '0', 16:30:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:46 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-vpgPh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:46 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)) 16:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:46 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-dYz_aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:46 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)) 16:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:46 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-If9wYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:46 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)) 16:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:46 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-h6p0cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:46 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)) 16:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:46 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-4VzvHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:46 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)) 16:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:46 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-_i1nVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-F05LWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-jbArMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-G_OdX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-OVgWic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-tXwkF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-9wFC4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-Mnx1Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:47 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)) 16:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:47 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-6zvR91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:48 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)) 16:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:48 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-8fl1ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:48 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)) 16:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:48 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-P6Gppj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:48 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)) 16:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:48 INFO - Running setup.py (path:/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/pip-3zd1mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:48 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)) 16:30:48 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)) 16:30:48 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)) 16:30:48 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)) 16:30:48 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)) 16:30:48 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)) 16:30:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:48 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 16:30:48 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 16:30:48 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 16:30:48 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 16:30:48 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 16:30:48 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 16:30:50 INFO - Downloading blessings-1.5.1.tar.gz 16:30:50 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 16:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:30:50 INFO - Installing collected packages: blessings 16:30:50 INFO - Running setup.py install for blessings 16:30:51 INFO - Successfully installed blessings 16:30:51 INFO - Cleaning up... 16:30:51 INFO - Return code: 0 16:30:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:30:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:51 INFO - Reading from file tmpfile_stdout 16:30:51 INFO - Current package versions: 16:30:51 INFO - blessings == 1.5.1 16:30:51 INFO - blobuploader == 1.2.4 16:30:51 INFO - docopt == 0.6.1 16:30:51 INFO - manifestparser == 1.1 16:30:51 INFO - mozInstall == 1.12 16:30:51 INFO - mozcrash == 0.16 16:30:51 INFO - mozdebug == 0.1 16:30:51 INFO - mozdevice == 0.47 16:30:51 INFO - mozfile == 1.2 16:30:51 INFO - mozhttpd == 0.7 16:30:51 INFO - mozinfo == 0.9 16:30:51 INFO - mozleak == 0.1 16:30:51 INFO - mozlog == 3.0 16:30:51 INFO - moznetwork == 0.27 16:30:51 INFO - mozprocess == 0.22 16:30:51 INFO - mozprofile == 0.27 16:30:51 INFO - mozrunner == 6.11 16:30:51 INFO - mozscreenshot == 0.1 16:30:51 INFO - mozsystemmonitor == 0.0 16:30:51 INFO - moztest == 0.7 16:30:51 INFO - mozversion == 1.4 16:30:51 INFO - psutil == 3.1.1 16:30:51 INFO - requests == 1.2.3 16:30:51 INFO - wsgiref == 0.1.2 16:30:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:51 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')]} 16:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:51 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')]} 16:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:51 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 0x10def0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df5d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bb57edf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, '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.lGaCpnNEcV/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.3MP2mPwByF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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 16:30:51 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 16:30:51 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 16:30:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:30:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:51 INFO - 'HOME': '/Users/cltbld', 16:30:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:51 INFO - 'LOGNAME': 'cltbld', 16:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:51 INFO - 'MOZ_NO_REMOTE': '1', 16:30:51 INFO - 'NO_EM_RESTART': '1', 16:30:51 INFO - 'PAGER': '/bin/cat', 16:30:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:51 INFO - 'PWD': '/builds/slave/test', 16:30:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:51 INFO - 'SHELL': '/bin/bash', 16:30:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:30:51 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:30:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:51 INFO - 'USER': 'cltbld', 16:30:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:51 INFO - 'XPC_FLAGS': '0x0', 16:30:51 INFO - 'XPC_SERVICE_NAME': '0', 16:30:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 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)) 16:30:51 INFO - Cleaning up... 16:30:51 INFO - Return code: 0 16:30:51 INFO - Running post-action listener: _resource_record_post_action 16:30:51 INFO - Running post-action listener: _start_resource_monitoring 16:30:51 INFO - Starting resource monitoring. 16:30:51 INFO - ##### 16:30:51 INFO - ##### Running install step. 16:30:51 INFO - ##### 16:30:51 INFO - Running pre-action listener: _resource_record_pre_action 16:30:51 INFO - Running main action method: install 16:30:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:52 INFO - Reading from file tmpfile_stdout 16:30:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:30:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:30:52 INFO - Reading from file tmpfile_stdout 16:30:52 INFO - Output received: 16:30:52 INFO - Usage: mozinstall [options] installer 16:30:52 INFO - Options: 16:30:52 INFO - -h, --help show this help message and exit 16:30:52 INFO - -d DEST, --destination=DEST 16:30:52 INFO - Directory to install application into. [default: 16:30:52 INFO - "/builds/slave/test"] 16:30:52 INFO - --app=APP Application being installed. [default: firefox] 16:30:52 INFO - mkdir: /builds/slave/test/build/application 16:30:52 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'] 16:30:52 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 16:31:30 INFO - Reading from file tmpfile_stdout 16:31:30 INFO - Output received: 16:31:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:31:30 INFO - Running post-action listener: _resource_record_post_action 16:31:30 INFO - ##### 16:31:30 INFO - ##### Running run-tests step. 16:31:30 INFO - ##### 16:31:30 INFO - Running pre-action listener: _resource_record_pre_action 16:31:30 INFO - Running main action method: run_tests 16:31:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:31:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:31:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:31:30 INFO - 2015-11-03 16:31:30.631 screenresolution[1631:8784] starting screenresolution argv=screenresolution get 16:31:30 INFO - 2015-11-03 16:31:30.634 screenresolution[1631:8784] Display 0: 1600x1200x32@60 16:31:30 INFO - 2015-11-03 16:31:30.641 screenresolution[1632:8786] starting screenresolution argv=screenresolution list 16:31:30 INFO - Available Modes on Display 0 16:31:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:31:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:31:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:31:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:31:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:31:30 INFO - Intel HD Graphics 3000: 16:31:30 INFO - Chipset Model: Intel HD Graphics 3000 16:31:30 INFO - Type: GPU 16:31:30 INFO - Bus: Built-In 16:31:30 INFO - VRAM (Total): 512 MB 16:31:30 INFO - VRAM (Dynamic, Max): 10 16:31:30 INFO - Vendor: Intel (0x8086) 16:31:30 INFO - Device ID: 0x0116 16:31:30 INFO - Revision ID: 0x0009 16:31:30 INFO - Displays: 16:31:30 INFO - Display: 16:31:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:31:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:31:30 INFO - Display Serial Number: 1600x1200 60 16:31:30 INFO - Main Display: Yes 16:31:30 INFO - Mirror: Off 16:31:30 INFO - Online: Yes 16:31:30 INFO - Rotation: Supported 16:31:30 INFO - Return code: 0 16:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:30 INFO - Python 2.7.3 16:31:30 INFO - Return code: 0 16:31:30 INFO - grabbing minidump binary from tooltool 16:31: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')]} 16:31:30 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 0x10dea59f0>, '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 0x10dc04cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de6f990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:30 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 16:31:30 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 16:31:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:31 INFO - Return code: 0 16:31:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:31:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:31:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0038', '--webServer', 'localhost'] in /builds/slave/test/build 16:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0038 --webServer localhost 16:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lGaCpnNEcV/Render', 16:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:31 INFO - 'HOME': '/Users/cltbld', 16:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:31 INFO - 'LOGNAME': 'cltbld', 16:31:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:31 INFO - 'MOZ_NO_REMOTE': '1', 16:31:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:31 INFO - 'NO_EM_RESTART': '1', 16:31:31 INFO - 'PAGER': '/bin/cat', 16:31:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:31 INFO - 'PWD': '/builds/slave/test', 16:31:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:31 INFO - 'SHELL': '/bin/bash', 16:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3MP2mPwByF/Listeners', 16:31:31 INFO - 'TMPDIR': '/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/', 16:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:31 INFO - 'USER': 'cltbld', 16:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:31 INFO - 'XPC_FLAGS': '0x0', 16:31:31 INFO - 'XPC_SERVICE_NAME': '0', 16:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:31:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0038', '--webServer', 'localhost'] with output_timeout 3600 16:31:31 INFO - mozversion INFO | application_buildid: 20151103143036 16:31:31 INFO - mozversion INFO | application_changeset: 117a37db2aa519779cc813b79d860f1236fd1707 16:31:31 INFO - mozversion INFO | application_display_name: Nightly 16:31:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:31 INFO - mozversion INFO | application_name: Firefox 16:31:31 INFO - mozversion INFO | application_remotingname: firefox 16:31:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:31:31 INFO - mozversion INFO | application_vendor: Mozilla 16:31:31 INFO - mozversion INFO | application_version: 45.0a1 16:31:31 INFO - mozversion INFO | platform_buildid: 20151103143036 16:31:31 INFO - mozversion INFO | platform_changeset: 117a37db2aa519779cc813b79d860f1236fd1707 16:31:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:31:31 INFO - mozversion INFO | platform_version: 45.0a1 16:31:31 INFO - 2015-11-03 16:31:31,335 DEBUG : using testdate: 1446597091 16:31:31 INFO - 2015-11-03 16:31:31,335 DEBUG : actual date: 1446597091 16:31:31 INFO - 2015-11-03 16:31:31,384 INFO : starting webserver on 'localhost:49269' 16:31:31 INFO - 2015-11-03 16:31:31,385 INFO : Starting test suite t-yosemite-r5-0038 16:31:31 INFO - 2015-11-03 16:31:31,385 INFO : Starting test dromaeo_css 16:31:31 INFO - 2015-11-03 16:31:31,385 DEBUG : operating with platform_type : mac_ 16:31:31 INFO - 2015-11-03 16:31:31,386 INFO : Initialising browser for dromaeo_css test... 16:31:31 INFO - 2015-11-03 16:31:31,412 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/tmpDvOy9u/profile http://localhost:49269/getInfo.html 16:31:34 INFO - 2015-11-03 16:31:34,177 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:31:34 INFO - 2015-11-03 16:31:34,178 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:31:34 INFO - 2015-11-03 16:31:34,178 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:31:34 INFO - 2015-11-03 16:31:34,178 DEBUG : BROWSER_OUTPUT: __metrics 16:31:34 INFO - 2015-11-03 16:31:34,194 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:31:34 INFO - 2015-11-03 16:31:34,924 INFO : Browser initialized. 16:31:34 INFO - 2015-11-03 16:31:34,925 INFO : Running cycle 1/1 for dromaeo_css test... 16:31:34 INFO - 2015-11-03 16:31:34,925 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/tmpDvOy9u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:31:46 INFO - 2015-11-03 16:31:46,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 220880896 16:31:46 INFO - 2015-11-03 16:31:46,876 DEBUG : BROWSER_OUTPUT: 16:32:37 INFO - 2015-11-03 16:32:37,966 DEBUG : BROWSER_OUTPUT: 1446597157963 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] 16:34:49 INFO - 2015-11-03 16:34:49,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 16:34:50 INFO - 2015-11-03 16:34:50,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 330719232 16:34:50 INFO - 2015-11-03 16:34:50,627 DEBUG : BROWSER_OUTPUT: 16:37:53 INFO - 2015-11-03 16:37:53,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 16:37:54 INFO - 2015-11-03 16:37:54,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 354111488 16:37:54 INFO - 2015-11-03 16:37:54,007 DEBUG : BROWSER_OUTPUT: 16:40:56 INFO - 2015-11-03 16:40:56,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 16:40:56 INFO - 2015-11-03 16:40:56,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 319741952 16:40:56 INFO - 2015-11-03 16:40:56,641 DEBUG : BROWSER_OUTPUT: 16:43:58 INFO - 2015-11-03 16:43:58,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 16:43:59 INFO - 2015-11-03 16:43:59,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 305913856 16:43:59 INFO - 2015-11-03 16:43:59,342 DEBUG : BROWSER_OUTPUT: 16:47:02 INFO - 2015-11-03 16:47:02,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 16:47:02 INFO - 2015-11-03 16:47:02,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 311746560 16:47:02 INFO - 2015-11-03 16:47:02,865 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 16:50:05 INFO - 2015-11-03 16:50:05,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 356634624 16:50:05 INFO - 2015-11-03 16:50:05,789 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,790 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:50:05 INFO - 2015-11-03 16:50:05,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:50:05 INFO - 2015-11-03 16:50:05,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:50:05 INFO - 2015-11-03 16:50:05,790 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:50:05 INFO - 2015-11-03 16:50:05,792 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3062.9081127566183;3071.6314042314925;3245.82147981861;3252.5609042779233;3322.933541329173;4896.338994235777;5075.822346217874;5107.284980102784;5185.844424667262;5285.550728188108;5023.171176755831;5031.547160755531;5046.167382381912;5091.439941606421;5248.658837175581;4670.322803193535;4696.225122854725;4745.240761478164;4820.325154478376;4856.805727770902;4816.7350795706225;4819.084373968953;4834.105690447261;4855.708657480544;4948.752562371867;4627.305904114376;4692.2257827458425;4698.530146985308;4712.340272361872;4753.786079626425;4614.446266448048;4757.26262429324;4761.809527618926;4807.351007613962;4819.7108173509705;4737.905241895177;4752.120857641347;4772.451168115642;4776.761161941924;4961.9751901240625;5005.0490406822955;5030.37120359955;5171.276021357013;5185.092608793446;5283.181106928432;5397.4062853086125;5401.675899446046;5466.070767969455;5482.17767334899;5592.273004509429;5496.230527726121;5556.666600004012;5568.192612071227;5585.664860108406;5589.944100558983;5004.099262132779;5132.615053870974;5138.922916156261;5223.112070947948;5313.017091837984;5581.05122129239;5616.9157462638095;5631.971840140773;5637.210790489335;5639.887202255932;5469.15228139639;5490.258815059996;5494.780208791683;5497.890042199134;5623.578231632644;5409.945900541023;5478.506934375925;5486.451354864562;5594.216809646653;5801.767929282866;5352.652077614943;5384.353877534642;5386.057439947994;5473;5478.178273258964;5486.231927530149;5489.176623506506;5495.697736624444;5496.367917689437;5514.724263786875;4171.70798044134;4246.723962942398;4334.739915605074;4363.869083927487;4422.447194100738;3815.198808250243;3861.9227615447535;3882.437046628223;3945.2504024235304;3954.7429417087797;5214.296070030573;5215.29593504872;5239.187925871496;5287.259783630295;5313.787448502017;5452.645578037414;5577.3028371453565;5590.888182236414;5592.692401917852;5631.239782629293;5114.309568208244;5225.242339860775;5236.607254455931;5237.895242095136;5240.397354304304;4886.853394398174;4890.731009794425;4893.755312234374;4898.118338698997;4916.164252077156;5484.177373394023;5678.233438485834;5715.799947001835;5725.198472213893;5738.741756620879;5472.233887255867;5547.223388725501;5572.721363931706;5575.498205161555;5592.7762889483965;5722.141678748221;5730.369659337553;5739.8565035874435;5743.339515955551;5767.480926716616;5312.654677445954;5604.3835178131185;5620.353659329229;5625.521830644441;5645.491905728504;5413.593980451403;5482.533984611353;5543.1408131739645;5626.915596265977;5652.491275785199;5465.508104270635;5473.124300111963;5476.205950137288;5495.972520137374;5540.418256083214;5237.607179461479;5460.7542660579575;5486.177073439016;5490.3411590609385;5507.311586051744;5172.275881376686;5241.68549887008;5276.445973172915;5305.416404195613;5423.511883930308;5242.737863106906;5452.291202143696;5502.202180683698;5547.583931205095;5549.805756798492;5258.684478931276;5368.919466208088;5397.325334333208;5407.864803379947;5414.35027796667 16:50:05 INFO - 2015-11-03 16:50:05,795 DEBUG : BROWSER_OUTPUT: |1;ext.html;495.62217036638145;496.12681680242787;501.8845665496936;506.6554742774912;529.894021195761;30884.845575772117;32261;38142.61857381429;38988.41517377242;39369;41011.17977640445;41678.37482437766;41961.37057944133;42061.789691051505;42201.57798422015;7749.457537972344;7939.245771651684;8817.515036672996;9009.684661036865;9136.680216192435;10621.57513699451;10946.069584085362;10961.287516311455;10968.287061341027;10987.505562249718;10643.201759868001;10714;10720.08879245265;10901.291416057971;10924.945375273152;8049.919500805005;8199.22107399796;10599.364038157697;10687.091597214247;10970.396628185446;10562.419066951315;10596.682099537025;10621.150307975344;10669.306495077795;10689.305195162367;38453;38952.22095558101;38968.220635587415;39016.609833901864;39569.62582245075;2966.658834234069;2999.9550006749914;3009.337945651953;3121.984390078058;3363.7477189210663;26867.73132268672;26907;27100.864495677593;27295.45409091807;27337.31656708578;2306.342692332694;2345.683332750074;2374.952500949971;2388.044782087162;2463.285647162321;283449;283963;285373.5731321351;286744;287464;57469;57767.422325776206;61112.69443652842;61587;66718.66640666766;61536;61728.38271617316;61731;62331;62865.68567157226;16368.754468682979;16566;16574.337026519046;16578.917105414395;16615.83384166167;12506.562270320495;12528.310942898228;12557.246565206116;12571.74856502883;12647.747045059048;19458;19905.402837914884;19913.203471860965;19990.00149977515;20020.599588008157;8084.717034903751;8366.916330836613;8384.161583841567;8396;8454.746357609281;917.8347897378536;945.2485274207022;956.7225504603726;1086.2504871638703;1099.384344766933;27502.587461188097;27768.30579235495;28009;28139.43721125566;28285.57571636427;983.8819341678901;1003.8544411060356;1012.2307046644456;1030.7371620236793;1038.4755698372426;13529.864701353057;14029.508967186099;14801.925990369979;15164.756589270428;15699.450519231772;295280;303087;303314;303784;306845;54154.729226353615;54242;54380.45619543833;54418;54444;1137.4256000719583;1192.1833544022372;1304.3869381390732;1345.1928842694501;1383.2323060701408;28811.85594072016;29463.55804662889;29542.704572953997;29730.702692972794;29863;47200.29199562078;48538.75730621324;48585.757071215834;48596;48640.51359486501;197044;201541;201900;215640;217717;30614.693853062076;30721.231969200948;30827;30870;31026;38843;39360.80319598383;39742;39906;40541.79729101453;35199.47200791939;35684.821575892995;36037.09907252339;36235.27529449343;36635.63364366429;35324.646753532135;35328.11679707925;38901;38976.80511597424;40206.39690404705;35978.8201058993;36580.08549786277;36682.63317366792;36699;37058.6294137066;32380.676193237767;32827.17932051718;34029.48955765616;34367.82816085903;34628.13429664178;23374.181903633973;23984.40038999039;24478.632820508064;24766.876165619058;24793.504129917663 16:50:05 INFO - 2015-11-03 16:50:05,796 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.45205212799397;323.2984423800354;327.06948730860694;328.13209062030927;336.25687231219007;9811.558479868405;10143.594256229742;11392.772144557104;16658.91670541647;16916.492505224847;9937.701868943925;11120.332780033204;11192.44037798111;11364.772704545925;11557.306561606289;4234.132002939397;4272.871813845574;4273.508546517143;4292.978535107336;4335.826566937319;3246.675332466758;4162;4243.702940794145;4334.414853994717;4739.289106634015;4603.309503574457;4659.673822832403;4670.159371313162;4726.7400292983875;4753.90492190156;4119.299719047739;4651.093036857831;4658.371119898804;4689.320048592952;4707.6233901287815;3933.6853051756075;3933.9016524586827;3940.4877365942243;3955.46601208836;3975.185087057146;12760.872391276154;12943.482260709561;13000.349982500931;13046.347682615926;13050.86949130506;1687.1479902649207;1705.5906582420255;1713.9657206855918;1771.601389687323;1787.5441762350647;9138.13187747163;9168;9175.220106290973;9261.027592102799;9297.628094876196;1416.4263473293333;1424.9216293103875;1426.2440906319666;1472.7717203833422;1506.8945173837835;54193.45806541963;56029.71985140089;56255.718721406134;56333.71833140849;56374.15438768422;6106.358832322631;6289.276733175652;6298.181236439325;6315.936840631627;6326.620402775849;7207.603581803051;7242.493025488166;7254.963725181446;7266.183454136466;7273.89089163663;5305.124654431976;5320.068987927175;5326.813561525328;5363.651362661414;5389.137737961907;5726.398728133569;5741.569382296345;5751.539876809845;5827.621204621771;5841.065429531254;2784.8607569621436;2802.1453456695904;2826.8445235512245;2836.2767494288823;2838.0634390651035;966.1304825656965;975.3562648651997;976.8778902637171;1000.2545558001189;1040.2302296300834;403.5439952853257;412.92360913231147;421.9599138081877;443.15799980038184;445.40315976591523;10692.89307106919;10999.890001100046;11070.612528561462;11088.390138542458;11119.555217791198;391.5986114232934;437.5405823884908;449.72566734292053;457.20902838089626;469.99530004699517;5888.4700376966275;6013.579049466495;6020.217371741734;6070.939290607126;6077.209962704908;484652;488270;498516;504690;507843;66090.66954665292;66519.66740166268;66781.33218667848;67671;69359;479.1973444480481;480.3635183381963;484.6922204400231;485.25755593941324;486.06432617211726;10192;10307.330023548446;10325.380477171393;10350.791254711065;10419.322744021614;29258;29758.553621696126;29778.553321699757;30148.246293841952;30254.092377228717;42098.78950605227;42610.57389426066;42685.359719603606;42816.35775463433;43027.35458968055;5765.56758243125;5994.940050599438;6009.759609615567;6071.696415179312;6148.938510615016;10996.780064398507;11095;11097.778044438905;11297.209195356247;11328.207025508136;9164;9618.663346782829;9770.36492627977;9827.459489727848;9885.50572471388;9423.952880235554;9464.905350946678;9688.12806847387;9692.273079518924;10080.24398170155;7999.9600001999615;9304.348695591243;9901.504924753877;9996.850047249152;10008;5910.113482977587;6061.787837425845;6065.059915713072;6112.358202388863;6130.325664176848;9407.331140855209;9541.522923853641;9573.760655983657;9648.807023859625;9829.852552211865 16:50:05 INFO - 2015-11-03 16:50:05,799 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1457.4024649893545;1674.698554260233;1728.6197036651931;1757.481542944832;1770.3980646580164;6541.247756507997;6941.409980151687;7308.524945878514;7520.210377910323;7607.23927607239;7219.458540609449;7312.926870731304;7364.521306115099;7384.187739348681;7483.73806916758;1860.6557786809417;1901.9049047547637;2095.3923362224937;2100.4433825036376;2128.5955668423026;2073.533454972634;2145.3349461666853;2149.290734057757;2160.2331172433796;2172.4025892879426;2077.7610574783866;2079.5009197792497;2122.628540005493;2124.479502521884;2127.627665158591;1890.4328701389666;1933.9709904351446;2057.5576251106086;2086.822620077295;2110.419634600482;2049.139361468172;2069.8240649544805;2072.89635518225;2079.178724403852;2092.7697953225133;7169.211386747454;7223.169335526429;7243.529170603894;7323.7436689715605;7363.374113200384;4412.602865742067;4446.510883802779;4540.318952157169;4546.863594092182;4608;2809.5364264896266;2811.8734656940487;2817.563277691961;2824.5339518979345;2860.113364856901;867.2931560777946;876.8334016536901;880.6829541365104;886.4061079077034;941.9576119074658;9740.123388894963;9740.318177727562;9760.707178784647;9854.063863932915;9884.90115098847;3971.920561588752;4026.4765580474937;4091.263572556909;4112.732672376286;4166.749995000309;8492.872606910902;8509.106543812934;8519.403641745143;8526.957365213135;8607.827843443096;4552.84065057728;4554.681172317906;4570.908581828345;4626.167289887785;4652.371929789503;4141.068259641616;4171.4368560243975;4175.352820312856;4181.393697913785;4244.129953359554;3527.735419843522;3586.228960773446;3597.7481576289933;3618.095476130967;3621.420572708354;1113.8774734779167;1158.79141754485;1161.4367031989477;1161.5469966712988;1165.44641295384;1009.7021378693303;1037.5331101004579;1040.8230600797883;1131.1290306463977;1253.5487224599137;6960;6965.825854353681;6986.882098864259;6997.335253150943;6998.090248267693;425.0521337417576;430.49201941709083;448.2760342047635;452.2266923560748;453.93417954397086;5226.712530810842;5405.351357837006;5408.9729551352775;5440.755166017539;5461.836144915659;8374.958125209336;8797.164269394398;8815.867761983576;8829.293656507463;8916.777080573038;8715.782105447288;8768.693095741746;8788.428752131218;8789.516576588348;8808.51553164582;6831.419329356961;6886.10480637514;6954.4436445084275;6967.825804354931;7019.017337572744;6751.93248067513;6756.662166891734;6761.22245941723;6761.357671021246;6829.965850170717;7765.92234077652;7814.960925195338;7890.368770498231;7943.086545047162;7968.800779980547;7846.960765196138;8068.515889046676;8091.83816323682;8136.227058429677;8190.754277371689;6370.77702280418;6414.61512309263;6459.935400645933;6524.804255872332;6560.40956313934;7037.155541334868;7072.823179420556;7078;7080;7110.751123710852;6534.477241820738;6629.337066293332;6696.464282857457;6707.564008339442;6717.529772915849;6308.526860485574;6517.3808488193545;6541.215054193527;6570.8357291066195;6583.111279977334;6625.105610742488;6698.5980841149685;6704.195496540251;6749.426298764463;6780.796576102724;6035.969820150871;6104.236970378703;6113;6117.449429551361;6211.720472578835;5628.380878103487;5781.653100813965;5928.8814223716145;6050.697465126814;6155.169052177898 16:50:05 INFO - 2015-11-03 16:50:05,800 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.9805012674175;302.1102852100565;302.5960342942171;303.23887043520756;307.5816889030918;5900.055991041434;5913.674747888865;5924.289085309769;5927.614705044169;5932.584719069667;5776.82669519914;5789.507891829189;5800.8259752207505;5813.883722325551;5820.097884827848;4325.416068830699;4486.977565112178;4512.075024619945;4517.7289362638185;4550.49944506104;4455.933161002587;4470;4550.795214215368;4560.863174104782;4680.485146633868;4467.374567560544;4498.235299999008;4502.48221454532;4560.8859778505475;4571.6114130298965;4349.804258808361;4386.670999675037;4464.151811155903;4513.984353520448;4539.6368290536675;3861.517310336208;3864.574896761354;3869.129445874684;3874.089588946595;3917.490726205575;5668.744906479218;5680.772769089232;5701.201831743518;5725.513331366838;5748.942510574924;5059.468755780626;5069.822556210552;5089.338386009832;5095;5119.56483698886;5952.9702351488395;6135.601185922901;6214.161088253073;6219.626822390671;6291.339409361997;4288.463942007249;4298.226319262531;4302.956970430287;4355.5644435556505;4359.04101097758;6493.31820158886;6519.087327774116;6574.802755917282;6611.173603299588;6638.137042184533;4266.722663026893;4334.891627709269;4373.759443230653;4417;4442.577955094261;4469.73181609098;4476.686631935733;4483.327500874895;4529.592336689714;4552.339910712928;5135.075686376488;5139.640225184276;5150.253213284052;5207.4011488678525;5209.166533354645;6279.403456671609;6296.685165741695;6318.178636777189;6326.778562750282;6339.904901426482;1572.449642625072;1582.027053362174;1603.6311648320718;1605.0770806786145;1639.5655151384892;1001.3191030099457;1022.539857064324;1026.1021606094666;1033.7570670892335;1041.4740556019162;5913;5927.8221653350465;5931.940680593225;6039.456448919618;6055.394460553997;6423.582467139621;6472.805815825533;6484.643344615997;6516.869662606721;6549.181352330958;5940.257467816523;5953.970230148821;5990.790322338785;6018.337982821886;6040.577159598786;3501.124718820295;3518.9120271993406;3568.0366301099075;3579.391503444421;3632.6912212462234;6478.643674597943;6498.3826536478955;6590.242122155918;6596.505262105361;6606.306337834458;6556.27880933097;6557.082008518812;6580.1445812045085;6656.667166641649;6679.699413526403;6367.554271200971;6480.254770701241;6515.902261466082;6532.281449040602;6555.180602424697;6394.7442102317245;6399.008153736178;6457.838554036187;6548.869022619616;6572.277049524453;6378.48972082223;6380.425761681471;6460.4508616766225;6463.192100987377;6506.73973041092;6485.805425837232;6573.079768832272;6592.077109204619;6621.470282377494;6706.429953454011;4172.457580514514;4172.4993000840095;4183.895402614959;4208.38978348144;4236.08924081324;6432.453241474527;6459.935400645933;6470.417662410406;6568.573042752206;6572.704228309642;6048.092786082123;6232.844178895564;6254.061890716429;6260.092286618506;6324.652144131933;6241.78153764616;6267.843303917439;6269.153664255267;6294.024426213944;6320.020396838498;6066.4540191382985;6070.484008859296;6110.114033465212;6141.539384546088;6185.567010309235;5932.703364831655;5993.250843644544;6201.844953876189;6232.5637205397;6262.373762623702;6021.397860213943;6042.425969532887;6086.360932102066;6118.877622447615;6162.414570615784 16:50:05 INFO - 2015-11-03 16:50:05,802 DEBUG : BROWSER_OUTPUT: |5;yui.html;637.5887552528623;638.3265654734255;712.4941291682904;721.7690339091487;742.721479445208;9942.850857237137;10008.949955250231;10150.13723833474;10173.186145108391;10214.795704085915;12215.938920305409;13360.331983400816;13368.665783355422;13377.531786387479;13602.115862468932;657.3623585122424;811;826.7602395305354;828.4325237212498;828.6975254032265;648.3127884442482;809.7125520440247;823.5264722784393;824.389951435936;824.5300178898001;836.3643630840575;853.4068822168596;856.4647095565272;859.1580251353677;861.0700443520982;659.8020593821834;664.4750646988873;819.5574389829485;838.4508147163588;856.9957150214241;622.5362105231632;624.5596854217765;625.8404106952744;626.8840264551072;629.0564153769346;12800.935995320056;12955.157914735511;13007.089503734742;13119.278439685813;13178;8806.955965220197;8924.152205540464;9050.084636064894;9286.953565232197;9340.392874463207;8416.663333466655;8604.741857744277;8675.132486751338;9032.141946515136;9057.68298109563;2782.749552540261;2788.0659978907092;2791.986040069807;2799.286182023591;2815.0710265612297;43284.134317313474;44126;44189.337159942625;44672.32991505098;44715.329270060975;6308.936910630835;6389.073584330246;6451.612903225728;6472.449841763409;6619.238787539398;11424.485898134437;11518.769624607461;11560.24858384219;11567.76864462706;11728.296302221894;5546.855969655854;5662.518685911744;5703.914441283384;5903.58674892762;5924.674142922181;3508.421110516736;3610.9638903610626;3623.8912832615065;3658.231771328051;3761.4357846322723;2665.626812246287;2846.8861245549947;2890.2802832314737;2897.4494845979198;2907.8982235622075;461.3218568704;476.0455287149244;476.86409373328434;477.3245857112217;478.8300153445546;427.4187105536468;544.335910189568;556.1518684006841;565.5447364871318;573.9856503587444;7097.183823860322;7164.713411463587;7304.926950730424;7314.305141011595;7341.265873412616;451.25993370871794;526.2080568744016;532.7496076843877;542.2029616463792;578.2767353287144;3128.2148600193564;3294.25879177188;3370.4607262837826;3379.442392005341;3410.8806191783665;56429;56922.146167807514;57019.71490142523;57138.14292785611;57325.42674573201;47995.76002119967;48140;48445.5155448441;48881;49642.50357496451;43745;44647.55352446499;45167;46074.5392546077;46218.30672539915;6907.067545881242;6921;6993.557516479935;7004.579725216503;7113.786586402416;33927.151821204665;34263;34776.82611587027;34929.65070349264;35329.47005794864;41161.79419102885;41418.37872431976;42949;45301;46437.53562464332;5937.554683398849;6162.075688646739;6287.622742635456;6380.904286435614;6455.225372955276;8731.432456890281;9564.76088097803;9901;10335.966403359604;10651.094656953936;8586.570671466277;9078.682246121354;9301.534923253945;9332.673356432493;9472.763180920532;8380.622871970898;8823.205911467741;9164.450132992042;9298.72103836886;9305.720828375159;8679.218870301704;8905.599248033725;9028.458292502472;9101.635934562544;9422.434653920787;7654.048902522578;7701.576413297323;7895.84208315842;8215.958920205361;8517.872231916403;7728.376703841388;8058.637361318872;8258.504489730636;8389.790255243668;8690.304775618062 16:50:05 INFO - 2015-11-03 16:50:05,802 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:50:05 INFO - 2015-11-03 16:50:05,802 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:50:05 INFO - 2015-11-03 16:50:05,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 16:50:05 INFO - 2015-11-03 16:50:05,802 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:50:05 INFO - 2015-11-03 16:50:05,803 DEBUG : BROWSER_OUTPUT: __startTimestamp1446598205789__endTimestamp 16:50:05 INFO - 2015-11-03 16:50:05,803 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,803 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:50:05 INFO - 2015-11-03 16:50:05,803 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:50:05 INFO - 2015-11-03 16:50:05,803 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,803 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5164.07 Median:5313.79 stddev:545.07 (10.3%) stddev-sans-first:521.23 16:50:05 INFO - 2015-11-03 16:50:05,805 DEBUG : BROWSER_OUTPUT: Values: 3062.9 3071.6 3245.8 3252.6 3322.9 4896.3 5075.8 5107.3 5185.8 5285.6 5023.2 5031.5 5046.2 5091.4 5248.7 4670.3 4696.2 4745.2 4820.3 4856.8 4816.7 4819.1 4834.1 4855.7 4948.8 4627.3 4692.2 4698.5 4712.3 4753.8 4614.4 4757.3 4761.8 4807.4 4819.7 4737.9 4752.1 4772.5 4776.8 4962.0 5005.0 5030.4 5171.3 5185.1 5283.2 5397.4 5401.7 5466.1 5482.2 5592.3 5496.2 5556.7 5568.2 5585.7 5589.9 5004.1 5132.6 5138.9 5223.1 5313.0 5581.1 5616.9 5632.0 5637.2 5639.9 5469.2 5490.3 5494.8 5497.9 5623.6 5409.9 5478.5 5486.5 5594.2 5801.8 5352.7 5384.4 5386.1 5473.0 5478.2 5486.2 5489.2 5495.7 5496.4 5514.7 4171.7 4246.7 4334.7 4363.9 4422.4 3815.2 3861.9 3882.4 3945.3 3954.7 5214.3 5215.3 5239.2 5287.3 5313.8 5452.6 5577.3 5590.9 5592.7 5631.2 5114.3 5225.2 5236.6 5237.9 5240.4 4886.9 4890.7 4893.8 4898.1 4916.2 5484.2 5678.2 5715.8 5725.2 5738.7 5472.2 5547.2 5572.7 5575.5 5592.8 5722.1 5730.4 5739.9 5743.3 5767.5 5312.7 5604.4 5620.4 5625.5 5645.5 5413.6 5482.5 5543.1 5626.9 5652.5 5465.5 5473.1 5476.2 5496.0 5540.4 5237.6 5460.8 5486.2 5490.3 5507.3 5172.3 5241.7 5276.4 5305.4 5423.5 5242.7 5452.3 5502.2 5547.6 5549.8 5258.7 5368.9 5397.3 5407.9 5414.4 16:50:05 INFO - 2015-11-03 16:50:05,805 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,806 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44220.32 Median:167199.35 stddev:69945.69 (41.8%) stddev-sans-first:70064.85 16:50:05 INFO - 2015-11-03 16:50:05,806 DEBUG : BROWSER_OUTPUT: Values: 495.6 496.1 501.9 506.7 529.9 30884.8 32261.0 38142.6 38988.4 39369.0 41011.2 41678.4 41961.4 42061.8 42201.6 7749.5 7939.2 8817.5 9009.7 9136.7 10621.6 10946.1 10961.3 10968.3 10987.5 10643.2 10714.0 10720.1 10901.3 10924.9 8049.9 8199.2 10599.4 10687.1 10970.4 10562.4 10596.7 10621.2 10669.3 10689.3 38453.0 38952.2 38968.2 39016.6 39569.6 2966.7 3000.0 3009.3 3122.0 3363.7 26867.7 26907.0 27100.9 27295.5 27337.3 2306.3 2345.7 2375.0 2388.0 2463.3 283449.0 283963.0 285373.6 286744.0 287464.0 57469.0 57767.4 61112.7 61587.0 66718.7 61536.0 61728.4 61731.0 62331.0 62865.7 16368.8 16566.0 16574.3 16578.9 16615.8 12506.6 12528.3 12557.2 12571.7 12647.7 19458.0 19905.4 19913.2 19990.0 20020.6 8084.7 8366.9 8384.2 8396.0 8454.7 917.8 945.2 956.7 1086.3 1099.4 27502.6 27768.3 28009.0 28139.4 28285.6 983.9 1003.9 1012.2 1030.7 1038.5 13529.9 14029.5 14801.9 15164.8 15699.5 295280.0 303087.0 303314.0 303784.0 306845.0 54154.7 54242.0 54380.5 54418.0 54444.0 1137.4 1192.2 1304.4 1345.2 1383.2 28811.9 29463.6 29542.7 29730.7 29863.0 47200.3 48538.8 48585.8 48596.0 48640.5 197044.0 201541.0 201900.0 215640.0 217717.0 30614.7 30721.2 30827.0 30870.0 31026.0 38843.0 39360.8 39742.0 39906.0 40541.8 35199.5 35684.8 36037.1 36235.3 36635.6 35324.6 35328.1 38901.0 38976.8 40206.4 35978.8 36580.1 36682.6 36699.0 37058.6 32380.7 32827.2 34029.5 34367.8 34628.1 23374.2 23984.4 24478.6 24766.9 24793.5 16:50:05 INFO - 2015-11-03 16:50:05,806 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,808 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24511.80 Median:4679.74 stddev:81408.39 (1739.6%) stddev-sans-first:81616.47 16:50:05 INFO - 2015-11-03 16:50:05,808 DEBUG : BROWSER_OUTPUT: Values: 310.5 323.3 327.1 328.1 336.3 9811.6 10143.6 11392.8 16658.9 16916.5 9937.7 11120.3 11192.4 11364.8 11557.3 4234.1 4272.9 4273.5 4293.0 4335.8 3246.7 4162.0 4243.7 4334.4 4739.3 4603.3 4659.7 4670.2 4726.7 4753.9 4119.3 4651.1 4658.4 4689.3 4707.6 3933.7 3933.9 3940.5 3955.5 3975.2 12760.9 12943.5 13000.3 13046.3 13050.9 1687.1 1705.6 1714.0 1771.6 1787.5 9138.1 9168.0 9175.2 9261.0 9297.6 1416.4 1424.9 1426.2 1472.8 1506.9 54193.5 56029.7 56255.7 56333.7 56374.2 6106.4 6289.3 6298.2 6315.9 6326.6 7207.6 7242.5 7255.0 7266.2 7273.9 5305.1 5320.1 5326.8 5363.7 5389.1 5726.4 5741.6 5751.5 5827.6 5841.1 2784.9 2802.1 2826.8 2836.3 2838.1 966.1 975.4 976.9 1000.3 1040.2 403.5 412.9 422.0 443.2 445.4 10692.9 10999.9 11070.6 11088.4 11119.6 391.6 437.5 449.7 457.2 470.0 5888.5 6013.6 6020.2 6070.9 6077.2 484652.0 488270.0 498516.0 504690.0 507843.0 66090.7 66519.7 66781.3 67671.0 69359.0 479.2 480.4 484.7 485.3 486.1 10192.0 10307.3 10325.4 10350.8 10419.3 29258.0 29758.6 29778.6 30148.2 30254.1 42098.8 42610.6 42685.4 42816.4 43027.4 5765.6 5994.9 6009.8 6071.7 6148.9 10996.8 11095.0 11097.8 11297.2 11328.2 9164.0 9618.7 9770.4 9827.5 9885.5 9424.0 9464.9 9688.1 9692.3 10080.2 8000.0 9304.3 9901.5 9996.9 10008.0 5910.1 6061.8 6065.1 6112.4 6130.3 9407.3 9541.5 9573.8 9648.8 9829.9 16:50:05 INFO - 2015-11-03 16:50:05,808 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,809 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5124.75 Median:6339.65 stddev:2665.85 (42.1%) stddev-sans-first:2659.08 16:50:05 INFO - 2015-11-03 16:50:05,809 DEBUG : BROWSER_OUTPUT: Values: 1457.4 1674.7 1728.6 1757.5 1770.4 6541.2 6941.4 7308.5 7520.2 7607.2 7219.5 7312.9 7364.5 7384.2 7483.7 1860.7 1901.9 2095.4 2100.4 2128.6 2073.5 2145.3 2149.3 2160.2 2172.4 2077.8 2079.5 2122.6 2124.5 2127.6 1890.4 1934.0 2057.6 2086.8 2110.4 2049.1 2069.8 2072.9 2079.2 2092.8 7169.2 7223.2 7243.5 7323.7 7363.4 4412.6 4446.5 4540.3 4546.9 4608.0 2809.5 2811.9 2817.6 2824.5 2860.1 867.3 876.8 880.7 886.4 942.0 9740.1 9740.3 9760.7 9854.1 9884.9 3971.9 4026.5 4091.3 4112.7 4166.7 8492.9 8509.1 8519.4 8527.0 8607.8 4552.8 4554.7 4570.9 4626.2 4652.4 4141.1 4171.4 4175.4 4181.4 4244.1 3527.7 3586.2 3597.7 3618.1 3621.4 1113.9 1158.8 1161.4 1161.5 1165.4 1009.7 1037.5 1040.8 1131.1 1253.5 6960.0 6965.8 6986.9 6997.3 6998.1 425.1 430.5 448.3 452.2 453.9 5226.7 5405.4 5409.0 5440.8 5461.8 8375.0 8797.2 8815.9 8829.3 8916.8 8715.8 8768.7 8788.4 8789.5 8808.5 6831.4 6886.1 6954.4 6967.8 7019.0 6751.9 6756.7 6761.2 6761.4 6830.0 7765.9 7815.0 7890.4 7943.1 7968.8 7847.0 8068.5 8091.8 8136.2 8190.8 6370.8 6414.6 6459.9 6524.8 6560.4 7037.2 7072.8 7078.0 7080.0 7110.8 6534.5 6629.3 6696.5 6707.6 6717.5 6308.5 6517.4 6541.2 6570.8 6583.1 6625.1 6698.6 6704.2 6749.4 6780.8 6036.0 6104.2 6113.0 6117.4 6211.7 5628.4 5781.7 5928.9 6050.7 6155.2 16:50:05 INFO - 2015-11-03 16:50:05,809 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,810 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5205.70 Median:5929.88 stddev:1575.67 (26.6%) stddev-sans-first:1536.46 16:50:05 INFO - 2015-11-03 16:50:05,811 DEBUG : BROWSER_OUTPUT: Values: 300.0 302.1 302.6 303.2 307.6 5900.1 5913.7 5924.3 5927.6 5932.6 5776.8 5789.5 5800.8 5813.9 5820.1 4325.4 4487.0 4512.1 4517.7 4550.5 4455.9 4470.0 4550.8 4560.9 4680.5 4467.4 4498.2 4502.5 4560.9 4571.6 4349.8 4386.7 4464.2 4514.0 4539.6 3861.5 3864.6 3869.1 3874.1 3917.5 5668.7 5680.8 5701.2 5725.5 5748.9 5059.5 5069.8 5089.3 5095.0 5119.6 5953.0 6135.6 6214.2 6219.6 6291.3 4288.5 4298.2 4303.0 4355.6 4359.0 6493.3 6519.1 6574.8 6611.2 6638.1 4266.7 4334.9 4373.8 4417.0 4442.6 4469.7 4476.7 4483.3 4529.6 4552.3 5135.1 5139.6 5150.3 5207.4 5209.2 6279.4 6296.7 6318.2 6326.8 6339.9 1572.4 1582.0 1603.6 1605.1 1639.6 1001.3 1022.5 1026.1 1033.8 1041.5 5913.0 5927.8 5931.9 6039.5 6055.4 6423.6 6472.8 6484.6 6516.9 6549.2 5940.3 5954.0 5990.8 6018.3 6040.6 3501.1 3518.9 3568.0 3579.4 3632.7 6478.6 6498.4 6590.2 6596.5 6606.3 6556.3 6557.1 6580.1 6656.7 6679.7 6367.6 6480.3 6515.9 6532.3 6555.2 6394.7 6399.0 6457.8 6548.9 6572.3 6378.5 6380.4 6460.5 6463.2 6506.7 6485.8 6573.1 6592.1 6621.5 6706.4 4172.5 4172.5 4183.9 4208.4 4236.1 6432.5 6459.9 6470.4 6568.6 6572.7 6048.1 6232.8 6254.1 6260.1 6324.7 6241.8 6267.8 6269.2 6294.0 6320.0 6066.5 6070.5 6110.1 6141.5 6185.6 5932.7 5993.3 6201.8 6232.6 6262.4 6021.4 6042.4 6086.4 6118.9 6162.4 16:50:05 INFO - 2015-11-03 16:50:05,811 DEBUG : BROWSER_OUTPUT: 16:50:05 INFO - 2015-11-03 16:50:05,811 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12313.66 Median:5931.11 stddev:15600.04 (263.0%) stddev-sans-first:15619.17 16:50:05 INFO - 2015-11-03 16:50:05,813 DEBUG : BROWSER_OUTPUT: Values: 637.6 638.3 712.5 721.8 742.7 9942.9 10008.9 10150.1 10173.2 10214.8 12215.9 13360.3 13368.7 13377.5 13602.1 657.4 811.0 826.8 828.4 828.7 648.3 809.7 823.5 824.4 824.5 836.4 853.4 856.5 859.2 861.1 659.8 664.5 819.6 838.5 857.0 622.5 624.6 625.8 626.9 629.1 12800.9 12955.2 13007.1 13119.3 13178.0 8807.0 8924.2 9050.1 9287.0 9340.4 8416.7 8604.7 8675.1 9032.1 9057.7 2782.7 2788.1 2792.0 2799.3 2815.1 43284.1 44126.0 44189.3 44672.3 44715.3 6308.9 6389.1 6451.6 6472.4 6619.2 11424.5 11518.8 11560.2 11567.8 11728.3 5546.9 5662.5 5703.9 5903.6 5924.7 3508.4 3611.0 3623.9 3658.2 3761.4 2665.6 2846.9 2890.3 2897.4 2907.9 461.3 476.0 476.9 477.3 478.8 427.4 544.3 556.2 565.5 574.0 7097.2 7164.7 7304.9 7314.3 7341.3 451.3 526.2 532.7 542.2 578.3 3128.2 3294.3 3370.5 3379.4 3410.9 56429.0 56922.1 57019.7 57138.1 57325.4 47995.8 48140.0 48445.5 48881.0 49642.5 43745.0 44647.6 45167.0 46074.5 46218.3 6907.1 6921.0 6993.6 7004.6 7113.8 33927.2 34263.0 34776.8 34929.7 35329.5 41161.8 41418.4 42949.0 45301.0 46437.5 5937.6 6162.1 6287.6 6380.9 6455.2 8731.4 9564.8 9901.0 10336.0 10651.1 8586.6 9078.7 9301.5 9332.7 9472.8 8380.6 8823.2 9164.5 9298.7 9305.7 8679.2 8905.6 9028.5 9101.6 9422.4 7654.0 7701.6 7895.8 8216.0 8517.9 7728.4 8058.6 8258.5 8389.8 8690.3 16:50:05 INFO - 2015-11-03 16:50:05,813 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:50:05 INFO - 2015-11-03 16:50:05,813 DEBUG : BROWSER_OUTPUT: 16:50:06 INFO - 2015-11-03 16:50:06,428 INFO : Browser exited with error code: 0 16:50:06 INFO - 2015-11-03 16:50:06,454 INFO : Completed test dromaeo_css (00:18:35) 16:50:06 INFO - 2015-11-03 16:50:06,454 INFO : Starting test kraken 16:50:06 INFO - 2015-11-03 16:50:06,455 DEBUG : operating with platform_type : mac_ 16:50:06 INFO - 2015-11-03 16:50:06,455 INFO : Initialising browser for kraken test... 16:50:06 INFO - 2015-11-03 16:50:06,468 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/tmpktI_d2/profile http://localhost:49269/getInfo.html 16:50:08 INFO - 2015-11-03 16:50:08,745 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:50:08 INFO - 2015-11-03 16:50:08,745 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:50:08 INFO - 2015-11-03 16:50:08,745 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:50:08 INFO - 2015-11-03 16:50:08,745 DEBUG : BROWSER_OUTPUT: __metrics 16:50:08 INFO - 2015-11-03 16:50:08,761 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:09 INFO - 2015-11-03 16:50:09,456 INFO : Browser initialized. 16:50:09 INFO - 2015-11-03 16:50:09,457 INFO : Running cycle 1/1 for kraken test... 16:50:09 INFO - 2015-11-03 16:50:09,457 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/tmpktI_d2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:50:21 INFO - 2015-11-03 16:50:21,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 220246016 16:50:21 INFO - 2015-11-03 16:50:21,328 DEBUG : BROWSER_OUTPUT: 16:50:23 INFO - 2015-11-03 16:50:23,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:24 INFO - 2015-11-03 16:50:24,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 277483520 16:50:24 INFO - 2015-11-03 16:50:24,461 DEBUG : BROWSER_OUTPUT: 16:50:27 INFO - 2015-11-03 16:50:27,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 16:50:27 INFO - 2015-11-03 16:50:27,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 287498240 16:50:27 INFO - 2015-11-03 16:50:27,666 DEBUG : BROWSER_OUTPUT: 16:50:30 INFO - 2015-11-03 16:50:30,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 16:50:31 INFO - 2015-11-03 16:50:31,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 269324288 16:50:31 INFO - 2015-11-03 16:50:31,218 DEBUG : BROWSER_OUTPUT: 16:50:33 INFO - 2015-11-03 16:50:33,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 16:50:33 INFO - 2015-11-03 16:50:33,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 270635008 16:50:33 INFO - 2015-11-03 16:50:33,811 DEBUG : BROWSER_OUTPUT: 16:50:35 INFO - 2015-11-03 16:50:35,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:50:36 INFO - 2015-11-03 16:50:36,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 273162240 16:50:36 INFO - 2015-11-03 16:50:36,567 DEBUG : BROWSER_OUTPUT: 16:50:39 INFO - 2015-11-03 16:50:39,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 16:50:40 INFO - 2015-11-03 16:50:40,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 273211392 16:50:40 INFO - 2015-11-03 16:50:40,198 DEBUG : BROWSER_OUTPUT: 16:50:43 INFO - 2015-11-03 16:50:43,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 16:50:43 INFO - 2015-11-03 16:50:43,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 273539072 16:50:43 INFO - 2015-11-03 16:50:43,942 DEBUG : BROWSER_OUTPUT: 16:50:46 INFO - 2015-11-03 16:50:46,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 16:50:47 INFO - 2015-11-03 16:50:47,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 272998400 16:50:47 INFO - 2015-11-03 16:50:47,469 DEBUG : BROWSER_OUTPUT: 16:50:49 INFO - 2015-11-03 16:50:49,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:50:49 INFO - 2015-11-03 16:50:49,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 307175424 16:50:49 INFO - 2015-11-03 16:50:49,596 DEBUG : BROWSER_OUTPUT: 16:50:51 INFO - 2015-11-03 16:50:51,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:50:52 INFO - 2015-11-03 16:50:52,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 307593216 16:50:52 INFO - 2015-11-03 16:50:52,046 DEBUG : BROWSER_OUTPUT: 16:50:54 INFO - 2015-11-03 16:50:54,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:50:54 INFO - 2015-11-03 16:50:54,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 316694528 16:50:54 INFO - 2015-11-03 16:50:54,708 DEBUG : BROWSER_OUTPUT: 16:50:57 INFO - 2015-11-03 16:50:57,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:50:57 INFO - 2015-11-03 16:50:57,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 317657088 16:50:57 INFO - 2015-11-03 16:50:57,942 DEBUG : BROWSER_OUTPUT: 16:51:00 INFO - 2015-11-03 16:51:00,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:01 INFO - 2015-11-03 16:51:01,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 317165568 16:51:01 INFO - 2015-11-03 16:51:01,158 DEBUG : BROWSER_OUTPUT: 16:51:02 INFO - 2015-11-03 16:51:02,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 16:51:03 INFO - 2015-11-03 16:51:03,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 376606720 16:51:03 INFO - 2015-11-03 16:51:03,130 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,131 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:51:03 INFO - 2015-11-03 16:51:03,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:51:03 INFO - 2015-11-03 16:51:03,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:51:03 INFO - 2015-11-03 16:51:03,131 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:51:03 INFO - 2015-11-03 16:51:03,131 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;109;102;106;106;108;96;107;112;107 16:51:03 INFO - 2015-11-03 16:51:03,131 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;149;159;124;148;144;125;161;125 16:51:03 INFO - 2015-11-03 16:51:03,132 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;171;162;162;164;163;163;159 16:51:03 INFO - 2015-11-03 16:51:03,132 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;84;87;85;67;68;70;77;82;66 16:51:03 INFO - 2015-11-03 16:51:03,132 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;99;137;89;92;89;124;90;90;131 16:51:03 INFO - 2015-11-03 16:51:03,132 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;117;114;121;119;114;120;125;122;114 16:51:03 INFO - 2015-11-03 16:51:03,132 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;125;126;125;126;126;124;130;139 16:51:03 INFO - 2015-11-03 16:51:03,132 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;100;102;106;105;108;109;108;109;107 16:51:03 INFO - 2015-11-03 16:51:03,132 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;59;56;57;57;57;66;57;59 16:51:03 INFO - 2015-11-03 16:51:03,134 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;68;66;68;68;68;73;69;70 16:51:03 INFO - 2015-11-03 16:51:03,134 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;87;89;85;86;85;87;88;87 16:51:03 INFO - 2015-11-03 16:51:03,134 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;121;131;129;132;142;147;139;142;131 16:51:03 INFO - 2015-11-03 16:51:03,134 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;151;151;150;151;160;157;161;161;150 16:51:03 INFO - 2015-11-03 16:51:03,135 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;70;70;71;71;71;71;72 16:51:03 INFO - 2015-11-03 16:51:03,135 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:51:03 INFO - 2015-11-03 16:51:03,135 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:51:03 INFO - 2015-11-03 16:51:03,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 16:51:03 INFO - 2015-11-03 16:51:03,135 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:51:03 INFO - 2015-11-03 16:51:03,135 DEBUG : BROWSER_OUTPUT: __startTimestamp1446598263130__endTimestamp 16:51:03 INFO - 2015-11-03 16:51:03,136 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,136 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:51:03 INFO - 2015-11-03 16:51:03,137 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:51:03 INFO - 2015-11-03 16:51:03,137 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,137 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.90 Median:107.50 stddev:4.31 (4.0%) stddev-sans-first:4.57 16:51:03 INFO - 2015-11-03 16:51:03,138 DEBUG : BROWSER_OUTPUT: Values: 106.0 109.0 102.0 106.0 106.0 108.0 96.0 107.0 112.0 107.0 16:51:03 INFO - 2015-11-03 16:51:03,138 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,138 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.00 Median:148.50 stddev:14.55 (9.8%) stddev-sans-first:14.77 16:51:03 INFO - 2015-11-03 16:51:03,138 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 149.0 159.0 124.0 148.0 144.0 125.0 161.0 125.0 16:51:03 INFO - 2015-11-03 16:51:03,138 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,138 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:3.46 16:51:03 INFO - 2015-11-03 16:51:03,139 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 171.0 162.0 162.0 164.0 163.0 163.0 159.0 16:51:03 INFO - 2015-11-03 16:51:03,139 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,139 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.90 Median:79.50 stddev:8.12 (10.2%) stddev-sans-first:8.54 16:51:03 INFO - 2015-11-03 16:51:03,139 DEBUG : BROWSER_OUTPUT: Values: 73.0 84.0 87.0 85.0 67.0 68.0 70.0 77.0 82.0 66.0 16:51:03 INFO - 2015-11-03 16:51:03,139 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,139 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:89.50 stddev:18.99 (21.2%) stddev-sans-first:20.08 16:51:03 INFO - 2015-11-03 16:51:03,140 DEBUG : BROWSER_OUTPUT: Values: 100.0 99.0 137.0 89.0 92.0 89.0 124.0 90.0 90.0 131.0 16:51:03 INFO - 2015-11-03 16:51:03,140 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,140 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:120.50 stddev:3.83 (3.2%) stddev-sans-first:3.97 16:51:03 INFO - 2015-11-03 16:51:03,140 DEBUG : BROWSER_OUTPUT: Values: 121.0 117.0 114.0 121.0 119.0 114.0 120.0 125.0 122.0 114.0 16:51:03 INFO - 2015-11-03 16:51:03,140 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,140 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:127.10 Median:126.00 stddev:4.48 (3.6%) stddev-sans-first:4.69 16:51:03 INFO - 2015-11-03 16:51:03,141 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 125.0 126.0 125.0 126.0 126.0 124.0 130.0 139.0 16:51:03 INFO - 2015-11-03 16:51:03,141 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,141 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.50 Median:107.50 stddev:3.37 (3.1%) stddev-sans-first:3.16 16:51:03 INFO - 2015-11-03 16:51:03,141 DEBUG : BROWSER_OUTPUT: Values: 101.0 100.0 102.0 106.0 105.0 108.0 109.0 108.0 109.0 107.0 16:51:03 INFO - 2015-11-03 16:51:03,141 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,141 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.50 stddev:2.87 (5.0%) stddev-sans-first:3.04 16:51:03 INFO - 2015-11-03 16:51:03,142 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 59.0 56.0 57.0 57.0 57.0 66.0 57.0 59.0 16:51:03 INFO - 2015-11-03 16:51:03,142 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,143 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:2.06 (3.0%) stddev-sans-first:2.01 16:51:03 INFO - 2015-11-03 16:51:03,143 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 68.0 66.0 68.0 68.0 68.0 73.0 69.0 70.0 16:51:03 INFO - 2015-11-03 16:51:03,144 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,144 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.30 16:51:03 INFO - 2015-11-03 16:51:03,144 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 87.0 89.0 85.0 86.0 85.0 87.0 88.0 87.0 16:51:03 INFO - 2015-11-03 16:51:03,144 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,144 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:135.50 stddev:8.42 (6.2%) stddev-sans-first:8.15 16:51:03 INFO - 2015-11-03 16:51:03,144 DEBUG : BROWSER_OUTPUT: Values: 124.0 121.0 131.0 129.0 132.0 142.0 147.0 139.0 142.0 131.0 16:51:03 INFO - 2015-11-03 16:51:03,144 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,145 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:6.82 (4.4%) stddev-sans-first:4.97 16:51:03 INFO - 2015-11-03 16:51:03,145 DEBUG : BROWSER_OUTPUT: Values: 139.0 151.0 151.0 150.0 151.0 160.0 157.0 161.0 161.0 150.0 16:51:03 INFO - 2015-11-03 16:51:03,145 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,145 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 16:51:03 INFO - 2015-11-03 16:51:03,145 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 70.0 70.0 71.0 71.0 71.0 71.0 72.0 16:51:03 INFO - 2015-11-03 16:51:03,145 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:51:03 INFO - 2015-11-03 16:51:03,145 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-03 16:51:03,792 INFO : Browser exited with error code: 0 16:51:03 INFO - 2015-11-03 16:51:03,842 INFO : Completed test kraken (00:00:57) 16:51:03 INFO - 2015-11-03 16:51:03,842 INFO : Starting test v8_7 16:51:03 INFO - 2015-11-03 16:51:03,842 DEBUG : operating with platform_type : mac_ 16:51:03 INFO - 2015-11-03 16:51:03,842 INFO : Initialising browser for v8_7 test... 16:51:03 INFO - 2015-11-03 16:51:03,856 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/tmpJgoepE/profile http://localhost:49269/getInfo.html 16:51:06 INFO - 2015-11-03 16:51:06,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:51:06 INFO - 2015-11-03 16:51:06,077 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:51:06 INFO - 2015-11-03 16:51:06,077 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:51:06 INFO - 2015-11-03 16:51:06,078 DEBUG : BROWSER_OUTPUT: __metrics 16:51:06 INFO - 2015-11-03 16:51:06,085 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:51:06 INFO - 2015-11-03 16:51:06,791 INFO : Browser initialized. 16:51:06 INFO - 2015-11-03 16:51:06,792 INFO : Running cycle 1/1 for v8_7 test... 16:51:06 INFO - 2015-11-03 16:51:06,792 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/T/tmpJgoepE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:51:18 INFO - 2015-11-03 16:51:18,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 220831744 16:51:18 INFO - 2015-11-03 16:51:18,663 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 16:51:40 INFO - 2015-11-03 16:51:40,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 661004288 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: |0;Richards;168.69095816464238 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;199.4415636218588 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: |2;Encrypt;331.6749585406302 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5894.117647058823 16:51:40 INFO - 2015-11-03 16:51:40,427 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2092.050209205021 16:51:40 INFO - 2015-11-03 16:51:40,428 DEBUG : BROWSER_OUTPUT: |5;Earley;1028.5714285714287 16:51:40 INFO - 2015-11-03 16:51:40,428 DEBUG : BROWSER_OUTPUT: |6;Boyer;13440 16:51:40 INFO - 2015-11-03 16:51:40,428 DEBUG : BROWSER_OUTPUT: |7;RegExp;32125 16:51:40 INFO - 2015-11-03 16:51:40,428 DEBUG : BROWSER_OUTPUT: |8;Splay;689.6551724137931 16:51:40 INFO - 2015-11-03 16:51:40,428 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5917.15976331361 16:51:40 INFO - 2015-11-03 16:51:40,428 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:51:40 INFO - 2015-11-03 16:51:40,428 DEBUG : BROWSER_OUTPUT: __startTimestamp1446598300422__endTimestamp 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.69 Median:168.69 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: Values: 168.7 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:199.44 Median:199.44 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: Values: 199.4 16:51:40 INFO - 2015-11-03 16:51:40,429 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:331.67 Median:331.67 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: Values: 331.7 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5894.12 Median:5894.12 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: Values: 5894.1 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2092.05 Median:2092.05 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,430 DEBUG : BROWSER_OUTPUT: Values: 2092.1 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1028.57 Median:1028.57 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: Values: 1028.6 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13440.00 Median:13440.00 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: Values: 13440.0 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,431 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32125.00 Median:32125.00 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: Values: 32125.0 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:689.66 Median:689.66 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: Values: 689.7 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5917.16 Median:5917.16 stddev:0.00 (0.0%) 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: Values: 5917.2 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:51:40 INFO - 2015-11-03 16:51:40,432 DEBUG : BROWSER_OUTPUT: 16:51:41 INFO - 2015-11-03 16:51:41,131 INFO : Browser exited with error code: 0 16:51:41 INFO - 2015-11-03 16:51:41,151 INFO : Completed test v8_7 (00:00:37) 16:51:41 INFO - 2015-11-03 16:51:41,531 INFO : Completed test suite (00:20:10) 16:51:41 INFO - 2015-11-03 16:51:41,531 DEBUG : Working with test: dromaeo_css 16:51:41 INFO - 2015-11-03 16:51:41,532 DEBUG : Generating results file: dromaeo_css 16:51:41 INFO - 2015-11-03 16:51:41,532 DEBUG : Working with test: kraken 16:51:41 INFO - 2015-11-03 16:51:41,533 DEBUG : Generating results file: kraken 16:51:41 INFO - 2015-11-03 16:51:41,533 INFO : javascript benchmark 16:51:41 INFO - 2015-11-03 16:51:41,533 DEBUG : Working with test: v8_7 16:51:41 INFO - 2015-11-03 16:51:41,533 DEBUG : Generating results file: v8_7 16:51:41 INFO - 2015-11-03 16:51:41,533 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:51:41 INFO - 2015-11-03 16:51:41,583 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 16:51:41 INFO - 2015-11-03 16:51:41,584 DEBUG : process_Request line: dromaeo_css 6268.94 graph.html#tests=[[72,64,55]] 16:51:41 INFO - 2015-11-03 16:51:41,584 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:51:41 INFO - 2015-11-03 16:51:41,612 DEBUG : process_Request line: kraken 1512.40 graph.html#tests=[[232,64,55]] 16:51:41 INFO - 2015-11-03 16:51:41,612 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:51:41 INFO - 2015-11-03 16:51:41,643 DEBUG : process_Request line: v8_7 17377.97 graph.html#tests=[[230,64,55]] 16:51:41 INFO - 2015-11-03 16:51:41,644 INFO : javascript benchmark 16:51:41 INFO - 2015-11-03 16:51:41,646 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.45205212799397, 323.2984423800354, 327.06948730860694, 328.13209062030927, 336.25687231219007, 9811.558479868405, 10143.594256229742, 11392.772144557104, 16658.91670541647, 16916.492505224847, 9937.701868943925, 11120.332780033204, 11192.44037798111, 11364.772704545925, 11557.306561606289, 4234.132002939397, 4272.871813845574, 4273.508546517143, 4292.978535107336, 4335.826566937319, 3246.675332466758, 4162.0, 4243.702940794145, 4334.414853994717, 4739.289106634015, 4603.309503574457, 4659.673822832403, 4670.159371313162, 4726.7400292983875, 4753.90492190156, 4119.299719047739, 4651.093036857831, 4658.371119898804, 4689.320048592952, 4707.6233901287815, 3933.6853051756075, 3933.9016524586827, 3940.4877365942243, 3955.46601208836, 3975.185087057146, 12760.872391276154, 12943.482260709561, 13000.349982500931, 13046.347682615926, 13050.86949130506, 1687.1479902649207, 1705.5906582420255, 1713.9657206855918, 1771.601389687323, 1787.5441762350647, 9138.13187747163, 9168.0, 9175.220106290973, 9261.027592102799, 9297.628094876196, 1416.4263473293333, 1424.9216293103875, 1426.2440906319666, 1472.7717203833422, 1506.8945173837835, 54193.45806541963, 56029.71985140089, 56255.718721406134, 56333.71833140849, 56374.15438768422, 6106.358832322631, 6289.276733175652, 6298.181236439325, 6315.936840631627, 6326.620402775849, 7207.603581803051, 7242.493025488166, 7254.963725181446, 7266.183454136466, 7273.89089163663, 5305.124654431976, 5320.068987927175, 5326.813561525328, 5363.651362661414, 5389.137737961907, 5726.398728133569, 5741.569382296345, 5751.539876809845, 5827.621204621771, 5841.065429531254, 2784.8607569621436, 2802.1453456695904, 2826.8445235512245, 2836.2767494288823, 2838.0634390651035, 966.1304825656965, 975.3562648651997, 976.8778902637171, 1000.2545558001189, 1040.2302296300834, 403.5439952853257, 412.92360913231147, 421.9599138081877, 443.15799980038184, 445.40315976591523, 10692.89307106919, 10999.890001100046, 11070.612528561462, 11088.390138542458, 11119.555217791198, 391.5986114232934, 437.5405823884908, 449.72566734292053, 457.20902838089626, 469.99530004699517, 5888.4700376966275, 6013.579049466495, 6020.217371741734, 6070.939290607126, 6077.209962704908, 484652.0, 488270.0, 498516.0, 504690.0, 507843.0, 66090.66954665292, 66519.66740166268, 66781.33218667848, 67671.0, 69359.0, 479.1973444480481, 480.3635183381963, 484.6922204400231, 485.25755593941324, 486.06432617211726, 10192.0, 10307.330023548446, 10325.380477171393, 10350.791254711065, 10419.322744021614, 29258.0, 29758.553621696126, 29778.553321699757, 30148.246293841952, 30254.092377228717, 42098.78950605227, 42610.57389426066, 42685.359719603606, 42816.35775463433, 43027.35458968055, 5765.56758243125, 5994.940050599438, 6009.759609615567, 6071.696415179312, 6148.938510615016, 10996.780064398507, 11095.0, 11097.778044438905, 11297.209195356247, 11328.207025508136, 9164.0, 9618.663346782829, 9770.36492627977, 9827.459489727848, 9885.50572471388, 9423.952880235554, 9464.905350946678, 9688.12806847387, 9692.273079518924, 10080.24398170155, 7999.9600001999615, 9304.348695591243, 9901.504924753877, 9996.850047249152, 10008.0, 5910.113482977587, 6061.787837425845, 6065.059915713072, 6112.358202388863, 6130.325664176848, 9407.331140855209, 9541.522923853641, 9573.760655983657, 9648.807023859625, 9829.852552211865], "dojo.html": [3062.9081127566183, 3071.6314042314925, 3245.82147981861, 3252.5609042779233, 3322.933541329173, 4896.338994235777, 5075.822346217874, 5107.284980102784, 5185.844424667262, 5285.550728188108, 5023.171176755831, 5031.547160755531, 5046.167382381912, 5091.439941606421, 5248.658837175581, 4670.322803193535, 4696.225122854725, 4745.240761478164, 4820.325154478376, 4856.805727770902, 4816.7350795706225, 4819.084373968953, 4834.105690447261, 4855.708657480544, 4948.752562371867, 4627.305904114376, 4692.2257827458425, 4698.530146985308, 4712.340272361872, 4753.786079626425, 4614.446266448048, 4757.26262429324, 4761.809527618926, 4807.351007613962, 4819.7108173509705, 4737.905241895177, 4752.120857641347, 4772.451168115642, 4776.761161941924, 4961.9751901240625, 5005.0490406822955, 5030.37120359955, 5171.276021357013, 5185.092608793446, 5283.181106928432, 5397.4062853086125, 5401.675899446046, 5466.070767969455, 5482.17767334899, 5592.273004509429, 5496.230527726121, 5556.666600004012, 5568.192612071227, 5585.664860108406, 5589.944100558983, 5004.099262132779, 5132.615053870974, 5138.922916156261, 5223.112070947948, 5313.017091837984, 5581.05122129239, 5616.9157462638095, 5631.971840140773, 5637.210790489335, 5639.887202255932, 5469.15228139639, 5490.258815059996, 5494.780208791683, 5497.890042199134, 5623.578231632644, 5409.945900541023, 5478.506934375925, 5486.451354864562, 5594.216809646653, 5801.767929282866, 5352.652077614943, 5384.353877534642, 5386.057439947994, 5473.0, 5478.178273258964, 5486.231927530149, 5489.176623506506, 5495.697736624444, 5496.367917689437, 5514.724263786875, 4171.70798044134, 4246.723962942398, 4334.739915605074, 4363.869083927487, 4422.447194100738, 3815.198808250243, 3861.9227615447535, 3882.437046628223, 3945.2504024235304, 3954.7429417087797, 5214.296070030573, 5215.29593504872, 5239.187925871496, 5287.259783630295, 5313.787448502017, 5452.645578037414, 5577.3028371453565, 5590.888182236414, 5592.692401917852, 5631.239782629293, 5114.309568208244, 5225.242339860775, 5236.607254455931, 5237.895242095136, 5240.397354304304, 4886.853394398174, 4890.731009794425, 4893.755312234374, 4898.118338698997, 4916.164252077156, 5484.177373394023, 5678.233438485834, 5715.799947001835, 5725.198472213893, 5738.741756620879, 5472.233887255867, 5547.223388725501, 5572.721363931706, 5575.498205161555, 5592.7762889483965, 5722.141678748221, 5730.369659337553, 5739.8565035874435, 5743.339515955551, 5767.480926716616, 5312.654677445954, 5604.3835178131185, 5620.353659329229, 5625.521830644441, 5645.491905728504, 5413.593980451403, 5482.533984611353, 5543.1408131739645, 5626.915596265977, 5652.491275785199, 5465.508104270635, 5473.124300111963, 5476.205950137288, 5495.972520137374, 5540.418256083214, 5237.607179461479, 5460.7542660579575, 5486.177073439016, 5490.3411590609385, 5507.311586051744, 5172.275881376686, 5241.68549887008, 5276.445973172915, 5305.416404195613, 5423.511883930308, 5242.737863106906, 5452.291202143696, 5502.202180683698, 5547.583931205095, 5549.805756798492, 5258.684478931276, 5368.919466208088, 5397.325334333208, 5407.864803379947, 5414.35027796667], "mootools.html": [1457.4024649893545, 1674.698554260233, 1728.6197036651931, 1757.481542944832, 1770.3980646580164, 6541.247756507997, 6941.409980151687, 7308.524945878514, 7520.210377910323, 7607.23927607239, 7219.458540609449, 7312.926870731304, 7364.521306115099, 7384.187739348681, 7483.73806916758, 1860.6557786809417, 1901.9049047547637, 2095.3923362224937, 2100.4433825036376, 2128.5955668423026, 2073.533454972634, 2145.3349461666853, 2149.290734057757, 2160.2331172433796, 2172.4025892879426, 2077.7610574783866, 2079.5009197792497, 2122.628540005493, 2124.479502521884, 2127.627665158591, 1890.4328701389666, 1933.9709904351446, 2057.5576251106086, 2086.822620077295, 2110.419634600482, 2049.139361468172, 2069.8240649544805, 2072.89635518225, 2079.178724403852, 2092.7697953225133, 7169.211386747454, 7223.169335526429, 7243.529170603894, 7323.7436689715605, 7363.374113200384, 4412.602865742067, 4446.510883802779, 4540.318952157169, 4546.863594092182, 4608.0, 2809.5364264896266, 2811.8734656940487, 2817.563277691961, 2824.5339518979345, 2860.113364856901, 867.2931560777946, 876.8334016536901, 880.6829541365104, 886.4061079077034, 941.9576119074658, 9740.123388894963, 9740.318177727562, 9760.707178784647, 9854.063863932915, 9884.90115098847, 3971.920561588752, 4026.4765580474937, 4091.263572556909, 4112.732672376286, 4166.749995000309, 8492.872606910902, 8509.106543812934, 8519.403641745143, 8526.957365213135, 8607.827843443096, 4552.84065057728, 4554.681172317906, 4570.908581828345, 4626.167289887785, 4652.371929789503, 4141.068259641616, 4171.4368560243975, 4175.352820312856, 4181.393697913785, 4244.129953359554, 3527.735419843522, 3586.228960773446, 3597.7481576289933, 3618.095476130967, 3621.420572708354, 1113.8774734779167, 1158.79141754485, 1161.4367031989477, 1161.5469966712988, 1165.44641295384, 1009.7021378693303, 1037.5331101004579, 1040.8230600797883, 1131.1290306463977, 1253.5487224599137, 6960.0, 6965.825854353681, 6986.882098864259, 6997.335253150943, 6998.090248267693, 425.0521337417576, 430.49201941709083, 448.2760342047635, 452.2266923560748, 453.93417954397086, 5226.712530810842, 5405.351357837006, 5408.9729551352775, 5440.755166017539, 5461.836144915659, 8374.958125209336, 8797.164269394398, 8815.867761983576, 8829.293656507463, 8916.777080573038, 8715.782105447288, 8768.693095741746, 8788.428752131218, 8789.516576588348, 8808.51553164582, 6831.419329356961, 6886.10480637514, 6954.4436445084275, 6967.825804354931, 7019.017337572744, 6751.93248067513, 6756.662166891734, 6761.22245941723, 6761.357671021246, 6829.965850170717, 7765.92234077652, 7814.960925195338, 7890.368770498231, 7943.086545047162, 7968.800779980547, 7846.960765196138, 8068.515889046676, 8091.83816323682, 8136.227058429677, 8190.754277371689, 6370.77702280418, 6414.61512309263, 6459.935400645933, 6524.804255872332, 6560.40956313934, 7037.155541334868, 7072.823179420556, 7078.0, 7080.0, 7110.751123710852, 6534.477241820738, 6629.337066293332, 6696.464282857457, 6707.564008339442, 6717.529772915849, 6308.526860485574, 6517.3808488193545, 6541.215054193527, 6570.8357291066195, 6583.111279977334, 6625.105610742488, 6698.5980841149685, 6704.195496540251, 6749.426298764463, 6780.796576102724, 6035.969820150871, 6104.236970378703, 6113.0, 6117.449429551361, 6211.720472578835, 5628.380878103487, 5781.653100813965, 5928.8814223716145, 6050.697465126814, 6155.169052177898], "ext.html": [495.62217036638145, 496.12681680242787, 501.8845665496936, 506.6554742774912, 529.894021195761, 30884.845575772117, 32261.0, 38142.61857381429, 38988.41517377242, 39369.0, 41011.17977640445, 41678.37482437766, 41961.37057944133, 42061.789691051505, 42201.57798422015, 7749.457537972344, 7939.245771651684, 8817.515036672996, 9009.684661036865, 9136.680216192435, 10621.57513699451, 10946.069584085362, 10961.287516311455, 10968.287061341027, 10987.505562249718, 10643.201759868001, 10714.0, 10720.08879245265, 10901.291416057971, 10924.945375273152, 8049.919500805005, 8199.22107399796, 10599.364038157697, 10687.091597214247, 10970.396628185446, 10562.419066951315, 10596.682099537025, 10621.150307975344, 10669.306495077795, 10689.305195162367, 38453.0, 38952.22095558101, 38968.220635587415, 39016.609833901864, 39569.62582245075, 2966.658834234069, 2999.9550006749914, 3009.337945651953, 3121.984390078058, 3363.7477189210663, 26867.73132268672, 26907.0, 27100.864495677593, 27295.45409091807, 27337.31656708578, 2306.342692332694, 2345.683332750074, 2374.952500949971, 2388.044782087162, 2463.285647162321, 283449.0, 283963.0, 285373.5731321351, 286744.0, 287464.0, 57469.0, 57767.422325776206, 61112.69443652842, 61587.0, 66718.66640666766, 61536.0, 61728.38271617316, 61731.0, 62331.0, 62865.68567157226, 16368.754468682979, 16566.0, 16574.337026519046, 16578.917105414395, 16615.83384166167, 12506.562270320495, 12528.310942898228, 12557.246565206116, 12571.74856502883, 12647.747045059048, 19458.0, 19905.402837914884, 19913.203471860965, 19990.00149977515, 20020.599588008157, 8084.717034903751, 8366.916330836613, 8384.161583841567, 8396.0, 8454.746357609281, 917.8347897378536, 945.2485274207022, 956.7225504603726, 1086.2504871638703, 1099.384344766933, 27502.587461188097, 27768.30579235495, 28009.0, 28139.43721125566, 28285.57571636427, 983.8819341678901, 1003.8544411060356, 1012.2307046644456, 1030.7371620236793, 1038.4755698372426, 13529.864701353057, 14029.508967186099, 14801.925990369979, 15164.756589270428, 15699.450519231772, 295280.0, 303087.0, 303314.0, 303784.0, 306845.0, 54154.729226353615, 54242.0, 54380.45619543833, 54418.0, 54444.0, 1137.4256000719583, 1192.1833544022372, 1304.3869381390732, 1345.1928842694501, 1383.2323060701408, 28811.85594072016, 29463.55804662889, 29542.704572953997, 29730.702692972794, 29863.0, 47200.29199562078, 48538.75730621324, 48585.757071215834, 48596.0, 48640.51359486501, 197044.0, 201541.0, 201900.0, 215640.0, 217717.0, 30614.693853062076, 30721.231969200948, 30827.0, 30870.0, 31026.0, 38843.0, 39360.80319598383, 39742.0, 39906.0, 40541.79729101453, 35199.47200791939, 35684.821575892995, 36037.09907252339, 36235.27529449343, 36635.63364366429, 35324.646753532135, 35328.11679707925, 38901.0, 38976.80511597424, 40206.39690404705, 35978.8201058993, 36580.08549786277, 36682.63317366792, 36699.0, 37058.6294137066, 32380.676193237767, 32827.17932051718, 34029.48955765616, 34367.82816085903, 34628.13429664178, 23374.181903633973, 23984.40038999039, 24478.632820508064, 24766.876165619058, 24793.504129917663], "prototype.html": [299.9805012674175, 302.1102852100565, 302.5960342942171, 303.23887043520756, 307.5816889030918, 5900.055991041434, 5913.674747888865, 5924.289085309769, 5927.614705044169, 5932.584719069667, 5776.82669519914, 5789.507891829189, 5800.8259752207505, 5813.883722325551, 5820.097884827848, 4325.416068830699, 4486.977565112178, 4512.075024619945, 4517.7289362638185, 4550.49944506104, 4455.933161002587, 4470.0, 4550.795214215368, 4560.863174104782, 4680.485146633868, 4467.374567560544, 4498.235299999008, 4502.48221454532, 4560.8859778505475, 4571.6114130298965, 4349.804258808361, 4386.670999675037, 4464.151811155903, 4513.984353520448, 4539.6368290536675, 3861.517310336208, 3864.574896761354, 3869.129445874684, 3874.089588946595, 3917.490726205575, 5668.744906479218, 5680.772769089232, 5701.201831743518, 5725.513331366838, 5748.942510574924, 5059.468755780626, 5069.822556210552, 5089.338386009832, 5095.0, 5119.56483698886, 5952.9702351488395, 6135.601185922901, 6214.161088253073, 6219.626822390671, 6291.339409361997, 4288.463942007249, 4298.226319262531, 4302.956970430287, 4355.5644435556505, 4359.04101097758, 6493.31820158886, 6519.087327774116, 6574.802755917282, 6611.173603299588, 6638.137042184533, 4266.722663026893, 4334.891627709269, 4373.759443230653, 4417.0, 4442.577955094261, 4469.73181609098, 4476.686631935733, 4483.327500874895, 4529.592336689714, 4552.339910712928, 5135.075686376488, 5139.640225184276, 5150.253213284052, 5207.4011488678525, 5209.166533354645, 6279.403456671609, 6296.685165741695, 6318.178636777189, 6326.778562750282, 6339.904901426482, 1572.449642625072, 1582.027053362174, 1603.6311648320718, 1605.0770806786145, 1639.5655151384892, 1001.3191030099457, 1022.539857064324, 1026.1021606094666, 1033.7570670892335, 1041.4740556019162, 5913.0, 5927.8221653350465, 5931.940680593225, 6039.456448919618, 6055.394460553997, 6423.582467139621, 6472.805815825533, 6484.643344615997, 6516.869662606721, 6549.181352330958, 5940.257467816523, 5953.970230148821, 5990.790322338785, 6018.337982821886, 6040.577159598786, 3501.124718820295, 3518.9120271993406, 3568.0366301099075, 3579.391503444421, 3632.6912212462234, 6478.643674597943, 6498.3826536478955, 6590.242122155918, 6596.505262105361, 6606.306337834458, 6556.27880933097, 6557.082008518812, 6580.1445812045085, 6656.667166641649, 6679.699413526403, 6367.554271200971, 6480.254770701241, 6515.902261466082, 6532.281449040602, 6555.180602424697, 6394.7442102317245, 6399.008153736178, 6457.838554036187, 6548.869022619616, 6572.277049524453, 6378.48972082223, 6380.425761681471, 6460.4508616766225, 6463.192100987377, 6506.73973041092, 6485.805425837232, 6573.079768832272, 6592.077109204619, 6621.470282377494, 6706.429953454011, 4172.457580514514, 4172.4993000840095, 4183.895402614959, 4208.38978348144, 4236.08924081324, 6432.453241474527, 6459.935400645933, 6470.417662410406, 6568.573042752206, 6572.704228309642, 6048.092786082123, 6232.844178895564, 6254.061890716429, 6260.092286618506, 6324.652144131933, 6241.78153764616, 6267.843303917439, 6269.153664255267, 6294.024426213944, 6320.020396838498, 6066.4540191382985, 6070.484008859296, 6110.114033465212, 6141.539384546088, 6185.567010309235, 5932.703364831655, 5993.250843644544, 6201.844953876189, 6232.5637205397, 6262.373762623702, 6021.397860213943, 6042.425969532887, 6086.360932102066, 6118.877622447615, 6162.414570615784], "yui.html": [637.5887552528623, 638.3265654734255, 712.4941291682904, 721.7690339091487, 742.721479445208, 9942.850857237137, 10008.949955250231, 10150.13723833474, 10173.186145108391, 10214.795704085915, 12215.938920305409, 13360.331983400816, 13368.665783355422, 13377.531786387479, 13602.115862468932, 657.3623585122424, 811.0, 826.7602395305354, 828.4325237212498, 828.6975254032265, 648.3127884442482, 809.7125520440247, 823.5264722784393, 824.389951435936, 824.5300178898001, 836.3643630840575, 853.4068822168596, 856.4647095565272, 859.1580251353677, 861.0700443520982, 659.8020593821834, 664.4750646988873, 819.5574389829485, 838.4508147163588, 856.9957150214241, 622.5362105231632, 624.5596854217765, 625.8404106952744, 626.8840264551072, 629.0564153769346, 12800.935995320056, 12955.157914735511, 13007.089503734742, 13119.278439685813, 13178.0, 8806.955965220197, 8924.152205540464, 9050.084636064894, 9286.953565232197, 9340.392874463207, 8416.663333466655, 8604.741857744277, 8675.132486751338, 9032.141946515136, 9057.68298109563, 2782.749552540261, 2788.0659978907092, 2791.986040069807, 2799.286182023591, 2815.0710265612297, 43284.134317313474, 44126.0, 44189.337159942625, 44672.32991505098, 44715.329270060975, 6308.936910630835, 6389.073584330246, 6451.612903225728, 6472.449841763409, 6619.238787539398, 11424.485898134437, 11518.769624607461, 11560.24858384219, 11567.76864462706, 11728.296302221894, 5546.855969655854, 5662.518685911744, 5703.914441283384, 5903.58674892762, 5924.674142922181, 3508.421110516736, 3610.9638903610626, 3623.8912832615065, 3658.231771328051, 3761.4357846322723, 2665.626812246287, 2846.8861245549947, 2890.2802832314737, 2897.4494845979198, 2907.8982235622075, 461.3218568704, 476.0455287149244, 476.86409373328434, 477.3245857112217, 478.8300153445546, 427.4187105536468, 544.335910189568, 556.1518684006841, 565.5447364871318, 573.9856503587444, 7097.183823860322, 7164.713411463587, 7304.926950730424, 7314.305141011595, 7341.265873412616, 451.25993370871794, 526.2080568744016, 532.7496076843877, 542.2029616463792, 578.2767353287144, 3128.2148600193564, 3294.25879177188, 3370.4607262837826, 3379.442392005341, 3410.8806191783665, 56429.0, 56922.146167807514, 57019.71490142523, 57138.14292785611, 57325.42674573201, 47995.76002119967, 48140.0, 48445.5155448441, 48881.0, 49642.50357496451, 43745.0, 44647.55352446499, 45167.0, 46074.5392546077, 46218.30672539915, 6907.067545881242, 6921.0, 6993.557516479935, 7004.579725216503, 7113.786586402416, 33927.151821204665, 34263.0, 34776.82611587027, 34929.65070349264, 35329.47005794864, 41161.79419102885, 41418.37872431976, 42949.0, 45301.0, 46437.53562464332, 5937.554683398849, 6162.075688646739, 6287.622742635456, 6380.904286435614, 6455.225372955276, 8731.432456890281, 9564.76088097803, 9901.0, 10335.966403359604, 10651.094656953936, 8586.570671466277, 9078.682246121354, 9301.534923253945, 9332.673356432493, 9472.763180920532, 8380.622871970898, 8823.205911467741, 9164.450132992042, 9298.72103836886, 9305.720828375159, 8679.218870301704, 8905.599248033725, 9028.458292502472, 9101.635934562544, 9422.434653920787, 7654.048902522578, 7701.576413297323, 7895.84208315842, 8215.958920205361, 8517.872231916403, 7728.376703841388, 8058.637361318872, 8258.504489730636, 8389.790255243668, 8690.304775618062]}, "summary": {"suite": 6268.946041313107, "subtests": {"jquery.html": {"filtered": 6237.519102352337, "value": 6237.519102352337}, "dojo.html": {"filtered": 5131.031548733312, "value": 5131.031548733312}, "mootools.html": {"filtered": 4131.202910935885, "value": 4131.202910935885}, "ext.html": {"filtered": 18313.71894527729, "value": 18313.71894527729}, "prototype.html": {"filtered": 4682.608506446895, "value": 4682.608506446895}, "yui.html": {"filtered": 5352.644256775828, "value": 5352.644256775828}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0038"}, "testrun": {"date": 1446597091, "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": "20151103143036", "branch": "Fx-Team", "revision": "117a37db2aa519779cc813b79d860f1236fd1707"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 160.0, 171.0, 162.0, 162.0, 164.0, 163.0, 163.0, 159.0], "ai-astar": [106.0, 109.0, 102.0, 106.0, 106.0, 108.0, 96.0, 107.0, 112.0, 107.0], "imaging-gaussian-blur": [121.0, 117.0, 114.0, 121.0, 119.0, 114.0, 120.0, 125.0, 122.0, 114.0], "audio-beat-detection": [154.0, 131.0, 149.0, 159.0, 124.0, 148.0, 144.0, 125.0, 161.0, 125.0], "json-stringify-tinderbox": [66.0, 67.0, 68.0, 66.0, 68.0, 68.0, 68.0, 73.0, 69.0, 70.0], "stanford-crypto-pbkdf2": [139.0, 151.0, 151.0, 150.0, 151.0, 160.0, 157.0, 161.0, 161.0, 150.0], "json-parse-financial": [58.0, 57.0, 59.0, 56.0, 57.0, 57.0, 57.0, 66.0, 57.0, 59.0], "stanford-crypto-sha256-iterative": [70.0, 69.0, 69.0, 70.0, 70.0, 71.0, 71.0, 71.0, 71.0, 72.0], "audio-fft": [73.0, 84.0, 87.0, 85.0, 67.0, 68.0, 70.0, 77.0, 82.0, 66.0], "imaging-darkroom": [125.0, 125.0, 125.0, 126.0, 125.0, 126.0, 126.0, 124.0, 130.0, 139.0], "stanford-crypto-ccm": [124.0, 121.0, 131.0, 129.0, 132.0, 142.0, 147.0, 139.0, 142.0, 131.0], "audio-oscillator": [100.0, 99.0, 137.0, 89.0, 92.0, 89.0, 124.0, 90.0, 90.0, 131.0], "stanford-crypto-aes": [85.0, 87.0, 87.0, 89.0, 85.0, 86.0, 85.0, 87.0, 88.0, 87.0], "imaging-desaturate": [101.0, 100.0, 102.0, 106.0, 105.0, 108.0, 109.0, 108.0, 109.0, 107.0]}, "summary": {"suite": 1512.3999999999999, "subtests": {"audio-fft": {"filtered": 75.9, "value": 75.9}, "stanford-crypto-pbkdf2": {"filtered": 153.1, "value": 153.1}, "audio-beat-detection": {"filtered": 142.0, "value": 142.0}, "stanford-crypto-ccm": {"filtered": 133.8, "value": 133.8}, "imaging-darkroom": {"filtered": 127.1, "value": 127.1}, "json-parse-financial": {"filtered": 58.3, "value": 58.3}, "audio-oscillator": {"filtered": 104.1, "value": 104.1}, "ai-astar": {"filtered": 105.9, "value": 105.9}, "audio-dft": {"filtered": 162.7, "value": 162.7}, "stanford-crypto-sha256-iterative": {"filtered": 70.4, "value": 70.4}, "json-stringify-tinderbox": {"filtered": 68.3, "value": 68.3}, "imaging-gaussian-blur": {"filtered": 118.7, "value": 118.7}, "stanford-crypto-aes": {"filtered": 86.6, "value": 86.6}, "imaging-desaturate": {"filtered": 105.5, "value": 105.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0038"}, "testrun": {"date": 1446597091, "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": "20151103143036", "branch": "Fx-Team", "revision": "117a37db2aa519779cc813b79d860f1236fd1707"}}, {"talos_counters": {}, "results": {"DeltaBlue": [199.4415636218588], "Encrypt": [331.6749585406302], "NavierStokes": [5917.15976331361], "Decrypt": [5894.117647058823], "Splay": [689.6551724137931], "Richards": [168.69095816464238], "RegExp": [32125.0], "Earley": [1028.5714285714287], "Boyer": [13440.0], "RayTrace": [2092.050209205021]}, "summary": {"suite": 17377.96657638909, "subtests": {"DeltaBlue": {"filtered": 331.51565199999993, "value": 331.51565199999993}, "Encrypt": {"filtered": 802.5357150000001, "value": 802.5357150000001}, "NavierStokes": {"filtered": 250.7959999999999, "value": 250.7959999999999}, "Decrypt": {"filtered": 45.160449101796395, "value": 45.160449101796395}, "Splay": {"filtered": 118.16195000000003, "value": 118.16195000000003}, "RegExp": {"filtered": 28.35750972762646, "value": 28.35750972762646}, "Richards": {"filtered": 209.27025600000007, "value": 209.27025600000007}, "Earley": {"filtered": 647.9501388888885, "value": 647.9501388888885}, "Boyer": {"filtered": 49.588020833333374, "value": 49.588020833333374}, "RayTrace": {"filtered": 353.71474199999983, "value": 353.71474199999983}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0038"}, "testrun": {"date": 1446597091, "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": "20151103143036", "branch": "Fx-Team", "revision": "117a37db2aa519779cc813b79d860f1236fd1707"}}] 16:51:41 INFO - RETURN: dromaeo_css: 6268.94 16:51:41 INFO - RETURN: kraken: 1512.40 16:51:41 INFO - RETURN: v8_7: 17377.97 16:51:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "17377.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1512.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6268.94"}}} 16:51:41 INFO - Return code: 0 16:51:41 INFO - # TBPL SUCCESS # 16:51:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:51:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:51:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:51:41 INFO - 2015-11-03 16:51:41.784 screenresolution[1660:11063] starting screenresolution argv=screenresolution get 16:51:41 INFO - 2015-11-03 16:51:41.787 screenresolution[1660:11063] Display 0: 1600x1200x32@60 16:51:41 INFO - 2015-11-03 16:51:41.793 screenresolution[1661:11066] starting screenresolution argv=screenresolution list 16:51:41 INFO - Available Modes on Display 0 16:51:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:51:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:51:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:51:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:51:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:51:42 INFO - Intel HD Graphics 3000: 16:51:42 INFO - Chipset Model: Intel HD Graphics 3000 16:51:42 INFO - Type: GPU 16:51:42 INFO - Bus: Built-In 16:51:42 INFO - VRAM (Total): 512 MB 16:51:42 INFO - VRAM (Dynamic, Max): 10 16:51:42 INFO - Vendor: Intel (0x8086) 16:51:42 INFO - Device ID: 0x0116 16:51:42 INFO - Revision ID: 0x0009 16:51:42 INFO - Displays: 16:51:42 INFO - Display: 16:51:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:51:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:51:42 INFO - Display Serial Number: 1600x1200 60 16:51:42 INFO - Main Display: Yes 16:51:42 INFO - Mirror: Off 16:51:42 INFO - Online: Yes 16:51:42 INFO - Rotation: Supported 16:51:42 INFO - Return code: 0 16:51:42 INFO - Running post-action listener: _resource_record_post_action 16:51:42 INFO - Running post-run listener: _resource_record_post_run 16:51:43 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 37859328; Write bytes: 689024000; Read time: 4287; Write time: 48110 16:51:43 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 336839168; Write bytes: 334850048; Read time: 33516; Write time: 7849 16:51:43 INFO - run-tests - Wall time: 1211s; CPU: 30.0%; Read bytes: 36782080; Write bytes: 343806976; Read time: 3773; Write time: 38958 16:51:43 INFO - Running post-run listener: _upload_blobber_files 16:51:43 INFO - Blob upload gear active. 16:51:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:51:43 INFO - Copying logs to upload dir... 16:51:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1320.511142 ========= master_lag: 10.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2015-11-03 16:51:53.360259) ========= ========= Started set props: build_url (results: 0, elapsed: 10 secs) (at 2015-11-03 16:51:53.369042) ========= 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.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010031 build_url: 'https://queue.taskcluster.net/v1/task/htitLYdKR9i_y9A2278s3A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 10.62 ========= ========= Finished set props: build_url (results: 0, elapsed: 10 secs) (at 2015-11-03 16:52:04.001821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-03 16:52:04.002167) ========= 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.lGaCpnNEcV/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.3MP2mPwByF/Listeners TMPDIR=/var/folders/60/9rh4wmh956561pthg6ktdq4m00000w/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.005380 ========= master_lag: 1.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-03 16:52:05.380441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 16:52:05.386845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 16:52:05.394627) ========= ========= Total master_lag: 22.62 =========