builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0278 starttime: 1464697326.15 results: success (0) buildid: 20160531030841 builduid: 435d7492ac054860baf6ca1058fc1654 revision: a9d17539d46af1dc601c51277eee909874d0e9ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.151297) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.151733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.152043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.300345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.300651) ========= 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.bR2mQdFmUo/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.3fdu3D7qOc/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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:0:0 using PTY: False --2016-05-31 05:22:06-- 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% 152M=0s 2016-05-31 05:22:06 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120665 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.470880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.471596) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020212 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:06.530594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 05:22:06.531274) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a9d17539d46af1dc601c51277eee909874d0e9ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a9d17539d46af1dc601c51277eee909874d0e9ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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:0:0 using PTY: False 2016-05-31 05:22:06,570 truncating revision to first 12 chars 2016-05-31 05:22:06,571 Setting DEBUG logging. 2016-05-31 05:22:06,571 attempt 1/10 2016-05-31 05:22:06,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a9d17539d46a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 05:22:07,480 unpacking tar archive at: fx-team-a9d17539d46a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.173125 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 05:22:07.728831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:07.729539) ========= script_repo_revision: a9d17539d46af1dc601c51277eee909874d0e9ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:07.730483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:07.731165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 05:22:07.750470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-05-31 05:22:07.751145) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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:0:0 using PTY: False 05:22:07 INFO - MultiFileLogger online at 20160531 05:22:07 in /builds/slave/test 05:22:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:22:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:22:07 INFO - {'append_to_log': False, 05:22:07 INFO - 'base_work_dir': '/builds/slave/test', 05:22:07 INFO - 'blob_upload_branch': 'Fx-Team', 05:22:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:22:07 INFO - 'branch': 'Fx-Team', 05:22:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:07 INFO - 'config_files': ('talos/mac_config.py',), 05:22:07 INFO - 'default_actions': ('clobber', 05:22:07 INFO - 'read-buildbot-config', 05:22:07 INFO - 'download-and-extract', 05:22:07 INFO - 'populate-webroot', 05:22:07 INFO - 'create-virtualenv', 05:22:07 INFO - 'install', 05:22:07 INFO - 'run-tests'), 05:22:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:07 INFO - 'download_minidump_stackwalk': True, 05:22:07 INFO - 'download_symbols': 'ondemand', 05:22:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:07 INFO - 'installer_path': 'installer.exe', 05:22:07 INFO - 'log_level': 'info', 05:22:07 INFO - 'log_name': 'talos', 05:22:07 INFO - 'log_to_console': True, 05:22:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:22:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:22:07 INFO - 'opt_config_files': (), 05:22:07 INFO - 'pip_index': False, 05:22:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:22:07 INFO - 'cmd': ('bash', 05:22:07 INFO - '-c', 05:22:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:22:07 INFO - 'enabled': True, 05:22:07 INFO - 'halt_on_failure': False, 05:22:07 INFO - 'name': 'check_screen_resolution'},), 05:22:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:22:07 INFO - 'cmd': ('bash', 05:22:07 INFO - '-c', 05:22:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:22:07 INFO - 'enabled': True, 05:22:07 INFO - 'halt_on_failure': False, 05:22:07 INFO - 'name': 'check_screen_resolution'},), 05:22:07 INFO - 'run_cmd_checks_enabled': True, 05:22:07 INFO - 'sps_profile': False, 05:22:07 INFO - 'sps_profile_interval': 0, 05:22:07 INFO - 'suite': 'dromaeojs-e10s', 05:22:07 INFO - 'system_bits': '32', 05:22:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:07 INFO - 'title': 't-yosemite-r7-0278', 05:22:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:07 INFO - 'use_talos_json': True, 05:22:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:22:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:07 INFO - 'work_dir': 'build'} 05:22:07 INFO - ##### 05:22:07 INFO - ##### Running clobber step. 05:22:07 INFO - ##### 05:22:07 INFO - Running pre-action listener: _resource_record_pre_action 05:22:07 INFO - Running main action method: clobber 05:22:07 INFO - rmtree: /builds/slave/test/build 05:22:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:22:09 INFO - Running post-action listener: _resource_record_post_action 05:22:09 INFO - ##### 05:22:09 INFO - ##### Finished clobber step (success) 05:22:09 INFO - ##### 05:22:09 INFO - ##### 05:22:09 INFO - ##### Running read-buildbot-config step. 05:22:09 INFO - ##### 05:22:09 INFO - Running pre-action listener: _resource_record_pre_action 05:22:09 INFO - Running main action method: read_buildbot_config 05:22:09 INFO - Using buildbot properties: 05:22:09 INFO - { 05:22:09 INFO - "project": "", 05:22:09 INFO - "product": "firefox", 05:22:09 INFO - "script_repo_revision": "production", 05:22:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:22:09 INFO - "repository": "", 05:22:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:22:09 INFO - "buildid": "20160531030841", 05:22:09 INFO - "pgo_build": "False", 05:22:09 INFO - "basedir": "/builds/slave/test", 05:22:09 INFO - "buildnumber": 686, 05:22:09 INFO - "slavename": "t-yosemite-r7-0278", 05:22:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:22:09 INFO - "platform": "yosemite_r7", 05:22:09 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:22:09 INFO - "branch": "fx-team", 05:22:09 INFO - "repo_path": "integration/fx-team", 05:22:09 INFO - "revision": "a9d17539d46af1dc601c51277eee909874d0e9ad", 05:22:09 INFO - "stage_platform": "macosx64", 05:22:09 INFO - "builduid": "435d7492ac054860baf6ca1058fc1654", 05:22:09 INFO - "slavebuilddir": "test" 05:22:09 INFO - } 05:22:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:22:09 INFO - Running post-action listener: _resource_record_post_action 05:22:09 INFO - ##### 05:22:09 INFO - ##### Finished read-buildbot-config step (success) 05:22:09 INFO - ##### 05:22:09 INFO - ##### 05:22:09 INFO - ##### Running download-and-extract step. 05:22:09 INFO - ##### 05:22:09 INFO - Running pre-action listener: _resource_record_pre_action 05:22:09 INFO - Running main action method: download_and_extract 05:22:09 INFO - mkdir: /builds/slave/test/build/tests 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:09 INFO - https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:22:13 INFO - Downloaded 1199 bytes. 05:22:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:22:13 INFO - Using the following test package requirements: 05:22:13 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:22:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:22:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:22:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'jsshell-mac.zip'], 05:22:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:22:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:22:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:22:13 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:22:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:22:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:22:13 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:22:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:13 INFO - https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:22:15 INFO - Downloaded 18684829 bytes. 05:22:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:22:18 INFO - Return code: 0 05:22:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:18 INFO - https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:22:21 INFO - Downloaded 18684829 bytes. 05:22:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:22:24 INFO - Return code: 0 05:22: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')]} 05:22:24 INFO - https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:22:25 INFO - Downloaded 10834055 bytes. 05:22:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:22:25 INFO - Return code: 0 05:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:25 INFO - https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:22:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:22:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:22:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:22:34 INFO - Downloaded 110903123 bytes. 05:22:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:22:34 INFO - mkdir: /builds/slave/test/properties 05:22:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:34 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:34 INFO - Contents: 05:22:34 INFO - build_url:https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:22:35 INFO - Running post-action listener: _resource_record_post_action 05:22:35 INFO - Running post-action listener: set_extra_try_arguments 05:22:35 INFO - ##### 05:22:35 INFO - ##### Finished download-and-extract step (success) 05:22:35 INFO - ##### 05:22:35 INFO - ##### 05:22:35 INFO - ##### Running populate-webroot step. 05:22:35 INFO - ##### 05:22:35 INFO - Running pre-action listener: _resource_record_pre_action 05:22:35 INFO - Running main action method: populate_webroot 05:22:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:35 INFO - '--tppagecycles', 05:22:35 INFO - '7'], 05:22:35 INFO - 'tests': ['tsvgm']}}, 05:22:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:22:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:22:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['damp', 'tps']}, 05:22:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'tests': ['damp', 'tps']}, 05:22:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['dromaeo_dom']}, 05:22:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['a11yr', 05:22:35 INFO - 'ts_paint', 05:22:35 INFO - 'tpaint', 05:22:35 INFO - 'sessionrestore', 05:22:35 INFO - 'sessionrestore_no_auto_restore', 05:22:35 INFO - 'tabpaint']}, 05:22:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:22:35 INFO - 'ts_paint', 05:22:35 INFO - 'tpaint', 05:22:35 INFO - 'sessionrestore', 05:22:35 INFO - 'sessionrestore_no_auto_restore', 05:22:35 INFO - 'tabpaint']}, 05:22:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:22:35 INFO - 'ts_paint', 05:22:35 INFO - 'tpaint', 05:22:35 INFO - 'sessionrestore', 05:22:35 INFO - 'sessionrestore_no_auto_restore', 05:22:35 INFO - 'tabpaint']}, 05:22:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:22:35 INFO - 'ts_paint', 05:22:35 INFO - 'tpaint', 05:22:35 INFO - 'sessionrestore', 05:22:35 INFO - 'sessionrestore_no_auto_restore', 05:22:35 INFO - 'tabpaint']}, 05:22:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['a11yr', 05:22:35 INFO - 'ts_paint', 05:22:35 INFO - 'tpaint', 05:22:35 INFO - 'sessionrestore', 05:22:35 INFO - 'sessionrestore_no_auto_restore', 05:22:35 INFO - 'tabpaint']}, 05:22:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['a11yr', 05:22:35 INFO - 'ts_paint', 05:22:35 INFO - 'tpaint', 05:22:35 INFO - 'sessionrestore', 05:22:35 INFO - 'sessionrestore_no_auto_restore', 05:22:35 INFO - 'tabpaint']}, 05:22:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['tsvgx', 05:22:35 INFO - 'tsvgr_opacity', 05:22:35 INFO - 'tart', 05:22:35 INFO - 'tscrollx', 05:22:35 INFO - 'cart']}, 05:22:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:22:35 INFO - 'tsvgr_opacity', 05:22:35 INFO - 'tart', 05:22:35 INFO - 'tscrollx', 05:22:35 INFO - 'cart']}, 05:22:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'talos_options': ['--disable-e10s'], 05:22:35 INFO - 'tests': ['tp5o']}, 05:22:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'tests': ['tp5o']}, 05:22:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'talos_options': ['--disable-e10s', 05:22:35 INFO - '--xperf_path', 05:22:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:35 INFO - 'tests': ['tp5n']}, 05:22:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:35 INFO - 'talos_options': ['--xperf_path', 05:22:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:35 INFO - 'tests': ['tp5n']}}, 05:22:35 INFO - 'talos.zip': {'path': '', 05:22:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:35 INFO - Running post-action listener: _resource_record_post_action 05:22:35 INFO - ##### 05:22:35 INFO - ##### Finished populate-webroot step (success) 05:22:35 INFO - ##### 05:22:35 INFO - ##### 05:22:35 INFO - ##### Running create-virtualenv step. 05:22:35 INFO - ##### 05:22:35 INFO - Running pre-action listener: _resource_record_pre_action 05:22:35 INFO - Running main action method: create_virtualenv 05:22:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:22:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:35 INFO - Using real prefix '/tools/python27' 05:22:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:39 INFO - Installing pip.................done. 05:22:39 INFO - Return code: 0 05:22:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:22:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:22:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:39 INFO - 'HOME': '/Users/cltbld', 05:22:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:39 INFO - 'LOGNAME': 'cltbld', 05:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:39 INFO - 'MOZ_NO_REMOTE': '1', 05:22:39 INFO - 'NO_EM_RESTART': '1', 05:22:39 INFO - 'PAGER': '/bin/cat', 05:22:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:39 INFO - 'PWD': '/builds/slave/test', 05:22:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:39 INFO - 'SHELL': '/bin/bash', 05:22:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:22:39 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:22:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:39 INFO - 'USER': 'cltbld', 05:22:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:39 INFO - 'XPC_FLAGS': '0x0', 05:22:39 INFO - 'XPC_SERVICE_NAME': '0', 05:22:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:22:39 INFO - Cleaning up... 05:22:39 INFO - Return code: 0 05:22:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 05:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 05:22:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:22:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:39 INFO - 'HOME': '/Users/cltbld', 05:22:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:39 INFO - 'LOGNAME': 'cltbld', 05:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:39 INFO - 'MOZ_NO_REMOTE': '1', 05:22:39 INFO - 'NO_EM_RESTART': '1', 05:22:39 INFO - 'PAGER': '/bin/cat', 05:22:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:39 INFO - 'PWD': '/builds/slave/test', 05:22:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:39 INFO - 'SHELL': '/bin/bash', 05:22:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:22:39 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:22:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:39 INFO - 'USER': 'cltbld', 05:22:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:39 INFO - 'XPC_FLAGS': '0x0', 05:22:39 INFO - 'XPC_SERVICE_NAME': '0', 05:22:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:40 INFO - Downloading/unpacking psutil>=3.1.1 05:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:43 INFO - Installing collected packages: psutil 05:22:43 INFO - Running setup.py install for psutil 05:22:43 INFO - building 'psutil._psutil_osx' extension 05:22:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:22:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:22:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:22:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:22:43 INFO - building 'psutil._psutil_posix' extension 05:22:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:22:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:22:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:22:43 INFO - ^ 05:22:43 INFO - 1 warning generated. 05:22:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:22:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:44 INFO - Successfully installed psutil 05:22:44 INFO - Cleaning up... 05:22:44 INFO - Return code: 0 05:22:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 05:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 05:22:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:22:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:44 INFO - 'HOME': '/Users/cltbld', 05:22:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:44 INFO - 'LOGNAME': 'cltbld', 05:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:44 INFO - 'MOZ_NO_REMOTE': '1', 05:22:44 INFO - 'NO_EM_RESTART': '1', 05:22:44 INFO - 'PAGER': '/bin/cat', 05:22:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:44 INFO - 'PWD': '/builds/slave/test', 05:22:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:44 INFO - 'SHELL': '/bin/bash', 05:22:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:22:44 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:22:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:44 INFO - 'USER': 'cltbld', 05:22:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:44 INFO - 'XPC_FLAGS': '0x0', 05:22:44 INFO - 'XPC_SERVICE_NAME': '0', 05:22:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:22:46 INFO - Installing collected packages: mozsystemmonitor 05:22:46 INFO - Running setup.py install for mozsystemmonitor 05:22:47 INFO - Successfully installed mozsystemmonitor 05:22:47 INFO - Cleaning up... 05:22:47 INFO - Return code: 0 05:22:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:22:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:22:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:47 INFO - 'HOME': '/Users/cltbld', 05:22:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:47 INFO - 'LOGNAME': 'cltbld', 05:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:47 INFO - 'MOZ_NO_REMOTE': '1', 05:22:47 INFO - 'NO_EM_RESTART': '1', 05:22:47 INFO - 'PAGER': '/bin/cat', 05:22:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:47 INFO - 'PWD': '/builds/slave/test', 05:22:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:47 INFO - 'SHELL': '/bin/bash', 05:22:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:22:47 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:22:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:47 INFO - 'USER': 'cltbld', 05:22:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:47 INFO - 'XPC_FLAGS': '0x0', 05:22:47 INFO - 'XPC_SERVICE_NAME': '0', 05:22:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:22:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:50 INFO - Downloading docopt-0.6.1.tar.gz 05:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:51 INFO - Running setup.py install for blobuploader 05:22:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:22:51 INFO - Running setup.py install for requests 05:22:51 INFO - Running setup.py install for docopt 05:22:51 INFO - Successfully installed blobuploader requests docopt 05:22:51 INFO - Cleaning up... 05:22:51 INFO - Return code: 0 05:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:22:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:22:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:52 INFO - 'HOME': '/Users/cltbld', 05:22:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:52 INFO - 'LOGNAME': 'cltbld', 05:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:52 INFO - 'MOZ_NO_REMOTE': '1', 05:22:52 INFO - 'NO_EM_RESTART': '1', 05:22:52 INFO - 'PAGER': '/bin/cat', 05:22:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:52 INFO - 'PWD': '/builds/slave/test', 05:22:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:52 INFO - 'SHELL': '/bin/bash', 05:22:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:22:52 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:22:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:52 INFO - 'USER': 'cltbld', 05:22:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:52 INFO - 'XPC_FLAGS': '0x0', 05:22:52 INFO - 'XPC_SERVICE_NAME': '0', 05:22:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Jd7oSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vzAIbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-wI9VQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-VR1jd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LQcDB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-I0uKlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-cWOF7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:52 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ca9WXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Y9SPmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-rWWSJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-9KLjDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-yuryJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-sXbND7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-i0zcHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Ww0RNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-amxJU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:53 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vPGjvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:54 INFO - Running setup.py install for manifestparser 05:22:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:22:54 INFO - Running setup.py install for mozcrash 05:22:54 INFO - Running setup.py install for mozdebug 05:22:54 INFO - Running setup.py install for mozdevice 05:22:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:22:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:22:54 INFO - Running setup.py install for mozfile 05:22:54 INFO - Running setup.py install for mozhttpd 05:22:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:22:54 INFO - Running setup.py install for mozinfo 05:22:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Running setup.py install for mozInstall 05:22:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Running setup.py install for mozleak 05:22:55 INFO - Running setup.py install for mozlog 05:22:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Running setup.py install for moznetwork 05:22:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Running setup.py install for mozprocess 05:22:55 INFO - Running setup.py install for mozprofile 05:22:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:55 INFO - Running setup.py install for mozrunner 05:22:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:56 INFO - Running setup.py install for mozscreenshot 05:22:56 INFO - Running setup.py install for moztest 05:22:56 INFO - Running setup.py install for mozversion 05:22:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:56 INFO - Cleaning up... 05:22:56 INFO - Return code: 0 05:22:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:22:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:22:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:56 INFO - 'HOME': '/Users/cltbld', 05:22:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:56 INFO - 'LOGNAME': 'cltbld', 05:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:56 INFO - 'MOZ_NO_REMOTE': '1', 05:22:56 INFO - 'NO_EM_RESTART': '1', 05:22:56 INFO - 'PAGER': '/bin/cat', 05:22:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:56 INFO - 'PWD': '/builds/slave/test', 05:22:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:56 INFO - 'SHELL': '/bin/bash', 05:22:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:22:56 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:22:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:56 INFO - 'USER': 'cltbld', 05:22:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:56 INFO - 'XPC_FLAGS': '0x0', 05:22:56 INFO - 'XPC_SERVICE_NAME': '0', 05:22:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:56 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Z8Qb77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:56 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LReogl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Z5Pyou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-D7XoYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6yZ05D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-uRiqFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Lml5K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ldwlqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-yue6J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Qg6Awp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:57 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-fGilgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:58 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-4ENz8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:58 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Az8uBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:58 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-CBBWhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:58 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-5cVXvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:58 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-8y0XGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:58 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-MI4XFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:22:58 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:58 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:22:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:01 INFO - Downloading blessings-1.6.tar.gz 05:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:01 INFO - Installing collected packages: blessings 05:23:01 INFO - Running setup.py install for blessings 05:23:01 INFO - Successfully installed blessings 05:23:01 INFO - Cleaning up... 05:23:01 INFO - Return code: 0 05:23:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:01 INFO - Reading from file tmpfile_stdout 05:23:01 INFO - Current package versions: 05:23:01 INFO - blessings == 1.6 05:23:01 INFO - blobuploader == 1.2.4 05:23:01 INFO - docopt == 0.6.1 05:23:01 INFO - manifestparser == 1.1 05:23:01 INFO - mozInstall == 1.12 05:23:01 INFO - mozcrash == 0.17 05:23:01 INFO - mozdebug == 0.1 05:23:01 INFO - mozdevice == 0.48 05:23:01 INFO - mozfile == 1.2 05:23:01 INFO - mozhttpd == 0.7 05:23:01 INFO - mozinfo == 0.9 05:23:01 INFO - mozleak == 0.1 05:23:01 INFO - mozlog == 3.2 05:23:01 INFO - moznetwork == 0.27 05:23:01 INFO - mozprocess == 0.22 05:23:01 INFO - mozprofile == 0.28 05:23:01 INFO - mozrunner == 6.11 05:23:01 INFO - mozscreenshot == 0.1 05:23:01 INFO - mozsystemmonitor == 0.3 05:23:01 INFO - moztest == 0.7 05:23:01 INFO - mozversion == 1.4 05:23:01 INFO - psutil == 3.1.1 05:23:01 INFO - requests == 1.2.3 05:23:01 INFO - wsgiref == 0.1.2 05:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:23:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:01 INFO - 'HOME': '/Users/cltbld', 05:23:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:01 INFO - 'LOGNAME': 'cltbld', 05:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:01 INFO - 'MOZ_NO_REMOTE': '1', 05:23:01 INFO - 'NO_EM_RESTART': '1', 05:23:01 INFO - 'PAGER': '/bin/cat', 05:23:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:01 INFO - 'PWD': '/builds/slave/test', 05:23:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:01 INFO - 'SHELL': '/bin/bash', 05:23:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:23:01 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:23:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:01 INFO - 'USER': 'cltbld', 05:23:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:01 INFO - 'XPC_FLAGS': '0x0', 05:23:01 INFO - 'XPC_SERVICE_NAME': '0', 05:23:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:23:02 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 2)) 05:23:02 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 3)) 05:23:02 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 4)) 05:23:02 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 5)) 05:23:02 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 6)) 05:23:02 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 7)) 05:23:02 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 8)) 05:23:02 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 9)) 05:23:02 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:23:02 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 4)) 05:23:02 INFO - Cleaning up... 05:23:02 INFO - Return code: 0 05:23:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 05:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 05:23:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:23:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:02 INFO - 'HOME': '/Users/cltbld', 05:23:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:02 INFO - 'LOGNAME': 'cltbld', 05:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:02 INFO - 'MOZ_NO_REMOTE': '1', 05:23:02 INFO - 'NO_EM_RESTART': '1', 05:23:02 INFO - 'PAGER': '/bin/cat', 05:23:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:02 INFO - 'PWD': '/builds/slave/test', 05:23:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:02 INFO - 'SHELL': '/bin/bash', 05:23:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:23:02 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:23:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:02 INFO - 'USER': 'cltbld', 05:23:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:02 INFO - 'XPC_FLAGS': '0x0', 05:23:02 INFO - 'XPC_SERVICE_NAME': '0', 05:23:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:02 INFO - Downloading/unpacking jsonschema 05:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:04 INFO - Downloading/unpacking functools32 (from jsonschema) 05:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:05 INFO - warning: no files found matching '*.txt' 05:23:05 INFO - no previously-included directories found matching 'build' 05:23:05 INFO - no previously-included directories found matching 'dist' 05:23:05 INFO - no previously-included directories found matching '.git*' 05:23:05 INFO - Installing collected packages: jsonschema, functools32 05:23:05 INFO - Running setup.py install for functools32 05:23:05 INFO - warning: no files found matching '*.txt' 05:23:05 INFO - no previously-included directories found matching 'build' 05:23:05 INFO - no previously-included directories found matching 'dist' 05:23:05 INFO - no previously-included directories found matching '.git*' 05:23:05 INFO - Successfully installed jsonschema functools32 05:23:05 INFO - Cleaning up... 05:23:05 INFO - Return code: 0 05:23:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:23: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')]} 05:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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')]} 05:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4dad614b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/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.3fdu3D7qOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test/build 05:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 flake8 05:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:05 INFO - 'HOME': '/Users/cltbld', 05:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:05 INFO - 'LOGNAME': 'cltbld', 05:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:05 INFO - 'MOZ_NO_REMOTE': '1', 05:23:05 INFO - 'NO_EM_RESTART': '1', 05:23:05 INFO - 'PAGER': '/bin/cat', 05:23:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:05 INFO - 'PWD': '/builds/slave/test', 05:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:05 INFO - 'SHELL': '/bin/bash', 05:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:23:05 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:05 INFO - 'USER': 'cltbld', 05:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:05 INFO - 'XPC_FLAGS': '0x0', 05:23:05 INFO - 'XPC_SERVICE_NAME': '0', 05:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:05 INFO - Downloading/unpacking flake8 05:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:23:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:23:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:09 INFO - no previously-included directories found matching 'docs/_build' 05:23:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:23:09 INFO - Running setup.py install for pep8 05:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:09 INFO - no previously-included directories found matching 'docs/_build' 05:23:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:23:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:23:09 INFO - Cleaning up... 05:23:09 INFO - Return code: 0 05:23:09 INFO - Running post-action listener: _resource_record_post_action 05:23:09 INFO - Running post-action listener: _start_resource_monitoring 05:23:09 INFO - Starting resource monitoring. 05:23:09 INFO - ##### 05:23:09 INFO - ##### Finished create-virtualenv step (success) 05:23:09 INFO - ##### 05:23:09 INFO - ##### 05:23:09 INFO - ##### Running install step. 05:23:09 INFO - ##### 05:23:09 INFO - Running pre-action listener: _resource_record_pre_action 05:23:09 INFO - Running main action method: install 05:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:10 INFO - Reading from file tmpfile_stdout 05:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:10 INFO - Reading from file tmpfile_stdout 05:23:10 INFO - Output received: 05:23:10 INFO - Usage: mozinstall [options] installer 05:23:10 INFO - Options: 05:23:10 INFO - -h, --help show this help message and exit 05:23:10 INFO - -d DEST, --destination=DEST 05:23:10 INFO - Directory to install application into. [default: 05:23:10 INFO - "/builds/slave/test"] 05:23:10 INFO - --app=APP Application being installed. [default: firefox] 05:23:10 INFO - mkdir: /builds/slave/test/build/application 05:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:23:44 INFO - Reading from file tmpfile_stdout 05:23:44 INFO - Output received: 05:23:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:23:44 INFO - Running post-action listener: _resource_record_post_action 05:23:44 INFO - ##### 05:23:44 INFO - ##### Finished install step (success) 05:23:44 INFO - ##### 05:23:44 INFO - ##### 05:23:44 INFO - ##### Running run-tests step. 05:23:44 INFO - ##### 05:23:44 INFO - Running pre-action listener: _resource_record_pre_action 05:23:44 INFO - Running main action method: run_tests 05:23:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:23:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:23:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:23:44 INFO - 2016-05-31 05:23:44.042 screenresolution[3087:21334] starting screenresolution argv=screenresolution get 05:23:44 INFO - 2016-05-31 05:23:44.045 screenresolution[3087:21334] Display 0: 1600x1200x32@60 05:23:44 INFO - 2016-05-31 05:23:44.051 screenresolution[3088:21336] starting screenresolution argv=screenresolution list 05:23:44 INFO - Available Modes on Display 0 05:23:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:23:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:23:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:23:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:23:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:23:44 INFO - Intel Iris: 05:23:44 INFO - Chipset Model: Intel Iris 05:23:44 INFO - Type: GPU 05:23:44 INFO - Bus: Built-In 05:23:44 INFO - VRAM (Dynamic, Max): 1536 MB 05:23:44 INFO - Vendor: Intel (0x8086) 05:23:44 INFO - Device ID: 0x0a2e 05:23:44 INFO - Revision ID: 0x0009 05:23:44 INFO - Displays: 05:23:44 INFO - Display: 05:23:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:23:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:23:44 INFO - Display Serial Number: 1600x1200 60 05:23:44 INFO - Main Display: Yes 05:23:44 INFO - Mirror: Off 05:23:44 INFO - Online: Yes 05:23:44 INFO - Rotation: Supported 05:23:44 INFO - Return code: 0 05:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:44 INFO - Python 2.7.3 05:23:44 INFO - Return code: 0 05:23:44 INFO - grabbing minidump binary from tooltool 05:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:44 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a67cd30>, '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 0x10a4a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a673b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:23:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:23:44 INFO - Calling ['/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'] with output_timeout 600 05:23:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:44 INFO - Return code: 0 05:23:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:23:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:23:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:23:45 INFO - Return code: 0 05:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:23:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bR2mQdFmUo/Render', 05:23:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:45 INFO - 'HOME': '/Users/cltbld', 05:23:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:45 INFO - 'LOGNAME': 'cltbld', 05:23:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:45 INFO - 'MOZ_NO_REMOTE': '1', 05:23:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:45 INFO - 'NO_EM_RESTART': '1', 05:23:45 INFO - 'PAGER': '/bin/cat', 05:23:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:45 INFO - 'PWD': '/builds/slave/test', 05:23:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:45 INFO - 'SHELL': '/bin/bash', 05:23:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3fdu3D7qOc/Listeners', 05:23:45 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:23:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:45 INFO - 'USER': 'cltbld', 05:23:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:45 INFO - 'XPC_FLAGS': '0x0', 05:23:45 INFO - 'XPC_SERVICE_NAME': '0', 05:23:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:23:45 INFO - mozversion application_buildid: 20160531030841 05:23:45 INFO - mozversion application_changeset: a9d17539d46af1dc601c51277eee909874d0e9ad 05:23:45 INFO - mozversion application_display_name: Nightly 05:23:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:45 INFO - mozversion application_name: Firefox 05:23:45 INFO - mozversion application_remotingname: firefox 05:23:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:23:45 INFO - mozversion application_vendor: Mozilla 05:23:45 INFO - mozversion application_version: 49.0a1 05:23:45 INFO - mozversion platform_buildid: 20160531030841 05:23:45 INFO - mozversion platform_changeset: a9d17539d46af1dc601c51277eee909874d0e9ad 05:23:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:23:45 INFO - mozversion platform_version: 49.0a1 05:23:45 INFO - using testdate: 1464697425 05:23:45 INFO - actual date: 1464697425 05:23:45 INFO - starting webserver on 'localhost:52863' 05:23:45 INFO - SUITE-START | Running 2 tests 05:23:45 INFO - TEST-START | dromaeo_css 05:23:45 INFO - operating with platform_type : mac_ 05:23:45 INFO - Initialising browser for dromaeo_css test... 05:23:45 INFO - TEST-INFO | started process 3106 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpBfZqBm/profile http://localhost:52863/getInfo.html) 05:23:48 INFO - PROCESS | 3106 | __metrics Screen width/height:1600/1200 05:23:48 INFO - PROCESS | 3106 | colorDepth:24 05:23:48 INFO - PROCESS | 3106 | Browser inner width/height: 1024/689 05:23:48 INFO - PROCESS | 3106 | __metrics 05:23:48 ERROR - PROCESS | 3106 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:23:49 INFO - TEST-INFO | 3106: exit 0 05:23:49 INFO - Browser initialized. 05:23:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:49 INFO - TEST-INFO | started process 3110 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpBfZqBm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:01 INFO - PROCESS | 3110 | RSS: Main: 252559360 05:24:01 INFO - PROCESS | 3110 | 05:24:51 INFO - PROCESS | 3110 | 1464697491001 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:27:01 INFO - PROCESS | 3110 | Cycle 1(1): loaded http://localhost:52863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52863/tests/dromaeo/cssquery-ext.html) 05:27:03 INFO - PROCESS | 3110 | RSS: Main: 266547200 05:27:03 INFO - PROCESS | 3110 | 05:30:05 INFO - PROCESS | 3110 | Cycle 1(1): loaded http://localhost:52863/tests/dromaeo/cssquery-ext.html (next: http://localhost:52863/tests/dromaeo/cssquery-jquery.html) 05:30:06 INFO - PROCESS | 3110 | RSS: Main: 276512768 05:30:06 INFO - PROCESS | 3110 | 05:33:07 INFO - PROCESS | 3110 | Cycle 1(1): loaded http://localhost:52863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52863/tests/dromaeo/cssquery-mootools.html) 05:33:08 INFO - PROCESS | 3110 | RSS: Main: 278630400 05:33:08 INFO - PROCESS | 3110 | 05:36:10 INFO - PROCESS | 3110 | Cycle 1(1): loaded http://localhost:52863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52863/tests/dromaeo/cssquery-prototype.html) 05:36:10 INFO - PROCESS | 3110 | RSS: Main: 280113152 05:36:10 INFO - PROCESS | 3110 | 05:39:13 INFO - PROCESS | 3110 | Cycle 1(1): loaded http://localhost:52863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52863/tests/dromaeo/cssquery-yui.html) 05:39:14 INFO - PROCESS | 3110 | RSS: Main: 283570176 05:39:14 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | Cycle 1(1): loaded http://localhost:52863/tests/dromaeo/cssquery-yui.html (next: http://localhost:52863/tests/dromaeo/cssquery-dojo.html) 05:42:17 INFO - PROCESS | 3110 | RSS: Main: 283971584 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | __start_tp_report 05:42:17 INFO - PROCESS | 3110 | _x_x_mozilla_page_load 05:42:17 INFO - PROCESS | 3110 | _x_x_mozilla_page_load_details 05:42:17 INFO - PROCESS | 3110 | |i|pagename|runs| 05:42:17 INFO - PROCESS | 3110 | |0;dojo.html;3379.3072420153862;3420.2646431017324;3471.6354782747812;3473.2358881046175;3503.0016445313086;5743.62666426682;5765.308163020433;5779.104238842986;5796.217510636063;5801.6519008859395;5652.689102099383;5763.769449222026;5797.652140871551;5802.361740208574;5818.301803783552;5174.922376164351;5217.817376391827;5286.920696189561;5289.047971365153;5343.145096784496;268.5718577661649;4771.355866957951;4982.227754698028;5267.394249661281;5274.129768588178;4695.859124226262;5213.556847667953;5214.243934629495;5215.791368345281;5239.13554263546;5236.659617124913;5250.18622113573;5282.947170528284;5289.550388217006;5296.073187192226;5111.309973153651;5162.225666150108;5214;5219.243209734605;5241;5498.422665620133;5666.121751128581;5684.118961560924;5718.313802343745;5724.885502289931;5332.786688532454;6136.877262454771;6148.016317389241;6273.56085074045;6304.716287767015;6224.813255602339;6247.593906396115;6264.248290205204;6289.0880822280515;6294.968525157345;5925.111233314994;5934;5936.821895343147;5944.641277678098;5983.401659833982;6219.253689557282;6280.214973128359;6348.777792777323;6365.904511432333;6409.679516024274;6098.886104840075;6128.872947855237;6130.524716956557;6145.877082458326;6153.630782153085;6193.071039344044;6224.221972253468;6235.345288744707;6288.717007734663;6289.0880822280515;6177.567570270038;6213.65824879627;6240.251169859555;6249.312575616678;6287.402696743802;6256.436920677161;6276.901542230092;6282.591631543935;6294.118823364733;6315.084312774622;4239.8092085856215;4978.626603004789;5024.57291130258;5027.874303142377;5032.798688052437;4399.802008909607;4430.867073987785;4446.044100518339;4484.977575112103;4523.977380113079;4718.8584342469785;5843.795467158629;5853.180554722342;5866;5953.672548009901;6244.65654389013;6285.088662143963;6298.307186209513;6302.401271879165;6311.211098612674;5692.203091567184;5693.259876216065;5739.713014349266;5778.133280007948;5984.880302393928;5344.786208551692;5355.0896347621;5359;5360.946390536123;5364.195370694427;6328.050792381179;6334.271558770616;6349.746010159542;6358.968205159037;6369.235691717024;6109.236345456818;6156.922538555646;6177.444030037318;6200.968995154995;6272.529560282906;6462.450691691259;6481.611103333815;6517.348265173445;6523.3150519194805;6536.281009089092;5906.379830117776;6168.414000669929;6187.628742275478;6189.6286222826775;6202.658853762906;4886.3647725796845;4921.31101645777;6209.627422354673;6219.844503887258;6249;6128.325884152829;6166.969165154145;6181.041938499539;6201.906971395342;6215.564910456224;6076.544259180668;6132.969335153296;6156.876862462816;6164.753409863555;6171.506279497719;5304.283921670525;6002.969985150046;6037.849053773691;6069.787557435468;6119.296280927751;6166.599171053867;6170.876582468415;6171.907421388593;6192.102145188832;6192.752289908353;5972.641641501524;6092.969535152296;6105.6947152641305;6120.724567394389;6127.20346354971 05:42:17 INFO - PROCESS | 3110 | |1;ext.html;498.9975050124749;499.1364938656124;529.9920501192481;541.1422894711882;560.7448610882049;32530.512042319384;42700.57299427001;43001.13997720044;43057.569424305744;43067.78466107669;44391.77804110983;44788;45007.09985800282;45125.54874451255;45149.871253218604;9420.43477391357;9577.329586928883;9629.374090684083;9662.90337096627;9696.46669433181;9497.905020949771;9510.762230944212;9527;9551.140397364235;9626.037396260388;8353.248207661309;9620.615175392975;9637.518124093802;9656.324057315991;9664.71005869825;8300.169983001711;8337.249647531751;9637.807243855119;9653.662121825773;9654.324197306192;9402.247820174369;9429.669961551313;9483.14651681352;9487.193588544913;9497.240220782322;30778.69221307803;40688.38967415461;40949;40993;41354.37968430476;3091;3212.421764082464;3457.757956943015;3588.5334906461994;4056.776877271749;26255.562936731163;32628.836855815807;32722.6727732722;33176;33405.83297083523;3300.5874265716784;3331.2338162222823;3331.816750078745;3412.0446275043028;3443.104792753902;507706;509488;511706;511857;512663;35209.82395088008;36165.45751813725;66989.66505167443;68111;68147;30315.393692126036;35949.8202508991;36070.63929360673;36202.09494762599;36342.273154536764;15073.321700523502;15158.393664253526;15213.61965950838;15221.391144354324;15232.619184520254;12779.680507987374;12799.424025918855;12889.677758055936;12929.353532323534;12935.741285174245;7867.567283799446;7875;7898.802529936683;7926.207379262143;7960.1243863175005;3233.4826427771445;3240.4491236489853;3247.0908145719236;3261.59230096238;3274.148721332471;976.8144052629978;989.5250279865704;997.7356000659831;1035.6530562261576;1093.3931667924219;29689.9608513701;29765;31449.213769655486;31636.683633163375;31707.682923170934;1015.8120747661707;1076.278893141597;1171.5138217639756;1190.8570971483477;1191.2257032928492;16297.429589964295;16351.67296654084;16407.91796041036;16609.750853737205;16677.332906683598;569705;600314;677768;715146;718677;51655.74172129115;62855.37144628587;62893;63168;63383;1411.3366717642896;1417.2417756500222;1425.693475902665;1429.7140571885664;1445.1762495377534;30752.538711918893;31020;31058.844705777232;31617;31816.522752158275;55094.17358739542;55945.44054559402;56242.71878640581;56425.15362269651;56562.71718641381;485325.57337213086;598399;612505.9374703098;614182;615116;27238.591421129095;27562.44875102527;27722.72277277282;27887.302817428914;28328.716712832607;50721.98556028932;51336.48663513317;52087;52246.477535225684;52469;41884.79057604692;42148.1570368597;42237.78881105575;42983.570164299206;43007.92480187895;36005.819970899975;40717.982050448976;41001.79499102486;41251.58748412477;41527.58472415237;40148.799256003535;40188.59811401849;40249.39625905555;40565.79717101395;40683.18633627252;31419.900303489267;34837.12907177341;35309.823450882584;36145;36612;20619.896900515403;25801.096961606254;26305;26354;27208 05:42:17 INFO - PROCESS | 3110 | |2;jquery.html;383.2124983159606;386.2256176366385;387.16565800699493;390.30831444092223;406.414762741652;14604;15653.608659783511;16662.083585402797;21069.894650526763;21094.683579746317;17337.739933901;17698.38055668052;20463.897680511578;21280.787192128075;21639.783602163974;5666.490015898558;5734.397888221739;5858.3848695886745;5946.494547963407;5974.253218347707;5783.363829978699;5800.912986305188;5832.358440571534;5841.445062719056;5849.034909239992;5381.165919282498;5773.1917531545405;5779.479846813786;5789.073748200289;5789.131630255453;5655.095184770458;5783.913241301384;5814.127880817869;5831.912521312183;5953.7320820562745;5593.440655934414;5605.271314729059;5719.084946408596;5745.396733342981;5765.654060756368;9624.278179136592;12638.873611263862;12982.610521684364;13167.868321316855;13206.009549283746;1994.6110508450713;2200.2959053103014;2217.0909926930044;2433.233531437609;2771.9168424947084;9722.319437639368;9948.751281217956;10190.9490452548;10344.586216551328;10548.736281592945;1681.5880109373281;1808.493621785902;1827.5157083372917;1837.1640903388925;1846.547595839028;129281;132876;133424.66575334218;133703.33148334295;133982.99999999904;11608.071354291636;11744.236624619372;11774.175807693378;11920.10599205063;11940.044796416265;12074.335911524775;14598.416063357347;14690.55928322152;14696.191709455868;14764.744996675403;8336.62485188168;8451.1548845115;8496.192861678132;8553.272971797467;8619.956900215459;7075.893861592081;8301.6679332826;8305.003399592088;8385;8422.368322375847;4472.843450479218;4538.750368729751;4585.908281834345;4601;4629.305604159403;1636.950891473234;1759.2962814874152;1949.9762624622188;1978.3174804692358;2002.779694233633;821.6015232612178;879.7580665317089;1023.370627064365;1044.6239353832614;1047.7223535763028;15484.225788710744;18795.812041879406;20091.191792738722;20269.391918242476;20796.58406831855;798.6086817459403;978.9265805064649;1025.9487025648689;1029.3926583315879;1037.5642230263309;9318.207952323994;11012.73378432156;11295.887041129648;11336.319820810777;11349.886501134883;540586;567272;568711;568924;581139;130799;135008.32495837458;135496.64503355036;137087;139140.30429847786;1030.9432981185957;1037.8287582548794;1072.083368719749;1097.0455703537973;1098.873629532598;14939.178345190685;18356.357527486474;18479.98360090208;18681.81318186801;18716.157772900526;49532.25701614551;50180.247296291316;50498.74750626223;50761;51426.48573514217;74347.51304973979;74443.62778186075;74543.8818417735;75357.86963195447;76210;6475.222973243241;7939.166387529226;7985.121636620083;8268.751937441886;8276.751697449086;8905.866412003954;11516.136289778133;12343.13598048128;12523.436445360163;12666.366681665695;10766.192535559707;10793.460326983777;10861.565537378416;10962;10996.395198264172;8613.353998450017;9194.58624361892;10509.423586462091;10583.62957296491;10746.623868164577;9284.74655921442;10628.627998020032;10929.83605245906;10991.285566438157;11274.492647831032;7188.640567971476;8038;8081.353491720531;8112.472689275178;8238.876416853871;8069.83860322802;10320.896791031993;10858.077063449695;10892.019718225398;10936.398498082683 05:42:17 INFO - PROCESS | 3110 | |3;mootools.html;1388.5556621880996;1543.6295289130612;1747.9737803932944;1750.894946303222;1936.5449119456935;7968.9601551992155;8459.280961118304;8542.188492093257;8946.955265223682;8953.373263871532;8639.006514250863;8691.56542172892;8780.824383512341;8813.647454101845;8834.028256891737;2303.239930822833;2309.584274830534;2342.426105604121;2345.659879317498;2349.6841768609634;2320.6054970655027;2341.812654987597;2345.4605440748637;2346.9178578749747;2364.196173301077;2330.498942727313;2338.333574931145;2339.6022676145094;2355.49356888269;2359.079958816063;2314.9189778357845;2315.3748487908256;2324.2097686786487;2333.6149535326567;2337.0651739304412;2064.318774804311;2188.420068681801;2307.711536057993;2309.6304591265316;2318.8376813623054;8676.045634980148;8719.346049046348;8736.301095912311;8767.167119123673;8788.252998495136;5183.429822719498;5253.159494480865;5304.336957880265;5336.119540275849;5339.145736682112;3398.881039163642;3504.4217704078796;3652.6529979652155;3653.6346365363515;3656.451532270154;871.6687658689721;999.2705325112636;1053.9209559283083;1081.1080858291941;1101.1136035491427;11534.307941523452;11615.825762613567;11623.244489108265;11631.767364652744;11646.41767911601;4321.5678432157165;4323.675724320626;4345.804438800262;4387.561243875651;4394.308191346355;9864.802703945881;9923.503824808731;9936.304458687822;9955.402675839328;9976.152027077635;4531.637469002472;5320.095583750772;5342.225377320345;5345.70598617072;5348.358197016305;3946.940795888064;4596.2416201326405;4855.878603034952;4865.854024379274;4899.1426500362295;3400.792718584916;3479.1302174456387;3947.3289540778137;3972;3992.3412636915164;1277.4379273119798;1294.7539967406162;1303.3418123847587;1305.2494815481136;1316.8748968847945;935.8268720286769;967.6274634265858;967.9661211857551;970.5826494607245;1013.7364285285731;6021.036634138517;6055.636661800306;6077.453029227391;6112.083187521818;6157.568970172135;438.49791988174;438.80473189431035;446.2636649528304;447.232995412862;452.237979005377;3675.805363256952;3949.5260568731937;3986.7807270599815;4153.293940030202;4154.086101057763;10006.599736010477;10210.438425886647;10425.218108641882;10429.895701043044;10446.52990615409;10192.694219173436;10243.84634230487;10389.220808439397;10409.323393979366;10414.687559373231;6374.84062898422;8066.516009039359;8217.712380066669;8224.547649879314;8279.172082791792;6096.817095487142;6100.23747031621;6146.200993870768;6242.063690446469;6260.937390626035;9876.703698889045;10108.494575271354;10133.847992280269;10135.898641013495;10138.89861101409;10074.546645400827;10160;10333.070023697903;10391.480425978822;10399.58401663925;6969.7909062728195;7500.849983000418;7640.312371886557;7908.130105688485;8254.42219044661;8255.669773209245;8435.915640843514;8436.873446898178;8450.366222533212;8692.695755648521;7322.560646361236;7467.215942325977;7490.176080631235;7569.318761311509;7588.8482230356185;7310.232425595449;7375.631218439164;7388.408927285696;7442.181360050498;7493.4379921505015;6914.8617027660175;6960.651967401711;7016.5790052597;7059.752908648173;7079.1858936223;4045.1707399982342;4924.433690125538;5048.896521083608;5161.845144645667;5173.663711858717;5096.0827051131155;5098.439171691185;5107.182850743863;5271.367435907716;5275.868103297448 05:42:17 INFO - PROCESS | 3110 | |4;prototype.html;306.4927544913168;317.7791434952708;321.49685741814056;325.41912685855755;327.27998403512265;4765.857024289273;5264.473552644734;5344.144936810111;5365.624406291561;5529.778808847651;4378.518362980078;4521.570450807168;5217.817376391827;5458.6724796512235;5488.780448782044;3443.483477478386;4138.358554424069;4160.230357383879;4176.60322269384;4183.0966910056;3796.462432714741;4013.1973605278913;4138.261929989411;4174.580642581522;4195;4066.552679205285;4087.386891966214;4088.5894366443677;4090.8568200113;4117.897052573695;3448.6378930212218;4087;4121.9175616487655;4139.730917490354;4139.8965025874295;3520.6655367740022;3550.0769799851964;3604.7296452766145;3609.06164397256;3614.168741189515;4134.919484983707;4417.425734654506;4625.213713668684;5208.713520756357;5231.895362092775;4105.557193469881;4626.907461850744;4798.040391921595;4812.831550895702;4823.348847905523;5000.299958005882;5695.601307908448;5729.598928074995;5759.798407055775;5764.5676574257095;3577.266660334625;3776.848926042955;4000.4599379084034;4049.9392509112386;4069.267531844267;5281.095397531342;5612.053671822285;6104.786332478342;6162.9493400766905;6260.467860231885;3978.840846366113;4070.898227544276;4077.4495443115393;4117.711760176819;4160.604742549453;3860.6911447084167;3863.555691095504;4164.688597828173;4173;4176.624103830609;4739.4075740532435;4805.159097158054;4843.934334446416;4845.806167753321;4857.061477805947;5019.974900125476;5316.362036555638;5817.331006934172;5835.79574714883;5841.824745257649;1330.9534166304134;1387.6461502317047;1423.8718515333462;1427.957161285163;1429.992850035764;789.9888143176743;868.5179725252419;880.4981160738446;886.8692417168162;896.5114012862875;4043.7557155778827;4269.097014030489;4306.4927275453965;4534.433195850519;4594.310853371954;4332.610065094157;4667.439907211156;4962.478939711351;5099.770510327045;5108.66793658411;4139.723152266241;4267.887395739067;4491.752953587584;4589.3248964128525;4592.4385708859145;2343.8007769339797;2362.6337917622795;2416.456297333086;2655.774259187952;2679;4599.2871104978785;4846.043913212938;5063.39235293824;5094.388673359221;5272.393674727456;4493.83160378304;4554.521775213621;4637.837675681335;4718.504557021532;5100.826809833759;4536.478304994902;4612.586685852445;4632.768361581908;5274.76263568148;5295.523402893758;4612.79242434098;4817.566419022165;4850.902981940412;4857.862540482177;5058.924116138187;4154.979225103855;4249.256380133403;4707.905841883212;4739.952600474089;4833.903321933612;4504.319929641858;4522.886927826699;4623.306504024289;4744.180934347745;4968.826091086795;3113.844307784647;3268.297316077055;3402.6257111717196;3583.211693427442;3597.2985267872514;4226.513950895686;4971.950280497149;5021.974890125526;5039.722815245197;5590.66723289454;4394.538573449741;4916.3362946001835;5133.897322053613;5203.895922081613;5455.863603409946;5163.690178589297;5211.530962213419;5678.943210568007;5700.857478563069;5768.740406681625;5291.60312976536;5316.627836051439;5387.946120538744;5559.221708960829;5612.719364031864;4738.4787673356595;4836.661433699607;5067.391912970467;5703.429657034263;5816.912746308724;5242.427271818363;5550.972245138749;5610.008447001419;5650.915236271541;5654.321481422091 05:42:17 INFO - PROCESS | 3110 | |5;yui.html;730.4448619049523;775.2944820213606;787.7951732549535;821.3265122599471;846.2214762418574;14661.853381466182;15070.849291507082;15201.011934224282;15223.31495082721;15238.923805380986;13707.520236791714;13765.65585860354;13766.518171863987;13778.173309601405;13824.101433406822;723.5297056913022;900.8963969143534;916.2029034739786;919.9632014719404;920.3465539466987;895.3329769321832;906.3836591118037;909.9181073703398;921.8571121476149;927.1794461901233;932.4125800745521;957.6887511558737;976.7021058577131;977.9070988256104;981.2640519610293;959.9664011759555;968.3415277611257;971.0774763974217;972.333951243397;973.7857671312371;690.4648897104734;712.9964350178268;722.0649259209284;722.2632914427255;724.8948902409121;13999.580012599637;14043.438262469488;14148.151110933273;14218;14310.356033978393;12374.648816724883;13480.797788033187;13616.319184040858;13675.452981880713;13798.724025519434;11396.259243149168;11411;11415.714607134889;11455.656330310021;11897;3290.440625093716;3797.088698712289;3814.332491813949;3885.1258466844733;3903.1413089120633;81368;82805;83138;83265.16734832696;83303.5834820828;10214.438205898747;10654.786904261871;10708.250422470508;10766.676999690022;10783.897140057614;21427.57144857094;21725.13099476003;21731.348059558237;21762.89118554397;21763.564728705336;7824.33493153077;7962.243586859239;7985.281324680806;8155.429119961665;8223.588820558949;3772.811359432072;3883.689304855605;4468.352088947085;4554.544545545419;4733.621310295168;3303.487959366302;3353.6311005789344;3382.746294027958;3399.813010284458;3415.624281329052;582.6358525921299;595.226205932295;602.2441835496423;602.5781952633174;606.4390438844051;603.8037637767743;614.8032629558588;624.675687542413;640.177372076879;653.8790323790018;8845.51349675774;8919.197272245528;9153.35926485153;9185.494797786052;9195.724128276162;551.8730691940796;573.6414740787009;594.810991632069;633.4678869749432;671.4863129705778;3297.0768184908266;4349.673774466928;4370.562943705604;4406.803345776852;4477.888052798706;75909;87568.56215719008;89578;97004.51497742608;97140.51429742947;75982.62008689922;81709.59145204235;83575;84876.87807804854;86187.56906215429;69503.65248173727;69826.65086674433;73585.26414735892;75490.62254688691;76763.08092297737;7680.769576912701;7938.880916786137;8225.683890577478;8697.304215662858;8787.25308348772;46323.53676463192;46490;46584.767076164404;46618.53381466278;47190.34833780801;49948;60120.79758404895;63973.3602663986;64812.67593662001;65569.67215163894;10566.841497377392;11743.765124697287;11846.11154163424;11846.763064738485;12147.75704485923;12202;12461.626151215478;12485.500579976699;12487.687807804878;12488.687782805502;11248;11563.479643416234;11621.825672615087;11873.881261187624;11987.100967427303;11504.942475287904;11524.193306468802;11613.30320180792;11681.123915706186;12183.147179697336;10808.945955270174;10889.128869690565;10931.234813562975;11044.392558409365;11702.941485292518;9728.756781080247;9745.220382369534;9811.203961621926;9987.650432234837;10152.441615711206;9542.42745435276;9683.128518433376;9684.515774211402;9811;9841.753956151153 05:42:17 INFO - PROCESS | 3110 | __end_tp_report 05:42:17 INFO - PROCESS | 3110 | __start_cc_report 05:42:17 INFO - PROCESS | 3110 | _x_x_mozilla_cycle_collect,416 05:42:17 INFO - PROCESS | 3110 | __end_cc_report 05:42:17 INFO - PROCESS | 3110 | __startTimestamp1464698537266__endTimestamp 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | ------- Summary: start ------- 05:42:17 INFO - PROCESS | 3110 | Number of tests: 6 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | [#0] dojo.html Cycles:165 Average:5721.61 Median:6037.85 stddev:788.59 (13.1%) stddev-sans-first:769.31 05:42:17 INFO - PROCESS | 3110 | Values: 3379.3 3420.3 3471.6 3473.2 3503.0 5743.6 5765.3 5779.1 5796.2 5801.7 5652.7 5763.8 5797.7 5802.4 5818.3 5174.9 5217.8 5286.9 5289.0 5343.1 268.6 4771.4 4982.2 5267.4 5274.1 4695.9 5213.6 5214.2 5215.8 5239.1 5236.7 5250.2 5282.9 5289.6 5296.1 5111.3 5162.2 5214.0 5219.2 5241.0 5498.4 5666.1 5684.1 5718.3 5724.9 5332.8 6136.9 6148.0 6273.6 6304.7 6224.8 6247.6 6264.2 6289.1 6295.0 5925.1 5934.0 5936.8 5944.6 5983.4 6219.3 6280.2 6348.8 6365.9 6409.7 6098.9 6128.9 6130.5 6145.9 6153.6 6193.1 6224.2 6235.3 6288.7 6289.1 6177.6 6213.7 6240.3 6249.3 6287.4 6256.4 6276.9 6282.6 6294.1 6315.1 4239.8 4978.6 5024.6 5027.9 5032.8 4399.8 4430.9 4446.0 4485.0 4524.0 4718.9 5843.8 5853.2 5866.0 5953.7 6244.7 6285.1 6298.3 6302.4 6311.2 5692.2 5693.3 5739.7 5778.1 5984.9 5344.8 5355.1 5359.0 5360.9 5364.2 6328.1 6334.3 6349.7 6359.0 6369.2 6109.2 6156.9 6177.4 6201.0 6272.5 6462.5 6481.6 6517.3 6523.3 6536.3 5906.4 6168.4 6187.6 6189.6 6202.7 4886.4 4921.3 6209.6 6219.8 6249.0 6128.3 6167.0 6181.0 6201.9 6215.6 6076.5 6133.0 6156.9 6164.8 6171.5 5304.3 6003.0 6037.8 6069.8 6119.3 6166.6 6170.9 6171.9 6192.1 6192.8 5972.6 6093.0 6105.7 6120.7 6127.2 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | [#1] ext.html Cycles:180 Average:70933.26 Median:40997.40 stddev:157679.24 (384.6%) stddev-sans-first:158032.89 05:42:17 INFO - PROCESS | 3110 | Values: 499.0 499.1 530.0 541.1 560.7 32530.5 42700.6 43001.1 43057.6 43067.8 44391.8 44788.0 45007.1 45125.5 45149.9 9420.4 9577.3 9629.4 9662.9 9696.5 9497.9 9510.8 9527.0 9551.1 9626.0 8353.2 9620.6 9637.5 9656.3 9664.7 8300.2 8337.2 9637.8 9653.7 9654.3 9402.2 9429.7 9483.1 9487.2 9497.2 30778.7 40688.4 40949.0 40993.0 41354.4 3091.0 3212.4 3457.8 3588.5 4056.8 26255.6 32628.8 32722.7 33176.0 33405.8 3300.6 3331.2 3331.8 3412.0 3443.1 507706.0 509488.0 511706.0 511857.0 512663.0 35209.8 36165.5 66989.7 68111.0 68147.0 30315.4 35949.8 36070.6 36202.1 36342.3 15073.3 15158.4 15213.6 15221.4 15232.6 12779.7 12799.4 12889.7 12929.4 12935.7 7867.6 7875.0 7898.8 7926.2 7960.1 3233.5 3240.4 3247.1 3261.6 3274.1 976.8 989.5 997.7 1035.7 1093.4 29690.0 29765.0 31449.2 31636.7 31707.7 1015.8 1076.3 1171.5 1190.9 1191.2 16297.4 16351.7 16407.9 16609.8 16677.3 569705.0 600314.0 677768.0 715146.0 718677.0 51655.7 62855.4 62893.0 63168.0 63383.0 1411.3 1417.2 1425.7 1429.7 1445.2 30752.5 31020.0 31058.8 31617.0 31816.5 55094.2 55945.4 56242.7 56425.2 56562.7 485325.6 598399.0 612505.9 614182.0 615116.0 27238.6 27562.4 27722.7 27887.3 28328.7 50722.0 51336.5 52087.0 52246.5 52469.0 41884.8 42148.2 42237.8 42983.6 43007.9 36005.8 40718.0 41001.8 41251.6 41527.6 40148.8 40188.6 40249.4 40565.8 40683.2 31419.9 34837.1 35309.8 36145.0 36612.0 20619.9 25801.1 26305.0 26354.0 27208.0 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | [#2] jquery.html Cycles:180 Average:33917.14 Median:21187.74 stddev:95375.97 (450.1%) stddev-sans-first:95610.29 05:42:17 INFO - PROCESS | 3110 | Values: 383.2 386.2 387.2 390.3 406.4 14604.0 15653.6 16662.1 21069.9 21094.7 17337.7 17698.4 20463.9 21280.8 21639.8 5666.5 5734.4 5858.4 5946.5 5974.3 5783.4 5800.9 5832.4 5841.4 5849.0 5381.2 5773.2 5779.5 5789.1 5789.1 5655.1 5783.9 5814.1 5831.9 5953.7 5593.4 5605.3 5719.1 5745.4 5765.7 9624.3 12638.9 12982.6 13167.9 13206.0 1994.6 2200.3 2217.1 2433.2 2771.9 9722.3 9948.8 10190.9 10344.6 10548.7 1681.6 1808.5 1827.5 1837.2 1846.5 129281.0 132876.0 133424.7 133703.3 133983.0 11608.1 11744.2 11774.2 11920.1 11940.0 12074.3 14598.4 14690.6 14696.2 14764.7 8336.6 8451.2 8496.2 8553.3 8620.0 7075.9 8301.7 8305.0 8385.0 8422.4 4472.8 4538.8 4585.9 4601.0 4629.3 1637.0 1759.3 1950.0 1978.3 2002.8 821.6 879.8 1023.4 1044.6 1047.7 15484.2 18795.8 20091.2 20269.4 20796.6 798.6 978.9 1025.9 1029.4 1037.6 9318.2 11012.7 11295.9 11336.3 11349.9 540586.0 567272.0 568711.0 568924.0 581139.0 130799.0 135008.3 135496.6 137087.0 139140.3 1030.9 1037.8 1072.1 1097.0 1098.9 14939.2 18356.4 18480.0 18681.8 18716.2 49532.3 50180.2 50498.7 50761.0 51426.5 74347.5 74443.6 74543.9 75357.9 76210.0 6475.2 7939.2 7985.1 8268.8 8276.8 8905.9 11516.1 12343.1 12523.4 12666.4 10766.2 10793.5 10861.6 10962.0 10996.4 8613.4 9194.6 10509.4 10583.6 10746.6 9284.7 10628.6 10929.8 10991.3 11274.5 7188.6 8038.0 8081.4 8112.5 8238.9 8069.8 10320.9 10858.1 10892.0 10936.4 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | [#3] mootools.html Cycles:180 Average:5679.90 Median:4563.94 stddev:3207.50 (70.3%) stddev-sans-first:3200.28 05:42:17 INFO - PROCESS | 3110 | Values: 1388.6 1543.6 1748.0 1750.9 1936.5 7969.0 8459.3 8542.2 8947.0 8953.4 8639.0 8691.6 8780.8 8813.6 8834.0 2303.2 2309.6 2342.4 2345.7 2349.7 2320.6 2341.8 2345.5 2346.9 2364.2 2330.5 2338.3 2339.6 2355.5 2359.1 2314.9 2315.4 2324.2 2333.6 2337.1 2064.3 2188.4 2307.7 2309.6 2318.8 8676.0 8719.3 8736.3 8767.2 8788.3 5183.4 5253.2 5304.3 5336.1 5339.1 3398.9 3504.4 3652.7 3653.6 3656.5 871.7 999.3 1053.9 1081.1 1101.1 11534.3 11615.8 11623.2 11631.8 11646.4 4321.6 4323.7 4345.8 4387.6 4394.3 9864.8 9923.5 9936.3 9955.4 9976.2 4531.6 5320.1 5342.2 5345.7 5348.4 3946.9 4596.2 4855.9 4865.9 4899.1 3400.8 3479.1 3947.3 3972.0 3992.3 1277.4 1294.8 1303.3 1305.2 1316.9 935.8 967.6 968.0 970.6 1013.7 6021.0 6055.6 6077.5 6112.1 6157.6 438.5 438.8 446.3 447.2 452.2 3675.8 3949.5 3986.8 4153.3 4154.1 10006.6 10210.4 10425.2 10429.9 10446.5 10192.7 10243.8 10389.2 10409.3 10414.7 6374.8 8066.5 8217.7 8224.5 8279.2 6096.8 6100.2 6146.2 6242.1 6260.9 9876.7 10108.5 10133.8 10135.9 10138.9 10074.5 10160.0 10333.1 10391.5 10399.6 6969.8 7500.8 7640.3 7908.1 8254.4 8255.7 8435.9 8436.9 8450.4 8692.7 7322.6 7467.2 7490.2 7569.3 7588.8 7310.2 7375.6 7388.4 7442.2 7493.4 6914.9 6960.7 7016.6 7059.8 7079.2 4045.2 4924.4 5048.9 5161.8 5173.7 5096.1 5098.4 5107.2 5271.4 5275.9 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | [#4] prototype.html Cycles:180 Average:4322.68 Median:4629.84 stddev:1285.14 (27.8%) stddev-sans-first:1252.90 05:42:17 INFO - PROCESS | 3110 | Values: 306.5 317.8 321.5 325.4 327.3 4765.9 5264.5 5344.1 5365.6 5529.8 4378.5 4521.6 5217.8 5458.7 5488.8 3443.5 4138.4 4160.2 4176.6 4183.1 3796.5 4013.2 4138.3 4174.6 4195.0 4066.6 4087.4 4088.6 4090.9 4117.9 3448.6 4087.0 4121.9 4139.7 4139.9 3520.7 3550.1 3604.7 3609.1 3614.2 4134.9 4417.4 4625.2 5208.7 5231.9 4105.6 4626.9 4798.0 4812.8 4823.3 5000.3 5695.6 5729.6 5759.8 5764.6 3577.3 3776.8 4000.5 4049.9 4069.3 5281.1 5612.1 6104.8 6162.9 6260.5 3978.8 4070.9 4077.4 4117.7 4160.6 3860.7 3863.6 4164.7 4173.0 4176.6 4739.4 4805.2 4843.9 4845.8 4857.1 5020.0 5316.4 5817.3 5835.8 5841.8 1331.0 1387.6 1423.9 1428.0 1430.0 790.0 868.5 880.5 886.9 896.5 4043.8 4269.1 4306.5 4534.4 4594.3 4332.6 4667.4 4962.5 5099.8 5108.7 4139.7 4267.9 4491.8 4589.3 4592.4 2343.8 2362.6 2416.5 2655.8 2679.0 4599.3 4846.0 5063.4 5094.4 5272.4 4493.8 4554.5 4637.8 4718.5 5100.8 4536.5 4612.6 4632.8 5274.8 5295.5 4612.8 4817.6 4850.9 4857.9 5058.9 4155.0 4249.3 4707.9 4740.0 4833.9 4504.3 4522.9 4623.3 4744.2 4968.8 3113.8 3268.3 3402.6 3583.2 3597.3 4226.5 4972.0 5022.0 5039.7 5590.7 4394.5 4916.3 5133.9 5203.9 5455.9 5163.7 5211.5 5678.9 5700.9 5768.7 5291.6 5316.6 5387.9 5559.2 5612.7 4738.5 4836.7 5067.4 5703.4 5816.9 5242.4 5551.0 5610.0 5650.9 5654.3 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - PROCESS | 3110 | [#5] yui.html Cycles:180 Average:18375.62 Median:595.02 stddev:25621.33 (4306.0%) stddev-sans-first:25658.95 05:42:17 INFO - PROCESS | 3110 | Values: 730.4 775.3 787.8 821.3 846.2 14661.9 15070.8 15201.0 15223.3 15238.9 13707.5 13765.7 13766.5 13778.2 13824.1 723.5 900.9 916.2 920.0 920.3 895.3 906.4 909.9 921.9 927.2 932.4 957.7 976.7 977.9 981.3 960.0 968.3 971.1 972.3 973.8 690.5 713.0 722.1 722.3 724.9 13999.6 14043.4 14148.2 14218.0 14310.4 12374.6 13480.8 13616.3 13675.5 13798.7 11396.3 11411.0 11415.7 11455.7 11897.0 3290.4 3797.1 3814.3 3885.1 3903.1 81368.0 82805.0 83138.0 83265.2 83303.6 10214.4 10654.8 10708.3 10766.7 10783.9 21427.6 21725.1 21731.3 21762.9 21763.6 7824.3 7962.2 7985.3 8155.4 8223.6 3772.8 3883.7 4468.4 4554.5 4733.6 3303.5 3353.6 3382.7 3399.8 3415.6 582.6 595.2 602.2 602.6 606.4 603.8 614.8 624.7 640.2 653.9 8845.5 8919.2 9153.4 9185.5 9195.7 551.9 573.6 594.8 633.5 671.5 3297.1 4349.7 4370.6 4406.8 4477.9 75909.0 87568.6 89578.0 97004.5 97140.5 75982.6 81709.6 83575.0 84876.9 86187.6 69503.7 69826.7 73585.3 75490.6 76763.1 7680.8 7938.9 8225.7 8697.3 8787.3 46323.5 46490.0 46584.8 46618.5 47190.3 49948.0 60120.8 63973.4 64812.7 65569.7 10566.8 11743.8 11846.1 11846.8 12147.8 12202.0 12461.6 12485.5 12487.7 12488.7 11248.0 11563.5 11621.8 11873.9 11987.1 11504.9 11524.2 11613.3 11681.1 12183.1 10808.9 10889.1 10931.2 11044.4 11702.9 9728.8 9745.2 9811.2 9987.7 10152.4 9542.4 9683.1 9684.5 9811.0 9841.8 05:42:17 INFO - PROCESS | 3110 | -------- Summary: end -------- 05:42:17 INFO - PROCESS | 3110 | 05:42:17 INFO - TEST-INFO | 3110: exit 0 05:42:17 INFO - TEST-OK | dromaeo_css | took 1112216ms 05:42:17 INFO - TEST-START | kraken 05:42:17 INFO - operating with platform_type : mac_ 05:42:17 INFO - Initialising browser for kraken test... 05:42:17 INFO - TEST-INFO | started process 3225 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpH7FKwM/profile http://localhost:52863/getInfo.html) 05:42:21 INFO - PROCESS | 3225 | __metrics Screen width/height:1600/1200 05:42:21 INFO - PROCESS | 3225 | colorDepth:24 05:42:21 INFO - PROCESS | 3225 | Browser inner width/height: 1024/689 05:42:21 INFO - PROCESS | 3225 | __metrics 05:42:21 ERROR - PROCESS | 3225 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:42:21 INFO - TEST-INFO | 3225: exit 0 05:42:21 INFO - Browser initialized. 05:42:21 INFO - Running cycle 1/1 for kraken test... 05:42:21 INFO - TEST-INFO | started process 3228 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpH7FKwM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:33 INFO - PROCESS | 3228 | RSS: Main: 252678144 05:42:33 INFO - PROCESS | 3228 | 05:42:36 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52863/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:37 INFO - PROCESS | 3228 | RSS: Main: 265433088 05:42:37 INFO - PROCESS | 3228 | 05:42:40 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52863/tests/kraken/driver.html?testName=audio-dft) 05:42:40 INFO - PROCESS | 3228 | RSS: Main: 269541376 05:42:40 INFO - PROCESS | 3228 | 05:42:44 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52863/tests/kraken/driver.html?testName=audio-fft) 05:42:45 INFO - PROCESS | 3228 | RSS: Main: 270053376 05:42:45 INFO - PROCESS | 3228 | 05:42:47 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52863/tests/kraken/driver.html?testName=audio-oscillator) 05:42:47 INFO - PROCESS | 3228 | RSS: Main: 270974976 05:42:47 INFO - PROCESS | 3228 | 05:42:49 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:50 INFO - PROCESS | 3228 | RSS: Main: 271503360 05:42:50 INFO - PROCESS | 3228 | 05:42:53 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52863/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:54 INFO - PROCESS | 3228 | RSS: Main: 271998976 05:42:54 INFO - PROCESS | 3228 | 05:42:57 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52863/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:57 INFO - PROCESS | 3228 | RSS: Main: 272183296 05:42:57 INFO - PROCESS | 3228 | 05:43:00 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52863/tests/kraken/driver.html?testName=json-parse-financial) 05:43:01 INFO - PROCESS | 3228 | RSS: Main: 272363520 05:43:01 INFO - PROCESS | 3228 | 05:43:02 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:03 INFO - PROCESS | 3228 | RSS: Main: 271859712 05:43:03 INFO - PROCESS | 3228 | 05:43:05 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:05 INFO - PROCESS | 3228 | RSS: Main: 271872000 05:43:05 INFO - PROCESS | 3228 | 05:43:08 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:08 INFO - PROCESS | 3228 | RSS: Main: 272171008 05:43:08 INFO - PROCESS | 3228 | 05:43:11 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:12 INFO - PROCESS | 3228 | RSS: Main: 272277504 05:43:12 INFO - PROCESS | 3228 | 05:43:15 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:15 INFO - PROCESS | 3228 | RSS: Main: 272166912 05:43:15 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | Cycle 1(1): loaded http://localhost:52863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52863/tests/kraken/driver.html?testName=ai-astar) 05:43:17 INFO - PROCESS | 3228 | RSS: Main: 273141760 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | __start_tp_report 05:43:17 INFO - PROCESS | 3228 | _x_x_mozilla_page_load 05:43:17 INFO - PROCESS | 3228 | _x_x_mozilla_page_load_details 05:43:17 INFO - PROCESS | 3228 | |i|pagename|runs| 05:43:17 INFO - PROCESS | 3228 | |0;ai-astar;116;111;116;115;116;116;117;115;120;117 05:43:17 INFO - PROCESS | 3228 | |1;audio-beat-detection;157;121;157;200;152;141;146;110;210;149 05:43:17 INFO - PROCESS | 3228 | |2;audio-dft;196;204;233;267;275;202;284;282;198;200 05:43:17 INFO - PROCESS | 3228 | |3;audio-fft;67;82;74;179;55;65;87;87;146;58 05:43:17 INFO - PROCESS | 3228 | |4;audio-oscillator;70;83;115;86;61;98;146;107;108;146 05:43:17 INFO - PROCESS | 3228 | |5;imaging-gaussian-blur;108;86;132;81;137;132;96;132;127;86 05:43:17 INFO - PROCESS | 3228 | |6;imaging-darkroom;104;98;95;95;94;95;95;94;95;106 05:43:17 INFO - PROCESS | 3228 | |7;imaging-desaturate;92;133;138;92;86;95;93;89;83;89 05:43:17 INFO - PROCESS | 3228 | |8;json-parse-financial;58;57;59;59;58;60;59;58;57;57 05:43:17 INFO - PROCESS | 3228 | |9;json-stringify-tinderbox;67;71;67;72;77;74;72;70;70;71 05:43:17 INFO - PROCESS | 3228 | |10;stanford-crypto-aes;91;95;88;86;87;86;89;87;120;93 05:43:17 INFO - PROCESS | 3228 | |11;stanford-crypto-ccm;156;154;141;132;137;155;159;157;173;163 05:43:17 INFO - PROCESS | 3228 | |12;stanford-crypto-pbkdf2;171;163;170;164;168;162;167;170;162;170 05:43:17 INFO - PROCESS | 3228 | |13;stanford-crypto-sha256-iterative;68;65;69;66;68;65;66;65;65;68 05:43:17 INFO - PROCESS | 3228 | __end_tp_report 05:43:17 INFO - PROCESS | 3228 | __start_cc_report 05:43:17 INFO - PROCESS | 3228 | _x_x_mozilla_cycle_collect,1075 05:43:17 INFO - PROCESS | 3228 | __end_cc_report 05:43:17 INFO - PROCESS | 3228 | __startTimestamp1464698597788__endTimestamp 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | ------- Summary: start ------- 05:43:17 INFO - PROCESS | 3228 | Number of tests: 14 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:2.23 (1.9%) stddev-sans-first:2.37 05:43:17 INFO - PROCESS | 3228 | Values: 116.0 111.0 116.0 115.0 116.0 116.0 117.0 115.0 120.0 117.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:154.50 stddev:30.83 (20.0%) stddev-sans-first:32.69 05:43:17 INFO - PROCESS | 3228 | Values: 157.0 121.0 157.0 200.0 152.0 141.0 146.0 110.0 210.0 149.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#2] audio-dft Cycles:10 Average:234.10 Median:250.00 stddev:38.58 (15.4%) stddev-sans-first:38.38 05:43:17 INFO - PROCESS | 3228 | Values: 196.0 204.0 233.0 267.0 275.0 202.0 284.0 282.0 198.0 200.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#3] audio-fft Cycles:10 Average:90.00 Median:70.50 stddev:40.55 (57.5%) stddev-sans-first:42.15 05:43:17 INFO - PROCESS | 3228 | Values: 67.0 82.0 74.0 179.0 55.0 65.0 87.0 87.0 146.0 58.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:65.50 stddev:28.75 (43.9%) stddev-sans-first:28.07 05:43:17 INFO - PROCESS | 3228 | Values: 70.0 83.0 115.0 86.0 61.0 98.0 146.0 107.0 108.0 146.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#5] imaging-gaussian-blur Cycles:10 Average:111.70 Median:109.00 stddev:22.69 (20.8%) stddev-sans-first:24.03 05:43:17 INFO - PROCESS | 3228 | Values: 108.0 86.0 132.0 81.0 137.0 132.0 96.0 132.0 127.0 86.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:95.00 stddev:4.33 (4.6%) stddev-sans-first:3.81 05:43:17 INFO - PROCESS | 3228 | Values: 104.0 98.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 106.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#7] imaging-desaturate Cycles:10 Average:99.00 Median:90.50 stddev:19.58 (21.6%) stddev-sans-first:20.61 05:43:17 INFO - PROCESS | 3228 | Values: 92.0 133.0 138.0 92.0 86.0 95.0 93.0 89.0 83.0 89.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.50 stddev:1.03 (1.8%) stddev-sans-first:1.09 05:43:17 INFO - PROCESS | 3228 | Values: 58.0 57.0 59.0 59.0 58.0 60.0 59.0 58.0 57.0 57.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.50 stddev:3.00 (4.2%) stddev-sans-first:2.79 05:43:17 INFO - PROCESS | 3228 | Values: 67.0 71.0 67.0 72.0 77.0 74.0 72.0 70.0 70.0 71.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:88.50 stddev:10.23 (11.6%) stddev-sans-first:10.84 05:43:17 INFO - PROCESS | 3228 | Values: 91.0 95.0 88.0 86.0 87.0 86.0 89.0 87.0 120.0 93.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:156.50 stddev:12.50 (8.0%) stddev-sans-first:13.20 05:43:17 INFO - PROCESS | 3228 | Values: 156.0 154.0 141.0 132.0 137.0 155.0 159.0 157.0 173.0 163.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:169.00 stddev:3.62 (2.1%) stddev-sans-first:3.49 05:43:17 INFO - PROCESS | 3228 | Values: 171.0 163.0 170.0 164.0 168.0 162.0 167.0 170.0 162.0 170.0 05:43:17 INFO - PROCESS | 3228 | 05:43:17 INFO - PROCESS | 3228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.58 05:43:17 INFO - PROCESS | 3228 | Values: 68.0 65.0 69.0 66.0 68.0 65.0 66.0 65.0 65.0 68.0 05:43:17 INFO - PROCESS | 3228 | -------- Summary: end -------- 05:43:17 INFO - PROCESS | 3228 | 05:43:18 INFO - TEST-INFO | 3228: exit 0 05:43:18 INFO - TEST-OK | kraken | took 60621ms 05:43:18 INFO - SUITE-END | took 1172s 05:43:18 INFO - Completed test suite (00:19:33) 05:43:18 INFO - javascript benchmark 05:43:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7069.036093089413, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3379.3072420153862, 3420.2646431017324, 3471.6354782747812, 3473.2358881046175, 3503.0016445313086, 5743.62666426682, 5765.308163020433, 5779.104238842986, 5796.217510636063, 5801.6519008859395, 5652.689102099383, 5763.769449222026, 5797.652140871551, 5802.361740208574, 5818.301803783552, 5174.922376164351, 5217.817376391827, 5286.920696189561, 5289.047971365153, 5343.145096784496, 268.5718577661649, 4771.355866957951, 4982.227754698028, 5267.394249661281, 5274.129768588178, 4695.859124226262, 5213.556847667953, 5214.243934629495, 5215.791368345281, 5239.13554263546, 5236.659617124913, 5250.18622113573, 5282.947170528284, 5289.550388217006, 5296.073187192226, 5111.309973153651, 5162.225666150108, 5214.0, 5219.243209734605, 5241.0, 5498.422665620133, 5666.121751128581, 5684.118961560924, 5718.313802343745, 5724.885502289931, 5332.786688532454, 6136.877262454771, 6148.016317389241, 6273.56085074045, 6304.716287767015, 6224.813255602339, 6247.593906396115, 6264.248290205204, 6289.0880822280515, 6294.968525157345, 5925.111233314994, 5934.0, 5936.821895343147, 5944.641277678098, 5983.401659833982, 6219.253689557282, 6280.214973128359, 6348.777792777323, 6365.904511432333, 6409.679516024274, 6098.886104840075, 6128.872947855237, 6130.524716956557, 6145.877082458326, 6153.630782153085, 6193.071039344044, 6224.221972253468, 6235.345288744707, 6288.717007734663, 6289.0880822280515, 6177.567570270038, 6213.65824879627, 6240.251169859555, 6249.312575616678, 6287.402696743802, 6256.436920677161, 6276.901542230092, 6282.591631543935, 6294.118823364733, 6315.084312774622, 4239.8092085856215, 4978.626603004789, 5024.57291130258, 5027.874303142377, 5032.798688052437, 4399.802008909607, 4430.867073987785, 4446.044100518339, 4484.977575112103, 4523.977380113079, 4718.8584342469785, 5843.795467158629, 5853.180554722342, 5866.0, 5953.672548009901, 6244.65654389013, 6285.088662143963, 6298.307186209513, 6302.401271879165, 6311.211098612674, 5692.203091567184, 5693.259876216065, 5739.713014349266, 5778.133280007948, 5984.880302393928, 5344.786208551692, 5355.0896347621, 5359.0, 5360.946390536123, 5364.195370694427, 6328.050792381179, 6334.271558770616, 6349.746010159542, 6358.968205159037, 6369.235691717024, 6109.236345456818, 6156.922538555646, 6177.444030037318, 6200.968995154995, 6272.529560282906, 6462.450691691259, 6481.611103333815, 6517.348265173445, 6523.3150519194805, 6536.281009089092, 5906.379830117776, 6168.414000669929, 6187.628742275478, 6189.6286222826775, 6202.658853762906, 4886.3647725796845, 4921.31101645777, 6209.627422354673, 6219.844503887258, 6249.0, 6128.325884152829, 6166.969165154145, 6181.041938499539, 6201.906971395342, 6215.564910456224, 6076.544259180668, 6132.969335153296, 6156.876862462816, 6164.753409863555, 6171.506279497719, 5304.283921670525, 6002.969985150046, 6037.849053773691, 6069.787557435468, 6119.296280927751, 6166.599171053867, 6170.876582468415, 6171.907421388593, 6192.102145188832, 6192.752289908353, 5972.641641501524, 6092.969535152296, 6105.6947152641305, 6120.724567394389, 6127.20346354971], "value": 5673.1537603256775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.9975050124749, 499.1364938656124, 529.9920501192481, 541.1422894711882, 560.7448610882049, 32530.512042319384, 42700.57299427001, 43001.13997720044, 43057.569424305744, 43067.78466107669, 44391.77804110983, 44788.0, 45007.09985800282, 45125.54874451255, 45149.871253218604, 9420.43477391357, 9577.329586928883, 9629.374090684083, 9662.90337096627, 9696.46669433181, 9497.905020949771, 9510.762230944212, 9527.0, 9551.140397364235, 9626.037396260388, 8353.248207661309, 9620.615175392975, 9637.518124093802, 9656.324057315991, 9664.71005869825, 8300.169983001711, 8337.249647531751, 9637.807243855119, 9653.662121825773, 9654.324197306192, 9402.247820174369, 9429.669961551313, 9483.14651681352, 9487.193588544913, 9497.240220782322, 30778.69221307803, 40688.38967415461, 40949.0, 40993.0, 41354.37968430476, 3091.0, 3212.421764082464, 3457.757956943015, 3588.5334906461994, 4056.776877271749, 26255.562936731163, 32628.836855815807, 32722.6727732722, 33176.0, 33405.83297083523, 3300.5874265716784, 3331.2338162222823, 3331.816750078745, 3412.0446275043028, 3443.104792753902, 507706.0, 509488.0, 511706.0, 511857.0, 512663.0, 35209.82395088008, 36165.45751813725, 66989.66505167443, 68111.0, 68147.0, 30315.393692126036, 35949.8202508991, 36070.63929360673, 36202.09494762599, 36342.273154536764, 15073.321700523502, 15158.393664253526, 15213.61965950838, 15221.391144354324, 15232.619184520254, 12779.680507987374, 12799.424025918855, 12889.677758055936, 12929.353532323534, 12935.741285174245, 7867.567283799446, 7875.0, 7898.802529936683, 7926.207379262143, 7960.1243863175005, 3233.4826427771445, 3240.4491236489853, 3247.0908145719236, 3261.59230096238, 3274.148721332471, 976.8144052629978, 989.5250279865704, 997.7356000659831, 1035.6530562261576, 1093.3931667924219, 29689.9608513701, 29765.0, 31449.213769655486, 31636.683633163375, 31707.682923170934, 1015.8120747661707, 1076.278893141597, 1171.5138217639756, 1190.8570971483477, 1191.2257032928492, 16297.429589964295, 16351.67296654084, 16407.91796041036, 16609.750853737205, 16677.332906683598, 569705.0, 600314.0, 677768.0, 715146.0, 718677.0, 51655.74172129115, 62855.37144628587, 62893.0, 63168.0, 63383.0, 1411.3366717642896, 1417.2417756500222, 1425.693475902665, 1429.7140571885664, 1445.1762495377534, 30752.538711918893, 31020.0, 31058.844705777232, 31617.0, 31816.522752158275, 55094.17358739542, 55945.44054559402, 56242.71878640581, 56425.15362269651, 56562.71718641381, 485325.57337213086, 598399.0, 612505.9374703098, 614182.0, 615116.0, 27238.591421129095, 27562.44875102527, 27722.72277277282, 27887.302817428914, 28328.716712832607, 50721.98556028932, 51336.48663513317, 52087.0, 52246.477535225684, 52469.0, 41884.79057604692, 42148.1570368597, 42237.78881105575, 42983.570164299206, 43007.92480187895, 36005.819970899975, 40717.982050448976, 41001.79499102486, 41251.58748412477, 41527.58472415237, 40148.799256003535, 40188.59811401849, 40249.39625905555, 40565.79717101395, 40683.18633627252, 31419.900303489267, 34837.12907177341, 35309.823450882584, 36145.0, 36612.0, 20619.896900515403, 25801.096961606254, 26305.0, 26354.0, 27208.0], "value": 19176.945775298867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.2124983159606, 386.2256176366385, 387.16565800699493, 390.30831444092223, 406.414762741652, 14604.0, 15653.608659783511, 16662.083585402797, 21069.894650526763, 21094.683579746317, 17337.739933901, 17698.38055668052, 20463.897680511578, 21280.787192128075, 21639.783602163974, 5666.490015898558, 5734.397888221739, 5858.3848695886745, 5946.494547963407, 5974.253218347707, 5783.363829978699, 5800.912986305188, 5832.358440571534, 5841.445062719056, 5849.034909239992, 5381.165919282498, 5773.1917531545405, 5779.479846813786, 5789.073748200289, 5789.131630255453, 5655.095184770458, 5783.913241301384, 5814.127880817869, 5831.912521312183, 5953.7320820562745, 5593.440655934414, 5605.271314729059, 5719.084946408596, 5745.396733342981, 5765.654060756368, 9624.278179136592, 12638.873611263862, 12982.610521684364, 13167.868321316855, 13206.009549283746, 1994.6110508450713, 2200.2959053103014, 2217.0909926930044, 2433.233531437609, 2771.9168424947084, 9722.319437639368, 9948.751281217956, 10190.9490452548, 10344.586216551328, 10548.736281592945, 1681.5880109373281, 1808.493621785902, 1827.5157083372917, 1837.1640903388925, 1846.547595839028, 129281.0, 132876.0, 133424.66575334218, 133703.33148334295, 133982.99999999904, 11608.071354291636, 11744.236624619372, 11774.175807693378, 11920.10599205063, 11940.044796416265, 12074.335911524775, 14598.416063357347, 14690.55928322152, 14696.191709455868, 14764.744996675403, 8336.62485188168, 8451.1548845115, 8496.192861678132, 8553.272971797467, 8619.956900215459, 7075.893861592081, 8301.6679332826, 8305.003399592088, 8385.0, 8422.368322375847, 4472.843450479218, 4538.750368729751, 4585.908281834345, 4601.0, 4629.305604159403, 1636.950891473234, 1759.2962814874152, 1949.9762624622188, 1978.3174804692358, 2002.779694233633, 821.6015232612178, 879.7580665317089, 1023.370627064365, 1044.6239353832614, 1047.7223535763028, 15484.225788710744, 18795.812041879406, 20091.191792738722, 20269.391918242476, 20796.58406831855, 798.6086817459403, 978.9265805064649, 1025.9487025648689, 1029.3926583315879, 1037.5642230263309, 9318.207952323994, 11012.73378432156, 11295.887041129648, 11336.319820810777, 11349.886501134883, 540586.0, 567272.0, 568711.0, 568924.0, 581139.0, 130799.0, 135008.32495837458, 135496.64503355036, 137087.0, 139140.30429847786, 1030.9432981185957, 1037.8287582548794, 1072.083368719749, 1097.0455703537973, 1098.873629532598, 14939.178345190685, 18356.357527486474, 18479.98360090208, 18681.81318186801, 18716.157772900526, 49532.25701614551, 50180.247296291316, 50498.74750626223, 50761.0, 51426.48573514217, 74347.51304973979, 74443.62778186075, 74543.8818417735, 75357.86963195447, 76210.0, 6475.222973243241, 7939.166387529226, 7985.121636620083, 8268.751937441886, 8276.751697449086, 8905.866412003954, 11516.136289778133, 12343.13598048128, 12523.436445360163, 12666.366681665695, 10766.192535559707, 10793.460326983777, 10861.565537378416, 10962.0, 10996.395198264172, 8613.353998450017, 9194.58624361892, 10509.423586462091, 10583.62957296491, 10746.623868164577, 9284.74655921442, 10628.627998020032, 10929.83605245906, 10991.285566438157, 11274.492647831032, 7188.640567971476, 8038.0, 8081.353491720531, 8112.472689275178, 8238.876416853871, 8069.83860322802, 10320.896791031993, 10858.077063449695, 10892.019718225398, 10936.398498082683], "value": 9221.126776530979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.5556621880996, 1543.6295289130612, 1747.9737803932944, 1750.894946303222, 1936.5449119456935, 7968.9601551992155, 8459.280961118304, 8542.188492093257, 8946.955265223682, 8953.373263871532, 8639.006514250863, 8691.56542172892, 8780.824383512341, 8813.647454101845, 8834.028256891737, 2303.239930822833, 2309.584274830534, 2342.426105604121, 2345.659879317498, 2349.6841768609634, 2320.6054970655027, 2341.812654987597, 2345.4605440748637, 2346.9178578749747, 2364.196173301077, 2330.498942727313, 2338.333574931145, 2339.6022676145094, 2355.49356888269, 2359.079958816063, 2314.9189778357845, 2315.3748487908256, 2324.2097686786487, 2333.6149535326567, 2337.0651739304412, 2064.318774804311, 2188.420068681801, 2307.711536057993, 2309.6304591265316, 2318.8376813623054, 8676.045634980148, 8719.346049046348, 8736.301095912311, 8767.167119123673, 8788.252998495136, 5183.429822719498, 5253.159494480865, 5304.336957880265, 5336.119540275849, 5339.145736682112, 3398.881039163642, 3504.4217704078796, 3652.6529979652155, 3653.6346365363515, 3656.451532270154, 871.6687658689721, 999.2705325112636, 1053.9209559283083, 1081.1080858291941, 1101.1136035491427, 11534.307941523452, 11615.825762613567, 11623.244489108265, 11631.767364652744, 11646.41767911601, 4321.5678432157165, 4323.675724320626, 4345.804438800262, 4387.561243875651, 4394.308191346355, 9864.802703945881, 9923.503824808731, 9936.304458687822, 9955.402675839328, 9976.152027077635, 4531.637469002472, 5320.095583750772, 5342.225377320345, 5345.70598617072, 5348.358197016305, 3946.940795888064, 4596.2416201326405, 4855.878603034952, 4865.854024379274, 4899.1426500362295, 3400.792718584916, 3479.1302174456387, 3947.3289540778137, 3972.0, 3992.3412636915164, 1277.4379273119798, 1294.7539967406162, 1303.3418123847587, 1305.2494815481136, 1316.8748968847945, 935.8268720286769, 967.6274634265858, 967.9661211857551, 970.5826494607245, 1013.7364285285731, 6021.036634138517, 6055.636661800306, 6077.453029227391, 6112.083187521818, 6157.568970172135, 438.49791988174, 438.80473189431035, 446.2636649528304, 447.232995412862, 452.237979005377, 3675.805363256952, 3949.5260568731937, 3986.7807270599815, 4153.293940030202, 4154.086101057763, 10006.599736010477, 10210.438425886647, 10425.218108641882, 10429.895701043044, 10446.52990615409, 10192.694219173436, 10243.84634230487, 10389.220808439397, 10409.323393979366, 10414.687559373231, 6374.84062898422, 8066.516009039359, 8217.712380066669, 8224.547649879314, 8279.172082791792, 6096.817095487142, 6100.23747031621, 6146.200993870768, 6242.063690446469, 6260.937390626035, 9876.703698889045, 10108.494575271354, 10133.847992280269, 10135.898641013495, 10138.89861101409, 10074.546645400827, 10160.0, 10333.070023697903, 10391.480425978822, 10399.58401663925, 6969.7909062728195, 7500.849983000418, 7640.312371886557, 7908.130105688485, 8254.42219044661, 8255.669773209245, 8435.915640843514, 8436.873446898178, 8450.366222533212, 8692.695755648521, 7322.560646361236, 7467.215942325977, 7490.176080631235, 7569.318761311509, 7588.8482230356185, 7310.232425595449, 7375.631218439164, 7388.408927285696, 7442.181360050498, 7493.4379921505015, 6914.8617027660175, 6960.651967401711, 7016.5790052597, 7059.752908648173, 7079.1858936223, 4045.1707399982342, 4924.433690125538, 5048.896521083608, 5161.845144645667, 5173.663711858717, 5096.0827051131155, 5098.439171691185, 5107.182850743863, 5271.367435907716, 5275.868103297448], "value": 4486.200770988973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.4927544913168, 317.7791434952708, 321.49685741814056, 325.41912685855755, 327.27998403512265, 4765.857024289273, 5264.473552644734, 5344.144936810111, 5365.624406291561, 5529.778808847651, 4378.518362980078, 4521.570450807168, 5217.817376391827, 5458.6724796512235, 5488.780448782044, 3443.483477478386, 4138.358554424069, 4160.230357383879, 4176.60322269384, 4183.0966910056, 3796.462432714741, 4013.1973605278913, 4138.261929989411, 4174.580642581522, 4195.0, 4066.552679205285, 4087.386891966214, 4088.5894366443677, 4090.8568200113, 4117.897052573695, 3448.6378930212218, 4087.0, 4121.9175616487655, 4139.730917490354, 4139.8965025874295, 3520.6655367740022, 3550.0769799851964, 3604.7296452766145, 3609.06164397256, 3614.168741189515, 4134.919484983707, 4417.425734654506, 4625.213713668684, 5208.713520756357, 5231.895362092775, 4105.557193469881, 4626.907461850744, 4798.040391921595, 4812.831550895702, 4823.348847905523, 5000.299958005882, 5695.601307908448, 5729.598928074995, 5759.798407055775, 5764.5676574257095, 3577.266660334625, 3776.848926042955, 4000.4599379084034, 4049.9392509112386, 4069.267531844267, 5281.095397531342, 5612.053671822285, 6104.786332478342, 6162.9493400766905, 6260.467860231885, 3978.840846366113, 4070.898227544276, 4077.4495443115393, 4117.711760176819, 4160.604742549453, 3860.6911447084167, 3863.555691095504, 4164.688597828173, 4173.0, 4176.624103830609, 4739.4075740532435, 4805.159097158054, 4843.934334446416, 4845.806167753321, 4857.061477805947, 5019.974900125476, 5316.362036555638, 5817.331006934172, 5835.79574714883, 5841.824745257649, 1330.9534166304134, 1387.6461502317047, 1423.8718515333462, 1427.957161285163, 1429.992850035764, 789.9888143176743, 868.5179725252419, 880.4981160738446, 886.8692417168162, 896.5114012862875, 4043.7557155778827, 4269.097014030489, 4306.4927275453965, 4534.433195850519, 4594.310853371954, 4332.610065094157, 4667.439907211156, 4962.478939711351, 5099.770510327045, 5108.66793658411, 4139.723152266241, 4267.887395739067, 4491.752953587584, 4589.3248964128525, 4592.4385708859145, 2343.8007769339797, 2362.6337917622795, 2416.456297333086, 2655.774259187952, 2679.0, 4599.2871104978785, 4846.043913212938, 5063.39235293824, 5094.388673359221, 5272.393674727456, 4493.83160378304, 4554.521775213621, 4637.837675681335, 4718.504557021532, 5100.826809833759, 4536.478304994902, 4612.586685852445, 4632.768361581908, 5274.76263568148, 5295.523402893758, 4612.79242434098, 4817.566419022165, 4850.902981940412, 4857.862540482177, 5058.924116138187, 4154.979225103855, 4249.256380133403, 4707.905841883212, 4739.952600474089, 4833.903321933612, 4504.319929641858, 4522.886927826699, 4623.306504024289, 4744.180934347745, 4968.826091086795, 3113.844307784647, 3268.297316077055, 3402.6257111717196, 3583.211693427442, 3597.2985267872514, 4226.513950895686, 4971.950280497149, 5021.974890125526, 5039.722815245197, 5590.66723289454, 4394.538573449741, 4916.3362946001835, 5133.897322053613, 5203.895922081613, 5455.863603409946, 5163.690178589297, 5211.530962213419, 5678.943210568007, 5700.857478563069, 5768.740406681625, 5291.60312976536, 5316.627836051439, 5387.946120538744, 5559.221708960829, 5612.719364031864, 4738.4787673356595, 4836.661433699607, 5067.391912970467, 5703.429657034263, 5816.912746308724, 5242.427271818363, 5550.972245138749, 5610.008447001419, 5650.915236271541, 5654.321481422091], "value": 3925.7506490534615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.4448619049523, 775.2944820213606, 787.7951732549535, 821.3265122599471, 846.2214762418574, 14661.853381466182, 15070.849291507082, 15201.011934224282, 15223.31495082721, 15238.923805380986, 13707.520236791714, 13765.65585860354, 13766.518171863987, 13778.173309601405, 13824.101433406822, 723.5297056913022, 900.8963969143534, 916.2029034739786, 919.9632014719404, 920.3465539466987, 895.3329769321832, 906.3836591118037, 909.9181073703398, 921.8571121476149, 927.1794461901233, 932.4125800745521, 957.6887511558737, 976.7021058577131, 977.9070988256104, 981.2640519610293, 959.9664011759555, 968.3415277611257, 971.0774763974217, 972.333951243397, 973.7857671312371, 690.4648897104734, 712.9964350178268, 722.0649259209284, 722.2632914427255, 724.8948902409121, 13999.580012599637, 14043.438262469488, 14148.151110933273, 14218.0, 14310.356033978393, 12374.648816724883, 13480.797788033187, 13616.319184040858, 13675.452981880713, 13798.724025519434, 11396.259243149168, 11411.0, 11415.714607134889, 11455.656330310021, 11897.0, 3290.440625093716, 3797.088698712289, 3814.332491813949, 3885.1258466844733, 3903.1413089120633, 81368.0, 82805.0, 83138.0, 83265.16734832696, 83303.5834820828, 10214.438205898747, 10654.786904261871, 10708.250422470508, 10766.676999690022, 10783.897140057614, 21427.57144857094, 21725.13099476003, 21731.348059558237, 21762.89118554397, 21763.564728705336, 7824.33493153077, 7962.243586859239, 7985.281324680806, 8155.429119961665, 8223.588820558949, 3772.811359432072, 3883.689304855605, 4468.352088947085, 4554.544545545419, 4733.621310295168, 3303.487959366302, 3353.6311005789344, 3382.746294027958, 3399.813010284458, 3415.624281329052, 582.6358525921299, 595.226205932295, 602.2441835496423, 602.5781952633174, 606.4390438844051, 603.8037637767743, 614.8032629558588, 624.675687542413, 640.177372076879, 653.8790323790018, 8845.51349675774, 8919.197272245528, 9153.35926485153, 9185.494797786052, 9195.724128276162, 551.8730691940796, 573.6414740787009, 594.810991632069, 633.4678869749432, 671.4863129705778, 3297.0768184908266, 4349.673774466928, 4370.562943705604, 4406.803345776852, 4477.888052798706, 75909.0, 87568.56215719008, 89578.0, 97004.51497742608, 97140.51429742947, 75982.62008689922, 81709.59145204235, 83575.0, 84876.87807804854, 86187.56906215429, 69503.65248173727, 69826.65086674433, 73585.26414735892, 75490.62254688691, 76763.08092297737, 7680.769576912701, 7938.880916786137, 8225.683890577478, 8697.304215662858, 8787.25308348772, 46323.53676463192, 46490.0, 46584.767076164404, 46618.53381466278, 47190.34833780801, 49948.0, 60120.79758404895, 63973.3602663986, 64812.67593662001, 65569.67215163894, 10566.841497377392, 11743.765124697287, 11846.11154163424, 11846.763064738485, 12147.75704485923, 12202.0, 12461.626151215478, 12485.500579976699, 12487.687807804878, 12488.687782805502, 11248.0, 11563.479643416234, 11621.825672615087, 11873.881261187624, 11987.100967427303, 11504.942475287904, 11524.193306468802, 11613.30320180792, 11681.123915706186, 12183.147179697336, 10808.945955270174, 10889.128869690565, 10931.234813562975, 11044.392558409365, 11702.941485292518, 9728.756781080247, 9745.220382369534, 9811.203961621926, 9987.650432234837, 10152.441615711206, 9542.42745435276, 9683.128518433376, 9684.515774211402, 9811.0, 9841.753956151153], "value": 7061.958993943318, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 116.0, 115.0, 116.0, 116.0, 117.0, 115.0, 120.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 121.0, 157.0, 200.0, 152.0, 141.0, 146.0, 110.0, 210.0, 149.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 204.0, 233.0, 267.0, 275.0, 202.0, 284.0, 282.0, 198.0, 200.0], "value": 234.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 82.0, 74.0, 179.0, 55.0, 65.0, 87.0, 87.0, 146.0, 58.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 115.0, 86.0, 61.0, 98.0, 146.0, 107.0, 108.0, 146.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 86.0, 132.0, 81.0, 137.0, 132.0, 96.0, 132.0, 127.0, 86.0], "value": 111.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 98.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 106.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 133.0, 138.0, 92.0, 86.0, 95.0, 93.0, 89.0, 83.0, 89.0], "value": 99.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 59.0, 59.0, 58.0, 60.0, 59.0, 58.0, 57.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 72.0, 77.0, 74.0, 72.0, 70.0, 70.0, 71.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 88.0, 86.0, 87.0, 86.0, 89.0, 87.0, 120.0, 93.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 141.0, 132.0, 137.0, 155.0, 159.0, 157.0, 173.0, 163.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 163.0, 170.0, 164.0, 168.0, 162.0, 167.0, 170.0, 162.0, 170.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 69.0, 66.0, 68.0, 65.0, 66.0, 65.0, 65.0, 68.0], "value": 66.5, "unit": "score"}]}]} 05:43:19 INFO - Return code: 0 05:43:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:43:19 ERROR - # TBPL SUCCESS # 05:43:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:43:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:43:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:43:19 INFO - 2016-05-31 05:43:19.090 screenresolution[3238:24040] starting screenresolution argv=screenresolution get 05:43:19 INFO - 2016-05-31 05:43:19.092 screenresolution[3238:24040] Display 0: 1600x1200x32@60 05:43:19 INFO - 2016-05-31 05:43:19.098 screenresolution[3239:24043] starting screenresolution argv=screenresolution list 05:43:19 INFO - Available Modes on Display 0 05:43:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:43:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:43:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:43:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:43:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:43:19 INFO - Intel Iris: 05:43:19 INFO - Chipset Model: Intel Iris 05:43:19 INFO - Type: GPU 05:43:19 INFO - Bus: Built-In 05:43:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:43:19 INFO - Vendor: Intel (0x8086) 05:43:19 INFO - Device ID: 0x0a2e 05:43:19 INFO - Revision ID: 0x0009 05:43:19 INFO - Displays: 05:43:19 INFO - Display: 05:43:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:43:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:43:19 INFO - Display Serial Number: 1600x1200 60 05:43:19 INFO - Main Display: Yes 05:43:19 INFO - Mirror: Off 05:43:19 INFO - Online: Yes 05:43:19 INFO - Rotation: Supported 05:43:19 INFO - Return code: 0 05:43:19 INFO - Running post-action listener: _resource_record_post_action 05:43:19 INFO - ##### 05:43:19 INFO - ##### Finished run-tests step (success) 05:43:19 INFO - ##### 05:43:19 INFO - Running post-run listener: _resource_record_post_run 05:43:19 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 225280; Write bytes: 704081408; Read time: 3; Write time: 1958 05:43:19 INFO - TinderboxPrint: CPU usage
54.6% 05:43:19 INFO - TinderboxPrint: I/O read bytes / time
225,280 / 3 05:43:19 INFO - TinderboxPrint: I/O write bytes / time
704,081,408 / 1,958 05:43:19 INFO - TinderboxPrint: CPU idle
2,196.2 (45.4%) 05:43:19 INFO - TinderboxPrint: CPU system
974.9 (20.2%) 05:43:19 INFO - TinderboxPrint: CPU user
1,666.4 (34.4%) 05:43:19 INFO - TinderboxPrint: Swap in / out
398,655,488 / 0 05:43:19 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399047168; Write bytes: 394413568; Read time: 29619; Write time: 818 05:43:19 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 225280; Write bytes: 300505088; Read time: 3; Write time: 1111 05:43:19 INFO - Running post-run listener: _upload_blobber_files 05:43:19 INFO - Blob upload gear active. 05:43:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:43:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:21 INFO - (blobuploader) - INFO - Done attempting. 05:43:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:43:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:43:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:22 INFO - (blobuploader) - INFO - Done attempting. 05:43:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:43:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:25 INFO - (blobuploader) - INFO - Done attempting. 05:43:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:25 INFO - Return code: 0 05:43:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/095618acce61535b51f18539c568a5702a24c14033c09a83cb588d53c70a376046bd4220e383392412b1c3a3d7b5c22128d4fe3ad8e77786ff7cbfdcb3552443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b924440428dc2e84d5faae9649177d875fd90b6174457343ae3eb44c4ae01a6e28d03db06b77fca4a7801ae39f0cc5af2eac40537ee2716b8301163c2af7898f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7b37bbaaa1f68bc682ebc68c106679e62167fcf9c64858bc84195135a8ec4f6d7cbe4cdc483c5c8b13dade59f41a431a1bcddbe73f45d10bfe95a04edb30f34"} 05:43:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:25 INFO - Contents: 05:43:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/095618acce61535b51f18539c568a5702a24c14033c09a83cb588d53c70a376046bd4220e383392412b1c3a3d7b5c22128d4fe3ad8e77786ff7cbfdcb3552443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b924440428dc2e84d5faae9649177d875fd90b6174457343ae3eb44c4ae01a6e28d03db06b77fca4a7801ae39f0cc5af2eac40537ee2716b8301163c2af7898f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7b37bbaaa1f68bc682ebc68c106679e62167fcf9c64858bc84195135a8ec4f6d7cbe4cdc483c5c8b13dade59f41a431a1bcddbe73f45d10bfe95a04edb30f34"} 05:43:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:25 INFO - Copying logs to upload dir... 05:43:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.440049 ========= master_lag: 1.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-05-31 05:43:27.169920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-05-31 05:43:27.173653) ========= 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.bR2mQdFmUo/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.3fdu3D7qOc/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/095618acce61535b51f18539c568a5702a24c14033c09a83cb588d53c70a376046bd4220e383392412b1c3a3d7b5c22128d4fe3ad8e77786ff7cbfdcb3552443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b924440428dc2e84d5faae9649177d875fd90b6174457343ae3eb44c4ae01a6e28d03db06b77fca4a7801ae39f0cc5af2eac40537ee2716b8301163c2af7898f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7b37bbaaa1f68bc682ebc68c106679e62167fcf9c64858bc84195135a8ec4f6d7cbe4cdc483c5c8b13dade59f41a431a1bcddbe73f45d10bfe95a04edb30f34"} build_url:https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/IBwVs9MmS7-7r3afpnLx5w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/095618acce61535b51f18539c568a5702a24c14033c09a83cb588d53c70a376046bd4220e383392412b1c3a3d7b5c22128d4fe3ad8e77786ff7cbfdcb3552443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b924440428dc2e84d5faae9649177d875fd90b6174457343ae3eb44c4ae01a6e28d03db06b77fca4a7801ae39f0cc5af2eac40537ee2716b8301163c2af7898f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7b37bbaaa1f68bc682ebc68c106679e62167fcf9c64858bc84195135a8ec4f6d7cbe4cdc483c5c8b13dade59f41a431a1bcddbe73f45d10bfe95a04edb30f34"}' ========= master_lag: 1.47 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-05-31 05:43:28.654566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 05:43:28.654909) ========= 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.bR2mQdFmUo/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.3fdu3D7qOc/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005277 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 05:43:28.716803) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-05-31 05:43:28.717109) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-05-31 05:43:32.428474) ========= ========= Total master_lag: 3.62 =========