builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0052 starttime: 1464872884.26 results: success (0) buildid: 20160602030245 builduid: 92531ca0f230476298410a1b7fd6f4da revision: 58ac3bd12914f8d2d683176139e5630b4e32c2ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.263400) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.264085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.264551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.293106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.293432) ========= 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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-06-02 06:08:04-- 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% 8.28M=0.001s 2016-06-02 06:08:04 (8.28 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.414444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.414755) ========= 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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.021159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:04.463188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 06:08:04.463546) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 58ac3bd12914f8d2d683176139e5630b4e32c2ca --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 58ac3bd12914f8d2d683176139e5630b4e32c2ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bbxfsQTJLS/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.z7lVIhH9fr/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-06-02 06:08:04,538 truncating revision to first 12 chars 2016-06-02 06:08:04,538 Setting DEBUG logging. 2016-06-02 06:08:04,538 attempt 1/10 2016-06-02 06:08:04,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/58ac3bd12914?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 06:08:05,336 unpacking tar archive at: fx-team-58ac3bd12914/testing/mozharness/ program finished with exit code 0 elapsedTime=1.064062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 06:08:05.547675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:05.548025) ========= script_repo_revision: 58ac3bd12914f8d2d683176139e5630b4e32c2ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:05.548448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:05.548780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 06:08:05.565813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-02 06:08:05.566136) ========= /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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:05 INFO - MultiFileLogger online at 20160602 06:08:05 in /builds/slave/test 06:08:05 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 06:08:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:08:05 INFO - {'append_to_log': False, 06:08:05 INFO - 'base_work_dir': '/builds/slave/test', 06:08:05 INFO - 'blob_upload_branch': 'Fx-Team', 06:08:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:08:05 INFO - 'branch': 'Fx-Team', 06:08:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:08:05 INFO - 'config_files': ('talos/mac_config.py',), 06:08:05 INFO - 'default_actions': ('clobber', 06:08:05 INFO - 'read-buildbot-config', 06:08:05 INFO - 'download-and-extract', 06:08:05 INFO - 'populate-webroot', 06:08:05 INFO - 'create-virtualenv', 06:08:05 INFO - 'install', 06:08:05 INFO - 'run-tests'), 06:08:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:08:05 INFO - 'download_minidump_stackwalk': True, 06:08:05 INFO - 'download_symbols': 'ondemand', 06:08:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:08:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:08:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:08:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:08:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:08:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:08:05 INFO - 'installer_path': 'installer.exe', 06:08:05 INFO - 'log_level': 'info', 06:08:05 INFO - 'log_name': 'talos', 06:08:05 INFO - 'log_to_console': True, 06:08:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:08:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:08:05 INFO - 'opt_config_files': (), 06:08:05 INFO - 'pip_index': False, 06:08:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:08:05 INFO - 'cmd': ('bash', 06:08:05 INFO - '-c', 06:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:08:05 INFO - 'enabled': True, 06:08:05 INFO - 'halt_on_failure': False, 06:08:05 INFO - 'name': 'check_screen_resolution'},), 06:08:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:08:05 INFO - 'cmd': ('bash', 06:08:05 INFO - '-c', 06:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:08:05 INFO - 'enabled': True, 06:08:05 INFO - 'halt_on_failure': False, 06:08:05 INFO - 'name': 'check_screen_resolution'},), 06:08:05 INFO - 'run_cmd_checks_enabled': True, 06:08:05 INFO - 'sps_profile': False, 06:08:05 INFO - 'sps_profile_interval': 0, 06:08:05 INFO - 'suite': 'dromaeojs-e10s', 06:08:05 INFO - 'system_bits': '32', 06:08:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:08:05 INFO - 'title': 't-yosemite-r7-0052', 06:08:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:08:05 INFO - 'use_talos_json': True, 06:08:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:08:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:08:05 INFO - 'work_dir': 'build'} 06:08:05 INFO - ##### 06:08:05 INFO - ##### Running clobber step. 06:08:05 INFO - ##### 06:08:05 INFO - Running pre-action listener: _resource_record_pre_action 06:08:05 INFO - Running main action method: clobber 06:08:05 INFO - rmtree: /builds/slave/test/build 06:08:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:08:07 INFO - Running post-action listener: _resource_record_post_action 06:08:07 INFO - ##### 06:08:07 INFO - ##### Finished clobber step (success) 06:08:07 INFO - ##### 06:08:07 INFO - ##### 06:08:07 INFO - ##### Running read-buildbot-config step. 06:08:07 INFO - ##### 06:08:07 INFO - Running pre-action listener: _resource_record_pre_action 06:08:07 INFO - Running main action method: read_buildbot_config 06:08:07 INFO - Using buildbot properties: 06:08:07 INFO - { 06:08:07 INFO - "project": "", 06:08:07 INFO - "product": "firefox", 06:08:07 INFO - "script_repo_revision": "production", 06:08:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:08:07 INFO - "repository": "", 06:08:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:08:07 INFO - "buildid": "20160602030245", 06:08:07 INFO - "pgo_build": "False", 06:08:07 INFO - "basedir": "/builds/slave/test", 06:08:07 INFO - "buildnumber": 12, 06:08:07 INFO - "slavename": "t-yosemite-r7-0052", 06:08:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:08:07 INFO - "platform": "yosemite_r7", 06:08:07 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:08:07 INFO - "branch": "fx-team", 06:08:07 INFO - "repo_path": "integration/fx-team", 06:08:07 INFO - "revision": "58ac3bd12914f8d2d683176139e5630b4e32c2ca", 06:08:07 INFO - "stage_platform": "macosx64", 06:08:07 INFO - "builduid": "92531ca0f230476298410a1b7fd6f4da", 06:08:07 INFO - "slavebuilddir": "test" 06:08:07 INFO - } 06:08:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:08:07 INFO - Running post-action listener: _resource_record_post_action 06:08:07 INFO - ##### 06:08:07 INFO - ##### Finished read-buildbot-config step (success) 06:08:07 INFO - ##### 06:08:07 INFO - ##### 06:08:07 INFO - ##### Running download-and-extract step. 06:08:07 INFO - ##### 06:08:07 INFO - Running pre-action listener: _resource_record_pre_action 06:08:07 INFO - Running main action method: download_and_extract 06:08:07 INFO - mkdir: /builds/slave/test/build/tests 06:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:07 INFO - https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:08 INFO - Downloaded 1199 bytes. 06:08:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:08:08 INFO - Using the following test package requirements: 06:08:08 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:08:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:08:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:08:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'jsshell-mac.zip'], 06:08:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:08:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:08:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:08:08 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:08:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:08:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:08 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:08:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:08 INFO - https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:09 INFO - Downloaded 18713675 bytes. 06:08:09 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'] 06:08:09 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 06:08:13 INFO - Return code: 0 06:08:13 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 06:08: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')]} 06:08:13 INFO - https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:14 INFO - Downloaded 18713675 bytes. 06:08:14 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'] 06:08:14 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 06:08:18 INFO - Return code: 0 06:08: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')]} 06:08:18 INFO - https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:19 INFO - Downloaded 10834055 bytes. 06:08:19 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'] 06:08:19 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 06:08:19 INFO - Return code: 0 06:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:19 INFO - https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu2jFzmSQBCetguT19P3mA/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 06:08:22 INFO - Downloaded 111074527 bytes. 06:08:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:22 INFO - mkdir: /builds/slave/test/properties 06:08:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:08:22 INFO - Writing to file /builds/slave/test/properties/build_url 06:08:22 INFO - Contents: 06:08:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:23 INFO - Running post-action listener: _resource_record_post_action 06:08:23 INFO - Running post-action listener: set_extra_try_arguments 06:08:23 INFO - ##### 06:08:23 INFO - ##### Finished download-and-extract step (success) 06:08:23 INFO - ##### 06:08:23 INFO - ##### 06:08:23 INFO - ##### Running populate-webroot step. 06:08:23 INFO - ##### 06:08:23 INFO - Running pre-action listener: _resource_record_pre_action 06:08:23 INFO - Running main action method: populate_webroot 06:08:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:08:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:08:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:08:23 INFO - '--tppagecycles', 06:08:23 INFO - '7'], 06:08:23 INFO - 'tests': ['tsvgm']}}, 06:08:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:08:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:08:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:08:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:08:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['damp', 'tps']}, 06:08:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'tests': ['damp', 'tps']}, 06:08:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['dromaeo_dom']}, 06:08:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:08:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['a11yr', 06:08:23 INFO - 'ts_paint', 06:08:23 INFO - 'tpaint', 06:08:23 INFO - 'sessionrestore', 06:08:23 INFO - 'sessionrestore_no_auto_restore', 06:08:23 INFO - 'tabpaint']}, 06:08:23 INFO - 'other-e10s': {'tests': ['a11yr', 06:08:23 INFO - 'ts_paint', 06:08:23 INFO - 'tpaint', 06:08:23 INFO - 'sessionrestore', 06:08:23 INFO - 'sessionrestore_no_auto_restore', 06:08:23 INFO - 'tabpaint']}, 06:08:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:08:23 INFO - 'ts_paint', 06:08:23 INFO - 'tpaint', 06:08:23 INFO - 'sessionrestore', 06:08:23 INFO - 'sessionrestore_no_auto_restore', 06:08:23 INFO - 'tabpaint']}, 06:08:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:08:23 INFO - 'ts_paint', 06:08:23 INFO - 'tpaint', 06:08:23 INFO - 'sessionrestore', 06:08:23 INFO - 'sessionrestore_no_auto_restore', 06:08:23 INFO - 'tabpaint']}, 06:08:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['a11yr', 06:08:23 INFO - 'ts_paint', 06:08:23 INFO - 'tpaint', 06:08:23 INFO - 'sessionrestore', 06:08:23 INFO - 'sessionrestore_no_auto_restore', 06:08:23 INFO - 'tabpaint']}, 06:08:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['a11yr', 06:08:23 INFO - 'ts_paint', 06:08:23 INFO - 'tpaint', 06:08:23 INFO - 'sessionrestore', 06:08:23 INFO - 'sessionrestore_no_auto_restore', 06:08:23 INFO - 'tabpaint']}, 06:08:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['tsvgx', 06:08:23 INFO - 'tsvgr_opacity', 06:08:23 INFO - 'tart', 06:08:23 INFO - 'tscrollx', 06:08:23 INFO - 'cart']}, 06:08:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:08:23 INFO - 'tsvgr_opacity', 06:08:23 INFO - 'tart', 06:08:23 INFO - 'tscrollx', 06:08:23 INFO - 'cart']}, 06:08:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'talos_options': ['--disable-e10s'], 06:08:23 INFO - 'tests': ['tp5o']}, 06:08:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'tests': ['tp5o']}, 06:08:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'talos_options': ['--disable-e10s', 06:08:23 INFO - '--xperf_path', 06:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:23 INFO - 'tests': ['tp5n']}, 06:08:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:23 INFO - 'talos_options': ['--xperf_path', 06:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:23 INFO - 'tests': ['tp5n']}}, 06:08:23 INFO - 'talos.zip': {'path': '', 06:08:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:08:23 INFO - Running post-action listener: _resource_record_post_action 06:08:23 INFO - ##### 06:08:23 INFO - ##### Finished populate-webroot step (success) 06:08:23 INFO - ##### 06:08:23 INFO - ##### 06:08:23 INFO - ##### Running create-virtualenv step. 06:08:23 INFO - ##### 06:08:23 INFO - Running pre-action listener: _resource_record_pre_action 06:08:23 INFO - Running main action method: create_virtualenv 06:08:23 INFO - Creating virtualenv /builds/slave/test/build/venv 06:08:23 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 06:08:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:08:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:08:23 INFO - Using real prefix '/tools/python27' 06:08:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:08:24 INFO - Installing distribute.............................................................................................................................................................................................done. 06:08:26 INFO - Installing pip.................done. 06:08:26 INFO - Return code: 0 06:08:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:26 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:26 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 06:08:26 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 06:08:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:26 INFO - 'HOME': '/Users/cltbld', 06:08:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:26 INFO - 'LOGNAME': 'cltbld', 06:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:26 INFO - 'MOZ_NO_REMOTE': '1', 06:08:26 INFO - 'NO_EM_RESTART': '1', 06:08:26 INFO - 'PAGER': '/bin/cat', 06:08:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:26 INFO - 'PWD': '/builds/slave/test', 06:08:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:26 INFO - 'SHELL': '/bin/bash', 06:08:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:26 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:26 INFO - 'USER': 'cltbld', 06:08:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:26 INFO - 'XPC_FLAGS': '0x0', 06:08:26 INFO - 'XPC_SERVICE_NAME': '0', 06:08:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:27 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 06:08:27 INFO - Cleaning up... 06:08:27 INFO - Return code: 0 06:08:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:08:27 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')]} 06:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:27 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')]} 06:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:27 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:27 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 06:08:27 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 06:08:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:27 INFO - 'HOME': '/Users/cltbld', 06:08:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:27 INFO - 'LOGNAME': 'cltbld', 06:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:27 INFO - 'MOZ_NO_REMOTE': '1', 06:08:27 INFO - 'NO_EM_RESTART': '1', 06:08:27 INFO - 'PAGER': '/bin/cat', 06:08:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:27 INFO - 'PWD': '/builds/slave/test', 06:08:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:27 INFO - 'SHELL': '/bin/bash', 06:08:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:27 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:27 INFO - 'USER': 'cltbld', 06:08:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:27 INFO - 'XPC_FLAGS': '0x0', 06:08:27 INFO - 'XPC_SERVICE_NAME': '0', 06:08:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:27 INFO - Downloading/unpacking psutil>=3.1.1 06:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:08:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:30 INFO - Installing collected packages: psutil 06:08:30 INFO - Running setup.py install for psutil 06:08:30 INFO - building 'psutil._psutil_osx' extension 06:08:30 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 06:08:30 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 06:08:30 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 06:08:30 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 06:08:30 INFO - building 'psutil._psutil_posix' extension 06:08:30 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 06:08:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:08:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:08:30 INFO - ^ 06:08:31 INFO - 1 warning generated. 06:08:31 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 06:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:31 INFO - Successfully installed psutil 06:08:31 INFO - Cleaning up... 06:08:31 INFO - Return code: 0 06:08:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:08:31 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')]} 06:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:31 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')]} 06:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:31 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:31 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 06:08:31 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 06:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:31 INFO - 'HOME': '/Users/cltbld', 06:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:31 INFO - 'LOGNAME': 'cltbld', 06:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:31 INFO - 'MOZ_NO_REMOTE': '1', 06:08:31 INFO - 'NO_EM_RESTART': '1', 06:08:31 INFO - 'PAGER': '/bin/cat', 06:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:31 INFO - 'PWD': '/builds/slave/test', 06:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:31 INFO - 'SHELL': '/bin/bash', 06:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:31 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:31 INFO - 'USER': 'cltbld', 06:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:31 INFO - 'XPC_FLAGS': '0x0', 06:08:31 INFO - 'XPC_SERVICE_NAME': '0', 06:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:08:31 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 06:08:31 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 06:08:31 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 06:08:31 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 06:08:31 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 06:08:31 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 06:08:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:08:34 INFO - Installing collected packages: mozsystemmonitor 06:08:34 INFO - Running setup.py install for mozsystemmonitor 06:08:34 INFO - Successfully installed mozsystemmonitor 06:08:34 INFO - Cleaning up... 06:08:34 INFO - Return code: 0 06:08:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:08:34 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')]} 06:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:34 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')]} 06:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:34 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:34 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 06:08:34 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 06:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:34 INFO - 'HOME': '/Users/cltbld', 06:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:34 INFO - 'LOGNAME': 'cltbld', 06:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:34 INFO - 'MOZ_NO_REMOTE': '1', 06:08:34 INFO - 'NO_EM_RESTART': '1', 06:08:34 INFO - 'PAGER': '/bin/cat', 06:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:34 INFO - 'PWD': '/builds/slave/test', 06:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:34 INFO - 'SHELL': '/bin/bash', 06:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:34 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:34 INFO - 'USER': 'cltbld', 06:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:34 INFO - 'XPC_FLAGS': '0x0', 06:08:34 INFO - 'XPC_SERVICE_NAME': '0', 06:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:08:34 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 06:08:34 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 06:08:34 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 06:08:34 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 06:08:34 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 06:08:34 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 06:08:36 INFO - Downloading blobuploader-1.2.4.tar.gz 06:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:08:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:08:37 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 06:08:37 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 06:08:37 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 06:08:37 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 06:08:37 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 06:08:37 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 06:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:08:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:08:37 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 06:08:37 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 06:08:37 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 06:08:37 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 06:08:37 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 06:08:37 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 06:08:38 INFO - Downloading docopt-0.6.1.tar.gz 06:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:08:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:08:38 INFO - Running setup.py install for blobuploader 06:08:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:08:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:08:38 INFO - Running setup.py install for requests 06:08:38 INFO - Running setup.py install for docopt 06:08:39 INFO - Successfully installed blobuploader requests docopt 06:08:39 INFO - Cleaning up... 06:08:39 INFO - Return code: 0 06:08:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:39 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:39 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 06:08:39 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 06:08:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:39 INFO - 'HOME': '/Users/cltbld', 06:08:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:39 INFO - 'LOGNAME': 'cltbld', 06:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:39 INFO - 'MOZ_NO_REMOTE': '1', 06:08:39 INFO - 'NO_EM_RESTART': '1', 06:08:39 INFO - 'PAGER': '/bin/cat', 06:08:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:39 INFO - 'PWD': '/builds/slave/test', 06:08:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:39 INFO - 'SHELL': '/bin/bash', 06:08:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:39 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:39 INFO - 'USER': 'cltbld', 06:08:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:39 INFO - 'XPC_FLAGS': '0x0', 06:08:39 INFO - 'XPC_SERVICE_NAME': '0', 06:08:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:39 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ZTlfPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:39 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-FE4n7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:39 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-JDO5ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:39 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-u9DuuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:39 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-b__aDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:39 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-jwWF0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:39 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-sywDHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-MGeirj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-qDNF9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-7jYneS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-yqIkod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-weWqZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-YZ8R6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-R0Wjul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-r4PgmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:40 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-I5PdM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-rE1aAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:08:41 INFO - Running setup.py install for manifestparser 06:08:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Running setup.py install for mozcrash 06:08:41 INFO - Running setup.py install for mozdebug 06:08:41 INFO - Running setup.py install for mozdevice 06:08:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Running setup.py install for mozfile 06:08:41 INFO - Running setup.py install for mozhttpd 06:08:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Running setup.py install for mozinfo 06:08:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Running setup.py install for mozInstall 06:08:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Running setup.py install for mozleak 06:08:42 INFO - Running setup.py install for mozlog 06:08:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Running setup.py install for moznetwork 06:08:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Running setup.py install for mozprocess 06:08:42 INFO - Running setup.py install for mozprofile 06:08:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:08:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:08:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:08:43 INFO - Running setup.py install for mozrunner 06:08:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:08:43 INFO - Running setup.py install for mozscreenshot 06:08:43 INFO - Running setup.py install for moztest 06:08:43 INFO - Running setup.py install for mozversion 06:08:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:08:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:08:43 INFO - Cleaning up... 06:08:43 INFO - Return code: 0 06:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:43 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:43 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 06:08:43 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 06:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:43 INFO - 'HOME': '/Users/cltbld', 06:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:43 INFO - 'LOGNAME': 'cltbld', 06:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:43 INFO - 'MOZ_NO_REMOTE': '1', 06:08:43 INFO - 'NO_EM_RESTART': '1', 06:08:43 INFO - 'PAGER': '/bin/cat', 06:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:43 INFO - 'PWD': '/builds/slave/test', 06:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:43 INFO - 'SHELL': '/bin/bash', 06:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:43 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:43 INFO - 'USER': 'cltbld', 06:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:43 INFO - 'XPC_FLAGS': '0x0', 06:08:43 INFO - 'XPC_SERVICE_NAME': '0', 06:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-lXgFxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-EgukPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Z2er_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-5dU5ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-PwAj73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zkrujf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-2eon86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-glM3i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-GMP0aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:44 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)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:44 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-LnF1qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:45 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)) 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:45 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-xdxT1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:45 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)) 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:45 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-RrZ_t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:45 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)) 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:45 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-aTb3AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:45 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)) 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:45 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-lX_oli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:45 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)) 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:45 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-I9SHae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:45 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)) 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:45 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-SDN14n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:45 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)) 06:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:45 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-hy7mEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:45 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)) 06:08:45 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)) 06:08:45 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)) 06:08:45 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)) 06:08:45 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)) 06:08:45 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)) 06:08:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:08:45 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 06:08:45 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 06:08:45 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 06:08:45 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 06:08:45 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 06:08:45 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 06:08:48 INFO - Downloading blessings-1.6.tar.gz 06:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:08:48 INFO - Installing collected packages: blessings 06:08:48 INFO - Running setup.py install for blessings 06:08:48 INFO - Successfully installed blessings 06:08:48 INFO - Cleaning up... 06:08:48 INFO - Return code: 0 06:08:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:48 INFO - Reading from file tmpfile_stdout 06:08:48 INFO - Current package versions: 06:08:48 INFO - blessings == 1.6 06:08:48 INFO - blobuploader == 1.2.4 06:08:48 INFO - docopt == 0.6.1 06:08:48 INFO - manifestparser == 1.1 06:08:48 INFO - mozInstall == 1.12 06:08:48 INFO - mozcrash == 0.17 06:08:48 INFO - mozdebug == 0.1 06:08:48 INFO - mozdevice == 0.48 06:08:48 INFO - mozfile == 1.2 06:08:48 INFO - mozhttpd == 0.7 06:08:48 INFO - mozinfo == 0.9 06:08:48 INFO - mozleak == 0.1 06:08:48 INFO - mozlog == 3.2 06:08:48 INFO - moznetwork == 0.27 06:08:48 INFO - mozprocess == 0.22 06:08:48 INFO - mozprofile == 0.28 06:08:48 INFO - mozrunner == 6.11 06:08:48 INFO - mozscreenshot == 0.1 06:08:48 INFO - mozsystemmonitor == 0.3 06:08:48 INFO - moztest == 0.7 06:08:48 INFO - mozversion == 1.4 06:08:48 INFO - psutil == 3.1.1 06:08:48 INFO - requests == 1.2.3 06:08:48 INFO - wsgiref == 0.1.2 06:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:48 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:48 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 06:08:48 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 06:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:48 INFO - 'HOME': '/Users/cltbld', 06:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:48 INFO - 'LOGNAME': 'cltbld', 06:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:48 INFO - 'MOZ_NO_REMOTE': '1', 06:08:48 INFO - 'NO_EM_RESTART': '1', 06:08:48 INFO - 'PAGER': '/bin/cat', 06:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:48 INFO - 'PWD': '/builds/slave/test', 06:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:48 INFO - 'SHELL': '/bin/bash', 06:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:48 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:48 INFO - 'USER': 'cltbld', 06:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:48 INFO - 'XPC_FLAGS': '0x0', 06:08:48 INFO - 'XPC_SERVICE_NAME': '0', 06:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 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)) 06:08:49 INFO - Cleaning up... 06:08:49 INFO - Return code: 0 06:08:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:49 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:49 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 06:08:49 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 06:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:49 INFO - 'HOME': '/Users/cltbld', 06:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:49 INFO - 'LOGNAME': 'cltbld', 06:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:49 INFO - 'MOZ_NO_REMOTE': '1', 06:08:49 INFO - 'NO_EM_RESTART': '1', 06:08:49 INFO - 'PAGER': '/bin/cat', 06:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:49 INFO - 'PWD': '/builds/slave/test', 06:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:49 INFO - 'SHELL': '/bin/bash', 06:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:49 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:49 INFO - 'USER': 'cltbld', 06:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:49 INFO - 'XPC_FLAGS': '0x0', 06:08:49 INFO - 'XPC_SERVICE_NAME': '0', 06:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:49 INFO - Downloading/unpacking jsonschema 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:08:51 INFO - Downloading/unpacking functools32 (from jsonschema) 06:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:52 INFO - Downloading functools32-3.2.3-2.tar.gz 06:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:08:52 INFO - warning: no files found matching '*.txt' 06:08:52 INFO - no previously-included directories found matching 'build' 06:08:52 INFO - no previously-included directories found matching 'dist' 06:08:52 INFO - no previously-included directories found matching '.git*' 06:08:52 INFO - Installing collected packages: jsonschema, functools32 06:08:52 INFO - Running setup.py install for functools32 06:08:52 INFO - warning: no files found matching '*.txt' 06:08:52 INFO - no previously-included directories found matching 'build' 06:08:52 INFO - no previously-included directories found matching 'dist' 06:08:52 INFO - no previously-included directories found matching '.git*' 06:08:52 INFO - Successfully installed jsonschema functools32 06:08:52 INFO - Cleaning up... 06:08:52 INFO - Return code: 0 06:08:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:52 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 0x1054f1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054f7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f8d96400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, '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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 06:08:52 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 06:08:52 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 06:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:52 INFO - 'HOME': '/Users/cltbld', 06:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:52 INFO - 'LOGNAME': 'cltbld', 06:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:52 INFO - 'MOZ_NO_REMOTE': '1', 06:08:52 INFO - 'NO_EM_RESTART': '1', 06:08:52 INFO - 'PAGER': '/bin/cat', 06:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:52 INFO - 'PWD': '/builds/slave/test', 06:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:52 INFO - 'SHELL': '/bin/bash', 06:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:08:52 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:52 INFO - 'USER': 'cltbld', 06:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:52 INFO - 'XPC_FLAGS': '0x0', 06:08:52 INFO - 'XPC_SERVICE_NAME': '0', 06:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:52 INFO - Downloading/unpacking flake8 06:08:52 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 06:08:52 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 06:08:52 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 06:08:52 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 06:08:52 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 06:08:52 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 06:08:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:08:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:08:55 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 06:08:55 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 06:08:55 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 06:08:55 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 06:08:55 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 06:08:55 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 06:08:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:08:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:08:55 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 06:08:55 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 06:08:55 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 06:08:55 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 06:08:55 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 06:08:55 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 06:08:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:56 INFO - no previously-included directories found matching 'docs/_build' 06:08:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:08:56 INFO - Running setup.py install for pep8 06:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:56 INFO - no previously-included directories found matching 'docs/_build' 06:08:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:08:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:08:56 INFO - Cleaning up... 06:08:56 INFO - Return code: 0 06:08:56 INFO - Running post-action listener: _resource_record_post_action 06:08:56 INFO - Running post-action listener: _start_resource_monitoring 06:08:56 INFO - Starting resource monitoring. 06:08:56 INFO - ##### 06:08:56 INFO - ##### Finished create-virtualenv step (success) 06:08:56 INFO - ##### 06:08:56 INFO - ##### 06:08:56 INFO - ##### Running install step. 06:08:56 INFO - ##### 06:08:56 INFO - Running pre-action listener: _resource_record_pre_action 06:08:56 INFO - Running main action method: install 06:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:57 INFO - Reading from file tmpfile_stdout 06:08:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:08:57 INFO - Reading from file tmpfile_stdout 06:08:57 INFO - Output received: 06:08:57 INFO - Usage: mozinstall [options] installer 06:08:57 INFO - Options: 06:08:57 INFO - -h, --help show this help message and exit 06:08:57 INFO - -d DEST, --destination=DEST 06:08:57 INFO - Directory to install application into. [default: 06:08:57 INFO - "/builds/slave/test"] 06:08:57 INFO - --app=APP Application being installed. [default: firefox] 06:08:57 INFO - mkdir: /builds/slave/test/build/application 06:08:57 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'] 06:08:57 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 06:09:31 INFO - Reading from file tmpfile_stdout 06:09:31 INFO - Output received: 06:09:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:09:31 INFO - Running post-action listener: _resource_record_post_action 06:09:31 INFO - ##### 06:09:31 INFO - ##### Finished install step (success) 06:09:31 INFO - ##### 06:09:31 INFO - ##### 06:09:31 INFO - ##### Running run-tests step. 06:09:31 INFO - ##### 06:09:31 INFO - Running pre-action listener: _resource_record_pre_action 06:09:31 INFO - Running main action method: run_tests 06:09:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:09:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:09:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:09:31 INFO - 2016-06-02 06:09:31.834 screenresolution[2220:28157] starting screenresolution argv=screenresolution get 06:09:31 INFO - 2016-06-02 06:09:31.836 screenresolution[2220:28157] Display 0: 1600x1200x32@60 06:09:31 INFO - 2016-06-02 06:09:31.842 screenresolution[2221:28159] starting screenresolution argv=screenresolution list 06:09:31 INFO - Available Modes on Display 0 06:09:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:09:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:09:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:09:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:09:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:09:32 INFO - Intel Iris: 06:09:32 INFO - Chipset Model: Intel Iris 06:09:32 INFO - Type: GPU 06:09:32 INFO - Bus: Built-In 06:09:32 INFO - VRAM (Dynamic, Max): 1536 MB 06:09:32 INFO - Vendor: Intel (0x8086) 06:09:32 INFO - Device ID: 0x0a2e 06:09:32 INFO - Revision ID: 0x0009 06:09:32 INFO - Displays: 06:09:32 INFO - Display: 06:09:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:09:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:09:32 INFO - Display Serial Number: 1600x1200 60 06:09:32 INFO - Main Display: Yes 06:09:32 INFO - Mirror: Off 06:09:32 INFO - Online: Yes 06:09:32 INFO - Rotation: Supported 06:09:32 INFO - Return code: 0 06:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:09:32 INFO - Python 2.7.3 06:09:32 INFO - Return code: 0 06:09:32 INFO - grabbing minidump binary from tooltool 06:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1051b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:09:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:09:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:09:32 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 06:09:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:09:32 INFO - Return code: 0 06:09:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:09:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:09:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:09:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:09:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:09:33 INFO - Return code: 0 06:09:33 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/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 06:09:33 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/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --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 06:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bbxfsQTJLS/Render', 06:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:33 INFO - 'HOME': '/Users/cltbld', 06:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:33 INFO - 'LOGNAME': 'cltbld', 06:09:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:09:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:33 INFO - 'MOZ_NO_REMOTE': '1', 06:09:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:09:33 INFO - 'NO_EM_RESTART': '1', 06:09:33 INFO - 'PAGER': '/bin/cat', 06:09:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:33 INFO - 'PWD': '/builds/slave/test', 06:09:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:33 INFO - 'SHELL': '/bin/bash', 06:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z7lVIhH9fr/Listeners', 06:09:33 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 06:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:33 INFO - 'USER': 'cltbld', 06:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:33 INFO - 'XPC_FLAGS': '0x0', 06:09:33 INFO - 'XPC_SERVICE_NAME': '0', 06:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:33 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/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 06:09:33 INFO - mozversion application_buildid: 20160602030245 06:09:33 INFO - mozversion application_changeset: 58ac3bd12914f8d2d683176139e5630b4e32c2ca 06:09:33 INFO - mozversion application_display_name: Nightly 06:09:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:09:33 INFO - mozversion application_name: Firefox 06:09:33 INFO - mozversion application_remotingname: firefox 06:09:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:09:33 INFO - mozversion application_vendor: Mozilla 06:09:33 INFO - mozversion application_version: 49.0a1 06:09:33 INFO - mozversion platform_buildid: 20160602030245 06:09:33 INFO - mozversion platform_changeset: 58ac3bd12914f8d2d683176139e5630b4e32c2ca 06:09:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:09:33 INFO - mozversion platform_version: 49.0a1 06:09:33 INFO - using testdate: 1464872973 06:09:33 INFO - actual date: 1464872973 06:09:33 INFO - starting webserver on 'localhost:59768' 06:09:33 INFO - SUITE-START | Running 2 tests 06:09:33 INFO - TEST-START | dromaeo_css 06:09:33 INFO - operating with platform_type : mac_ 06:09:33 INFO - Initialising browser for dromaeo_css test... 06:09:33 INFO - TEST-INFO | started process 2239 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpN89_In/profile http://localhost:59768/getInfo.html) 06:09:36 INFO - PROCESS | 2239 | __metrics Screen width/height:1600/1200 06:09:36 INFO - PROCESS | 2239 | colorDepth:24 06:09:36 INFO - PROCESS | 2239 | Browser inner width/height: 1024/689 06:09:36 INFO - PROCESS | 2239 | __metrics 06:09:36 ERROR - PROCESS | 2239 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:09:37 INFO - TEST-INFO | 2239: exit 0 06:09:37 INFO - Browser initialized. 06:09:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:09:37 INFO - TEST-INFO | started process 2242 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpN89_In/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:49 INFO - PROCESS | 2242 | RSS: Main: 252915712 06:09:49 INFO - PROCESS | 2242 | 06:10:39 INFO - PROCESS | 2242 | 1464873039142 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] 06:12:49 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:59768/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59768/tests/dromaeo/cssquery-ext.html) 06:12:51 INFO - PROCESS | 2242 | RSS: Main: 265453568 06:12:51 INFO - PROCESS | 2242 | 06:15:53 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:59768/tests/dromaeo/cssquery-ext.html (next: http://localhost:59768/tests/dromaeo/cssquery-jquery.html) 06:15:54 INFO - PROCESS | 2242 | RSS: Main: 276721664 06:15:54 INFO - PROCESS | 2242 | 06:18:55 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:59768/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59768/tests/dromaeo/cssquery-mootools.html) 06:18:56 INFO - PROCESS | 2242 | RSS: Main: 278827008 06:18:56 INFO - PROCESS | 2242 | 06:21:58 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:59768/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59768/tests/dromaeo/cssquery-prototype.html) 06:21:58 INFO - PROCESS | 2242 | RSS: Main: 280104960 06:21:58 INFO - PROCESS | 2242 | 06:25:01 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:59768/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59768/tests/dromaeo/cssquery-yui.html) 06:25:02 INFO - PROCESS | 2242 | RSS: Main: 283947008 06:25:02 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:59768/tests/dromaeo/cssquery-yui.html (next: http://localhost:59768/tests/dromaeo/cssquery-dojo.html) 06:28:05 INFO - PROCESS | 2242 | RSS: Main: 284192768 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | __start_tp_report 06:28:05 INFO - PROCESS | 2242 | _x_x_mozilla_page_load 06:28:05 INFO - PROCESS | 2242 | _x_x_mozilla_page_load_details 06:28:05 INFO - PROCESS | 2242 | |i|pagename|runs| 06:28:05 INFO - PROCESS | 2242 | |0;dojo.html;3425.7773244739074;3484.7734897231676;3494.6155922848484;3495.1786330212394;3513.069036705272;5249.4750524947485;5292.700899591004;5548.69482178481;5668.801591944288;5760.539156867451;5625.662460252388;5715.057015592422;5748.425157484249;5771.422857714227;5823.5341172706185;4732.739699316537;4923.163062279403;5134.409542902567;5186.559142472895;5303.522682958533;179.92912297665248;5136.743162841862;5207.6354655174155;5243.895122097556;5281.128613778722;5206.557442617382;5223.112070947929;5227.137522308814;5231.476852314776;5251.343582052244;5248.685078895279;5284.9735751320995;5288;5292.153255479105;5346.6524675896335;4722.787474563653;4804.879878003043;5136.049830781318;5161.870953226162;5224.791008359661;4495.168393847116;4957.256411538262;5622.943770562283;5624.465675760796;5742.799002034909;6135.938640613582;6218.253809542839;6221.191245138103;6277.2153480814895;6322.304546499881;6184.783532576384;6210.254769427697;6237.157983672191;6284;6297.086922396273;5852.209951656514;5868.735906884158;5880.353161152269;5888.205092312526;5932.7330270137945;6198.876022479525;6215.906761398583;6368.745250189941;6402.135711678957;6420.903686444707;5974.701264936823;6102.549845102896;6147.508199344042;6170.56806023583;6181.8454538636;6272.5922815016875;6297.874042519215;6319.842003949846;6335.873282534323;6345.460635845912;5791.507721843691;6112.449879510866;6188.907166392508;6229.657368844757;6261.592996455216;6225.035119556476;6252.3122456529745;6275.811725648238;6291.087792270187;6329.588576742497;4887.780049897763;4941.50584941503;4945.4807245238735;4948.925766113512;4954.603631709455;4295.742255464682;4379.802908869108;4403.713758605681;4440.711353761995;4461.063176732922;5677.120046392815;5786.363500014995;5792.681402522818;5808.5062769665055;5883.117532370093;6224.253089629274;6263.78076767311;6277.686115694197;6278.215223097113;6284.277308109535;5917.644941303535;5936.347001829795;5948.345681974979;5951.702414879239;5983;5326.840194794162;5378.78484860609;5397.460253974649;5418.701971391612;5457.7271136443815;6397.6481293529305;6440.710168042356;6447.709853056624;6450.709718062699;6457.321981192001;6269.185005949197;6291.402316779899;6302.810915672537;6310.558260921692;6316.84207894788;6269.592476489013;6270.278917924497;6287.46556542699;6319.873602527831;6393.360663933569;6159.476444502267;6168.845778855564;6184.628922264678;6199.56603037783;6206.968965155145;6228.501719862309;6252.437280644764;6270.12218289449;6271.122042914087;6276.435120839146;6007.579469437097;6118.816435506942;6123.099607467949;6132.5707200495535;6170.352113028068;4967.379077615298;6121.112438696453;6126.295476020315;6155.322914479314;6190.3190649029475;4513.75174365413;4517.435320584927;5435.537979271806;5895.968205563923;6008.789692360747;5658.151277308437;6114.908276375769;6159.260888693386;6159.907601385893;6202.627842329474;6017.488513476404;6043.116618570694;6043.8186854394435;6071.423214794764;6087.634741915499 06:28:05 INFO - PROCESS | 2242 | |1;ext.html;490.9484504127067;511.25612234199247;560.4787547580751;561.0238185557132;576.9269159363586;33423.99728008164;33699.83150084249;38181.04547386313;39906.2018759625;39970;37020.444693329555;41326.17347653045;42527.78736106323;42611.36082958758;42731.572684273146;9332.393394429375;9545.331826772128;9588.089131532493;9614.75963100921;9627.085426884434;9485.95257023714;9530.285228607847;9573.329866909318;9579.425234485918;9581.90418095817;9512.57193426294;9551.522423878812;9569.904300957005;9603.903960960371;9643.469609171492;9499.192568631675;9503.952480237624;9554.61781528738;9573.377730447499;9575.281853860919;9392.389494682891;9431.292653051049;9490.478023708692;9508.809823803555;9537.14165725088;37759;37820.62179378198;38163.618363816284;38767.612323876965;39224.803875980724;2749.911893617126;3290.68738469845;3439.098267044054;3518.313928783888;3610.2238018825815;29673.109806705834;30132.24669383261;30188.698113018807;30309.090727278217;30416.935407260862;3124.812511249332;3151.700588444094;3169.793963392372;3175.872965081394;3277.72139368154;442233;443666;447448;448263;449287.75356123334;34928.476072858924;35023.12442188965;35111.82444087815;35187.296254074776;35223.94328170159;35260.11849703726;36138.638613613526;36258.274834503165;36496.27007459889;36500;16861.578460538585;17183.398581049853;17378.131093445278;17445.7383139253;17448.302067917393;13220.669483262995;13223.272720000492;13225.801612975813;13258.469661213636;13274.734505310033;20313;20481.692774608393;20523.58952820965;20731.689024664644;20763.792362076187;7841.843163136706;8546.401751877309;8555.486670799772;8559.871601925975;8596.355273354398;817.0685418622775;888.2627419242143;980.857775622545;1021.2953062386929;1035.9488213337634;30748.38503229923;30902;30971.845140774603;31689.683103169133;31855.203619909687;881.7751473374377;917.1837065012145;1045.4668119259234;1104;1120.0007985745406;15914.76127858083;16071.357145714273;16092;16260.469365160365;16272;526227;639449;642716;653304;653527.7323613352;59788;61219;61673.07490387648;61794.69102654458;61818.69090654518;1366.4943970730894;1395.448797724893;1412.4844431782326;1431.3487363249697;1432.9211893345966;30353;30651.386972260876;30733.078007659806;31267.53098703567;31403.214919627193;52120;53168;53414.73292633512;53801.73099134479;53923.92152157013;565363;571716;572644;576598;585472;27257.45485090327;27504.724952750217;27551.862240688668;27833.860830695718;28144;49926.50073499219;49956.500434995185;50289;51051.97896041984;51149.97700045904;38871;39785.60214397819;41346.79326603468;41829.79085104555;41944.79027604842;40105.79947100246;40513.79743101384;40660.39009414802;41248.587514124476;41295.1740965185;32668.67331326656;35225.471617925235;37863.43204851985;38247.42628860625;39123.41314880336;33054;35129.29741405106;35398.115047124025;35861.46207806937;35865;22562.661560076285;25681.22956311314;26108.608370874834;26113.347166320993;26650 06:28:05 INFO - PROCESS | 2242 | |2;jquery.html;351.8803606773698;370.8720491430456;380.8267238406525;382.7531242348683;399.3769719237987;19501.024948752558;20819.583608327863;21296;21802;21824.672629910543;20302.086406111725;20885;21088.89455552724;21299.893500532515;21374.893125534352;5482.23248745176;5772.971135144318;5836.6206196597295;6002.459778619924;6018.3078945921125;5979.910301345483;6006.189164462807;6018.51851851853;6027.63834169949;6039.214902062726;4776.450708168553;5195.714235717034;5818;5881.029630111027;5889.558283128783;4958.677685950402;5742.454466825645;5754.597178197528;5763.394843541451;5897.174395584621;4916.237983112624;5004.249362595603;5029.949700503022;5086.92369614456;5122.180451127839;26099.08653197148;26159.73840261592;26299.605505917425;26775.661216939076;26844;2295.31140657802;2365.751596082404;2570.6015567587056;2577.9613305800426;2953.9556906646417;15677.686446271011;15946.920265398714;16014.279357428828;16056.598585035468;16109.83890161095;1826.97259541107;1827.7075667893207;1867.327762005677;1904.6476401865561;1912.2828939147819;86262.56868715616;115502.42248788786;116049;116514;117363.41318293354;8774.38579299443;8937.865932011026;10710;11173.497192626352;11236.381998989971;13865.514706985206;13989.740923316951;14011.649708757363;14028;14029.649258768612;8663;8700.042490439728;8834;8932.821343573092;8972.19250267479;8919.687810926587;8940.240079593308;8950.731478055668;9050.185483306534;9062.229710474552;5780.942190578125;6547.869042619121;6852.862942741217;6859.314068593101;6909.042191601419;1887.169645356039;1911.4361263427322;1913.6268427656473;1922.327185485069;1943.465546974565;768.404486522938;961.9855702164473;1049.338916482611;1060.6552870317023;1104.823228283487;19550.804491955183;19800;21070.894645526674;21242.977352743073;21688.34934951954;866.8959724833061;1027.9897201028043;1035.285652899512;1072.3565860483802;1114.2979922648678;11302.830457543143;11791.88208117908;11798.997085247678;11819.40902954866;11819.88180118205;582606;589493;598324;598774;599632;65828.34171658318;116174.41912790382;118256.8174318263;118552;121408;957.9664711735056;992.8064027514565;995.6515219673201;997.6807421625156;998.4308943902051;17101.828981710023;18580.349687760863;19806.20775168977;20111.79888201158;20174.89912550428;42172.57827421687;44280.778596106815;55519.444805553045;56291.71854140703;56386.8722625537;72447;76752;76926;78926;79179.60410198143;6713;8264.462809917337;8493.490390576586;8607.096254893397;8614.267787238156;11568.190226684388;12531.561395351118;13248.933755331162;13339.333033348488;13619;9843.261755368232;10426.426546540013;10728.517216725422;11441.942790285995;11821.99513041401;8247.587620618826;11236.438178091226;11238.775224495628;11301.15241356885;11369.31784092957;11640.06879449625;11798.941005294919;11856.822147667619;11896.988755955841;11930.105242106703;7080.575165490087;8365.121662225622;8460.788480288042;8477.025142108736;8597.914020859711;9867.358621689567;11048;11505.367204803817;11849.05207583374;11868.406579671155 06:28:05 INFO - PROCESS | 2242 | |3;mootools.html;1550.2403822127158;1598.5284341119373;1780.545960780001;1869.3270422647852;1956.7554055743033;8013.759587212393;8537.615807288672;8654.134586541342;9027.684031058907;9029.593668284926;8712.390132690698;8796.07641197673;8873.866891996626;8895.822083558325;8900.51047192404;1982.7025946108056;2366.325597204797;2402.7356990731005;2406.927792166238;2414.6860908081926;2371.134535894395;2386.9641955370685;2400.9039638414442;2409.4337830609793;2410.7950824179966;2339.485313231095;2382.059086660768;2383.6782034425305;2393.3059412770276;2404.1705611563984;2335.112657190257;2342.8711420871846;2345.1909091363455;2364.089825417218;2390.2829151254728;2328.557574060923;2354.5526349993615;2359.6106642403984;2362.5038741864228;2363.7045369328835;8789.252913502296;8875.778105547348;8876.378653494257;8877.023527411979;8928.687495937676;5248.71132087735;5415.620906536544;5416.756245968902;5423.891522169534;5433.1850222466555;3254.300325430044;3422.828858557062;3641.0533261351975;3669.4679271505483;3680.245549662313;934.434667026446;1064.6699523147772;1081.145894743152;1089.2919602258596;1094.6825420628008;11497.827532587018;11671.299722016705;11672.299662020307;11672.533098676044;11731.354775487345;3910.8240129194255;4689.6717229793585;4790.904181916342;4838.588719958772;4852.50096200457;8251.711190108437;9787.755306117262;9824.214062874953;9892.505374731234;9905.158061564847;5308.761105750251;5350.545203657655;5391.3799913009725;5398.73006349681;5411.5129638331955;4153.958460415418;4451.9760455094865;4685.695429797052;4948.356713627278;4953.18272485036;3958.4656071430563;3965.0682089708894;4048.3320252158064;4093.16090201508;4144.839444955417;1299.402274953532;1323.9536616218386;1332.2938842413537;1333.1201407071287;1334.9733005339838;812.5652775764937;820.8917960753055;826.5362686094351;842.4692443760392;858.6565373850385;5735.053716136791;5935.139404786281;5999;6058.909116363258;6117.908231376533;973.5424350555228;990.8563258327646;1006.6426418621284;1008.7679833638305;1025.369397820335;3934.822932967966;4016.477857878457;4031.6169963853386;4036.535798383165;4132.318167502389;10307.330023548595;10384.844227336596;10658.147348212124;10683.679489615324;10691.786164276671;10455.268131230741;10565.841512377321;10602.893971060344;10603.257771956043;10619;7740.954971078945;8054.798630034296;8200.835983280302;8232.34141268697;8289.668413263522;6018.2778066630535;6031.155638210566;6068.271807383142;6090.269167699905;6213.316535181036;9485.146336829719;9861.211103111591;9867;9989.051040151175;9998.350107243297;9773.853392199266;10106.242031847494;10127.59489620407;10145.442000690033;10189.898101019191;6946.131733533309;7338.596377199092;7398.186199517941;7603;7627.809304767426;8404.369672274726;8431.367647426345;8487.278581320657;8500.192481714228;8501.87247191305;7380.114386273682;7477.4391920605085;7532.096148462219;7561.659725312485;7630.8855367170645;7218.133823941161;7240.818979525554;7246.528975616779;7285.125784905633;7444.851102977802;6149.938500614937;6943.305669433016;7046.189688185924;7053.788386348418;7077.68150433242;4867.58625516835;4941.234108713155;5070.087384270867;5074.441811400669;5092.465291144376;5043.52086551777;5077.847664570068;5108.897822043464;5121.180611102206;5223.164293712987 06:28:05 INFO - PROCESS | 2242 | |4;prototype.html;300.3542383874669;308.6327270548048;312.53588421194513;319.08900090242344;319.5574129830184;5265.314689508349;5307.787688492465;5331.360236771593;5435.565154787618;5557.888842223153;4980.750962451872;5402.270693456382;5451.437824222619;5454.7272636368125;5457.781688732456;3316.286998295366;4143.585641435848;4151.107511884944;4176.770277634729;4181.790910454481;3388.559487266652;3840.3855383138703;4092.4679791627045;4144.46122004139;4200.823769344588;4032.556418793945;4062.573429789874;4079.9192411869863;4093.8362465501345;4127.649149822269;3476.913077173091;4092.877213683594;4107.685540627001;4129.6076872697195;4140.751554906685;2965.4958657028355;2968.435997160554;3140.6702296259023;3279.4916787897914;3563.251717139404;4863.537963893425;5239.13554263546;5272.762725677354;5302.2311764793885;5316.308879845596;3919.8432062717457;4651.348811166439;4653.6044436222965;4657.510961349078;4666.580007799314;4868.561829435333;5464.808731694372;5646.237757902672;5726.513246374063;5772.7113644317615;3232.7252183564424;3274.4269752793402;3742.2515496900455;3844.9231015379537;3855.51806024247;5358.624896257264;5724.914126288109;6060.757544703325;6061.666433384648;6072.360462675098;3373.0555444475585;3463.7055850252505;3708.4066549351974;3891.7664940103687;3944.4083387491532;3856.5345168836225;3968.3650615901315;3972.7020473464604;3985.5815139410524;4016.9196616068098;3715.9628403715615;3745.5505339358906;4606.907861842745;4617.492075871652;4640.8375706850775;4641.280601506772;5238.337879287437;5481.588880833953;5503;5760.946698249934;1323.1862404621088;1346.6969931765275;1353.4789106194187;1357.0839683213792;1361.6936189357316;780.812604974802;787.0791174326052;818.4802650317091;835.8996920369594;838.1618381618382;3866;4240.660747140221;4510.616597589176;4527.501974782771;4578.954210457853;4215.915681686349;4300.78496075195;4762.9523704762505;5008.69947803133;5051.792112008828;4010.8997275067773;4411.426514553087;4520.570545798144;4549.452306708254;4550.6587005974025;1999.1896512535632;2326.9883650581637;2416.2509622017233;2550.8827673031337;2585.203283717798;4374.343848422762;4486.5962063414445;4764.523547645277;4821.662483626183;5174.896502069938;4659;4726.432828060655;4906.9263961040615;5057;5146.897062058738;4647.373419303217;4861.156223609158;5177.611679124156;5194.740262986911;5222.503862133091;4406.955930440655;4757.595604373667;4761.523847615349;4885.8045678172475;5045.873853153554;4363.407356314986;4371.109712355942;4408.140412619508;4901.950980490149;4993.450720420678;4698.906021879611;4984;5027.321311622884;5177.741112944413;5183.626339020238;2832.730890565393;2919.9270018249713;3096.7677424192825;3423.400904841593;3426.1434641339665;4643.814247430065;4681.695689780289;4970.484002379165;5030.5221004006025;5721.628094173865;5120.078385890575;5240.947590524046;5683.715814209356;5743.8564035899435;5776.393478684678;4847.854564363075;5662.57530685192;5694.17434471991;5719.2279042328755;5732.792874743337;5084.9745751271;5297.847780570554;5558.805441809517;5597.496225339739;5597.608167428404;4717.599004084554;4960;5170;5752.353917198136;5780.7398667060925;4435.556444355539;4996.725180115129;5075.172937742336;5603.411641777555;5669.773209071591 06:28:05 INFO - PROCESS | 2242 | |5;yui.html;702.9156501219854;718.9604571748554;754.1779460388183;758.188738050286;775.7982924439644;15204.391824327027;15634.452794152206;15684.294206760695;15975.92012039941;15987.76018359724;13302.733945321088;13489.797653035212;13585.796213056812;13622.931885340584;13653.726925461484;711.6015031582305;889.1952782731622;903.3089686389917;916.051886297682;919.0028818731685;902.9548522573845;924.1405492891608;924.8289066522681;925.8796356473649;929.9538019727806;843.4601854812925;953.1755031897428;975.229568640773;976.1361195342138;977.501474248135;867.8958524977044;941.7174847545709;964.2478866484154;969.6024629901707;971.3006635222629;701.642162497125;716.4089626058523;718.7232915327585;720.772956518695;721.2354903801935;15566.299516521784;15680.294386752623;15723.37106515738;15742.527724168292;15746.68506629861;14633.634159146;14657.48698795537;14671.266436678123;14708.117512949257;14893.925530372388;11235.606753763579;11331.093512518979;11917.702057448547;12436.626901192978;12482.563110291187;3841.750286231386;4035.5762644922156;4052.3111071117983;4056.776877271749;4065.8170382332864;106434;110084.9999999992;110122.63957563616;110389.34415983767;112074;11197.60808371703;11307.208495405243;11392.772144557062;11437.826812905521;11705.122115841175;22392.776072239394;23389.298321050395;23420.64869026966;23421.765782341958;23689.40776480602;6922.480813938974;7756.961215193888;8087.393445491612;8223.17768223173;8279.668813247523;4343.02392411452;4403.801828917706;4449.644028477714;4490.3040028795585;4602.4477062752685;3576.338377400189;3623.0942264433893;3626.437902125175;3677.6506231907924;3681.006128345332;504.88640055987844;640.3404493371835;647.0811447744214;663.7842701122155;665.065582856088;666.1772710702279;670.6713710282024;686.4131167851515;697.3479796390391;709.6026225313738;9185.540722963959;9282.164605185566;9689.176420004238;9727.56225969833;9768.609255629695;665.2715276771927;677.7880723172073;691.2534462780185;704.2007321689919;709.4324540367685;3833.616638336144;4602.447706275201;4648.349231107648;4704.95295047052;4725.456572494207;115108;140500;146460.14159433503;149845;150264;125771;126954.36522817326;127387.3630631841;128204.35897820452;130214.34892825475;82285.58857205795;111707.88292116974;112010;112273.87726122634;114005.28992065125;9059.22996545301;9076.455412675261;9082.682106126254;9091.409058411182;9152;60295.69852150711;60331.19006429814;60366.094508581526;60738.696306518184;61633.07550386838;86733.13266867503;88613.66439855241;92551.07448925424;92939;94145.5292723532;12061.457234424297;12116.232165533796;12317.815232771694;12440.626781196579;12718.554850580185;12998.935005324913;13199.538016169772;13342.332883355988;13530.458781648624;14025;10961.890381096087;11965.675513869348;12213.69465763363;12298.938505307417;12705.555305564261;12344.321062341658;12432.564860229848;12505.373871486725;12513.186642868184;12847.743045138857;12276.324802135969;12294.231498294035;12402.13185077036;12506.499740010298;12598.811017834923;8640.827183456422;10304.227182961158;10490.580376784843;10558.577656893638;11031.613893513688;10290.223045925766;10427.895721042692;10612.257142000295;10620.52207650642;10781.62264320745 06:28:05 INFO - PROCESS | 2242 | __end_tp_report 06:28:05 INFO - PROCESS | 2242 | __start_cc_report 06:28:05 INFO - PROCESS | 2242 | _x_x_mozilla_cycle_collect,432 06:28:05 INFO - PROCESS | 2242 | __end_cc_report 06:28:05 INFO - PROCESS | 2242 | __startTimestamp1464874085343__endTimestamp 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | ------- Summary: start ------- 06:28:05 INFO - PROCESS | 2242 | Number of tests: 6 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | [#0] dojo.html Cycles:165 Average:5695.17 Median:5983.00 stddev:802.00 (13.4%) stddev-sans-first:784.45 06:28:05 INFO - PROCESS | 2242 | Values: 3425.8 3484.8 3494.6 3495.2 3513.1 5249.5 5292.7 5548.7 5668.8 5760.5 5625.7 5715.1 5748.4 5771.4 5823.5 4732.7 4923.2 5134.4 5186.6 5303.5 179.9 5136.7 5207.6 5243.9 5281.1 5206.6 5223.1 5227.1 5231.5 5251.3 5248.7 5285.0 5288.0 5292.2 5346.7 4722.8 4804.9 5136.0 5161.9 5224.8 4495.2 4957.3 5622.9 5624.5 5742.8 6135.9 6218.3 6221.2 6277.2 6322.3 6184.8 6210.3 6237.2 6284.0 6297.1 5852.2 5868.7 5880.4 5888.2 5932.7 6198.9 6215.9 6368.7 6402.1 6420.9 5974.7 6102.5 6147.5 6170.6 6181.8 6272.6 6297.9 6319.8 6335.9 6345.5 5791.5 6112.4 6188.9 6229.7 6261.6 6225.0 6252.3 6275.8 6291.1 6329.6 4887.8 4941.5 4945.5 4948.9 4954.6 4295.7 4379.8 4403.7 4440.7 4461.1 5677.1 5786.4 5792.7 5808.5 5883.1 6224.3 6263.8 6277.7 6278.2 6284.3 5917.6 5936.3 5948.3 5951.7 5983.0 5326.8 5378.8 5397.5 5418.7 5457.7 6397.6 6440.7 6447.7 6450.7 6457.3 6269.2 6291.4 6302.8 6310.6 6316.8 6269.6 6270.3 6287.5 6319.9 6393.4 6159.5 6168.8 6184.6 6199.6 6207.0 6228.5 6252.4 6270.1 6271.1 6276.4 6007.6 6118.8 6123.1 6132.6 6170.4 4967.4 6121.1 6126.3 6155.3 6190.3 4513.8 4517.4 5435.5 5896.0 6008.8 5658.2 6114.9 6159.3 6159.9 6202.6 6017.5 6043.1 6043.8 6071.4 6087.6 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | [#1] ext.html Cycles:180 Average:67464.02 Median:38507.52 stddev:147967.70 (384.3%) stddev-sans-first:148297.35 06:28:05 INFO - PROCESS | 2242 | Values: 490.9 511.3 560.5 561.0 576.9 33424.0 33699.8 38181.0 39906.2 39970.0 37020.4 41326.2 42527.8 42611.4 42731.6 9332.4 9545.3 9588.1 9614.8 9627.1 9486.0 9530.3 9573.3 9579.4 9581.9 9512.6 9551.5 9569.9 9603.9 9643.5 9499.2 9504.0 9554.6 9573.4 9575.3 9392.4 9431.3 9490.5 9508.8 9537.1 37759.0 37820.6 38163.6 38767.6 39224.8 2749.9 3290.7 3439.1 3518.3 3610.2 29673.1 30132.2 30188.7 30309.1 30416.9 3124.8 3151.7 3169.8 3175.9 3277.7 442233.0 443666.0 447448.0 448263.0 449287.8 34928.5 35023.1 35111.8 35187.3 35223.9 35260.1 36138.6 36258.3 36496.3 36500.0 16861.6 17183.4 17378.1 17445.7 17448.3 13220.7 13223.3 13225.8 13258.5 13274.7 20313.0 20481.7 20523.6 20731.7 20763.8 7841.8 8546.4 8555.5 8559.9 8596.4 817.1 888.3 980.9 1021.3 1035.9 30748.4 30902.0 30971.8 31689.7 31855.2 881.8 917.2 1045.5 1104.0 1120.0 15914.8 16071.4 16092.0 16260.5 16272.0 526227.0 639449.0 642716.0 653304.0 653527.7 59788.0 61219.0 61673.1 61794.7 61818.7 1366.5 1395.4 1412.5 1431.3 1432.9 30353.0 30651.4 30733.1 31267.5 31403.2 52120.0 53168.0 53414.7 53801.7 53923.9 565363.0 571716.0 572644.0 576598.0 585472.0 27257.5 27504.7 27551.9 27833.9 28144.0 49926.5 49956.5 50289.0 51052.0 51150.0 38871.0 39785.6 41346.8 41829.8 41944.8 40105.8 40513.8 40660.4 41248.6 41295.2 32668.7 35225.5 37863.4 38247.4 39123.4 33054.0 35129.3 35398.1 35861.5 35865.0 22562.7 25681.2 26108.6 26113.3 26650.0 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | [#2] jquery.html Cycles:180 Average:34331.56 Median:26229.67 stddev:98509.36 (375.6%) stddev-sans-first:98752.66 06:28:05 INFO - PROCESS | 2242 | Values: 351.9 370.9 380.8 382.8 399.4 19501.0 20819.6 21296.0 21802.0 21824.7 20302.1 20885.0 21088.9 21299.9 21374.9 5482.2 5773.0 5836.6 6002.5 6018.3 5979.9 6006.2 6018.5 6027.6 6039.2 4776.5 5195.7 5818.0 5881.0 5889.6 4958.7 5742.5 5754.6 5763.4 5897.2 4916.2 5004.2 5029.9 5086.9 5122.2 26099.1 26159.7 26299.6 26775.7 26844.0 2295.3 2365.8 2570.6 2578.0 2954.0 15677.7 15946.9 16014.3 16056.6 16109.8 1827.0 1827.7 1867.3 1904.6 1912.3 86262.6 115502.4 116049.0 116514.0 117363.4 8774.4 8937.9 10710.0 11173.5 11236.4 13865.5 13989.7 14011.6 14028.0 14029.6 8663.0 8700.0 8834.0 8932.8 8972.2 8919.7 8940.2 8950.7 9050.2 9062.2 5780.9 6547.9 6852.9 6859.3 6909.0 1887.2 1911.4 1913.6 1922.3 1943.5 768.4 962.0 1049.3 1060.7 1104.8 19550.8 19800.0 21070.9 21243.0 21688.3 866.9 1028.0 1035.3 1072.4 1114.3 11302.8 11791.9 11799.0 11819.4 11819.9 582606.0 589493.0 598324.0 598774.0 599632.0 65828.3 116174.4 118256.8 118552.0 121408.0 958.0 992.8 995.7 997.7 998.4 17101.8 18580.3 19806.2 20111.8 20174.9 42172.6 44280.8 55519.4 56291.7 56386.9 72447.0 76752.0 76926.0 78926.0 79179.6 6713.0 8264.5 8493.5 8607.1 8614.3 11568.2 12531.6 13248.9 13339.3 13619.0 9843.3 10426.4 10728.5 11441.9 11822.0 8247.6 11236.4 11238.8 11301.2 11369.3 11640.1 11798.9 11856.8 11897.0 11930.1 7080.6 8365.1 8460.8 8477.0 8597.9 9867.4 11048.0 11505.4 11849.1 11868.4 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | [#3] mootools.html Cycles:180 Average:5714.78 Median:5076.14 stddev:3164.03 (62.3%) stddev-sans-first:3157.42 06:28:05 INFO - PROCESS | 2242 | Values: 1550.2 1598.5 1780.5 1869.3 1956.8 8013.8 8537.6 8654.1 9027.7 9029.6 8712.4 8796.1 8873.9 8895.8 8900.5 1982.7 2366.3 2402.7 2406.9 2414.7 2371.1 2387.0 2400.9 2409.4 2410.8 2339.5 2382.1 2383.7 2393.3 2404.2 2335.1 2342.9 2345.2 2364.1 2390.3 2328.6 2354.6 2359.6 2362.5 2363.7 8789.3 8875.8 8876.4 8877.0 8928.7 5248.7 5415.6 5416.8 5423.9 5433.2 3254.3 3422.8 3641.1 3669.5 3680.2 934.4 1064.7 1081.1 1089.3 1094.7 11497.8 11671.3 11672.3 11672.5 11731.4 3910.8 4689.7 4790.9 4838.6 4852.5 8251.7 9787.8 9824.2 9892.5 9905.2 5308.8 5350.5 5391.4 5398.7 5411.5 4154.0 4452.0 4685.7 4948.4 4953.2 3958.5 3965.1 4048.3 4093.2 4144.8 1299.4 1324.0 1332.3 1333.1 1335.0 812.6 820.9 826.5 842.5 858.7 5735.1 5935.1 5999.0 6058.9 6117.9 973.5 990.9 1006.6 1008.8 1025.4 3934.8 4016.5 4031.6 4036.5 4132.3 10307.3 10384.8 10658.1 10683.7 10691.8 10455.3 10565.8 10602.9 10603.3 10619.0 7741.0 8054.8 8200.8 8232.3 8289.7 6018.3 6031.2 6068.3 6090.3 6213.3 9485.1 9861.2 9867.0 9989.1 9998.4 9773.9 10106.2 10127.6 10145.4 10189.9 6946.1 7338.6 7398.2 7603.0 7627.8 8404.4 8431.4 8487.3 8500.2 8501.9 7380.1 7477.4 7532.1 7561.7 7630.9 7218.1 7240.8 7246.5 7285.1 7444.9 6149.9 6943.3 7046.2 7053.8 7077.7 4867.6 4941.2 5070.1 5074.4 5092.5 5043.5 5077.8 5108.9 5121.2 5223.2 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | [#4] prototype.html Cycles:180 Average:4281.83 Median:4658.26 stddev:1332.01 (28.6%) stddev-sans-first:1301.79 06:28:05 INFO - PROCESS | 2242 | Values: 300.4 308.6 312.5 319.1 319.6 5265.3 5307.8 5331.4 5435.6 5557.9 4980.8 5402.3 5451.4 5454.7 5457.8 3316.3 4143.6 4151.1 4176.8 4181.8 3388.6 3840.4 4092.5 4144.5 4200.8 4032.6 4062.6 4079.9 4093.8 4127.6 3476.9 4092.9 4107.7 4129.6 4140.8 2965.5 2968.4 3140.7 3279.5 3563.3 4863.5 5239.1 5272.8 5302.2 5316.3 3919.8 4651.3 4653.6 4657.5 4666.6 4868.6 5464.8 5646.2 5726.5 5772.7 3232.7 3274.4 3742.3 3844.9 3855.5 5358.6 5724.9 6060.8 6061.7 6072.4 3373.1 3463.7 3708.4 3891.8 3944.4 3856.5 3968.4 3972.7 3985.6 4016.9 3716.0 3745.6 4606.9 4617.5 4640.8 4641.3 5238.3 5481.6 5503.0 5760.9 1323.2 1346.7 1353.5 1357.1 1361.7 780.8 787.1 818.5 835.9 838.2 3866.0 4240.7 4510.6 4527.5 4579.0 4215.9 4300.8 4763.0 5008.7 5051.8 4010.9 4411.4 4520.6 4549.5 4550.7 1999.2 2327.0 2416.3 2550.9 2585.2 4374.3 4486.6 4764.5 4821.7 5174.9 4659.0 4726.4 4906.9 5057.0 5146.9 4647.4 4861.2 5177.6 5194.7 5222.5 4407.0 4757.6 4761.5 4885.8 5045.9 4363.4 4371.1 4408.1 4902.0 4993.5 4698.9 4984.0 5027.3 5177.7 5183.6 2832.7 2919.9 3096.8 3423.4 3426.1 4643.8 4681.7 4970.5 5030.5 5721.6 5120.1 5240.9 5683.7 5743.9 5776.4 4847.9 5662.6 5694.2 5719.2 5732.8 5085.0 5297.8 5558.8 5597.5 5597.6 4717.6 4960.0 5170.0 5752.4 5780.7 4435.6 4996.7 5075.2 5603.4 5669.8 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - PROCESS | 2242 | [#5] yui.html Cycles:180 Average:24332.46 Median:3652.04 stddev:38630.75 (1057.8%) stddev-sans-first:38698.38 06:28:05 INFO - PROCESS | 2242 | Values: 702.9 719.0 754.2 758.2 775.8 15204.4 15634.5 15684.3 15975.9 15987.8 13302.7 13489.8 13585.8 13622.9 13653.7 711.6 889.2 903.3 916.1 919.0 903.0 924.1 924.8 925.9 930.0 843.5 953.2 975.2 976.1 977.5 867.9 941.7 964.2 969.6 971.3 701.6 716.4 718.7 720.8 721.2 15566.3 15680.3 15723.4 15742.5 15746.7 14633.6 14657.5 14671.3 14708.1 14893.9 11235.6 11331.1 11917.7 12436.6 12482.6 3841.8 4035.6 4052.3 4056.8 4065.8 106434.0 110085.0 110122.6 110389.3 112074.0 11197.6 11307.2 11392.8 11437.8 11705.1 22392.8 23389.3 23420.6 23421.8 23689.4 6922.5 7757.0 8087.4 8223.2 8279.7 4343.0 4403.8 4449.6 4490.3 4602.4 3576.3 3623.1 3626.4 3677.7 3681.0 504.9 640.3 647.1 663.8 665.1 666.2 670.7 686.4 697.3 709.6 9185.5 9282.2 9689.2 9727.6 9768.6 665.3 677.8 691.3 704.2 709.4 3833.6 4602.4 4648.3 4705.0 4725.5 115108.0 140500.0 146460.1 149845.0 150264.0 125771.0 126954.4 127387.4 128204.4 130214.3 82285.6 111707.9 112010.0 112273.9 114005.3 9059.2 9076.5 9082.7 9091.4 9152.0 60295.7 60331.2 60366.1 60738.7 61633.1 86733.1 88613.7 92551.1 92939.0 94145.5 12061.5 12116.2 12317.8 12440.6 12718.6 12998.9 13199.5 13342.3 13530.5 14025.0 10961.9 11965.7 12213.7 12298.9 12705.6 12344.3 12432.6 12505.4 12513.2 12847.7 12276.3 12294.2 12402.1 12506.5 12598.8 8640.8 10304.2 10490.6 10558.6 11031.6 10290.2 10427.9 10612.3 10620.5 10781.6 06:28:05 INFO - PROCESS | 2242 | -------- Summary: end -------- 06:28:05 INFO - PROCESS | 2242 | 06:28:05 INFO - TEST-INFO | 2242: exit 0 06:28:05 INFO - TEST-OK | dromaeo_css | took 1112409ms 06:28:05 INFO - TEST-START | kraken 06:28:05 INFO - operating with platform_type : mac_ 06:28:05 INFO - Initialising browser for kraken test... 06:28:05 INFO - TEST-INFO | started process 2246 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpq4loma/profile http://localhost:59768/getInfo.html) 06:28:08 INFO - PROCESS | 2246 | __metrics Screen width/height:1600/1200 06:28:08 INFO - PROCESS | 2246 | colorDepth:24 06:28:08 INFO - PROCESS | 2246 | Browser inner width/height: 1024/689 06:28:08 INFO - PROCESS | 2246 | __metrics 06:28:08 ERROR - PROCESS | 2246 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:28:09 INFO - TEST-INFO | 2246: exit 0 06:28:09 INFO - Browser initialized. 06:28:09 INFO - Running cycle 1/1 for kraken test... 06:28:09 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpq4loma/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:21 INFO - PROCESS | 2248 | RSS: Main: 253247488 06:28:21 INFO - PROCESS | 2248 | 06:28:24 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59768/tests/kraken/driver.html?testName=audio-beat-detection) 06:28:25 INFO - PROCESS | 2248 | RSS: Main: 266018816 06:28:25 INFO - PROCESS | 2248 | 06:28:28 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59768/tests/kraken/driver.html?testName=audio-dft) 06:28:28 INFO - PROCESS | 2248 | RSS: Main: 270438400 06:28:28 INFO - PROCESS | 2248 | 06:28:32 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59768/tests/kraken/driver.html?testName=audio-fft) 06:28:32 INFO - PROCESS | 2248 | RSS: Main: 270065664 06:28:32 INFO - PROCESS | 2248 | 06:28:35 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59768/tests/kraken/driver.html?testName=audio-oscillator) 06:28:35 INFO - PROCESS | 2248 | RSS: Main: 271015936 06:28:35 INFO - PROCESS | 2248 | 06:28:37 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59768/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:28:38 INFO - PROCESS | 2248 | RSS: Main: 271577088 06:28:38 INFO - PROCESS | 2248 | 06:28:41 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59768/tests/kraken/driver.html?testName=imaging-darkroom) 06:28:41 INFO - PROCESS | 2248 | RSS: Main: 271781888 06:28:41 INFO - PROCESS | 2248 | 06:28:44 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59768/tests/kraken/driver.html?testName=imaging-desaturate) 06:28:45 INFO - PROCESS | 2248 | RSS: Main: 272048128 06:28:45 INFO - PROCESS | 2248 | 06:28:48 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59768/tests/kraken/driver.html?testName=json-parse-financial) 06:28:49 INFO - PROCESS | 2248 | RSS: Main: 272257024 06:28:49 INFO - PROCESS | 2248 | 06:28:50 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59768/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:28:51 INFO - PROCESS | 2248 | RSS: Main: 272019456 06:28:51 INFO - PROCESS | 2248 | 06:28:53 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:28:53 INFO - PROCESS | 2248 | RSS: Main: 271978496 06:28:53 INFO - PROCESS | 2248 | 06:28:56 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:28:56 INFO - PROCESS | 2248 | RSS: Main: 272343040 06:28:56 INFO - PROCESS | 2248 | 06:28:59 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:29:00 INFO - PROCESS | 2248 | RSS: Main: 272887808 06:29:00 INFO - PROCESS | 2248 | 06:29:03 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:29:03 INFO - PROCESS | 2248 | RSS: Main: 272719872 06:29:03 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:59768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59768/tests/kraken/driver.html?testName=ai-astar) 06:29:05 INFO - PROCESS | 2248 | RSS: Main: 273461248 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | __start_tp_report 06:29:05 INFO - PROCESS | 2248 | _x_x_mozilla_page_load 06:29:05 INFO - PROCESS | 2248 | _x_x_mozilla_page_load_details 06:29:05 INFO - PROCESS | 2248 | |i|pagename|runs| 06:29:05 INFO - PROCESS | 2248 | |0;ai-astar;123;152;126;116;118;115;114;115;114;121 06:29:05 INFO - PROCESS | 2248 | |1;audio-beat-detection;160;124;134;189;146;161;167;151;182;147 06:29:05 INFO - PROCESS | 2248 | |2;audio-dft;272;255;207;193;201;228;196;215;194;169 06:29:05 INFO - PROCESS | 2248 | |3;audio-fft;74;77;91;164;84;81;84;64;134;82 06:29:05 INFO - PROCESS | 2248 | |4;audio-oscillator;70;72;127;69;73;80;115;69;83;135 06:29:05 INFO - PROCESS | 2248 | |5;imaging-gaussian-blur;90;74;117;128;94;73;134;126;89;87 06:29:05 INFO - PROCESS | 2248 | |6;imaging-darkroom;96;98;97;96;123;152;96;95;95;98 06:29:05 INFO - PROCESS | 2248 | |7;imaging-desaturate;97;93;91;91;92;99;91;95;93;91 06:29:05 INFO - PROCESS | 2248 | |8;json-parse-financial;57;54;57;55;58;57;55;58;58;55 06:29:05 INFO - PROCESS | 2248 | |9;json-stringify-tinderbox;69;72;72;70;82;83;78;71;71;72 06:29:05 INFO - PROCESS | 2248 | |10;stanford-crypto-aes;97;106;110;88;85;92;111;106;124;89 06:29:05 INFO - PROCESS | 2248 | |11;stanford-crypto-ccm;148;151;156;149;151;139;137;161;168;163 06:29:05 INFO - PROCESS | 2248 | |12;stanford-crypto-pbkdf2;170;172;170;165;168;163;166;169;163;166 06:29:05 INFO - PROCESS | 2248 | |13;stanford-crypto-sha256-iterative;65;70;68;68;64;66;66;65;69;62 06:29:05 INFO - PROCESS | 2248 | __end_tp_report 06:29:05 INFO - PROCESS | 2248 | __start_cc_report 06:29:05 INFO - PROCESS | 2248 | _x_x_mozilla_cycle_collect,1102 06:29:05 INFO - PROCESS | 2248 | __end_cc_report 06:29:05 INFO - PROCESS | 2248 | __startTimestamp1464874145685__endTimestamp 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | ------- Summary: start ------- 06:29:05 INFO - PROCESS | 2248 | Number of tests: 14 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#0] ai-astar Cycles:10 Average:121.40 Median:119.50 stddev:11.51 (9.6%) stddev-sans-first:12.19 06:29:05 INFO - PROCESS | 2248 | Values: 123.0 152.0 126.0 116.0 118.0 115.0 114.0 115.0 114.0 121.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:160.50 stddev:20.11 (12.5%) stddev-sans-first:21.28 06:29:05 INFO - PROCESS | 2248 | Values: 160.0 124.0 134.0 189.0 146.0 161.0 167.0 151.0 182.0 147.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#2] audio-dft Cycles:10 Average:213.00 Median:211.00 stddev:30.98 (14.7%) stddev-sans-first:24.42 06:29:05 INFO - PROCESS | 2248 | Values: 272.0 255.0 207.0 193.0 201.0 228.0 196.0 215.0 194.0 169.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#3] audio-fft Cycles:10 Average:93.50 Median:81.50 stddev:30.93 (37.9%) stddev-sans-first:31.99 06:29:05 INFO - PROCESS | 2248 | Values: 74.0 77.0 91.0 164.0 84.0 81.0 84.0 64.0 134.0 82.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:71.00 stddev:25.94 (36.5%) stddev-sans-first:26.56 06:29:05 INFO - PROCESS | 2248 | Values: 70.0 72.0 127.0 69.0 73.0 80.0 115.0 69.0 83.0 135.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#5] imaging-gaussian-blur Cycles:10 Average:101.20 Median:80.50 stddev:22.90 (28.5%) stddev-sans-first:23.93 06:29:05 INFO - PROCESS | 2248 | Values: 90.0 74.0 117.0 128.0 94.0 73.0 134.0 126.0 89.0 87.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:96.00 stddev:18.67 (19.4%) stddev-sans-first:19.54 06:29:05 INFO - PROCESS | 2248 | Values: 96.0 98.0 97.0 96.0 123.0 152.0 96.0 95.0 95.0 98.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:93.00 stddev:2.83 (3.0%) stddev-sans-first:2.67 06:29:05 INFO - PROCESS | 2248 | Values: 97.0 93.0 91.0 91.0 92.0 99.0 91.0 95.0 93.0 91.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.51 (2.6%) stddev-sans-first:1.58 06:29:05 INFO - PROCESS | 2248 | Values: 57.0 54.0 57.0 55.0 58.0 57.0 55.0 58.0 58.0 55.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:72.00 stddev:5.08 (7.1%) stddev-sans-first:5.05 06:29:05 INFO - PROCESS | 2248 | Values: 69.0 72.0 72.0 70.0 82.0 83.0 78.0 71.0 71.0 72.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#10] stanford-crypto-aes Cycles:10 Average:100.80 Median:86.50 stddev:12.59 (14.5%) stddev-sans-first:13.27 06:29:05 INFO - PROCESS | 2248 | Values: 97.0 106.0 110.0 88.0 85.0 92.0 111.0 106.0 124.0 89.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:153.50 stddev:9.97 (6.5%) stddev-sans-first:10.45 06:29:05 INFO - PROCESS | 2248 | Values: 148.0 151.0 156.0 149.0 151.0 139.0 137.0 161.0 168.0 163.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:168.50 stddev:3.08 (1.8%) stddev-sans-first:3.10 06:29:05 INFO - PROCESS | 2248 | Values: 170.0 172.0 170.0 165.0 168.0 163.0 166.0 169.0 163.0 166.0 06:29:05 INFO - PROCESS | 2248 | 06:29:05 INFO - PROCESS | 2248 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.45 (3.7%) stddev-sans-first:2.55 06:29:05 INFO - PROCESS | 2248 | Values: 65.0 70.0 68.0 68.0 64.0 66.0 66.0 65.0 69.0 62.0 06:29:05 INFO - PROCESS | 2248 | -------- Summary: end -------- 06:29:05 INFO - PROCESS | 2248 | 06:29:06 INFO - TEST-INFO | 2248: exit 0 06:29:06 INFO - TEST-OK | kraken | took 60675ms 06:29:06 INFO - SUITE-END | took 1173s 06:29:06 INFO - Completed test suite (00:19:33) 06:29:06 INFO - javascript benchmark 06:29:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7293.87248061738, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3425.7773244739074, 3484.7734897231676, 3494.6155922848484, 3495.1786330212394, 3513.069036705272, 5249.4750524947485, 5292.700899591004, 5548.69482178481, 5668.801591944288, 5760.539156867451, 5625.662460252388, 5715.057015592422, 5748.425157484249, 5771.422857714227, 5823.5341172706185, 4732.739699316537, 4923.163062279403, 5134.409542902567, 5186.559142472895, 5303.522682958533, 179.92912297665248, 5136.743162841862, 5207.6354655174155, 5243.895122097556, 5281.128613778722, 5206.557442617382, 5223.112070947929, 5227.137522308814, 5231.476852314776, 5251.343582052244, 5248.685078895279, 5284.9735751320995, 5288.0, 5292.153255479105, 5346.6524675896335, 4722.787474563653, 4804.879878003043, 5136.049830781318, 5161.870953226162, 5224.791008359661, 4495.168393847116, 4957.256411538262, 5622.943770562283, 5624.465675760796, 5742.799002034909, 6135.938640613582, 6218.253809542839, 6221.191245138103, 6277.2153480814895, 6322.304546499881, 6184.783532576384, 6210.254769427697, 6237.157983672191, 6284.0, 6297.086922396273, 5852.209951656514, 5868.735906884158, 5880.353161152269, 5888.205092312526, 5932.7330270137945, 6198.876022479525, 6215.906761398583, 6368.745250189941, 6402.135711678957, 6420.903686444707, 5974.701264936823, 6102.549845102896, 6147.508199344042, 6170.56806023583, 6181.8454538636, 6272.5922815016875, 6297.874042519215, 6319.842003949846, 6335.873282534323, 6345.460635845912, 5791.507721843691, 6112.449879510866, 6188.907166392508, 6229.657368844757, 6261.592996455216, 6225.035119556476, 6252.3122456529745, 6275.811725648238, 6291.087792270187, 6329.588576742497, 4887.780049897763, 4941.50584941503, 4945.4807245238735, 4948.925766113512, 4954.603631709455, 4295.742255464682, 4379.802908869108, 4403.713758605681, 4440.711353761995, 4461.063176732922, 5677.120046392815, 5786.363500014995, 5792.681402522818, 5808.5062769665055, 5883.117532370093, 6224.253089629274, 6263.78076767311, 6277.686115694197, 6278.215223097113, 6284.277308109535, 5917.644941303535, 5936.347001829795, 5948.345681974979, 5951.702414879239, 5983.0, 5326.840194794162, 5378.78484860609, 5397.460253974649, 5418.701971391612, 5457.7271136443815, 6397.6481293529305, 6440.710168042356, 6447.709853056624, 6450.709718062699, 6457.321981192001, 6269.185005949197, 6291.402316779899, 6302.810915672537, 6310.558260921692, 6316.84207894788, 6269.592476489013, 6270.278917924497, 6287.46556542699, 6319.873602527831, 6393.360663933569, 6159.476444502267, 6168.845778855564, 6184.628922264678, 6199.56603037783, 6206.968965155145, 6228.501719862309, 6252.437280644764, 6270.12218289449, 6271.122042914087, 6276.435120839146, 6007.579469437097, 6118.816435506942, 6123.099607467949, 6132.5707200495535, 6170.352113028068, 4967.379077615298, 6121.112438696453, 6126.295476020315, 6155.322914479314, 6190.3190649029475, 4513.75174365413, 4517.435320584927, 5435.537979271806, 5895.968205563923, 6008.789692360747, 5658.151277308437, 6114.908276375769, 6159.260888693386, 6159.907601385893, 6202.627842329474, 6017.488513476404, 6043.116618570694, 6043.8186854394435, 6071.423214794764, 6087.634741915499], "value": 5646.452670104313, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.9484504127067, 511.25612234199247, 560.4787547580751, 561.0238185557132, 576.9269159363586, 33423.99728008164, 33699.83150084249, 38181.04547386313, 39906.2018759625, 39970.0, 37020.444693329555, 41326.17347653045, 42527.78736106323, 42611.36082958758, 42731.572684273146, 9332.393394429375, 9545.331826772128, 9588.089131532493, 9614.75963100921, 9627.085426884434, 9485.95257023714, 9530.285228607847, 9573.329866909318, 9579.425234485918, 9581.90418095817, 9512.57193426294, 9551.522423878812, 9569.904300957005, 9603.903960960371, 9643.469609171492, 9499.192568631675, 9503.952480237624, 9554.61781528738, 9573.377730447499, 9575.281853860919, 9392.389494682891, 9431.292653051049, 9490.478023708692, 9508.809823803555, 9537.14165725088, 37759.0, 37820.62179378198, 38163.618363816284, 38767.612323876965, 39224.803875980724, 2749.911893617126, 3290.68738469845, 3439.098267044054, 3518.313928783888, 3610.2238018825815, 29673.109806705834, 30132.24669383261, 30188.698113018807, 30309.090727278217, 30416.935407260862, 3124.812511249332, 3151.700588444094, 3169.793963392372, 3175.872965081394, 3277.72139368154, 442233.0, 443666.0, 447448.0, 448263.0, 449287.75356123334, 34928.476072858924, 35023.12442188965, 35111.82444087815, 35187.296254074776, 35223.94328170159, 35260.11849703726, 36138.638613613526, 36258.274834503165, 36496.27007459889, 36500.0, 16861.578460538585, 17183.398581049853, 17378.131093445278, 17445.7383139253, 17448.302067917393, 13220.669483262995, 13223.272720000492, 13225.801612975813, 13258.469661213636, 13274.734505310033, 20313.0, 20481.692774608393, 20523.58952820965, 20731.689024664644, 20763.792362076187, 7841.843163136706, 8546.401751877309, 8555.486670799772, 8559.871601925975, 8596.355273354398, 817.0685418622775, 888.2627419242143, 980.857775622545, 1021.2953062386929, 1035.9488213337634, 30748.38503229923, 30902.0, 30971.845140774603, 31689.683103169133, 31855.203619909687, 881.7751473374377, 917.1837065012145, 1045.4668119259234, 1104.0, 1120.0007985745406, 15914.76127858083, 16071.357145714273, 16092.0, 16260.469365160365, 16272.0, 526227.0, 639449.0, 642716.0, 653304.0, 653527.7323613352, 59788.0, 61219.0, 61673.07490387648, 61794.69102654458, 61818.69090654518, 1366.4943970730894, 1395.448797724893, 1412.4844431782326, 1431.3487363249697, 1432.9211893345966, 30353.0, 30651.386972260876, 30733.078007659806, 31267.53098703567, 31403.214919627193, 52120.0, 53168.0, 53414.73292633512, 53801.73099134479, 53923.92152157013, 565363.0, 571716.0, 572644.0, 576598.0, 585472.0, 27257.45485090327, 27504.724952750217, 27551.862240688668, 27833.860830695718, 28144.0, 49926.50073499219, 49956.500434995185, 50289.0, 51051.97896041984, 51149.97700045904, 38871.0, 39785.60214397819, 41346.79326603468, 41829.79085104555, 41944.79027604842, 40105.79947100246, 40513.79743101384, 40660.39009414802, 41248.587514124476, 41295.1740965185, 32668.67331326656, 35225.471617925235, 37863.43204851985, 38247.42628860625, 39123.41314880336, 33054.0, 35129.29741405106, 35398.115047124025, 35861.46207806937, 35865.0, 22562.661560076285, 25681.22956311314, 26108.608370874834, 26113.347166320993, 26650.0], "value": 19601.193885456174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8803606773698, 370.8720491430456, 380.8267238406525, 382.7531242348683, 399.3769719237987, 19501.024948752558, 20819.583608327863, 21296.0, 21802.0, 21824.672629910543, 20302.086406111725, 20885.0, 21088.89455552724, 21299.893500532515, 21374.893125534352, 5482.23248745176, 5772.971135144318, 5836.6206196597295, 6002.459778619924, 6018.3078945921125, 5979.910301345483, 6006.189164462807, 6018.51851851853, 6027.63834169949, 6039.214902062726, 4776.450708168553, 5195.714235717034, 5818.0, 5881.029630111027, 5889.558283128783, 4958.677685950402, 5742.454466825645, 5754.597178197528, 5763.394843541451, 5897.174395584621, 4916.237983112624, 5004.249362595603, 5029.949700503022, 5086.92369614456, 5122.180451127839, 26099.08653197148, 26159.73840261592, 26299.605505917425, 26775.661216939076, 26844.0, 2295.31140657802, 2365.751596082404, 2570.6015567587056, 2577.9613305800426, 2953.9556906646417, 15677.686446271011, 15946.920265398714, 16014.279357428828, 16056.598585035468, 16109.83890161095, 1826.97259541107, 1827.7075667893207, 1867.327762005677, 1904.6476401865561, 1912.2828939147819, 86262.56868715616, 115502.42248788786, 116049.0, 116514.0, 117363.41318293354, 8774.38579299443, 8937.865932011026, 10710.0, 11173.497192626352, 11236.381998989971, 13865.514706985206, 13989.740923316951, 14011.649708757363, 14028.0, 14029.649258768612, 8663.0, 8700.042490439728, 8834.0, 8932.821343573092, 8972.19250267479, 8919.687810926587, 8940.240079593308, 8950.731478055668, 9050.185483306534, 9062.229710474552, 5780.942190578125, 6547.869042619121, 6852.862942741217, 6859.314068593101, 6909.042191601419, 1887.169645356039, 1911.4361263427322, 1913.6268427656473, 1922.327185485069, 1943.465546974565, 768.404486522938, 961.9855702164473, 1049.338916482611, 1060.6552870317023, 1104.823228283487, 19550.804491955183, 19800.0, 21070.894645526674, 21242.977352743073, 21688.34934951954, 866.8959724833061, 1027.9897201028043, 1035.285652899512, 1072.3565860483802, 1114.2979922648678, 11302.830457543143, 11791.88208117908, 11798.997085247678, 11819.40902954866, 11819.88180118205, 582606.0, 589493.0, 598324.0, 598774.0, 599632.0, 65828.34171658318, 116174.41912790382, 118256.8174318263, 118552.0, 121408.0, 957.9664711735056, 992.8064027514565, 995.6515219673201, 997.6807421625156, 998.4308943902051, 17101.828981710023, 18580.349687760863, 19806.20775168977, 20111.79888201158, 20174.89912550428, 42172.57827421687, 44280.778596106815, 55519.444805553045, 56291.71854140703, 56386.8722625537, 72447.0, 76752.0, 76926.0, 78926.0, 79179.60410198143, 6713.0, 8264.462809917337, 8493.490390576586, 8607.096254893397, 8614.267787238156, 11568.190226684388, 12531.561395351118, 13248.933755331162, 13339.333033348488, 13619.0, 9843.261755368232, 10426.426546540013, 10728.517216725422, 11441.942790285995, 11821.99513041401, 8247.587620618826, 11236.438178091226, 11238.775224495628, 11301.15241356885, 11369.31784092957, 11640.06879449625, 11798.941005294919, 11856.822147667619, 11896.988755955841, 11930.105242106703, 7080.575165490087, 8365.121662225622, 8460.788480288042, 8477.025142108736, 8597.914020859711, 9867.358621689567, 11048.0, 11505.367204803817, 11849.05207583374, 11868.406579671155], "value": 9777.162495848661, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.2403822127158, 1598.5284341119373, 1780.545960780001, 1869.3270422647852, 1956.7554055743033, 8013.759587212393, 8537.615807288672, 8654.134586541342, 9027.684031058907, 9029.593668284926, 8712.390132690698, 8796.07641197673, 8873.866891996626, 8895.822083558325, 8900.51047192404, 1982.7025946108056, 2366.325597204797, 2402.7356990731005, 2406.927792166238, 2414.6860908081926, 2371.134535894395, 2386.9641955370685, 2400.9039638414442, 2409.4337830609793, 2410.7950824179966, 2339.485313231095, 2382.059086660768, 2383.6782034425305, 2393.3059412770276, 2404.1705611563984, 2335.112657190257, 2342.8711420871846, 2345.1909091363455, 2364.089825417218, 2390.2829151254728, 2328.557574060923, 2354.5526349993615, 2359.6106642403984, 2362.5038741864228, 2363.7045369328835, 8789.252913502296, 8875.778105547348, 8876.378653494257, 8877.023527411979, 8928.687495937676, 5248.71132087735, 5415.620906536544, 5416.756245968902, 5423.891522169534, 5433.1850222466555, 3254.300325430044, 3422.828858557062, 3641.0533261351975, 3669.4679271505483, 3680.245549662313, 934.434667026446, 1064.6699523147772, 1081.145894743152, 1089.2919602258596, 1094.6825420628008, 11497.827532587018, 11671.299722016705, 11672.299662020307, 11672.533098676044, 11731.354775487345, 3910.8240129194255, 4689.6717229793585, 4790.904181916342, 4838.588719958772, 4852.50096200457, 8251.711190108437, 9787.755306117262, 9824.214062874953, 9892.505374731234, 9905.158061564847, 5308.761105750251, 5350.545203657655, 5391.3799913009725, 5398.73006349681, 5411.5129638331955, 4153.958460415418, 4451.9760455094865, 4685.695429797052, 4948.356713627278, 4953.18272485036, 3958.4656071430563, 3965.0682089708894, 4048.3320252158064, 4093.16090201508, 4144.839444955417, 1299.402274953532, 1323.9536616218386, 1332.2938842413537, 1333.1201407071287, 1334.9733005339838, 812.5652775764937, 820.8917960753055, 826.5362686094351, 842.4692443760392, 858.6565373850385, 5735.053716136791, 5935.139404786281, 5999.0, 6058.909116363258, 6117.908231376533, 973.5424350555228, 990.8563258327646, 1006.6426418621284, 1008.7679833638305, 1025.369397820335, 3934.822932967966, 4016.477857878457, 4031.6169963853386, 4036.535798383165, 4132.318167502389, 10307.330023548595, 10384.844227336596, 10658.147348212124, 10683.679489615324, 10691.786164276671, 10455.268131230741, 10565.841512377321, 10602.893971060344, 10603.257771956043, 10619.0, 7740.954971078945, 8054.798630034296, 8200.835983280302, 8232.34141268697, 8289.668413263522, 6018.2778066630535, 6031.155638210566, 6068.271807383142, 6090.269167699905, 6213.316535181036, 9485.146336829719, 9861.211103111591, 9867.0, 9989.051040151175, 9998.350107243297, 9773.853392199266, 10106.242031847494, 10127.59489620407, 10145.442000690033, 10189.898101019191, 6946.131733533309, 7338.596377199092, 7398.186199517941, 7603.0, 7627.809304767426, 8404.369672274726, 8431.367647426345, 8487.278581320657, 8500.192481714228, 8501.87247191305, 7380.114386273682, 7477.4391920605085, 7532.096148462219, 7561.659725312485, 7630.8855367170645, 7218.133823941161, 7240.818979525554, 7246.528975616779, 7285.125784905633, 7444.851102977802, 6149.938500614937, 6943.305669433016, 7046.189688185924, 7053.788386348418, 7077.68150433242, 4867.58625516835, 4941.234108713155, 5070.087384270867, 5074.441811400669, 5092.465291144376, 5043.52086551777, 5077.847664570068, 5108.897822043464, 5121.180611102206, 5223.164293712987], "value": 4610.288511688549, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.3542383874669, 308.6327270548048, 312.53588421194513, 319.08900090242344, 319.5574129830184, 5265.314689508349, 5307.787688492465, 5331.360236771593, 5435.565154787618, 5557.888842223153, 4980.750962451872, 5402.270693456382, 5451.437824222619, 5454.7272636368125, 5457.781688732456, 3316.286998295366, 4143.585641435848, 4151.107511884944, 4176.770277634729, 4181.790910454481, 3388.559487266652, 3840.3855383138703, 4092.4679791627045, 4144.46122004139, 4200.823769344588, 4032.556418793945, 4062.573429789874, 4079.9192411869863, 4093.8362465501345, 4127.649149822269, 3476.913077173091, 4092.877213683594, 4107.685540627001, 4129.6076872697195, 4140.751554906685, 2965.4958657028355, 2968.435997160554, 3140.6702296259023, 3279.4916787897914, 3563.251717139404, 4863.537963893425, 5239.13554263546, 5272.762725677354, 5302.2311764793885, 5316.308879845596, 3919.8432062717457, 4651.348811166439, 4653.6044436222965, 4657.510961349078, 4666.580007799314, 4868.561829435333, 5464.808731694372, 5646.237757902672, 5726.513246374063, 5772.7113644317615, 3232.7252183564424, 3274.4269752793402, 3742.2515496900455, 3844.9231015379537, 3855.51806024247, 5358.624896257264, 5724.914126288109, 6060.757544703325, 6061.666433384648, 6072.360462675098, 3373.0555444475585, 3463.7055850252505, 3708.4066549351974, 3891.7664940103687, 3944.4083387491532, 3856.5345168836225, 3968.3650615901315, 3972.7020473464604, 3985.5815139410524, 4016.9196616068098, 3715.9628403715615, 3745.5505339358906, 4606.907861842745, 4617.492075871652, 4640.8375706850775, 4641.280601506772, 5238.337879287437, 5481.588880833953, 5503.0, 5760.946698249934, 1323.1862404621088, 1346.6969931765275, 1353.4789106194187, 1357.0839683213792, 1361.6936189357316, 780.812604974802, 787.0791174326052, 818.4802650317091, 835.8996920369594, 838.1618381618382, 3866.0, 4240.660747140221, 4510.616597589176, 4527.501974782771, 4578.954210457853, 4215.915681686349, 4300.78496075195, 4762.9523704762505, 5008.69947803133, 5051.792112008828, 4010.8997275067773, 4411.426514553087, 4520.570545798144, 4549.452306708254, 4550.6587005974025, 1999.1896512535632, 2326.9883650581637, 2416.2509622017233, 2550.8827673031337, 2585.203283717798, 4374.343848422762, 4486.5962063414445, 4764.523547645277, 4821.662483626183, 5174.896502069938, 4659.0, 4726.432828060655, 4906.9263961040615, 5057.0, 5146.897062058738, 4647.373419303217, 4861.156223609158, 5177.611679124156, 5194.740262986911, 5222.503862133091, 4406.955930440655, 4757.595604373667, 4761.523847615349, 4885.8045678172475, 5045.873853153554, 4363.407356314986, 4371.109712355942, 4408.140412619508, 4901.950980490149, 4993.450720420678, 4698.906021879611, 4984.0, 5027.321311622884, 5177.741112944413, 5183.626339020238, 2832.730890565393, 2919.9270018249713, 3096.7677424192825, 3423.400904841593, 3426.1434641339665, 4643.814247430065, 4681.695689780289, 4970.484002379165, 5030.5221004006025, 5721.628094173865, 5120.078385890575, 5240.947590524046, 5683.715814209356, 5743.8564035899435, 5776.393478684678, 4847.854564363075, 5662.57530685192, 5694.17434471991, 5719.2279042328755, 5732.792874743337, 5084.9745751271, 5297.847780570554, 5558.805441809517, 5597.496225339739, 5597.608167428404, 4717.599004084554, 4960.0, 5170.0, 5752.353917198136, 5780.7398667060925, 4435.556444355539, 4996.725180115129, 5075.172937742336, 5603.411641777555, 5669.773209071591], "value": 3866.083115140755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.9156501219854, 718.9604571748554, 754.1779460388183, 758.188738050286, 775.7982924439644, 15204.391824327027, 15634.452794152206, 15684.294206760695, 15975.92012039941, 15987.76018359724, 13302.733945321088, 13489.797653035212, 13585.796213056812, 13622.931885340584, 13653.726925461484, 711.6015031582305, 889.1952782731622, 903.3089686389917, 916.051886297682, 919.0028818731685, 902.9548522573845, 924.1405492891608, 924.8289066522681, 925.8796356473649, 929.9538019727806, 843.4601854812925, 953.1755031897428, 975.229568640773, 976.1361195342138, 977.501474248135, 867.8958524977044, 941.7174847545709, 964.2478866484154, 969.6024629901707, 971.3006635222629, 701.642162497125, 716.4089626058523, 718.7232915327585, 720.772956518695, 721.2354903801935, 15566.299516521784, 15680.294386752623, 15723.37106515738, 15742.527724168292, 15746.68506629861, 14633.634159146, 14657.48698795537, 14671.266436678123, 14708.117512949257, 14893.925530372388, 11235.606753763579, 11331.093512518979, 11917.702057448547, 12436.626901192978, 12482.563110291187, 3841.750286231386, 4035.5762644922156, 4052.3111071117983, 4056.776877271749, 4065.8170382332864, 106434.0, 110084.9999999992, 110122.63957563616, 110389.34415983767, 112074.0, 11197.60808371703, 11307.208495405243, 11392.772144557062, 11437.826812905521, 11705.122115841175, 22392.776072239394, 23389.298321050395, 23420.64869026966, 23421.765782341958, 23689.40776480602, 6922.480813938974, 7756.961215193888, 8087.393445491612, 8223.17768223173, 8279.668813247523, 4343.02392411452, 4403.801828917706, 4449.644028477714, 4490.3040028795585, 4602.4477062752685, 3576.338377400189, 3623.0942264433893, 3626.437902125175, 3677.6506231907924, 3681.006128345332, 504.88640055987844, 640.3404493371835, 647.0811447744214, 663.7842701122155, 665.065582856088, 666.1772710702279, 670.6713710282024, 686.4131167851515, 697.3479796390391, 709.6026225313738, 9185.540722963959, 9282.164605185566, 9689.176420004238, 9727.56225969833, 9768.609255629695, 665.2715276771927, 677.7880723172073, 691.2534462780185, 704.2007321689919, 709.4324540367685, 3833.616638336144, 4602.447706275201, 4648.349231107648, 4704.95295047052, 4725.456572494207, 115108.0, 140500.0, 146460.14159433503, 149845.0, 150264.0, 125771.0, 126954.36522817326, 127387.3630631841, 128204.35897820452, 130214.34892825475, 82285.58857205795, 111707.88292116974, 112010.0, 112273.87726122634, 114005.28992065125, 9059.22996545301, 9076.455412675261, 9082.682106126254, 9091.409058411182, 9152.0, 60295.69852150711, 60331.19006429814, 60366.094508581526, 60738.696306518184, 61633.07550386838, 86733.13266867503, 88613.66439855241, 92551.07448925424, 92939.0, 94145.5292723532, 12061.457234424297, 12116.232165533796, 12317.815232771694, 12440.626781196579, 12718.554850580185, 12998.935005324913, 13199.538016169772, 13342.332883355988, 13530.458781648624, 14025.0, 10961.890381096087, 11965.675513869348, 12213.69465763363, 12298.938505307417, 12705.555305564261, 12344.321062341658, 12432.564860229848, 12505.373871486725, 12513.186642868184, 12847.743045138857, 12276.324802135969, 12294.231498294035, 12402.13185077036, 12506.499740010298, 12598.811017834923, 8640.827183456422, 10304.227182961158, 10490.580376784843, 10558.577656893638, 11031.613893513688, 10290.223045925766, 10427.895721042692, 10612.257142000295, 10620.52207650642, 10781.62264320745], "value": 7806.030837802812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 152.0, 126.0, 116.0, 118.0, 115.0, 114.0, 115.0, 114.0, 121.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 134.0, 189.0, 146.0, 161.0, 167.0, 151.0, 182.0, 147.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [272.0, 255.0, 207.0, 193.0, 201.0, 228.0, 196.0, 215.0, 194.0, 169.0], "value": 213.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 91.0, 164.0, 84.0, 81.0, 84.0, 64.0, 134.0, 82.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 127.0, 69.0, 73.0, 80.0, 115.0, 69.0, 83.0, 135.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 74.0, 117.0, 128.0, 94.0, 73.0, 134.0, 126.0, 89.0, 87.0], "value": 101.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 96.0, 123.0, 152.0, 96.0, 95.0, 95.0, 98.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 91.0, 91.0, 92.0, 99.0, 91.0, 95.0, 93.0, 91.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 57.0, 55.0, 58.0, 57.0, 55.0, 58.0, 58.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 72.0, 70.0, 82.0, 83.0, 78.0, 71.0, 71.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 110.0, 88.0, 85.0, 92.0, 111.0, 106.0, 124.0, 89.0], "value": 100.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 156.0, 149.0, 151.0, 139.0, 137.0, 161.0, 168.0, 163.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 170.0, 165.0, 168.0, 163.0, 166.0, 169.0, 163.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 68.0, 68.0, 64.0, 66.0, 66.0, 65.0, 69.0, 62.0], "value": 66.3, "unit": "score"}]}]} 06:29:06 INFO - Return code: 0 06:29:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:29:07 ERROR - # TBPL SUCCESS # 06:29:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:29:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:29:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:29:07 INFO - 2016-06-02 06:29:07.016 screenresolution[2253:30676] starting screenresolution argv=screenresolution get 06:29:07 INFO - 2016-06-02 06:29:07.020 screenresolution[2253:30676] Display 0: 1600x1200x32@60 06:29:07 INFO - 2016-06-02 06:29:07.026 screenresolution[2254:30679] starting screenresolution argv=screenresolution list 06:29:07 INFO - Available Modes on Display 0 06:29:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:29:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:29:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:29:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:29:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:29:07 INFO - Intel Iris: 06:29:07 INFO - Chipset Model: Intel Iris 06:29:07 INFO - Type: GPU 06:29:07 INFO - Bus: Built-In 06:29:07 INFO - VRAM (Dynamic, Max): 1536 MB 06:29:07 INFO - Vendor: Intel (0x8086) 06:29:07 INFO - Device ID: 0x0a2e 06:29:07 INFO - Revision ID: 0x0009 06:29:07 INFO - Displays: 06:29:07 INFO - Display: 06:29:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:29:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:29:07 INFO - Display Serial Number: 1600x1200 60 06:29:07 INFO - Main Display: Yes 06:29:07 INFO - Mirror: Off 06:29:07 INFO - Online: Yes 06:29:07 INFO - Rotation: Supported 06:29:07 INFO - Return code: 0 06:29:07 INFO - Running post-action listener: _resource_record_post_action 06:29:07 INFO - ##### 06:29:07 INFO - ##### Finished run-tests step (success) 06:29:07 INFO - ##### 06:29:07 INFO - Running post-run listener: _resource_record_post_run 06:29:07 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 311296; Write bytes: 697794560; Read time: 3; Write time: 2054 06:29:07 INFO - TinderboxPrint: CPU usage
54.5% 06:29:07 INFO - TinderboxPrint: I/O read bytes / time
311,296 / 3 06:29:07 INFO - TinderboxPrint: I/O write bytes / time
697,794,560 / 2,054 06:29:07 INFO - TinderboxPrint: CPU idle
2,200.4 (45.5%) 06:29:07 INFO - TinderboxPrint: CPU system
975.7 (20.2%) 06:29:07 INFO - TinderboxPrint: CPU user
1,661.6 (34.3%) 06:29:07 INFO - TinderboxPrint: Swap in / out
399,499,264 / 0 06:29:07 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 382906880; Write bytes: 377889792; Read time: 29012; Write time: 787 06:29:07 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 311296; Write bytes: 294784000; Read time: 3; Write time: 1220 06:29:07 INFO - Running post-run listener: _upload_blobber_files 06:29:07 INFO - Blob upload gear active. 06:29:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:29:07 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 06:29:07 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'] 06:29:07 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 06:29:08 INFO - (blobuploader) - INFO - Open directory for files ... 06:29:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:29:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:09 INFO - (blobuploader) - INFO - Done attempting. 06:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:10 INFO - (blobuploader) - INFO - Done attempting. 06:29:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:29:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:29:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:12 INFO - (blobuploader) - INFO - Done attempting. 06:29:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:29:12 INFO - Return code: 0 06:29:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:29:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:29:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35e3d495738f18e347745b45f10a3da8e84a04b5757ecf06c009fcebe14e4f800be5586ec29127ac73a70fa0ceeeb5737ef7d9401eb6136465a09706b622d0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4bf43a824ffee8bd3e1ee5f54a6a7eb7a2aa3c41fcd96e288f51ae3a05f9ed41b12a14cded758f6daae0318cf7aa4229fe40c79bfd23c7d83463de26f5b4bc9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58303c58942820f271faaf50cee2d7b9521df25cb31440ded05af9b1a46972c796481495a0632822f8068fee8d18b793996337c928d18b718d1185ac0025db5f"} 06:29:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:29:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:29:12 INFO - Contents: 06:29:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35e3d495738f18e347745b45f10a3da8e84a04b5757ecf06c009fcebe14e4f800be5586ec29127ac73a70fa0ceeeb5737ef7d9401eb6136465a09706b622d0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4bf43a824ffee8bd3e1ee5f54a6a7eb7a2aa3c41fcd96e288f51ae3a05f9ed41b12a14cded758f6daae0318cf7aa4229fe40c79bfd23c7d83463de26f5b4bc9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58303c58942820f271faaf50cee2d7b9521df25cb31440ded05af9b1a46972c796481495a0632822f8068fee8d18b793996337c928d18b718d1185ac0025db5f"} 06:29:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:29:12 INFO - Copying logs to upload dir... 06:29:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:29:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.327302 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-02 06:29:12.930302) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 06:29:12.933849) ========= 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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/35e3d495738f18e347745b45f10a3da8e84a04b5757ecf06c009fcebe14e4f800be5586ec29127ac73a70fa0ceeeb5737ef7d9401eb6136465a09706b622d0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4bf43a824ffee8bd3e1ee5f54a6a7eb7a2aa3c41fcd96e288f51ae3a05f9ed41b12a14cded758f6daae0318cf7aa4229fe40c79bfd23c7d83463de26f5b4bc9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58303c58942820f271faaf50cee2d7b9521df25cb31440ded05af9b1a46972c796481495a0632822f8068fee8d18b793996337c928d18b718d1185ac0025db5f"} build_url:https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010929 build_url: 'https://queue.taskcluster.net/v1/task/Wu2jFzmSQBCetguT19P3mA/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/35e3d495738f18e347745b45f10a3da8e84a04b5757ecf06c009fcebe14e4f800be5586ec29127ac73a70fa0ceeeb5737ef7d9401eb6136465a09706b622d0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4bf43a824ffee8bd3e1ee5f54a6a7eb7a2aa3c41fcd96e288f51ae3a05f9ed41b12a14cded758f6daae0318cf7aa4229fe40c79bfd23c7d83463de26f5b4bc9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58303c58942820f271faaf50cee2d7b9521df25cb31440ded05af9b1a46972c796481495a0632822f8068fee8d18b793996337c928d18b718d1185ac0025db5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 06:29:12.965166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:29:12.965536) ========= 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.bbxfsQTJLS/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.z7lVIhH9fr/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005148 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:29:13.015030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 06:29:13.015467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 06:29:13.015990) ========= ========= Total master_lag: 0.17 =========