builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0005 starttime: 1449189539.36 results: success (0) buildid: 20151203150742 builduid: e666b2f983cf45fda5bafc9b04fbf36d revision: e2d7d6033fae23341f077089774d25e56443466e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.357236) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.357692) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.358011) ========= 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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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.005310 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.453677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.454024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.471762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.472375) ========= 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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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.035877 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.521844) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.522159) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.522510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.522781) ========= 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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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-12-03 16:38:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-12-03 16:38:59 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.709569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.709879) ========= 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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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.107859 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.827643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:38:59.828019) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e2d7d6033fae23341f077089774d25e56443466e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e2d7d6033fae23341f077089774d25e56443466e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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-12-03 16:38:59,914 truncating revision to first 12 chars 2015-12-03 16:38:59,914 Setting DEBUG logging. 2015-12-03 16:38:59,914 attempt 1/10 2015-12-03 16:38:59,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e2d7d6033fae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 16:39:00,242 unpacking tar archive at: mozilla-aurora-e2d7d6033fae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585515 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:39:00.424681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 16:39:00.425024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 16:39:00.433439) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 16:39:00.433800) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 16:39:00.434255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-12-03 16:39:00.434590) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39:00 INFO - MultiFileLogger online at 20151203 16:39:00 in /builds/slave/test 16:39:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:39:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:39:00 INFO - {'append_to_log': False, 16:39:00 INFO - 'base_work_dir': '/builds/slave/test', 16:39:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:39:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:39:00 INFO - 'branch': 'Mozilla-Aurora', 16:39:00 INFO - 'buildbot_json_path': 'buildprops.json', 16:39:00 INFO - 'config_files': ('talos/mac_config.py',), 16:39:00 INFO - 'default_actions': ('clobber', 16:39:00 INFO - 'read-buildbot-config', 16:39:00 INFO - 'download-and-extract', 16:39:00 INFO - 'populate-webroot', 16:39:00 INFO - 'create-virtualenv', 16:39:00 INFO - 'install', 16:39:00 INFO - 'run-tests'), 16:39:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:39:00 INFO - 'download_minidump_stackwalk': True, 16:39:00 INFO - 'download_symbols': 'ondemand', 16:39:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:39:00 INFO - 'tooltool.py': '/tools/tooltool.py', 16:39:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:39:00 INFO - '/tools/misc-python/virtualenv.py')}, 16:39:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:39:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:39:00 INFO - 'installer_path': 'installer.exe', 16:39:00 INFO - 'log_level': 'info', 16:39:00 INFO - 'log_name': 'talos', 16:39:00 INFO - 'log_to_console': True, 16:39:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:39:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:39:00 INFO - 'opt_config_files': (), 16:39:00 INFO - 'pip_index': False, 16:39:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:00 INFO - 'cmd': ('bash', 16:39:00 INFO - '-c', 16:39:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:00 INFO - 'enabled': True, 16:39:00 INFO - 'halt_on_failure': False, 16:39:00 INFO - 'name': 'check_screen_resolution'},), 16:39:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:00 INFO - 'cmd': ('bash', 16:39:00 INFO - '-c', 16:39:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:00 INFO - 'enabled': True, 16:39:00 INFO - 'halt_on_failure': False, 16:39:00 INFO - 'name': 'check_screen_resolution'},), 16:39:00 INFO - 'run_cmd_checks_enabled': True, 16:39:00 INFO - 'sps_profile': False, 16:39:00 INFO - 'sps_profile_interval': 0, 16:39:00 INFO - 'suite': 'dromaeojs', 16:39:00 INFO - 'system_bits': '64', 16:39:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:39:00 INFO - 'title': 't-yosemite-r5-0005', 16:39:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:39:00 INFO - 'use_talos_json': True, 16:39:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:39:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:39:00 INFO - 'work_dir': 'build'} 16:39:00 INFO - ##### 16:39:00 INFO - ##### Running clobber step. 16:39:00 INFO - ##### 16:39:00 INFO - Running pre-action listener: _resource_record_pre_action 16:39:00 INFO - Running main action method: clobber 16:39:00 INFO - rmtree: /builds/slave/test/build 16:39:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:39:04 INFO - Running post-action listener: _resource_record_post_action 16:39:04 INFO - ##### 16:39:04 INFO - ##### Running read-buildbot-config step. 16:39:04 INFO - ##### 16:39:04 INFO - Running pre-action listener: _resource_record_pre_action 16:39:04 INFO - Running main action method: read_buildbot_config 16:39:04 INFO - Using buildbot properties: 16:39:04 INFO - { 16:39:04 INFO - "properties": { 16:39:04 INFO - "buildnumber": 294, 16:39:04 INFO - "product": "firefox", 16:39:04 INFO - "script_repo_revision": "production", 16:39:04 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 16:39:04 INFO - "repository": "", 16:39:04 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 16:39:04 INFO - "buildid": "20151203150742", 16:39:04 INFO - "slavename": "t-yosemite-r5-0005", 16:39:04 INFO - "pgo_build": "False", 16:39:04 INFO - "basedir": "/builds/slave/test", 16:39:04 INFO - "project": "", 16:39:04 INFO - "platform": "yosemite", 16:39:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:39:04 INFO - "slavebuilddir": "test", 16:39:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:39:04 INFO - "branch": "mozilla-aurora", 16:39:04 INFO - "repo_path": "releases/mozilla-aurora", 16:39:04 INFO - "stage_platform": "macosx64", 16:39:04 INFO - "builduid": "e666b2f983cf45fda5bafc9b04fbf36d", 16:39:04 INFO - "revision": "e2d7d6033fae23341f077089774d25e56443466e" 16:39:04 INFO - }, 16:39:04 INFO - "sourcestamp": { 16:39:04 INFO - "repository": "", 16:39:04 INFO - "hasPatch": false, 16:39:04 INFO - "project": "", 16:39:04 INFO - "branch": "mozilla-aurora-macosx64-talos", 16:39:04 INFO - "changes": [ 16:39:04 INFO - { 16:39:04 INFO - "category": null, 16:39:04 INFO - "files": [ 16:39:04 INFO - { 16:39:04 INFO - "url": null, 16:39:04 INFO - "name": "https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 16:39:04 INFO - } 16:39:04 INFO - ], 16:39:04 INFO - "repository": "", 16:39:04 INFO - "rev": "e2d7d6033fae23341f077089774d25e56443466e", 16:39:04 INFO - "who": "mozilla@noorenberghe.ca", 16:39:04 INFO - "when": 1449186798, 16:39:04 INFO - "number": 6741473, 16:39:04 INFO - "comments": "Bug 1229168 - Follow-up for Aurora/Beta to deal with lack of bug 1219504. a=bustage", 16:39:04 INFO - "project": "", 16:39:04 INFO - "at": "Thu 03 Dec 2015 15:53:18", 16:39:04 INFO - "branch": "mozilla-aurora-macosx64-talos", 16:39:04 INFO - "revlink": "", 16:39:04 INFO - "properties": [ 16:39:04 INFO - [ 16:39:04 INFO - "buildid", 16:39:04 INFO - "20151203150742", 16:39:04 INFO - "Change" 16:39:04 INFO - ], 16:39:04 INFO - [ 16:39:04 INFO - "builduid", 16:39:04 INFO - "e666b2f983cf45fda5bafc9b04fbf36d", 16:39:04 INFO - "Change" 16:39:04 INFO - ], 16:39:04 INFO - [ 16:39:04 INFO - "pgo_build", 16:39:04 INFO - "False", 16:39:04 INFO - "Change" 16:39:04 INFO - ] 16:39:04 INFO - ], 16:39:04 INFO - "revision": "e2d7d6033fae23341f077089774d25e56443466e" 16:39:04 INFO - } 16:39:04 INFO - ], 16:39:04 INFO - "revision": "e2d7d6033fae23341f077089774d25e56443466e" 16:39:04 INFO - } 16:39:04 INFO - } 16:39:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 16:39:04 INFO - Running post-action listener: _resource_record_post_action 16:39:04 INFO - ##### 16:39:04 INFO - ##### Running download-and-extract step. 16:39:04 INFO - ##### 16:39:04 INFO - Running pre-action listener: _resource_record_pre_action 16:39:04 INFO - Running main action method: download_and_extract 16:39:04 INFO - mkdir: /builds/slave/test/build/tests 16:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:04 INFO - https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:39:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/test_packages.json 16:39:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/test_packages.json 16:39:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:39:05 INFO - Downloaded 1149 bytes. 16:39:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:39:05 INFO - Using the following test package requirements: 16:39:05 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 16:39:05 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 16:39:05 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 16:39:05 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 16:39:05 INFO - u'jsshell-mac.zip'], 16:39:05 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 16:39:05 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 16:39:05 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 16:39:05 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 16:39:05 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 16:39:05 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 16:39:05 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 16:39:05 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 16:39:05 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 16:39:05 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 16:39:05 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 16:39:05 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 16:39:05 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:05 INFO - https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:39:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:39:06 INFO - Downloaded 17490071 bytes. 16:39:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:39:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 16:39:10 INFO - Return code: 0 16:39:10 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:39:10 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:39:10 INFO - https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:39:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:39:11 INFO - Downloaded 17490071 bytes. 16:39:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:39:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 16:39:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 16:39:16 INFO - Return code: 0 16:39: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:39:16 INFO - https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:39:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 16:39:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 16:39:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 16:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:39:18 INFO - Downloaded 11131307 bytes. 16:39:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 16:39:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 16:39:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:39:19 INFO - Return code: 0 16:39:19 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:39:19 INFO - https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:39:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:39:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:39:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 16:39:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 16:39:23 INFO - Downloaded 108686784 bytes. 16:39:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:39:23 INFO - mkdir: /builds/slave/test/properties 16:39:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:39:23 INFO - Writing to file /builds/slave/test/properties/build_url 16:39:23 INFO - Contents: 16:39:23 INFO - build_url:https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:39:23 INFO - Running post-action listener: _resource_record_post_action 16:39:23 INFO - Running post-action listener: set_extra_try_arguments 16:39:23 INFO - ##### 16:39:23 INFO - ##### Running populate-webroot step. 16:39:23 INFO - ##### 16:39:23 INFO - Running pre-action listener: _resource_record_pre_action 16:39:23 INFO - Running main action method: populate_webroot 16:39:23 INFO - Guessing talos json url... 16:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:23 INFO - https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 16:39:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 16:39:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 16:39:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 16:39:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 16:39:24 INFO - Downloaded 107 bytes. 16:39:24 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 16:39:24 INFO - Contents: 16:39:24 INFO - 20151203150742 16:39:24 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/e2d7d6033fae23341f077089774d25e56443466e 16:39:24 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:39:24 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2d7d6033f/testing/talos/talos.json 16:39:24 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2d7d6033f/testing/talos/talos.json to /builds/slave/test/build/talos.json 16:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e2d7d6033f/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 16:39:25 INFO - Downloaded 4264 bytes. 16:39:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:39:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:39:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:39:25 INFO - '../fennec_ids.txt'], 16:39:25 INFO - 'tests': ['tcheck2']}, 16:39:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:39:25 INFO - '--tppagecycles', 16:39:25 INFO - '7'], 16:39:25 INFO - 'tests': ['tsvgm']}}, 16:39:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:39:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:39:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:39:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:39:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'tests': ['damp', 'tps']}, 16:39:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['damp', 'tps']}, 16:39:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:39:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:39:25 INFO - 'other': {'tests': ['a11yr', 16:39:25 INFO - 'ts_paint', 16:39:25 INFO - 'tpaint', 16:39:25 INFO - 'sessionrestore', 16:39:25 INFO - 'sessionrestore_no_auto_restore']}, 16:39:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['a11yr', 16:39:25 INFO - 'ts_paint', 16:39:25 INFO - 'tpaint', 16:39:25 INFO - 'sessionrestore', 16:39:25 INFO - 'sessionrestore_no_auto_restore']}, 16:39:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['a11yr', 16:39:25 INFO - 'ts_paint', 16:39:25 INFO - 'tpaint', 16:39:25 INFO - 'sessionrestore', 16:39:25 INFO - 'sessionrestore_no_auto_restore']}, 16:39:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['a11yr', 16:39:25 INFO - 'ts_paint', 16:39:25 INFO - 'tpaint', 16:39:25 INFO - 'sessionrestore', 16:39:25 INFO - 'sessionrestore_no_auto_restore']}, 16:39:25 INFO - 'other_l64': {'tests': ['a11yr', 16:39:25 INFO - 'ts_paint', 16:39:25 INFO - 'tpaint', 16:39:25 INFO - 'sessionrestore', 16:39:25 INFO - 'sessionrestore_no_auto_restore']}, 16:39:25 INFO - 'other_nol64': {'tests': ['a11yr', 16:39:25 INFO - 'ts_paint', 16:39:25 INFO - 'tpaint', 16:39:25 INFO - 'sessionrestore', 16:39:25 INFO - 'sessionrestore_no_auto_restore']}, 16:39:25 INFO - 'svgr': {'tests': ['tsvgx', 16:39:25 INFO - 'tsvgr_opacity', 16:39:25 INFO - 'tart', 16:39:25 INFO - 'tscrollx', 16:39:25 INFO - 'cart']}, 16:39:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['tsvgx', 16:39:25 INFO - 'tsvgr_opacity', 16:39:25 INFO - 'tart', 16:39:25 INFO - 'tscrollx', 16:39:25 INFO - 'cart']}, 16:39:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'tests': ['tp5o']}, 16:39:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'talos_options': ['--e10s'], 16:39:25 INFO - 'tests': ['tp5o']}, 16:39:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'talos_options': ['--xperf_path', 16:39:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:25 INFO - 'tests': ['tp5n']}, 16:39:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:25 INFO - 'talos_options': ['--e10s', 16:39:25 INFO - '--xperf_path', 16:39:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 16:39:25 INFO - 'C:/slave/talos-data/talos/xperf.config'], 16:39:25 INFO - 'tests': ['tp5n']}}, 16:39:25 INFO - 'talos.zip': {'path': '', 16:39:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:39:25 INFO - Running post-action listener: _resource_record_post_action 16:39:25 INFO - ##### 16:39:25 INFO - ##### Running create-virtualenv step. 16:39:25 INFO - ##### 16:39:25 INFO - Running pre-action listener: _resource_record_pre_action 16:39:25 INFO - Running main action method: create_virtualenv 16:39:25 INFO - Creating virtualenv /builds/slave/test/build/venv 16:39:25 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:39:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:39:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:39:25 INFO - Using real prefix '/tools/python27' 16:39:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:39:26 INFO - Installing distribute.............................................................................................................................................................................................done. 16:39:29 INFO - Installing pip.................done. 16:39:29 INFO - Return code: 0 16:39:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:29 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 0x106836a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e0c5e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, '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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39:29 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:39:29 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:39:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:39:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:29 INFO - 'HOME': '/Users/cltbld', 16:39:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:29 INFO - 'LOGNAME': 'cltbld', 16:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:29 INFO - 'MOZ_NO_REMOTE': '1', 16:39:29 INFO - 'NO_EM_RESTART': '1', 16:39:29 INFO - 'PAGER': '/bin/cat', 16:39:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:29 INFO - 'PWD': '/builds/slave/test', 16:39:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:29 INFO - 'SHELL': '/bin/bash', 16:39:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:39:29 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:39:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:29 INFO - 'USER': 'cltbld', 16:39:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:29 INFO - 'XPC_FLAGS': '0x0', 16:39:29 INFO - 'XPC_SERVICE_NAME': '0', 16:39:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:30 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:39:30 INFO - Cleaning up... 16:39:30 INFO - Return code: 0 16:39:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:39: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:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:30 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 0x106836a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e0c5e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, '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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39:30 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:39:30 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:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:30 INFO - 'HOME': '/Users/cltbld', 16:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:30 INFO - 'LOGNAME': 'cltbld', 16:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:30 INFO - 'MOZ_NO_REMOTE': '1', 16:39:30 INFO - 'NO_EM_RESTART': '1', 16:39:30 INFO - 'PAGER': '/bin/cat', 16:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:30 INFO - 'PWD': '/builds/slave/test', 16:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:30 INFO - 'SHELL': '/bin/bash', 16:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:39:30 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:30 INFO - 'USER': 'cltbld', 16:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:30 INFO - 'XPC_FLAGS': '0x0', 16:39:30 INFO - 'XPC_SERVICE_NAME': '0', 16:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:30 INFO - Downloading/unpacking psutil>=0.7.1 16:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:39:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:39:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:33 INFO - Installing collected packages: psutil 16:39:33 INFO - Running setup.py install for psutil 16:39:33 INFO - building 'psutil._psutil_osx' extension 16:39:33 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:39:35 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:39:35 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:39:35 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:39:35 INFO - building 'psutil._psutil_posix' extension 16:39:35 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:39:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:39:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:39:35 INFO - ^ 16:39:35 INFO - 1 warning generated. 16:39:35 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:39:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:35 INFO - Successfully installed psutil 16:39:35 INFO - Cleaning up... 16:39:35 INFO - Return code: 0 16:39:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:39: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:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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', '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 0x106836a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e0c5e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, '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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:39: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 mozsystemmonitor==0.0.0 16:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:35 INFO - 'HOME': '/Users/cltbld', 16:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:35 INFO - 'LOGNAME': 'cltbld', 16:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:35 INFO - 'MOZ_NO_REMOTE': '1', 16:39:35 INFO - 'NO_EM_RESTART': '1', 16:39:35 INFO - 'PAGER': '/bin/cat', 16:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:35 INFO - 'PWD': '/builds/slave/test', 16:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:35 INFO - 'SHELL': '/bin/bash', 16:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:39:35 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:35 INFO - 'USER': 'cltbld', 16:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:35 INFO - 'XPC_FLAGS': '0x0', 16:39:35 INFO - 'XPC_SERVICE_NAME': '0', 16:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:39: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:39: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:39: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:39: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:39: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:39: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:39:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:39:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:39:38 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:39:38 INFO - Installing collected packages: mozsystemmonitor 16:39:38 INFO - Running setup.py install for mozsystemmonitor 16:39:38 INFO - Successfully installed mozsystemmonitor 16:39:38 INFO - Cleaning up... 16:39:38 INFO - Return code: 0 16:39:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:38 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 0x106836a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e0c5e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, '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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39:38 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:39:38 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:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:38 INFO - 'HOME': '/Users/cltbld', 16:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:38 INFO - 'LOGNAME': 'cltbld', 16:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:38 INFO - 'MOZ_NO_REMOTE': '1', 16:39:38 INFO - 'NO_EM_RESTART': '1', 16:39:38 INFO - 'PAGER': '/bin/cat', 16:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:38 INFO - 'PWD': '/builds/slave/test', 16:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:38 INFO - 'SHELL': '/bin/bash', 16:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:39:38 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:38 INFO - 'USER': 'cltbld', 16:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:38 INFO - 'XPC_FLAGS': '0x0', 16:39:38 INFO - 'XPC_SERVICE_NAME': '0', 16:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:39 INFO - Downloading/unpacking blobuploader==1.2.4 16:39: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:39: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:39: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:39: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:39: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:39: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:39:41 INFO - Downloading blobuploader-1.2.4.tar.gz 16:39:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:39:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:39:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:39:42 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:39:42 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:39:42 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:39:42 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:39:42 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:39:42 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:39:42 INFO - Downloading docopt-0.6.1.tar.gz 16:39:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:39:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:39:42 INFO - Running setup.py install for blobuploader 16:39:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:39:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:39:42 INFO - Running setup.py install for requests 16:39:43 INFO - Running setup.py install for docopt 16:39:43 INFO - Successfully installed blobuploader requests docopt 16:39:43 INFO - Cleaning up... 16:39:43 INFO - Return code: 0 16:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:43 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 0x106836a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e0c5e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, '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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39:43 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:39:43 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:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:43 INFO - 'HOME': '/Users/cltbld', 16:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:43 INFO - 'LOGNAME': 'cltbld', 16:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:43 INFO - 'MOZ_NO_REMOTE': '1', 16:39:43 INFO - 'NO_EM_RESTART': '1', 16:39:43 INFO - 'PAGER': '/bin/cat', 16:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:43 INFO - 'PWD': '/builds/slave/test', 16:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:43 INFO - 'SHELL': '/bin/bash', 16:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:39:43 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:43 INFO - 'USER': 'cltbld', 16:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:43 INFO - 'XPC_FLAGS': '0x0', 16:39:43 INFO - 'XPC_SERVICE_NAME': '0', 16:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:43 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-RgZNUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-2_R9yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-KcH3hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-wZ0yBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-8yAoVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-Tae8eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-QJzZ3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-CMzaWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:44 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-04ORgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-grHU6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-ZLWjTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-80rLWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-nFPkIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-s5yUof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-vxLQHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-vbq0nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:45 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-YAfMVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:39:45 INFO - Running setup.py install for manifestparser 16:39:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:39:46 INFO - Running setup.py install for mozcrash 16:39:46 INFO - Running setup.py install for mozdebug 16:39:46 INFO - Running setup.py install for mozdevice 16:39:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:39:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:39:46 INFO - Running setup.py install for mozfile 16:39:46 INFO - Running setup.py install for mozhttpd 16:39:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:39:46 INFO - Running setup.py install for mozinfo 16:39:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:39:47 INFO - Running setup.py install for mozInstall 16:39:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:39:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:39:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:39:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:39:47 INFO - Running setup.py install for mozleak 16:39:47 INFO - Running setup.py install for mozlog 16:39:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:39:47 INFO - Running setup.py install for moznetwork 16:39:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:39:47 INFO - Running setup.py install for mozprocess 16:39:47 INFO - Running setup.py install for mozprofile 16:39:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Running setup.py install for mozrunner 16:39:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Running setup.py install for mozscreenshot 16:39:48 INFO - Running setup.py install for moztest 16:39:48 INFO - Running setup.py install for mozversion 16:39:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:39:48 INFO - Cleaning up... 16:39:48 INFO - Return code: 0 16:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x106836a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e0c5e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, '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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39:48 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:39:48 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:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:48 INFO - 'HOME': '/Users/cltbld', 16:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:48 INFO - 'LOGNAME': 'cltbld', 16:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:48 INFO - 'MOZ_NO_REMOTE': '1', 16:39:48 INFO - 'NO_EM_RESTART': '1', 16:39:48 INFO - 'PAGER': '/bin/cat', 16:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:48 INFO - 'PWD': '/builds/slave/test', 16:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:48 INFO - 'SHELL': '/bin/bash', 16:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:39:48 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:48 INFO - 'USER': 'cltbld', 16:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:48 INFO - 'XPC_FLAGS': '0x0', 16:39:48 INFO - 'XPC_SERVICE_NAME': '0', 16:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:49 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-2r1SyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:49 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-CVpQey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:49 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-zqkK7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:49 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-pXfMLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:49 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-6Bgyed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:49 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-Q3T3Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:49 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-6B_uQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-h8BiaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-XiqgrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-IFau9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-I3SMRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-XV2B5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-LyyjES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-0Zd2Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-dor9nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:50 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:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:50 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-yQjvdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:51 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:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:51 INFO - Running setup.py (path:/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/pip-uXyhe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:51 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:39:51 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:39: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:39:51 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:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:39:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:53 INFO - Downloading blessings-1.5.1.tar.gz 16:39:53 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:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:39:53 INFO - Installing collected packages: blessings 16:39:53 INFO - Running setup.py install for blessings 16:39:54 INFO - Successfully installed blessings 16:39:54 INFO - Cleaning up... 16:39:54 INFO - Return code: 0 16:39:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:54 INFO - Reading from file tmpfile_stdout 16:39:54 INFO - Current package versions: 16:39:54 INFO - blessings == 1.5.1 16:39:54 INFO - blobuploader == 1.2.4 16:39:54 INFO - docopt == 0.6.1 16:39:54 INFO - manifestparser == 1.1 16:39:54 INFO - mozInstall == 1.12 16:39:54 INFO - mozcrash == 0.16 16:39:54 INFO - mozdebug == 0.1 16:39:54 INFO - mozdevice == 0.46 16:39:54 INFO - mozfile == 1.2 16:39:54 INFO - mozhttpd == 0.7 16:39:54 INFO - mozinfo == 0.8 16:39:54 INFO - mozleak == 0.1 16:39:54 INFO - mozlog == 3.0 16:39:54 INFO - moznetwork == 0.27 16:39:54 INFO - mozprocess == 0.22 16:39:54 INFO - mozprofile == 0.27 16:39:54 INFO - mozrunner == 6.11 16:39:54 INFO - mozscreenshot == 0.1 16:39:54 INFO - mozsystemmonitor == 0.0 16:39:54 INFO - moztest == 0.7 16:39:54 INFO - mozversion == 1.4 16:39:54 INFO - psutil == 3.1.1 16:39:54 INFO - requests == 1.2.3 16:39:54 INFO - wsgiref == 0.1.2 16:39:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:54 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 0x106836a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068a3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e0c5e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, '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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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:39:54 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:39:54 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:39:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:39:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:54 INFO - 'HOME': '/Users/cltbld', 16:39:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:54 INFO - 'LOGNAME': 'cltbld', 16:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:54 INFO - 'MOZ_NO_REMOTE': '1', 16:39:54 INFO - 'NO_EM_RESTART': '1', 16:39:54 INFO - 'PAGER': '/bin/cat', 16:39:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:54 INFO - 'PWD': '/builds/slave/test', 16:39:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:54 INFO - 'SHELL': '/bin/bash', 16:39:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:39:54 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:39:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:54 INFO - 'USER': 'cltbld', 16:39:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:54 INFO - 'XPC_FLAGS': '0x0', 16:39:54 INFO - 'XPC_SERVICE_NAME': '0', 16:39:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 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:39:54 INFO - Cleaning up... 16:39:54 INFO - Return code: 0 16:39:54 INFO - Running post-action listener: _resource_record_post_action 16:39:54 INFO - Running post-action listener: _start_resource_monitoring 16:39:54 INFO - Starting resource monitoring. 16:39:54 INFO - ##### 16:39:54 INFO - ##### Running install step. 16:39:54 INFO - ##### 16:39:54 INFO - Running pre-action listener: _resource_record_pre_action 16:39:54 INFO - Running main action method: install 16:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:55 INFO - Reading from file tmpfile_stdout 16:39:55 INFO - Detecting whether we're running mozinstall >=1.0... 16:39:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:39:55 INFO - Reading from file tmpfile_stdout 16:39:55 INFO - Output received: 16:39:55 INFO - Usage: mozinstall [options] installer 16:39:55 INFO - Options: 16:39:55 INFO - -h, --help show this help message and exit 16:39:55 INFO - -d DEST, --destination=DEST 16:39:55 INFO - Directory to install application into. [default: 16:39:55 INFO - "/builds/slave/test"] 16:39:55 INFO - --app=APP Application being installed. [default: firefox] 16:39:55 INFO - mkdir: /builds/slave/test/build/application 16:39:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:40:32 INFO - Reading from file tmpfile_stdout 16:40:32 INFO - Output received: 16:40:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:40:32 INFO - Running post-action listener: _resource_record_post_action 16:40:32 INFO - ##### 16:40:32 INFO - ##### Running run-tests step. 16:40:32 INFO - ##### 16:40:32 INFO - Running pre-action listener: _resource_record_pre_action 16:40:32 INFO - Running main action method: run_tests 16:40:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:40:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:40:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:40:32 INFO - 2015-12-03 16:40:32.275 screenresolution[1632:7505] starting screenresolution argv=screenresolution get 16:40:32 INFO - 2015-12-03 16:40:32.278 screenresolution[1632:7505] Display 0: 1600x1200x32@60 16:40:32 INFO - 2015-12-03 16:40:32.284 screenresolution[1633:7507] starting screenresolution argv=screenresolution list 16:40:32 INFO - Available Modes on Display 0 16:40:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:40:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:40:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:40:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:40:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:40:32 INFO - Intel HD Graphics 3000: 16:40:32 INFO - Chipset Model: Intel HD Graphics 3000 16:40:32 INFO - Type: GPU 16:40:32 INFO - Bus: Built-In 16:40:32 INFO - VRAM (Total): 512 MB 16:40:32 INFO - VRAM (Dynamic, Max): 10 16:40:32 INFO - Vendor: Intel (0x8086) 16:40:32 INFO - Device ID: 0x0116 16:40:32 INFO - Revision ID: 0x0009 16:40:32 INFO - Displays: 16:40:32 INFO - Display: 16:40:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:40:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:40:32 INFO - Display Serial Number: 1600x1200 60 16:40:32 INFO - Main Display: Yes 16:40:32 INFO - Mirror: Off 16:40:32 INFO - Online: Yes 16:40:32 INFO - Rotation: Supported 16:40:32 INFO - Return code: 0 16:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:40:32 INFO - Python 2.7.3 16:40:32 INFO - Return code: 0 16:40:32 INFO - grabbing minidump binary from tooltool 16:40: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:40:32 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 0x1067eb9f0>, '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 0x10654acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067b5990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:40:32 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:40:32 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:40:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:40:32 INFO - Return code: 0 16:40:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:40:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:40:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:40:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:40:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0005', '--webServer', 'localhost'] in /builds/slave/test/build 16:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0005 --webServer localhost 16:40:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DB0Uy2AcrN/Render', 16:40:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:32 INFO - 'HOME': '/Users/cltbld', 16:40:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:32 INFO - 'LOGNAME': 'cltbld', 16:40:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:40:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:32 INFO - 'MOZ_NO_REMOTE': '1', 16:40:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:40:32 INFO - 'NO_EM_RESTART': '1', 16:40:32 INFO - 'PAGER': '/bin/cat', 16:40:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:32 INFO - 'PWD': '/builds/slave/test', 16:40:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:40:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:32 INFO - 'SHELL': '/bin/bash', 16:40:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DcLVmltUnK/Listeners', 16:40:32 INFO - 'TMPDIR': '/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/', 16:40:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:32 INFO - 'USER': 'cltbld', 16:40:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:32 INFO - 'XPC_FLAGS': '0x0', 16:40:32 INFO - 'XPC_SERVICE_NAME': '0', 16:40:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:40:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0005', '--webServer', 'localhost'] with output_timeout 3600 16:40:32 INFO - mozversion INFO | application_buildid: 20151203150742 16:40:32 INFO - mozversion INFO | application_changeset: e2d7d6033fae23341f077089774d25e56443466e 16:40:32 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:40:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:40:32 INFO - mozversion INFO | application_name: Firefox 16:40:32 INFO - mozversion INFO | application_remotingname: firefox-dev 16:40:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:40:32 INFO - mozversion INFO | application_vendor: Mozilla 16:40:32 INFO - mozversion INFO | application_version: 44.0a2 16:40:32 INFO - mozversion INFO | platform_buildid: 20151203150742 16:40:32 INFO - mozversion INFO | platform_changeset: e2d7d6033fae23341f077089774d25e56443466e 16:40:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:40:32 INFO - mozversion INFO | platform_version: 44.0a2 16:40:32 INFO - 2015-12-03 16:40:32,974 DEBUG : using testdate: 1449189632 16:40:32 INFO - 2015-12-03 16:40:32,974 DEBUG : actual date: 1449189632 16:40:33 INFO - 2015-12-03 16:40:33,050 INFO : starting webserver on 'localhost:49280' 16:40:33 INFO - 2015-12-03 16:40:33,052 INFO : Starting test suite t-yosemite-r5-0005 16:40:33 INFO - 2015-12-03 16:40:33,052 INFO : Starting test dromaeo_css 16:40:33 INFO - 2015-12-03 16:40:33,052 DEBUG : operating with platform_type : mac_ 16:40:33 INFO - 2015-12-03 16:40:33,052 INFO : Initialising browser for dromaeo_css test... 16:40:33 INFO - 2015-12-03 16:40:33,082 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/tmpAmHcYB/profile http://localhost:49280/getInfo.html 16:40:35 INFO - 2015-12-03 16:40:35,755 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:40:35 INFO - 2015-12-03 16:40:35,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:40:35 INFO - 2015-12-03 16:40:35,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:40:35 INFO - 2015-12-03 16:40:35,756 DEBUG : BROWSER_OUTPUT: __metrics 16:40:35 INFO - 2015-12-03 16:40:35,763 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:40:36 INFO - 2015-12-03 16:40:36,360 INFO : Browser initialized. 16:40:36 INFO - 2015-12-03 16:40:36,361 INFO : Running cycle 1/1 for dromaeo_css test... 16:40:36 INFO - 2015-12-03 16:40:36,361 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/tmpAmHcYB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:40:48 INFO - 2015-12-03 16:40:48,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 197292032 16:40:48 INFO - 2015-12-03 16:40:48,170 DEBUG : BROWSER_OUTPUT: 16:41:39 INFO - 2015-12-03 16:41:39,602 DEBUG : BROWSER_OUTPUT: 1449189699598 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:43:49 INFO - 2015-12-03 16:43:49,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 16:43:51 INFO - 2015-12-03 16:43:51,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 311869440 16:43:51 INFO - 2015-12-03 16:43:51,025 DEBUG : BROWSER_OUTPUT: 16:46:53 INFO - 2015-12-03 16:46:53,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 16:46:54 INFO - 2015-12-03 16:46:54,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 340676608 16:46:54 INFO - 2015-12-03 16:46:54,143 DEBUG : BROWSER_OUTPUT: 16:49:56 INFO - 2015-12-03 16:49:56,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 16:49:56 INFO - 2015-12-03 16:49:56,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 310714368 16:49:56 INFO - 2015-12-03 16:49:56,696 DEBUG : BROWSER_OUTPUT: 16:52:58 INFO - 2015-12-03 16:52:58,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 16:52:59 INFO - 2015-12-03 16:52:59,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 296931328 16:52:59 INFO - 2015-12-03 16:52:59,135 DEBUG : BROWSER_OUTPUT: 16:56:02 INFO - 2015-12-03 16:56:02,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 16:56:02 INFO - 2015-12-03 16:56:02,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 297832448 16:56:02 INFO - 2015-12-03 16:56:02,794 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 16:59:05 INFO - 2015-12-03 16:59:05,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 358350848 16:59:05 INFO - 2015-12-03 16:59:05,382 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,382 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:59:05 INFO - 2015-12-03 16:59:05,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:59:05 INFO - 2015-12-03 16:59:05,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:59:05 INFO - 2015-12-03 16:59:05,382 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:59:05 INFO - 2015-12-03 16:59:05,382 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3157.147570156058;3200.3759266942957;3233.0462513558496;3249.626292976307;3250.999999999999;5457.399686034538;5457.5633949284065;5471.097268950628;5477.589180811445;5536.224928510007;5483.150111732678;5494.2582751328555;5499.1476321170185;5531.363893152288;5535.003699334118;5030.723310217936;5041.243813427978;5075.314832497603;5121.923171152417;5149.459306772791;5022.422421421528;5035.84892453227;5041.621878359119;5056.115179843531;5134.768935397916;5125.948740512585;5159.071367153911;5173.3533308336455;5184.662996905189;5185.351831021122;5108.66793658411;5125.948740512585;5183.170692689189;5189.091908915943;5190.06578815813;4907.631927605408;4916.901661966741;5005.57452616528;5059.367579052619;5079.060373830853;5395.946040539584;5453.918191227135;5469.398366179717;5478.698671573062;5495.587830912697;5717;5849.415058494159;5864.179014937912;5876.11858221266;5896.115582662592;5798.82603521895;5936.584439089265;5951.315598706117;5967.343592204854;5995.040793473067;5597.3003374578175;5628.915566266509;5635.549156067505;5637.548996080386;5642.802501912413;5832.416758324133;6155.784547540815;6162.044883043135;6163.876722465526;6166.445019948226;5704.600677952587;5732.656040637575;5784.334801497882;5846.912296315559;5887.175795388649;5874.265716785402;5980.401959804072;5997.040473524303;6002.849928751816;6003.159557661931;5692.800751973744;5877.353491115974;5902.2327097477055;5904.76380944766;5905.616134951214;5755.769769209269;5838.4453476919625;5878.647281163144;5886.05823068307;5938.673372964528;4543.954560454419;4577.336286238543;4584.701994370355;4590.540945905383;4601.838935637236;3999.24014437256;4180.602842729997;4205.621494065549;4215.641670457984;4223.260929337353;5310.734463276821;5409.269748583891;5424.783008679608;5437.864053398696;5459.918101228484;5946.554008449383;5989.431004054608;5990.400959904062;5994.940050599525;5996.580239383201;5421.837344879581;5528.6406383585745;5540.529055030368;5547.805826796123;5551.528120109836;5135.152699804565;5207.7916883325;5223.7910483580235;5226.033183860998;5227.921581176285;5976.880462390728;6079.908801367983;6099.420555047263;6110.877782444238;6118.1128736332985;5734.627249228787;5859.033259512304;5872.735726892385;6037.758489660365;6084.60450070744;5923.644581325134;6010.669413182317;6024.33732289439;6026.337102918763;6046.667433291212;5876.647401155944;5887.8233652990475;5891.1457838614015;5907.054871220584;5918.319393269829;5808.883822323614;5925.496332811759;5937;5948.8810223796145;5963.463288304073;5727.169560413633;5800.593958423039;5800.709964501673;5802.390748971297;5828.242328497268;5799.710014499343;5804.622699524517;5818.389069147678;5836.649801011953;5842.620229685057;5510.531604813636;5629.183768353648;5629.4652008059165;5703.572232082527;5707.6575405475805;5705.800296989585;5777.740001700017;5790.160426738184;5792.160136780059;5799.014167591436;5694.715264236855;5699.430056994267;5708.400617935057;5733.713314334183;5762.971185144215 16:59:05 INFO - 2015-12-03 16:59:05,383 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.3164765145283;582.897992851251;602.6625089949629;602.7317843559617;611.0437165835465;32363.190920226978;41814.58185418145;42720;42760.14479710404;42820.57179428205;44266;44713.10573788522;44819.55180448195;44826.32760508587;44856.3271550927;8745.737627871174;8885;9351.906480935206;9509.429434233933;9544.570494327738;11267.661970140867;11437.027852632536;11459.656210313662;11468.426578671075;11479.540818367297;11259.155563332743;11365.31808091517;11366.31802091873;11382.601608943647;11406.657800265964;8839.204471597523;9104.772380690469;11237.662870113909;11238.550457981672;11306.491207895664;11043.116550675926;11186.496607652674;11187.66437006883;11201.439928003567;11225.494852731565;41193;41643.791781041204;41672;41734;41762.164756705;3089.459344614706;3096.829674367909;3131.7031317031265;3135.6394014688376;3159.2259896325318;29051.854740726372;29390.265243368875;29437.55843662347;29451;30418.239544011354;2436.098643501916;2467.491152026093;2471.5551200783852;2520.155747824481;2631.158029430583;265544;267196;268411;269514;270304;64369;66213.33786662071;66637.66681166564;66671.33328666748;66740.33259667439;60980.39019609836;72828.63585682037;73988;73997.6300118496;74138.25861741422;17336.65326693484;17824.287028518975;17829.46511604654;17836.286548538174;17863.464096076877;13397.06220564551;13595.184288942695;13597.388117534734;13597.912167026614;13610.59168224955;21501.13995440165;21593.24423645165;21805.345839624835;22209.333719988426;22269.44326391821;9139.314551408672;9370.437773733598;9395.765105872271;9400.90599094014;9438.716838494856;985.7239972807625;1031.566741968375;1055.5935964653663;1106.7067227184803;1169.1348402182323;29703.85148074289;29887.252818679706;29932.551011734842;30413.543796843063;30555.2361190972;1056.6301794372062;1097.2154909239932;1142.154805443982;1218.3786269002694;1237.1463690053833;12873.163244389085;15164.78681705461;17760.111994400228;17833.910830445766;17838;396027;402979;404264;404849;404986;58673.119903201485;59734.70132649309;61766;62277;62304.688476558236;1482.4070371851346;1485.0569888120906;1493.4250313629113;1494.0064856870276;1603.0541980231485;29883.85058074783;31145.37709245757;31159.37681246317;31618.367632647678;31704.524432133996;48991.51008490012;49093;50089;53753;54278.45721542892;236371;236943;240712;241276;241878;33761.493577595866;34048.319033619686;34975.82512087423;35002.82498587592;35489.46765798567;44736.55263447454;46232.76883615561;46309.305360420294;46973;47227.52772472231;36861.63138368582;37298.627013729514;38095.61904380921;38889.222215556096;39142.60857391504;37997.81001094977;42253;42750.144997100506;42987.35518967156;43023.56976430196;39862.2027559453;40503.18993620052;41331.380029300184;41336.58663413327;41341;39956.600433995285;40602.79698601488;41257.58742412538;41420.792896035324;41515;33269.50095748517;34633.65366346405;34657.65342346645;34663;34710 16:59:05 INFO - 2015-12-03 16:59:05,387 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.2341835309143;363.40945962810434;365.2949806872738;370.40919733025834;373.31310388884447;15494.380224791023;15580.766288505682;17795.37716179934;18670.253189872405;19248.23007079717;15721.213939303047;18470.16884240209;18640;18687.626247475077;18821.905890470527;4861.805527778884;4984.975075124619;4996.575291100243;5464.043792336335;5618.12918997554;3584.766990145645;3675.558932928039;4949.158643030693;5011.67424117433;5035.018171456568;4972.2044472884345;5007.949920500803;5010.0981823271795;5032.924506132411;5034.119029169899;4860.805567777303;4925.458199598042;4934.8156442453555;5012.373453318335;5017.49825017499;4206.0326124991425;4206.894827629303;4206.936895946533;4211.852585159535;4219.3249080147025;13432.395542200624;13988.580342589637;14451.060681055698;14452.566423007327;14457.493987710379;1804.613229509912;1872.0546124207324;1908.0173710539084;1932.9323473678494;2019.7576290845045;9981.30130890838;10060.195184385231;10243.948780256125;10290.536925838354;10445.425501597409;1613.4836852207297;1622.5456872075838;1629.9185040747916;1706.8463838254618;1719.4153987644136;58326.7083664579;59042.11436828408;60842.695786521224;61118.388816111714;61487.692561537355;6763.695633696496;6858.6570671466225;6875.243723190445;6951.16586009682;6958.338957799001;7969.960150199212;7973.162817904153;7974.481658692166;7985.560794156261;7988.241117093867;5798.072308430631;5821.446962538552;5828.562857785683;5831.708414579339;5854.18041474194;6083.270007599028;6084.5132389408745;6099.2985806632805;6110.052941793941;6125.509959203253;3162.130414136131;3163.2724473371254;3176.8093914365213;3194.552762613236;3195.936081278408;1096.188820273008;1117.1453837814079;1122.7193201699574;1131.9398694376157;1181.149572307937;440.8831659610206;442.6635756824772;465.9324397962344;500.4070176840383;504.76023888652594;12458.688532786753;12634.87365126337;12772.297523636104;12790.936045319713;12865.935670321589;435.4252386849392;476.83787512246005;478.6434106590612;503.98488045357965;519.1589624807835;6481.611103333815;6699.899501507482;6729.192496900403;6811.080504131978;6830.692618832065;653033;660307;662498;664523;672381;43572.128557428674;49060.26409603859;72827;74870.25129748633;75252.62373688097;460.2750667698388;469.6172619315247;470.8964027913922;471.5991407303833;471.8985418135049;10629.574817007233;10755.408452534874;11411.486483108447;11616.303021818718;11759.353235572125;37268.813655931546;37343.253134937695;37899.242015160096;38140;38785.80607096946;47285;48153.75923120502;48284.51715482941;48679;49179.26231106608;8370.790730231549;8421.95789021051;8458.323334133378;8545.74362769118;8575.95712021436;12309.507619695112;12633.305168215837;12711.93644031811;12712.427940742504;12719.93640031794;10750;10931.726706832393;11040.834387484034;11115.72210694739;11121.110311175249;10070.395776253448;10590.523426445983;10753.569857205624;10789.56841726322;10813.351198928089;9285.257179425495;9587.952060239653;11047.72380690489;11163.776724465628;11257.268277561932;8232.794180145544;8281.668733250603;8325.125861784425;8329.12544182852;8335.708250211213;10512.57949682004;10606.416647084485;10810.891891081303;10812.891871081189;10818.51316690735 16:59:05 INFO - 2015-12-03 16:59:05,387 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1334.572936660268;1695.3218712514997;1781.0649409060238;1811.3931832836;1842.4380563927996;7219.350258476736;7486.812829679254;7594.050743657043;7621.771346859596;7628.389728821695;7606.847863042736;7805.219478052206;7824.647890844912;7834.334081603056;7856.607169641509;2273.6021196290667;2296.391456264083;2299.091858715806;2300.424893776556;2307.065638416436;2306.7231932168165;2311.919082832101;2340.9063637454483;2340.9882950585225;2343.988280058606;2264.728232612081;2284.6116160252714;2291.3584196424945;2291.564602725485;2297.0811675329833;2243.371855880356;2283.2465286455513;2296;2296.5521723264055;2297.6438652008965;2303.781140791622;2314.2131675230503;2318.327684971356;2319.814414846808;2323.9651405228933;7011.193712723051;7161.820954476128;7720.613969301512;7762.534247945085;7772.494787838829;4682.484926658065;4803.03939212159;4805.711657300538;4824.517548245182;4827.710337379768;3010.969890301091;3073.3085055862475;3099;3118.189270789588;3121.1260846962887;906.6237511432813;925.8564922437033;947.6872632031414;965.3339195954769;966.3573723473882;10015.399076055388;10086.697399078039;10091.243156763272;10093.848592271122;10095.99040095992;4186.1418409226035;4227.450431443954;4283.828646854091;4288.206681763883;4294.398784170218;8430.156984301644;8447;8448.535330556755;8454;8455.873161902577;4768.6661933665;4783.210770222874;4788.976055119702;4797.64017698674;4799.136155491975;4422.557744225552;4431.933520997188;4432.202203603318;4433.933490997638;4444;3434.8282585870606;3485.6514348564942;3504.7196224301993;3507.4037413639744;3508.5965114011706;1007.7732510185297;1011.6964910526813;1017.765913839821;1023.150784848574;1024.0425202435747;1268.4926029588055;1314.6056183145017;1315.967100822487;1328.382302229468;1329.7008173160962;7394.963025184839;7486.326230639269;7499.475036747484;7517.812054698677;7519.548827070284;470.48011946798977;483.789551545079;487.02108761389155;487.2763945540869;488.33586322601235;5562.137868630369;5669.31968163823;5922.644641321534;5993.041113421831;5996.280446346466;8828.19022100468;9056.50189239585;9059.275257979345;9060.320475964329;9085.954570227106;8851.424657397249;8985.955070224607;8996.550172491348;9117.36178467501;9142.3600347975;7185.820354491179;7271.200167981518;7275.017872587239;7284.890726639104;7313.5246208997305;7243.167035790952;7322.2677732228485;7336.9728238045645;7345.522541034816;7368.557886526825;7940.761777146464;8253.917460825554;8257.710980115668;8312.04411492686;8321.95839020801;8243.340532757486;8353.457025293337;8358.958205208935;8389.916100838913;8434.367422443464;6652.567583107082;6715.731370745116;6717.16035495563;6719.260881302955;6723.798286051427;7436.851262974602;7536.208698086842;7537.736179233701;7543.811404714926;7572.507786993828;7018.929810702032;7068.505204635626;7119.252478489684;7169.283071692789;7182.138143422822;6966.268541803241;7019.543729657556;7030.086088808423;7139.071920650283;7153.3919616833155;7075.929240707527;7128.358447739728;7139.500234983501;7142.428605711427;7148.606826624586;6475.546711730133;6510.576812507172;6546.378094081055;6556.409923106943;6557.737690492327;6317.526185536195;6337.334579869047;6351.364863513611;6368.840778980562;6379.489640828815 16:59:05 INFO - 2015-12-03 16:59:05,388 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.2292281905978;344.335432615053;344.56928838951313;346.7364802749909;348.39901170480925;6158.230221222348;6233.1585235993125;6233.906491402621;6270.561060725751;6309.77915772948;6134.2332208473945;6169.722362493687;6214.813555593328;6222.377762223787;6226.719797609107;4816.3016362627395;4821.758912054401;4823.252395878627;4833.613310935134;4838.104950584145;4653.046125544272;4748.240281554952;4750.548697873696;4814.8314808981695;4817.2774083887525;4729.952700472985;4760.714357138566;4764.190087685084;4777.570018698317;4783;4751.786169622341;4770.165221086313;4770.475247722748;4775.188218002948;4783.928241076386;4149.605787450188;4157.771322577257;4159.771212583307;4168.91662166758;4174.20690068889;5980.162777211194;6050.455459008666;6069.969650151766;6073.605215660968;6077.24034495688;5342.839714808562;5345.518903298683;5367.141257398836;5373.516383525502;5375.81184658535;6312.147860038882;6427.42153206209;6501.609903405763;6506.869862602722;6522.739090436425;4333.046729719456;4337.566243375669;4364.083542456056;4387.62705170061;4395.670324725626;6707.5975441473665;6751.05485232063;6754.594724316507;6778.932210677879;6791.864162716767;4448.377227188196;4464.04023135021;4467.5532446755715;4468.396766436555;4473.642108631302;4526.049529598756;4543.65922555803;4626.306054091846;4631.1895418301665;4649.883752906205;5349.331333583302;5353.304070470814;5354.437784032621;5361.08861493547;5370.731463426813;6532.542722009509;6545.836354091186;6554.672266386661;6572.244191917895;6590.044443555657;1662.335065973596;1682.5373022418687;1683.2257161705509;1684.0485125903824;1685.6291615844495;1068.631322193842;1079.4710591809956;1081.0540776820283;1081.3079629037422;1083.4691001409253;6169.105479705418;6192.907106393408;6197.876042479125;6203.47270482005;6221.06683997404;6781.11845460087;6792.08306878575;6792.592444453348;6801.319868013258;6804.727810887509;6184.81445556625;6185.474234690012;6196.659183744938;6206.224221972254;6265.0602409638;3755.3615885299564;3820.2359528094494;3821.7515861468914;3830.1190726132586;3841.3469710149343;6931.584104953719;6934.965325173342;6939;6944;6950.165980082423;6873.415759660485;7039.1553013638695;7053.400460960773;7059.258777828357;7080.468964827659;6997.965010174917;7008.26413226614;7010.369066784014;7010.68451919675;7045.907884277945;6671.5997040177745;6759.391654751096;6817.5568588041615;6895.310468953065;6941.895871562032;6703.798886033427;6729.158855143107;6753.1896172457655;6754.12196414463;6764.898526522008;6937.340952609494;6939.30606939302;6943.756968506078;6950.478714096362;6975.232724400414;4421.734695918255;4609.516000819865;4609.792559334771;4622.075584883104;4626.074785043073;6889.793306200822;6904.3095690430555;6906.482013848881;6924.169099708067;6927.480438967198;6699.866002680016;6704.161979752531;6708;6716.227633821977;6727.125473688389;6533.0853680485725;6736.259011508828;6745.5952642841585;6756;6793.796186114425;6554.8361290968105;6576.145101136822;6578.407943285128;6584.539082264196;6600.405963463311;6539.182602174728;6705.329467053256;6729.2934241903895;6735.023421603938;6747.932520674731;6590.538662293593;6591;6592.736290548324;6597.977313516412;6604.867902642017 16:59:05 INFO - 2015-12-03 16:59:05,392 DEBUG : BROWSER_OUTPUT: |5;yui.html;764.373213964549;767.531339208142;782.0693374883884;782.7182214402814;786.8898354230407;14103.294835258235;14455.710885782279;14480.5655830325;14503.564893053212;14532;13462.066760902444;13519.729605407885;14032.579022629312;14102.153870767761;14131.646708832284;760.2739383888401;768.8731359325704;938.816930698514;957.1194501059042;957.4494665567291;933.1648174883475;940.2994768897181;951.7953639967405;952.9904700952972;953.3326671330062;979.8236317462889;988.1205726903062;988.8862780780195;988.9456079915602;989.0356902020544;783.5690370296343;794.4478587381772;964.1948972607881;983.3657291047234;986.634945070325;726.8328284494543;726.8836986082255;727.1274470635205;727.2654618834962;727.8908163775424;14016.789748153786;14170.362333695008;14172.362243698955;14178.574642760734;14191.219482928434;11854.466549005316;12126.969207617363;12128.090393220455;12345.444454999457;12381.071419643473;9114.680986165518;9404.90595094047;9480.525973701357;9618.374805637612;9679.516024198761;3017.3663530658587;3101.4417404867113;3105.891293804706;3155.621325440939;3177.491601343797;44430.33354499685;44459.333110003376;44907.32639010417;47746.28380574294;47798.76100619475;6642.335766423319;6685.331466853276;6765.932340676629;6962.1297337832775;7018.263082376379;12744.235345879277;12749.553765618159;12750.936245318899;12764.489420423079;12777.16948398351;6245.406686364788;6377.936220637827;6496.707648155844;6564.573302735403;6630.701618427182;3966.841326346914;3972.7219094663096;4029.81865816039;4032.5967403259438;4052.452918855976;2903.0565066353097;2906.8110572812698;2919.9270018249713;2922.6931172227037;2947.7347038766616;435.86488188661616;437.5974103824489;440.46043596593915;442.7498463368187;444.04973357016013;466.21442868766235;466.51249444330756;542.7557599080429;546.7457632201045;575.7351618255566;7413.8060167270005;7461.5896125712525;7473.252674732484;7720.729774457979;7780.961095194488;366.31316281971306;390.145581177221;430.14615987265256;581.3838321811282;600.6786369292407;3327.085051610826;3507.719382449398;3641.599424063351;3735.4210097434398;3756.586775454698;59638.70180649069;62949.37050629435;63321;63578.68210658917;63668;54064.45935540594;54636.18045729317;54736.452635473135;54913.72543137339;55441.722791385786;46480.07039859184;48237.517624823304;49245.50754492481;49249.50750492521;50205;8266.421350505407;8302.584870756316;8316.916830831857;8338.166183381612;8426.368022398223;37027.444588330654;37419;37542.43686344652;37684.43473347957;37995.24009519739;46453.3032004527;49195;49417.25874111963;49562.75218623884;50317.74841125918;7927.3033401835855;7995.440889026584;7997.580097292045;7999.240072193133;8102.149274326347;10300.433476158883;10570;10691.30506517074;10763.892361076289;11279.7744045117;10475.94762026185;10713.303635263683;10731.570737170427;10782.67651970442;11031.669049928514;10340.12108970746;10418.531166097393;10594.364338139736;10720.195985300978;10872.402017889091;10409;10425;10450.738731531772;10629.04338609498;10756.623518176826;8761.430507017023;9014;9141.497217652826;9391.906080939103;9902.455364954996;9060.184583387527;9063.229625481908;9313.301502387212;9370.812583748424;9551.856722149312 16:59:05 INFO - 2015-12-03 16:59:05,392 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:59:05 INFO - 2015-12-03 16:59:05,392 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:59:05 INFO - 2015-12-03 16:59:05,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,832 16:59:05 INFO - 2015-12-03 16:59:05,392 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190745377__endTimestamp 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5500.42 Median:5704.60 stddev:599.42 (10.5%) stddev-sans-first:572.38 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: Values: 3157.1 3200.4 3233.0 3249.6 3251.0 5457.4 5457.6 5471.1 5477.6 5536.2 5483.2 5494.3 5499.1 5531.4 5535.0 5030.7 5041.2 5075.3 5121.9 5149.5 5022.4 5035.8 5041.6 5056.1 5134.8 5125.9 5159.1 5173.4 5184.7 5185.4 5108.7 5125.9 5183.2 5189.1 5190.1 4907.6 4916.9 5005.6 5059.4 5079.1 5395.9 5453.9 5469.4 5478.7 5495.6 5717.0 5849.4 5864.2 5876.1 5896.1 5798.8 5936.6 5951.3 5967.3 5995.0 5597.3 5628.9 5635.5 5637.5 5642.8 5832.4 6155.8 6162.0 6163.9 6166.4 5704.6 5732.7 5784.3 5846.9 5887.2 5874.3 5980.4 5997.0 6002.8 6003.2 5692.8 5877.4 5902.2 5904.8 5905.6 5755.8 5838.4 5878.6 5886.1 5938.7 4544.0 4577.3 4584.7 4590.5 4601.8 3999.2 4180.6 4205.6 4215.6 4223.3 5310.7 5409.3 5424.8 5437.9 5459.9 5946.6 5989.4 5990.4 5994.9 5996.6 5421.8 5528.6 5540.5 5547.8 5551.5 5135.2 5207.8 5223.8 5226.0 5227.9 5976.9 6079.9 6099.4 6110.9 6118.1 5734.6 5859.0 5872.7 6037.8 6084.6 5923.6 6010.7 6024.3 6026.3 6046.7 5876.6 5887.8 5891.1 5907.1 5918.3 5808.9 5925.5 5937.0 5948.9 5963.5 5727.2 5800.6 5800.7 5802.4 5828.2 5799.7 5804.6 5818.4 5836.6 5842.6 5510.5 5629.2 5629.5 5703.6 5707.7 5705.8 5777.7 5790.2 5792.2 5799.0 5694.7 5699.4 5708.4 5733.7 5763.0 16:59:05 INFO - 2015-12-03 16:59:05,393 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,394 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49905.31 Median:34340.99 stddev:81651.69 (237.8%) stddev-sans-first:81796.69 16:59:05 INFO - 2015-12-03 16:59:05,394 DEBUG : BROWSER_OUTPUT: Values: 563.3 582.9 602.7 602.7 611.0 32363.2 41814.6 42720.0 42760.1 42820.6 44266.0 44713.1 44819.6 44826.3 44856.3 8745.7 8885.0 9351.9 9509.4 9544.6 11267.7 11437.0 11459.7 11468.4 11479.5 11259.2 11365.3 11366.3 11382.6 11406.7 8839.2 9104.8 11237.7 11238.6 11306.5 11043.1 11186.5 11187.7 11201.4 11225.5 41193.0 41643.8 41672.0 41734.0 41762.2 3089.5 3096.8 3131.7 3135.6 3159.2 29051.9 29390.3 29437.6 29451.0 30418.2 2436.1 2467.5 2471.6 2520.2 2631.2 265544.0 267196.0 268411.0 269514.0 270304.0 64369.0 66213.3 66637.7 66671.3 66740.3 60980.4 72828.6 73988.0 73997.6 74138.3 17336.7 17824.3 17829.5 17836.3 17863.5 13397.1 13595.2 13597.4 13597.9 13610.6 21501.1 21593.2 21805.3 22209.3 22269.4 9139.3 9370.4 9395.8 9400.9 9438.7 985.7 1031.6 1055.6 1106.7 1169.1 29703.9 29887.3 29932.6 30413.5 30555.2 1056.6 1097.2 1142.2 1218.4 1237.1 12873.2 15164.8 17760.1 17833.9 17838.0 396027.0 402979.0 404264.0 404849.0 404986.0 58673.1 59734.7 61766.0 62277.0 62304.7 1482.4 1485.1 1493.4 1494.0 1603.1 29883.9 31145.4 31159.4 31618.4 31704.5 48991.5 49093.0 50089.0 53753.0 54278.5 236371.0 236943.0 240712.0 241276.0 241878.0 33761.5 34048.3 34975.8 35002.8 35489.5 44736.6 46232.8 46309.3 46973.0 47227.5 36861.6 37298.6 38095.6 38889.2 39142.6 37997.8 42253.0 42750.1 42987.4 43023.6 39862.2 40503.2 41331.4 41336.6 41341.0 39956.6 40602.8 41257.6 41420.8 41515.0 33269.5 34633.7 34657.7 34663.0 34710.0 16:59:05 INFO - 2015-12-03 16:59:05,394 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,394 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30413.78 Median:22006.51 stddev:108264.62 (492.0%) stddev-sans-first:108544.81 16:59:05 INFO - 2015-12-03 16:59:05,398 DEBUG : BROWSER_OUTPUT: Values: 361.2 363.4 365.3 370.4 373.3 15494.4 15580.8 17795.4 18670.3 19248.2 15721.2 18470.2 18640.0 18687.6 18821.9 4861.8 4985.0 4996.6 5464.0 5618.1 3584.8 3675.6 4949.2 5011.7 5035.0 4972.2 5007.9 5010.1 5032.9 5034.1 4860.8 4925.5 4934.8 5012.4 5017.5 4206.0 4206.9 4206.9 4211.9 4219.3 13432.4 13988.6 14451.1 14452.6 14457.5 1804.6 1872.1 1908.0 1932.9 2019.8 9981.3 10060.2 10243.9 10290.5 10445.4 1613.5 1622.5 1629.9 1706.8 1719.4 58326.7 59042.1 60842.7 61118.4 61487.7 6763.7 6858.7 6875.2 6951.2 6958.3 7970.0 7973.2 7974.5 7985.6 7988.2 5798.1 5821.4 5828.6 5831.7 5854.2 6083.3 6084.5 6099.3 6110.1 6125.5 3162.1 3163.3 3176.8 3194.6 3195.9 1096.2 1117.1 1122.7 1131.9 1181.1 440.9 442.7 465.9 500.4 504.8 12458.7 12634.9 12772.3 12790.9 12865.9 435.4 476.8 478.6 504.0 519.2 6481.6 6699.9 6729.2 6811.1 6830.7 653033.0 660307.0 662498.0 664523.0 672381.0 43572.1 49060.3 72827.0 74870.3 75252.6 460.3 469.6 470.9 471.6 471.9 10629.6 10755.4 11411.5 11616.3 11759.4 37268.8 37343.3 37899.2 38140.0 38785.8 47285.0 48153.8 48284.5 48679.0 49179.3 8370.8 8422.0 8458.3 8545.7 8576.0 12309.5 12633.3 12711.9 12712.4 12719.9 10750.0 10931.7 11040.8 11115.7 11121.1 10070.4 10590.5 10753.6 10789.6 10813.4 9285.3 9588.0 11047.7 11163.8 11257.3 8232.8 8281.7 8325.1 8329.1 8335.7 10512.6 10606.4 10810.9 10812.9 10818.5 16:59:05 INFO - 2015-12-03 16:59:05,398 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,399 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5389.52 Median:6493.06 stddev:2752.78 (42.4%) stddev-sans-first:2743.62 16:59:05 INFO - 2015-12-03 16:59:05,399 DEBUG : BROWSER_OUTPUT: Values: 1334.6 1695.3 1781.1 1811.4 1842.4 7219.4 7486.8 7594.1 7621.8 7628.4 7606.8 7805.2 7824.6 7834.3 7856.6 2273.6 2296.4 2299.1 2300.4 2307.1 2306.7 2311.9 2340.9 2341.0 2344.0 2264.7 2284.6 2291.4 2291.6 2297.1 2243.4 2283.2 2296.0 2296.6 2297.6 2303.8 2314.2 2318.3 2319.8 2324.0 7011.2 7161.8 7720.6 7762.5 7772.5 4682.5 4803.0 4805.7 4824.5 4827.7 3011.0 3073.3 3099.0 3118.2 3121.1 906.6 925.9 947.7 965.3 966.4 10015.4 10086.7 10091.2 10093.8 10096.0 4186.1 4227.5 4283.8 4288.2 4294.4 8430.2 8447.0 8448.5 8454.0 8455.9 4768.7 4783.2 4789.0 4797.6 4799.1 4422.6 4431.9 4432.2 4433.9 4444.0 3434.8 3485.7 3504.7 3507.4 3508.6 1007.8 1011.7 1017.8 1023.2 1024.0 1268.5 1314.6 1316.0 1328.4 1329.7 7395.0 7486.3 7499.5 7517.8 7519.5 470.5 483.8 487.0 487.3 488.3 5562.1 5669.3 5922.6 5993.0 5996.3 8828.2 9056.5 9059.3 9060.3 9086.0 8851.4 8986.0 8996.6 9117.4 9142.4 7185.8 7271.2 7275.0 7284.9 7313.5 7243.2 7322.3 7337.0 7345.5 7368.6 7940.8 8253.9 8257.7 8312.0 8322.0 8243.3 8353.5 8359.0 8389.9 8434.4 6652.6 6715.7 6717.2 6719.3 6723.8 7436.9 7536.2 7537.7 7543.8 7572.5 7018.9 7068.5 7119.3 7169.3 7182.1 6966.3 7019.5 7030.1 7139.1 7153.4 7075.9 7128.4 7139.5 7142.4 7148.6 6475.5 6510.6 6546.4 6556.4 6557.7 6317.5 6337.3 6351.4 6368.8 6379.5 16:59:05 INFO - 2015-12-03 16:59:05,399 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,399 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5501.43 Median:6210.52 stddev:1670.94 (26.9%) stddev-sans-first:1629.96 16:59:05 INFO - 2015-12-03 16:59:05,399 DEBUG : BROWSER_OUTPUT: Values: 332.2 344.3 344.6 346.7 348.4 6158.2 6233.2 6233.9 6270.6 6309.8 6134.2 6169.7 6214.8 6222.4 6226.7 4816.3 4821.8 4823.3 4833.6 4838.1 4653.0 4748.2 4750.5 4814.8 4817.3 4730.0 4760.7 4764.2 4777.6 4783.0 4751.8 4770.2 4770.5 4775.2 4783.9 4149.6 4157.8 4159.8 4168.9 4174.2 5980.2 6050.5 6070.0 6073.6 6077.2 5342.8 5345.5 5367.1 5373.5 5375.8 6312.1 6427.4 6501.6 6506.9 6522.7 4333.0 4337.6 4364.1 4387.6 4395.7 6707.6 6751.1 6754.6 6778.9 6791.9 4448.4 4464.0 4467.6 4468.4 4473.6 4526.0 4543.7 4626.3 4631.2 4649.9 5349.3 5353.3 5354.4 5361.1 5370.7 6532.5 6545.8 6554.7 6572.2 6590.0 1662.3 1682.5 1683.2 1684.0 1685.6 1068.6 1079.5 1081.1 1081.3 1083.5 6169.1 6192.9 6197.9 6203.5 6221.1 6781.1 6792.1 6792.6 6801.3 6804.7 6184.8 6185.5 6196.7 6206.2 6265.1 3755.4 3820.2 3821.8 3830.1 3841.3 6931.6 6935.0 6939.0 6944.0 6950.2 6873.4 7039.2 7053.4 7059.3 7080.5 6998.0 7008.3 7010.4 7010.7 7045.9 6671.6 6759.4 6817.6 6895.3 6941.9 6703.8 6729.2 6753.2 6754.1 6764.9 6937.3 6939.3 6943.8 6950.5 6975.2 4421.7 4609.5 4609.8 4622.1 4626.1 6889.8 6904.3 6906.5 6924.2 6927.5 6699.9 6704.2 6708.0 6716.2 6727.1 6533.1 6736.3 6745.6 6756.0 6793.8 6554.8 6576.1 6578.4 6584.5 6600.4 6539.2 6705.3 6729.3 6735.0 6747.9 6590.5 6591.0 6592.7 6598.0 6604.9 16:59:05 INFO - 2015-12-03 16:59:05,399 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-12-03 16:59:05,399 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13717.58 Median:49333.38 stddev:17040.17 (34.5%) stddev-sans-first:17060.21 16:59:05 INFO - 2015-12-03 16:59:05,401 DEBUG : BROWSER_OUTPUT: Values: 764.4 767.5 782.1 782.7 786.9 14103.3 14455.7 14480.6 14503.6 14532.0 13462.1 13519.7 14032.6 14102.2 14131.6 760.3 768.9 938.8 957.1 957.4 933.2 940.3 951.8 953.0 953.3 979.8 988.1 988.9 988.9 989.0 783.6 794.4 964.2 983.4 986.6 726.8 726.9 727.1 727.3 727.9 14016.8 14170.4 14172.4 14178.6 14191.2 11854.5 12127.0 12128.1 12345.4 12381.1 9114.7 9404.9 9480.5 9618.4 9679.5 3017.4 3101.4 3105.9 3155.6 3177.5 44430.3 44459.3 44907.3 47746.3 47798.8 6642.3 6685.3 6765.9 6962.1 7018.3 12744.2 12749.6 12750.9 12764.5 12777.2 6245.4 6377.9 6496.7 6564.6 6630.7 3966.8 3972.7 4029.8 4032.6 4052.5 2903.1 2906.8 2919.9 2922.7 2947.7 435.9 437.6 440.5 442.7 444.0 466.2 466.5 542.8 546.7 575.7 7413.8 7461.6 7473.3 7720.7 7781.0 366.3 390.1 430.1 581.4 600.7 3327.1 3507.7 3641.6 3735.4 3756.6 59638.7 62949.4 63321.0 63578.7 63668.0 54064.5 54636.2 54736.5 54913.7 55441.7 46480.1 48237.5 49245.5 49249.5 50205.0 8266.4 8302.6 8316.9 8338.2 8426.4 37027.4 37419.0 37542.4 37684.4 37995.2 46453.3 49195.0 49417.3 49562.8 50317.7 7927.3 7995.4 7997.6 7999.2 8102.1 10300.4 10570.0 10691.3 10763.9 11279.8 10475.9 10713.3 10731.6 10782.7 11031.7 10340.1 10418.5 10594.4 10720.2 10872.4 10409.0 10425.0 10450.7 10629.0 10756.6 8761.4 9014.0 9141.5 9391.9 9902.5 9060.2 9063.2 9313.3 9370.8 9551.9 16:59:05 INFO - 2015-12-03 16:59:05,401 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:59:05 INFO - 2015-12-03 16:59:05,401 DEBUG : BROWSER_OUTPUT: 16:59:06 INFO - 2015-12-03 16:59:06,052 INFO : Browser exited with error code: 0 16:59:06 INFO - 2015-12-03 16:59:06,080 INFO : Completed test dromaeo_css (00:18:33) 16:59:06 INFO - 2015-12-03 16:59:06,080 INFO : Starting test kraken 16:59:06 INFO - 2015-12-03 16:59:06,080 DEBUG : operating with platform_type : mac_ 16:59:06 INFO - 2015-12-03 16:59:06,080 INFO : Initialising browser for kraken test... 16:59:06 INFO - 2015-12-03 16:59:06,093 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/tmpyFMxO2/profile http://localhost:49280/getInfo.html 16:59:08 INFO - 2015-12-03 16:59:08,154 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:59:08 INFO - 2015-12-03 16:59:08,154 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:59:08 INFO - 2015-12-03 16:59:08,155 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:59:08 INFO - 2015-12-03 16:59:08,155 DEBUG : BROWSER_OUTPUT: __metrics 16:59:08 INFO - 2015-12-03 16:59:08,170 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:08 INFO - 2015-12-03 16:59:08,763 INFO : Browser initialized. 16:59:08 INFO - 2015-12-03 16:59:08,763 INFO : Running cycle 1/1 for kraken test... 16:59:08 INFO - 2015-12-03 16:59:08,763 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/tmpyFMxO2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:59:20 INFO - 2015-12-03 16:59:20,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 197541888 16:59:20 INFO - 2015-12-03 16:59:20,512 DEBUG : BROWSER_OUTPUT: 16:59:23 INFO - 2015-12-03 16:59:23,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 16:59:23 INFO - 2015-12-03 16:59:23,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 262725632 16:59:23 INFO - 2015-12-03 16:59:23,929 DEBUG : BROWSER_OUTPUT: 16:59:26 INFO - 2015-12-03 16:59:26,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 16:59:27 INFO - 2015-12-03 16:59:27,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 276725760 16:59:27 INFO - 2015-12-03 16:59:27,098 DEBUG : BROWSER_OUTPUT: 16:59:29 INFO - 2015-12-03 16:59:29,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 16:59:30 INFO - 2015-12-03 16:59:30,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 264953856 16:59:30 INFO - 2015-12-03 16:59:30,501 DEBUG : BROWSER_OUTPUT: 16:59:32 INFO - 2015-12-03 16:59:32,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 16:59:33 INFO - 2015-12-03 16:59:33,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 265510912 16:59:33 INFO - 2015-12-03 16:59:33,106 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2015-12-03 16:59:35,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:59:35 INFO - 2015-12-03 16:59:35,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 266244096 16:59:35 INFO - 2015-12-03 16:59:35,852 DEBUG : BROWSER_OUTPUT: 16:59:38 INFO - 2015-12-03 16:59:38,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 16:59:39 INFO - 2015-12-03 16:59:39,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 266493952 16:59:39 INFO - 2015-12-03 16:59:39,461 DEBUG : BROWSER_OUTPUT: 16:59:42 INFO - 2015-12-03 16:59:42,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 16:59:43 INFO - 2015-12-03 16:59:43,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 267968512 16:59:43 INFO - 2015-12-03 16:59:43,151 DEBUG : BROWSER_OUTPUT: 16:59:45 INFO - 2015-12-03 16:59:45,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 16:59:46 INFO - 2015-12-03 16:59:46,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 266960896 16:59:46 INFO - 2015-12-03 16:59:46,568 DEBUG : BROWSER_OUTPUT: 16:59:48 INFO - 2015-12-03 16:59:48,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:59:48 INFO - 2015-12-03 16:59:48,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 299151360 16:59:48 INFO - 2015-12-03 16:59:48,719 DEBUG : BROWSER_OUTPUT: 16:59:50 INFO - 2015-12-03 16:59:50,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:59:51 INFO - 2015-12-03 16:59:51,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 300195840 16:59:51 INFO - 2015-12-03 16:59:51,136 DEBUG : BROWSER_OUTPUT: 16:59:53 INFO - 2015-12-03 16:59:53,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:59:53 INFO - 2015-12-03 16:59:53,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 306311168 16:59:53 INFO - 2015-12-03 16:59:53,763 DEBUG : BROWSER_OUTPUT: 16:59:56 INFO - 2015-12-03 16:59:56,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:59:56 INFO - 2015-12-03 16:59:56,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 307445760 16:59:56 INFO - 2015-12-03 16:59:56,857 DEBUG : BROWSER_OUTPUT: 16:59:59 INFO - 2015-12-03 16:59:59,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:00:00 INFO - 2015-12-03 17:00:00,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 307449856 17:00:00 INFO - 2015-12-03 17:00:00,008 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 17:00:01 INFO - 2015-12-03 17:00:01,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 365965312 17:00:01 INFO - 2015-12-03 17:00:01,976 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,976 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:00:01 INFO - 2015-12-03 17:00:01,977 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:00:01 INFO - 2015-12-03 17:00:01,977 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:00:01 INFO - 2015-12-03 17:00:01,977 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:00:01 INFO - 2015-12-03 17:00:01,977 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;109;102;108;109;109;95;107;108;107 17:00:01 INFO - 2015-12-03 17:00:01,977 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;128;157;148;124;145;126;156;145;123 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;160;160;160;161;161;161;160 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;78;75;119;65;67;70;70;117;64 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;101;137;87;90;88;127;88;88;130 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;115;120;120;120;114;114;120;114;120 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;124;124;124;124;124;124;125;124;124 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;100;99;101;100;99;101;101;101;100 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;61;61;62;62;63;63;71;57;56 17:00:01 INFO - 2015-12-03 17:00:01,978 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;65;66;66;66;67;67;67;67 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;84;80;81;82;82;81;84;88 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;125;120;119;126;116;127;126;124;119 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;144;146;144;147;143;149;147;147;143 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;68;68;68;68;67;67;69;69 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,878 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:00:01 INFO - 2015-12-03 17:00:01,979 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190801975__endTimestamp 17:00:01 INFO - 2015-12-03 17:00:01,980 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,981 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:00:01 INFO - 2015-12-03 17:00:01,981 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:00:01 INFO - 2015-12-03 17:00:01,981 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,981 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.00 Median:108.50 stddev:4.40 (4.1%) stddev-sans-first:4.66 17:00:01 INFO - 2015-12-03 17:00:01,982 DEBUG : BROWSER_OUTPUT: Values: 106.0 109.0 102.0 108.0 109.0 109.0 95.0 107.0 108.0 107.0 17:00:01 INFO - 2015-12-03 17:00:01,982 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,982 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:146.50 stddev:13.79 (9.4%) stddev-sans-first:13.86 17:00:01 INFO - 2015-12-03 17:00:01,982 DEBUG : BROWSER_OUTPUT: Values: 153.0 128.0 157.0 148.0 124.0 145.0 126.0 156.0 145.0 123.0 17:00:01 INFO - 2015-12-03 17:00:01,982 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,983 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 17:00:01 INFO - 2015-12-03 17:00:01,983 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 160.0 160.0 160.0 161.0 161.0 161.0 160.0 17:00:01 INFO - 2015-12-03 17:00:01,983 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,983 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:70.00 stddev:20.46 (29.2%) stddev-sans-first:21.70 17:00:01 INFO - 2015-12-03 17:00:01,983 DEBUG : BROWSER_OUTPUT: Values: 80.0 78.0 75.0 119.0 65.0 67.0 70.0 70.0 117.0 64.0 17:00:01 INFO - 2015-12-03 17:00:01,983 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,983 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:87.50 stddev:19.92 (22.8%) stddev-sans-first:21.08 17:00:01 INFO - 2015-12-03 17:00:01,985 DEBUG : BROWSER_OUTPUT: Values: 100.0 101.0 137.0 87.0 90.0 88.0 127.0 88.0 88.0 130.0 17:00:01 INFO - 2015-12-03 17:00:01,985 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,985 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:120.00 stddev:2.98 (2.5%) stddev-sans-first:3.05 17:00:01 INFO - 2015-12-03 17:00:01,985 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 120.0 120.0 120.0 114.0 114.0 120.0 114.0 120.0 17:00:01 INFO - 2015-12-03 17:00:01,985 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,985 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.10 Median:124.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:00:01 INFO - 2015-12-03 17:00:01,985 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 124.0 124.0 124.0 124.0 124.0 125.0 124.0 124.0 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.20 Median:101.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: Values: 100.0 100.0 99.0 101.0 100.0 99.0 101.0 101.0 101.0 100.0 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.30 Median:62.00 stddev:4.30 (6.9%) stddev-sans-first:4.27 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: Values: 57.0 61.0 61.0 62.0 62.0 63.0 63.0 71.0 57.0 56.0 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 17:00:01 INFO - 2015-12-03 17:00:01,986 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 65.0 66.0 66.0 66.0 67.0 67.0 67.0 67.0 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:2.30 (2.8%) stddev-sans-first:2.42 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 84.0 80.0 81.0 82.0 82.0 81.0 84.0 88.0 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:124.50 stddev:3.90 (3.1%) stddev-sans-first:3.97 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: Values: 119.0 125.0 120.0 119.0 126.0 116.0 127.0 126.0 124.0 119.0 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,987 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:146.50 stddev:2.01 (1.4%) stddev-sans-first:2.13 17:00:01 INFO - 2015-12-03 17:00:01,988 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 146.0 144.0 147.0 143.0 149.0 147.0 147.0 143.0 17:00:01 INFO - 2015-12-03 17:00:01,988 DEBUG : BROWSER_OUTPUT: 17:00:01 INFO - 2015-12-03 17:00:01,988 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 17:00:01 INFO - 2015-12-03 17:00:01,988 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 68.0 68.0 67.0 67.0 69.0 69.0 17:00:01 INFO - 2015-12-03 17:00:01,988 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:00:01 INFO - 2015-12-03 17:00:01,988 DEBUG : BROWSER_OUTPUT: 17:00:02 INFO - 2015-12-03 17:00:02,593 INFO : Browser exited with error code: 0 17:00:02 INFO - 2015-12-03 17:00:02,640 INFO : Completed test kraken (00:00:56) 17:00:02 INFO - 2015-12-03 17:00:02,641 INFO : Starting test v8_7 17:00:02 INFO - 2015-12-03 17:00:02,641 DEBUG : operating with platform_type : mac_ 17:00:02 INFO - 2015-12-03 17:00:02,641 INFO : Initialising browser for v8_7 test... 17:00:02 INFO - 2015-12-03 17:00:02,653 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/tmpqCrFuN/profile http://localhost:49280/getInfo.html 17:00:04 INFO - 2015-12-03 17:00:04,622 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:00:04 INFO - 2015-12-03 17:00:04,623 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:00:04 INFO - 2015-12-03 17:00:04,623 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:00:04 INFO - 2015-12-03 17:00:04,623 DEBUG : BROWSER_OUTPUT: __metrics 17:00:04 INFO - 2015-12-03 17:00:04,639 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:05 INFO - 2015-12-03 17:00:05,225 INFO : Browser initialized. 17:00:05 INFO - 2015-12-03 17:00:05,226 INFO : Running cycle 1/1 for v8_7 test... 17:00:05 INFO - 2015-12-03 17:00:05,226 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/T/tmpqCrFuN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:00:16 INFO - 2015-12-03 17:00:16,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 197939200 17:00:16 INFO - 2015-12-03 17:00:16,993 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49280/tests/v8_7/run.html (next: http://localhost:49280/tests/v8_7/run.html) 17:00:38 INFO - 2015-12-03 17:00:38,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 516132864 17:00:38 INFO - 2015-12-03 17:00:38,639 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,639 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:00:38 INFO - 2015-12-03 17:00:38,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |0;Richards;165.72754391779912 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.64430816404752 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.4149040026033 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5758.620689655172 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1012.1457489878543 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |5;Earley;668.002672010688 17:00:38 INFO - 2015-12-03 17:00:38,640 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: |7;RegExp;29228.571428571428 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: |8;Splay;588.2352941176471 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190838636__endTimestamp 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: Values: 165.7 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.64 Median:191.64 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,641 DEBUG : BROWSER_OUTPUT: Values: 191.6 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.41 Median:325.41 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: Values: 325.4 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5758.62 Median:5758.62 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: Values: 5758.6 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1012.15 Median:1012.15 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: Values: 1012.1 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:668.00 Median:668.00 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: Values: 668.0 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,642 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: Values: 11988.1 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29228.57 Median:29228.57 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: Values: 29228.6 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:588.24 Median:588.24 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: Values: 588.2 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: Values: 5803.5 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:00:38 INFO - 2015-12-03 17:00:38,643 DEBUG : BROWSER_OUTPUT: 17:00:39 INFO - 2015-12-03 17:00:39,185 INFO : Browser exited with error code: 0 17:00:39 INFO - 2015-12-03 17:00:39,204 INFO : Completed test v8_7 (00:00:36) 17:00:39 INFO - 2015-12-03 17:00:39,341 INFO : Completed test suite (00:20:06) 17:00:39 INFO - 2015-12-03 17:00:39,341 DEBUG : Working with test: dromaeo_css 17:00:39 INFO - 2015-12-03 17:00:39,341 DEBUG : Generating results file: dromaeo_css 17:00:39 INFO - 2015-12-03 17:00:39,342 DEBUG : Working with test: kraken 17:00:39 INFO - 2015-12-03 17:00:39,342 DEBUG : Generating results file: kraken 17:00:39 INFO - 2015-12-03 17:00:39,342 INFO : javascript benchmark 17:00:39 INFO - 2015-12-03 17:00:39,343 DEBUG : Working with test: v8_7 17:00:39 INFO - 2015-12-03 17:00:39,343 DEBUG : Generating results file: v8_7 17:00:39 INFO - 2015-12-03 17:00:39,343 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:39 INFO - 2015-12-03 17:00:39,399 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 17:00:39 INFO - 2015-12-03 17:00:39,399 DEBUG : process_Request line: dromaeo_css 6833.58 graph.html#tests=[[72,52,55]] 17:00:39 INFO - 2015-12-03 17:00:39,399 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:39 INFO - 2015-12-03 17:00:39,429 DEBUG : process_Request line: kraken 1478.70 graph.html#tests=[[232,52,55]] 17:00:39 INFO - 2015-12-03 17:00:39,429 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:39 INFO - 2015-12-03 17:00:39,461 DEBUG : process_Request line: v8_7 20483.84 graph.html#tests=[[230,52,55]] 17:00:39 INFO - 2015-12-03 17:00:39,462 INFO : javascript benchmark 17:00:39 INFO - 2015-12-03 17:00:39,464 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [361.2341835309143, 363.40945962810434, 365.2949806872738, 370.40919733025834, 373.31310388884447, 15494.380224791023, 15580.766288505682, 17795.37716179934, 18670.253189872405, 19248.23007079717, 15721.213939303047, 18470.16884240209, 18640.0, 18687.626247475077, 18821.905890470527, 4861.805527778884, 4984.975075124619, 4996.575291100243, 5464.043792336335, 5618.12918997554, 3584.766990145645, 3675.558932928039, 4949.158643030693, 5011.67424117433, 5035.018171456568, 4972.2044472884345, 5007.949920500803, 5010.0981823271795, 5032.924506132411, 5034.119029169899, 4860.805567777303, 4925.458199598042, 4934.8156442453555, 5012.373453318335, 5017.49825017499, 4206.0326124991425, 4206.894827629303, 4206.936895946533, 4211.852585159535, 4219.3249080147025, 13432.395542200624, 13988.580342589637, 14451.060681055698, 14452.566423007327, 14457.493987710379, 1804.613229509912, 1872.0546124207324, 1908.0173710539084, 1932.9323473678494, 2019.7576290845045, 9981.30130890838, 10060.195184385231, 10243.948780256125, 10290.536925838354, 10445.425501597409, 1613.4836852207297, 1622.5456872075838, 1629.9185040747916, 1706.8463838254618, 1719.4153987644136, 58326.7083664579, 59042.11436828408, 60842.695786521224, 61118.388816111714, 61487.692561537355, 6763.695633696496, 6858.6570671466225, 6875.243723190445, 6951.16586009682, 6958.338957799001, 7969.960150199212, 7973.162817904153, 7974.481658692166, 7985.560794156261, 7988.241117093867, 5798.072308430631, 5821.446962538552, 5828.562857785683, 5831.708414579339, 5854.18041474194, 6083.270007599028, 6084.5132389408745, 6099.2985806632805, 6110.052941793941, 6125.509959203253, 3162.130414136131, 3163.2724473371254, 3176.8093914365213, 3194.552762613236, 3195.936081278408, 1096.188820273008, 1117.1453837814079, 1122.7193201699574, 1131.9398694376157, 1181.149572307937, 440.8831659610206, 442.6635756824772, 465.9324397962344, 500.4070176840383, 504.76023888652594, 12458.688532786753, 12634.87365126337, 12772.297523636104, 12790.936045319713, 12865.935670321589, 435.4252386849392, 476.83787512246005, 478.6434106590612, 503.98488045357965, 519.1589624807835, 6481.611103333815, 6699.899501507482, 6729.192496900403, 6811.080504131978, 6830.692618832065, 653033.0, 660307.0, 662498.0, 664523.0, 672381.0, 43572.128557428674, 49060.26409603859, 72827.0, 74870.25129748633, 75252.62373688097, 460.2750667698388, 469.6172619315247, 470.8964027913922, 471.5991407303833, 471.8985418135049, 10629.574817007233, 10755.408452534874, 11411.486483108447, 11616.303021818718, 11759.353235572125, 37268.813655931546, 37343.253134937695, 37899.242015160096, 38140.0, 38785.80607096946, 47285.0, 48153.75923120502, 48284.51715482941, 48679.0, 49179.26231106608, 8370.790730231549, 8421.95789021051, 8458.323334133378, 8545.74362769118, 8575.95712021436, 12309.507619695112, 12633.305168215837, 12711.93644031811, 12712.427940742504, 12719.93640031794, 10750.0, 10931.726706832393, 11040.834387484034, 11115.72210694739, 11121.110311175249, 10070.395776253448, 10590.523426445983, 10753.569857205624, 10789.56841726322, 10813.351198928089, 9285.257179425495, 9587.952060239653, 11047.72380690489, 11163.776724465628, 11257.268277561932, 8232.794180145544, 8281.668733250603, 8325.125861784425, 8329.12544182852, 8335.708250211213, 10512.57949682004, 10606.416647084485, 10810.891891081303, 10812.891871081189, 10818.51316690735], "dojo.html": [3157.147570156058, 3200.3759266942957, 3233.0462513558496, 3249.626292976307, 3250.999999999999, 5457.399686034538, 5457.5633949284065, 5471.097268950628, 5477.589180811445, 5536.224928510007, 5483.150111732678, 5494.2582751328555, 5499.1476321170185, 5531.363893152288, 5535.003699334118, 5030.723310217936, 5041.243813427978, 5075.314832497603, 5121.923171152417, 5149.459306772791, 5022.422421421528, 5035.84892453227, 5041.621878359119, 5056.115179843531, 5134.768935397916, 5125.948740512585, 5159.071367153911, 5173.3533308336455, 5184.662996905189, 5185.351831021122, 5108.66793658411, 5125.948740512585, 5183.170692689189, 5189.091908915943, 5190.06578815813, 4907.631927605408, 4916.901661966741, 5005.57452616528, 5059.367579052619, 5079.060373830853, 5395.946040539584, 5453.918191227135, 5469.398366179717, 5478.698671573062, 5495.587830912697, 5717.0, 5849.415058494159, 5864.179014937912, 5876.11858221266, 5896.115582662592, 5798.82603521895, 5936.584439089265, 5951.315598706117, 5967.343592204854, 5995.040793473067, 5597.3003374578175, 5628.915566266509, 5635.549156067505, 5637.548996080386, 5642.802501912413, 5832.416758324133, 6155.784547540815, 6162.044883043135, 6163.876722465526, 6166.445019948226, 5704.600677952587, 5732.656040637575, 5784.334801497882, 5846.912296315559, 5887.175795388649, 5874.265716785402, 5980.401959804072, 5997.040473524303, 6002.849928751816, 6003.159557661931, 5692.800751973744, 5877.353491115974, 5902.2327097477055, 5904.76380944766, 5905.616134951214, 5755.769769209269, 5838.4453476919625, 5878.647281163144, 5886.05823068307, 5938.673372964528, 4543.954560454419, 4577.336286238543, 4584.701994370355, 4590.540945905383, 4601.838935637236, 3999.24014437256, 4180.602842729997, 4205.621494065549, 4215.641670457984, 4223.260929337353, 5310.734463276821, 5409.269748583891, 5424.783008679608, 5437.864053398696, 5459.918101228484, 5946.554008449383, 5989.431004054608, 5990.400959904062, 5994.940050599525, 5996.580239383201, 5421.837344879581, 5528.6406383585745, 5540.529055030368, 5547.805826796123, 5551.528120109836, 5135.152699804565, 5207.7916883325, 5223.7910483580235, 5226.033183860998, 5227.921581176285, 5976.880462390728, 6079.908801367983, 6099.420555047263, 6110.877782444238, 6118.1128736332985, 5734.627249228787, 5859.033259512304, 5872.735726892385, 6037.758489660365, 6084.60450070744, 5923.644581325134, 6010.669413182317, 6024.33732289439, 6026.337102918763, 6046.667433291212, 5876.647401155944, 5887.8233652990475, 5891.1457838614015, 5907.054871220584, 5918.319393269829, 5808.883822323614, 5925.496332811759, 5937.0, 5948.8810223796145, 5963.463288304073, 5727.169560413633, 5800.593958423039, 5800.709964501673, 5802.390748971297, 5828.242328497268, 5799.710014499343, 5804.622699524517, 5818.389069147678, 5836.649801011953, 5842.620229685057, 5510.531604813636, 5629.183768353648, 5629.4652008059165, 5703.572232082527, 5707.6575405475805, 5705.800296989585, 5777.740001700017, 5790.160426738184, 5792.160136780059, 5799.014167591436, 5694.715264236855, 5699.430056994267, 5708.400617935057, 5733.713314334183, 5762.971185144215], "mootools.html": [1334.572936660268, 1695.3218712514997, 1781.0649409060238, 1811.3931832836, 1842.4380563927996, 7219.350258476736, 7486.812829679254, 7594.050743657043, 7621.771346859596, 7628.389728821695, 7606.847863042736, 7805.219478052206, 7824.647890844912, 7834.334081603056, 7856.607169641509, 2273.6021196290667, 2296.391456264083, 2299.091858715806, 2300.424893776556, 2307.065638416436, 2306.7231932168165, 2311.919082832101, 2340.9063637454483, 2340.9882950585225, 2343.988280058606, 2264.728232612081, 2284.6116160252714, 2291.3584196424945, 2291.564602725485, 2297.0811675329833, 2243.371855880356, 2283.2465286455513, 2296.0, 2296.5521723264055, 2297.6438652008965, 2303.781140791622, 2314.2131675230503, 2318.327684971356, 2319.814414846808, 2323.9651405228933, 7011.193712723051, 7161.820954476128, 7720.613969301512, 7762.534247945085, 7772.494787838829, 4682.484926658065, 4803.03939212159, 4805.711657300538, 4824.517548245182, 4827.710337379768, 3010.969890301091, 3073.3085055862475, 3099.0, 3118.189270789588, 3121.1260846962887, 906.6237511432813, 925.8564922437033, 947.6872632031414, 965.3339195954769, 966.3573723473882, 10015.399076055388, 10086.697399078039, 10091.243156763272, 10093.848592271122, 10095.99040095992, 4186.1418409226035, 4227.450431443954, 4283.828646854091, 4288.206681763883, 4294.398784170218, 8430.156984301644, 8447.0, 8448.535330556755, 8454.0, 8455.873161902577, 4768.6661933665, 4783.210770222874, 4788.976055119702, 4797.64017698674, 4799.136155491975, 4422.557744225552, 4431.933520997188, 4432.202203603318, 4433.933490997638, 4444.0, 3434.8282585870606, 3485.6514348564942, 3504.7196224301993, 3507.4037413639744, 3508.5965114011706, 1007.7732510185297, 1011.6964910526813, 1017.765913839821, 1023.150784848574, 1024.0425202435747, 1268.4926029588055, 1314.6056183145017, 1315.967100822487, 1328.382302229468, 1329.7008173160962, 7394.963025184839, 7486.326230639269, 7499.475036747484, 7517.812054698677, 7519.548827070284, 470.48011946798977, 483.789551545079, 487.02108761389155, 487.2763945540869, 488.33586322601235, 5562.137868630369, 5669.31968163823, 5922.644641321534, 5993.041113421831, 5996.280446346466, 8828.19022100468, 9056.50189239585, 9059.275257979345, 9060.320475964329, 9085.954570227106, 8851.424657397249, 8985.955070224607, 8996.550172491348, 9117.36178467501, 9142.3600347975, 7185.820354491179, 7271.200167981518, 7275.017872587239, 7284.890726639104, 7313.5246208997305, 7243.167035790952, 7322.2677732228485, 7336.9728238045645, 7345.522541034816, 7368.557886526825, 7940.761777146464, 8253.917460825554, 8257.710980115668, 8312.04411492686, 8321.95839020801, 8243.340532757486, 8353.457025293337, 8358.958205208935, 8389.916100838913, 8434.367422443464, 6652.567583107082, 6715.731370745116, 6717.16035495563, 6719.260881302955, 6723.798286051427, 7436.851262974602, 7536.208698086842, 7537.736179233701, 7543.811404714926, 7572.507786993828, 7018.929810702032, 7068.505204635626, 7119.252478489684, 7169.283071692789, 7182.138143422822, 6966.268541803241, 7019.543729657556, 7030.086088808423, 7139.071920650283, 7153.3919616833155, 7075.929240707527, 7128.358447739728, 7139.500234983501, 7142.428605711427, 7148.606826624586, 6475.546711730133, 6510.576812507172, 6546.378094081055, 6556.409923106943, 6557.737690492327, 6317.526185536195, 6337.334579869047, 6351.364863513611, 6368.840778980562, 6379.489640828815], "ext.html": [563.3164765145283, 582.897992851251, 602.6625089949629, 602.7317843559617, 611.0437165835465, 32363.190920226978, 41814.58185418145, 42720.0, 42760.14479710404, 42820.57179428205, 44266.0, 44713.10573788522, 44819.55180448195, 44826.32760508587, 44856.3271550927, 8745.737627871174, 8885.0, 9351.906480935206, 9509.429434233933, 9544.570494327738, 11267.661970140867, 11437.027852632536, 11459.656210313662, 11468.426578671075, 11479.540818367297, 11259.155563332743, 11365.31808091517, 11366.31802091873, 11382.601608943647, 11406.657800265964, 8839.204471597523, 9104.772380690469, 11237.662870113909, 11238.550457981672, 11306.491207895664, 11043.116550675926, 11186.496607652674, 11187.66437006883, 11201.439928003567, 11225.494852731565, 41193.0, 41643.791781041204, 41672.0, 41734.0, 41762.164756705, 3089.459344614706, 3096.829674367909, 3131.7031317031265, 3135.6394014688376, 3159.2259896325318, 29051.854740726372, 29390.265243368875, 29437.55843662347, 29451.0, 30418.239544011354, 2436.098643501916, 2467.491152026093, 2471.5551200783852, 2520.155747824481, 2631.158029430583, 265544.0, 267196.0, 268411.0, 269514.0, 270304.0, 64369.0, 66213.33786662071, 66637.66681166564, 66671.33328666748, 66740.33259667439, 60980.39019609836, 72828.63585682037, 73988.0, 73997.6300118496, 74138.25861741422, 17336.65326693484, 17824.287028518975, 17829.46511604654, 17836.286548538174, 17863.464096076877, 13397.06220564551, 13595.184288942695, 13597.388117534734, 13597.912167026614, 13610.59168224955, 21501.13995440165, 21593.24423645165, 21805.345839624835, 22209.333719988426, 22269.44326391821, 9139.314551408672, 9370.437773733598, 9395.765105872271, 9400.90599094014, 9438.716838494856, 985.7239972807625, 1031.566741968375, 1055.5935964653663, 1106.7067227184803, 1169.1348402182323, 29703.85148074289, 29887.252818679706, 29932.551011734842, 30413.543796843063, 30555.2361190972, 1056.6301794372062, 1097.2154909239932, 1142.154805443982, 1218.3786269002694, 1237.1463690053833, 12873.163244389085, 15164.78681705461, 17760.111994400228, 17833.910830445766, 17838.0, 396027.0, 402979.0, 404264.0, 404849.0, 404986.0, 58673.119903201485, 59734.70132649309, 61766.0, 62277.0, 62304.688476558236, 1482.4070371851346, 1485.0569888120906, 1493.4250313629113, 1494.0064856870276, 1603.0541980231485, 29883.85058074783, 31145.37709245757, 31159.37681246317, 31618.367632647678, 31704.524432133996, 48991.51008490012, 49093.0, 50089.0, 53753.0, 54278.45721542892, 236371.0, 236943.0, 240712.0, 241276.0, 241878.0, 33761.493577595866, 34048.319033619686, 34975.82512087423, 35002.82498587592, 35489.46765798567, 44736.55263447454, 46232.76883615561, 46309.305360420294, 46973.0, 47227.52772472231, 36861.63138368582, 37298.627013729514, 38095.61904380921, 38889.222215556096, 39142.60857391504, 37997.81001094977, 42253.0, 42750.144997100506, 42987.35518967156, 43023.56976430196, 39862.2027559453, 40503.18993620052, 41331.380029300184, 41336.58663413327, 41341.0, 39956.600433995285, 40602.79698601488, 41257.58742412538, 41420.792896035324, 41515.0, 33269.50095748517, 34633.65366346405, 34657.65342346645, 34663.0, 34710.0], "prototype.html": [332.2292281905978, 344.335432615053, 344.56928838951313, 346.7364802749909, 348.39901170480925, 6158.230221222348, 6233.1585235993125, 6233.906491402621, 6270.561060725751, 6309.77915772948, 6134.2332208473945, 6169.722362493687, 6214.813555593328, 6222.377762223787, 6226.719797609107, 4816.3016362627395, 4821.758912054401, 4823.252395878627, 4833.613310935134, 4838.104950584145, 4653.046125544272, 4748.240281554952, 4750.548697873696, 4814.8314808981695, 4817.2774083887525, 4729.952700472985, 4760.714357138566, 4764.190087685084, 4777.570018698317, 4783.0, 4751.786169622341, 4770.165221086313, 4770.475247722748, 4775.188218002948, 4783.928241076386, 4149.605787450188, 4157.771322577257, 4159.771212583307, 4168.91662166758, 4174.20690068889, 5980.162777211194, 6050.455459008666, 6069.969650151766, 6073.605215660968, 6077.24034495688, 5342.839714808562, 5345.518903298683, 5367.141257398836, 5373.516383525502, 5375.81184658535, 6312.147860038882, 6427.42153206209, 6501.609903405763, 6506.869862602722, 6522.739090436425, 4333.046729719456, 4337.566243375669, 4364.083542456056, 4387.62705170061, 4395.670324725626, 6707.5975441473665, 6751.05485232063, 6754.594724316507, 6778.932210677879, 6791.864162716767, 4448.377227188196, 4464.04023135021, 4467.5532446755715, 4468.396766436555, 4473.642108631302, 4526.049529598756, 4543.65922555803, 4626.306054091846, 4631.1895418301665, 4649.883752906205, 5349.331333583302, 5353.304070470814, 5354.437784032621, 5361.08861493547, 5370.731463426813, 6532.542722009509, 6545.836354091186, 6554.672266386661, 6572.244191917895, 6590.044443555657, 1662.335065973596, 1682.5373022418687, 1683.2257161705509, 1684.0485125903824, 1685.6291615844495, 1068.631322193842, 1079.4710591809956, 1081.0540776820283, 1081.3079629037422, 1083.4691001409253, 6169.105479705418, 6192.907106393408, 6197.876042479125, 6203.47270482005, 6221.06683997404, 6781.11845460087, 6792.08306878575, 6792.592444453348, 6801.319868013258, 6804.727810887509, 6184.81445556625, 6185.474234690012, 6196.659183744938, 6206.224221972254, 6265.0602409638, 3755.3615885299564, 3820.2359528094494, 3821.7515861468914, 3830.1190726132586, 3841.3469710149343, 6931.584104953719, 6934.965325173342, 6939.0, 6944.0, 6950.165980082423, 6873.415759660485, 7039.1553013638695, 7053.400460960773, 7059.258777828357, 7080.468964827659, 6997.965010174917, 7008.26413226614, 7010.369066784014, 7010.68451919675, 7045.907884277945, 6671.5997040177745, 6759.391654751096, 6817.5568588041615, 6895.310468953065, 6941.895871562032, 6703.798886033427, 6729.158855143107, 6753.1896172457655, 6754.12196414463, 6764.898526522008, 6937.340952609494, 6939.30606939302, 6943.756968506078, 6950.478714096362, 6975.232724400414, 4421.734695918255, 4609.516000819865, 4609.792559334771, 4622.075584883104, 4626.074785043073, 6889.793306200822, 6904.3095690430555, 6906.482013848881, 6924.169099708067, 6927.480438967198, 6699.866002680016, 6704.161979752531, 6708.0, 6716.227633821977, 6727.125473688389, 6533.0853680485725, 6736.259011508828, 6745.5952642841585, 6756.0, 6793.796186114425, 6554.8361290968105, 6576.145101136822, 6578.407943285128, 6584.539082264196, 6600.405963463311, 6539.182602174728, 6705.329467053256, 6729.2934241903895, 6735.023421603938, 6747.932520674731, 6590.538662293593, 6591.0, 6592.736290548324, 6597.977313516412, 6604.867902642017], "yui.html": [764.373213964549, 767.531339208142, 782.0693374883884, 782.7182214402814, 786.8898354230407, 14103.294835258235, 14455.710885782279, 14480.5655830325, 14503.564893053212, 14532.0, 13462.066760902444, 13519.729605407885, 14032.579022629312, 14102.153870767761, 14131.646708832284, 760.2739383888401, 768.8731359325704, 938.816930698514, 957.1194501059042, 957.4494665567291, 933.1648174883475, 940.2994768897181, 951.7953639967405, 952.9904700952972, 953.3326671330062, 979.8236317462889, 988.1205726903062, 988.8862780780195, 988.9456079915602, 989.0356902020544, 783.5690370296343, 794.4478587381772, 964.1948972607881, 983.3657291047234, 986.634945070325, 726.8328284494543, 726.8836986082255, 727.1274470635205, 727.2654618834962, 727.8908163775424, 14016.789748153786, 14170.362333695008, 14172.362243698955, 14178.574642760734, 14191.219482928434, 11854.466549005316, 12126.969207617363, 12128.090393220455, 12345.444454999457, 12381.071419643473, 9114.680986165518, 9404.90595094047, 9480.525973701357, 9618.374805637612, 9679.516024198761, 3017.3663530658587, 3101.4417404867113, 3105.891293804706, 3155.621325440939, 3177.491601343797, 44430.33354499685, 44459.333110003376, 44907.32639010417, 47746.28380574294, 47798.76100619475, 6642.335766423319, 6685.331466853276, 6765.932340676629, 6962.1297337832775, 7018.263082376379, 12744.235345879277, 12749.553765618159, 12750.936245318899, 12764.489420423079, 12777.16948398351, 6245.406686364788, 6377.936220637827, 6496.707648155844, 6564.573302735403, 6630.701618427182, 3966.841326346914, 3972.7219094663096, 4029.81865816039, 4032.5967403259438, 4052.452918855976, 2903.0565066353097, 2906.8110572812698, 2919.9270018249713, 2922.6931172227037, 2947.7347038766616, 435.86488188661616, 437.5974103824489, 440.46043596593915, 442.7498463368187, 444.04973357016013, 466.21442868766235, 466.51249444330756, 542.7557599080429, 546.7457632201045, 575.7351618255566, 7413.8060167270005, 7461.5896125712525, 7473.252674732484, 7720.729774457979, 7780.961095194488, 366.31316281971306, 390.145581177221, 430.14615987265256, 581.3838321811282, 600.6786369292407, 3327.085051610826, 3507.719382449398, 3641.599424063351, 3735.4210097434398, 3756.586775454698, 59638.70180649069, 62949.37050629435, 63321.0, 63578.68210658917, 63668.0, 54064.45935540594, 54636.18045729317, 54736.452635473135, 54913.72543137339, 55441.722791385786, 46480.07039859184, 48237.517624823304, 49245.50754492481, 49249.50750492521, 50205.0, 8266.421350505407, 8302.584870756316, 8316.916830831857, 8338.166183381612, 8426.368022398223, 37027.444588330654, 37419.0, 37542.43686344652, 37684.43473347957, 37995.24009519739, 46453.3032004527, 49195.0, 49417.25874111963, 49562.75218623884, 50317.74841125918, 7927.3033401835855, 7995.440889026584, 7997.580097292045, 7999.240072193133, 8102.149274326347, 10300.433476158883, 10570.0, 10691.30506517074, 10763.892361076289, 11279.7744045117, 10475.94762026185, 10713.303635263683, 10731.570737170427, 10782.67651970442, 11031.669049928514, 10340.12108970746, 10418.531166097393, 10594.364338139736, 10720.195985300978, 10872.402017889091, 10409.0, 10425.0, 10450.738731531772, 10629.04338609498, 10756.623518176826, 8761.430507017023, 9014.0, 9141.497217652826, 9391.906080939103, 9902.455364954996, 9060.184583387527, 9063.229625481908, 9313.301502387212, 9370.812583748424, 9551.856722149312]}, "summary": {"suite": 6833.581549525429, "subtests": {"jquery.html": {"filtered": 7119.999555266183, "value": 7119.999555266183}, "dojo.html": {"filtered": 5461.547306067307, "value": 5461.547306067307}, "mootools.html": {"filtered": 4368.013072369561, "value": 4368.013072369561}, "ext.html": {"filtered": 20270.236889270356, "value": 20270.236889270356}, "prototype.html": {"filtered": 4954.724888189932, "value": 4954.724888189932}, "yui.html": {"filtered": 5968.86660958109, "value": 5968.86660958109}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0005"}, "testrun": {"date": 1449189632, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151203150742", "branch": "Mozilla-Aurora", "revision": "e2d7d6033fae23341f077089774d25e56443466e"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0], "ai-astar": [106.0, 109.0, 102.0, 108.0, 109.0, 109.0, 95.0, 107.0, 108.0, 107.0], "imaging-gaussian-blur": [120.0, 115.0, 120.0, 120.0, 120.0, 114.0, 114.0, 120.0, 114.0, 120.0], "audio-beat-detection": [153.0, 128.0, 157.0, 148.0, 124.0, 145.0, 126.0, 156.0, 145.0, 123.0], "json-stringify-tinderbox": [66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [145.0, 144.0, 146.0, 144.0, 147.0, 143.0, 149.0, 147.0, 147.0, 143.0], "json-parse-financial": [57.0, 61.0, 61.0, 62.0, 62.0, 63.0, 63.0, 71.0, 57.0, 56.0], "stanford-crypto-sha256-iterative": [67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 69.0, 69.0], "audio-fft": [80.0, 78.0, 75.0, 119.0, 65.0, 67.0, 70.0, 70.0, 117.0, 64.0], "imaging-darkroom": [124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 125.0, 124.0, 124.0], "stanford-crypto-ccm": [119.0, 125.0, 120.0, 119.0, 126.0, 116.0, 127.0, 126.0, 124.0, 119.0], "audio-oscillator": [100.0, 101.0, 137.0, 87.0, 90.0, 88.0, 127.0, 88.0, 88.0, 130.0], "stanford-crypto-aes": [82.0, 84.0, 84.0, 80.0, 81.0, 82.0, 82.0, 81.0, 84.0, 88.0], "imaging-desaturate": [100.0, 100.0, 99.0, 101.0, 100.0, 99.0, 101.0, 101.0, 101.0, 100.0]}, "summary": {"suite": 1478.6999999999998, "subtests": {"audio-fft": {"filtered": 80.5, "value": 80.5}, "stanford-crypto-pbkdf2": {"filtered": 145.5, "value": 145.5}, "audio-beat-detection": {"filtered": 140.5, "value": 140.5}, "stanford-crypto-ccm": {"filtered": 122.1, "value": 122.1}, "imaging-darkroom": {"filtered": 124.1, "value": 124.1}, "json-parse-financial": {"filtered": 61.3, "value": 61.3}, "audio-oscillator": {"filtered": 103.6, "value": 103.6}, "ai-astar": {"filtered": 106.0, "value": 106.0}, "audio-dft": {"filtered": 160.4, "value": 160.4}, "stanford-crypto-sha256-iterative": {"filtered": 67.8, "value": 67.8}, "json-stringify-tinderbox": {"filtered": 66.2, "value": 66.2}, "imaging-gaussian-blur": {"filtered": 117.7, "value": 117.7}, "stanford-crypto-aes": {"filtered": 82.8, "value": 82.8}, "imaging-desaturate": {"filtered": 100.2, "value": 100.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0005"}, "testrun": {"date": 1449189632, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151203150742", "branch": "Mozilla-Aurora", "revision": "e2d7d6033fae23341f077089774d25e56443466e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.64430816404752], "Encrypt": [325.4149040026033], "NavierStokes": [5803.468208092486], "Decrypt": [5758.620689655172], "Splay": [588.2352941176471], "Richards": [165.72754391779912], "RegExp": [29228.571428571428], "Earley": [668.002672010688], "Boyer": [11988.095238095239], "RayTrace": [1012.1457489878543]}, "summary": {"suite": 20483.836881205778, "subtests": {"DeltaBlue": {"filtered": 345.00372400000015, "value": 345.00372400000015}, "Encrypt": {"filtered": 817.9742130000002, "value": 817.9742130000002}, "NavierStokes": {"filtered": 255.70916334661337, "value": 255.70916334661337}, "Decrypt": {"filtered": 46.22304790419163, "value": 46.22304790419163}, "Splay": {"filtered": 138.53470000000002, "value": 138.53470000000002}, "RegExp": {"filtered": 31.167619745845577, "value": 31.167619745845577}, "Richards": {"filtered": 213.01226799999995, "value": 213.01226799999995}, "Earley": {"filtered": 997.6951110000001, "value": 997.6951110000001}, "Boyer": {"filtered": 55.59373584905661, "value": 55.59373584905661}, "RayTrace": {"filtered": 731.1091319999999, "value": 731.1091319999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0005"}, "testrun": {"date": 1449189632, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151203150742", "branch": "Mozilla-Aurora", "revision": "e2d7d6033fae23341f077089774d25e56443466e"}}] 17:00:39 INFO - RETURN: dromaeo_css: 6833.58 17:00:39 INFO - RETURN: kraken: 1478.70 17:00:39 INFO - RETURN: v8_7: 20483.84 17:00:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20483.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1478.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6833.58"}}} 17:00:39 INFO - Return code: 0 17:00:39 INFO - # TBPL SUCCESS # 17:00:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:00:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:00:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:00:39 INFO - 2015-12-03 17:00:39.567 screenresolution[1659:9737] starting screenresolution argv=screenresolution get 17:00:39 INFO - 2015-12-03 17:00:39.571 screenresolution[1659:9737] Display 0: 1600x1200x32@60 17:00:39 INFO - 2015-12-03 17:00:39.577 screenresolution[1660:9740] starting screenresolution argv=screenresolution list 17:00:39 INFO - Available Modes on Display 0 17:00:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:00:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:00:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:00:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:00:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:00:39 INFO - Intel HD Graphics 3000: 17:00:39 INFO - Chipset Model: Intel HD Graphics 3000 17:00:39 INFO - Type: GPU 17:00:39 INFO - Bus: Built-In 17:00:39 INFO - VRAM (Total): 512 MB 17:00:39 INFO - VRAM (Dynamic, Max): 10 17:00:39 INFO - Vendor: Intel (0x8086) 17:00:39 INFO - Device ID: 0x0116 17:00:39 INFO - Revision ID: 0x0009 17:00:39 INFO - Displays: 17:00:39 INFO - Display: 17:00:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:00:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:00:39 INFO - Display Serial Number: 1600x1200 60 17:00:39 INFO - Main Display: Yes 17:00:39 INFO - Mirror: Off 17:00:39 INFO - Online: Yes 17:00:39 INFO - Rotation: Supported 17:00:39 INFO - Return code: 0 17:00:39 INFO - Running post-action listener: _resource_record_post_action 17:00:39 INFO - Running post-run listener: _resource_record_post_run 17:00:40 INFO - Total resource usage - Wall time: 1245s; CPU: 30.0%; Read bytes: 40047616; Write bytes: 682039296; Read time: 5397; Write time: 15475 17:00:40 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 341144064; Write bytes: 335284224; Read time: 32886; Write time: 3720 17:00:40 INFO - run-tests - Wall time: 1208s; CPU: 30.0%; Read bytes: 37790720; Write bytes: 336490496; Read time: 4905; Write time: 11497 17:00:40 INFO - Running post-run listener: _upload_blobber_files 17:00:40 INFO - Blob upload gear active. 17:00:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:00:40 INFO - Copying logs to upload dir... 17:00:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1300.516883 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-12-03 17:00:40.981173) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:00:40.984410) ========= 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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009897 build_url: 'https://queue.taskcluster.net/v1/task/wWRjN-kHTEOEtauLL4hdiw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.19 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:00:41.181623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:00:41.181963) ========= 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.DB0Uy2AcrN/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.DcLVmltUnK/Listeners TMPDIR=/var/folders/g9/ny3dcy5d1f50fbskw_l889z000000w/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.005054 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:00:41.230803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:00:41.231121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:00:41.231532) ========= ========= Total master_lag: 0.40 =========