builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1460895565.76 results: success (0) buildid: 20160417032814 builduid: 6fadf322d07d4224be63ab6f3180c7ee revision: f8c0dd78206cac5a132b164ebacfa8ffbac9713c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:25.765184) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:25.765550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:25.765816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:26.113978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:26.114259) ========= 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.0rqCbLoRym/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.q0qq2SXu1j/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-04-17 05:19:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.6M=0s 2016-04-17 05:19:26 (29.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.531277 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:26.738468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:26.738803) ========= 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.0rqCbLoRym/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.q0qq2SXu1j/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.027796 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:26.882463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-17 05:19:26.882804) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8c0dd78206cac5a132b164ebacfa8ffbac9713c --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 f8c0dd78206cac5a132b164ebacfa8ffbac9713c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0rqCbLoRym/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.q0qq2SXu1j/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-04-17 05:19:26,709 truncating revision to first 12 chars 2016-04-17 05:19:26,709 Setting DEBUG logging. 2016-04-17 05:19:26,709 attempt 1/10 2016-04-17 05:19:26,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8c0dd78206c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-17 05:19:27,784 unpacking tar archive at: fx-team-f8c0dd78206c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.325088 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-17 05:19:28.256063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:28.259361) ========= script_repo_revision: f8c0dd78206cac5a132b164ebacfa8ffbac9713c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:28.259731) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:28.260033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 05:19:28.274132) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-04-17 05:19:28.274417) ========= /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.0rqCbLoRym/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.q0qq2SXu1j/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:19:28 INFO - MultiFileLogger online at 20160417 05:19:28 in /builds/slave/test 05:19:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:19:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:19:28 INFO - {'append_to_log': False, 05:19:28 INFO - 'base_work_dir': '/builds/slave/test', 05:19:28 INFO - 'blob_upload_branch': 'Fx-Team', 05:19:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:19:28 INFO - 'branch': 'Fx-Team', 05:19:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:28 INFO - 'config_files': ('talos/mac_config.py',), 05:19:28 INFO - 'default_actions': ('clobber', 05:19:28 INFO - 'read-buildbot-config', 05:19:28 INFO - 'download-and-extract', 05:19:28 INFO - 'populate-webroot', 05:19:28 INFO - 'create-virtualenv', 05:19:28 INFO - 'install', 05:19:28 INFO - 'run-tests'), 05:19:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:28 INFO - 'download_minidump_stackwalk': True, 05:19:28 INFO - 'download_symbols': 'ondemand', 05:19:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:19:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:19:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:19:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:19:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:28 INFO - 'installer_path': 'installer.exe', 05:19:28 INFO - 'log_level': 'info', 05:19:28 INFO - 'log_name': 'talos', 05:19:28 INFO - 'log_to_console': True, 05:19:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:19:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:19:28 INFO - 'opt_config_files': (), 05:19:28 INFO - 'pip_index': False, 05:19:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:19:28 INFO - 'cmd': ('bash', 05:19:28 INFO - '-c', 05:19:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:19:28 INFO - 'enabled': True, 05:19:28 INFO - 'halt_on_failure': False, 05:19:28 INFO - 'name': 'check_screen_resolution'},), 05:19:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:19:28 INFO - 'cmd': ('bash', 05:19:28 INFO - '-c', 05:19:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:19:28 INFO - 'enabled': True, 05:19:28 INFO - 'halt_on_failure': False, 05:19:28 INFO - 'name': 'check_screen_resolution'},), 05:19:28 INFO - 'run_cmd_checks_enabled': True, 05:19:28 INFO - 'sps_profile': False, 05:19:28 INFO - 'sps_profile_interval': 0, 05:19:28 INFO - 'suite': 'dromaeojs-e10s', 05:19:28 INFO - 'system_bits': '32', 05:19:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:28 INFO - 'title': 't-yosemite-r7-0071', 05:19:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:19:28 INFO - 'use_talos_json': True, 05:19:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:19:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:28 INFO - 'work_dir': 'build'} 05:19:28 INFO - ##### 05:19:28 INFO - ##### Running clobber step. 05:19:28 INFO - ##### 05:19:28 INFO - Running pre-action listener: _resource_record_pre_action 05:19:28 INFO - Running main action method: clobber 05:19:28 INFO - rmtree: /builds/slave/test/build 05:19:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:19:30 INFO - Running post-action listener: _resource_record_post_action 05:19:30 INFO - ##### 05:19:30 INFO - ##### Running read-buildbot-config step. 05:19:30 INFO - ##### 05:19:30 INFO - Running pre-action listener: _resource_record_pre_action 05:19:30 INFO - Running main action method: read_buildbot_config 05:19:30 INFO - Using buildbot properties: 05:19:30 INFO - { 05:19:30 INFO - "project": "", 05:19:30 INFO - "product": "firefox", 05:19:30 INFO - "script_repo_revision": "production", 05:19:30 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:19:30 INFO - "repository": "", 05:19:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:19:30 INFO - "buildid": "20160417032814", 05:19:30 INFO - "pgo_build": "False", 05:19:30 INFO - "basedir": "/builds/slave/test", 05:19:30 INFO - "buildnumber": 700, 05:19:30 INFO - "slavename": "t-yosemite-r7-0071", 05:19:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:19:30 INFO - "platform": "yosemite_r7", 05:19:30 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:19:30 INFO - "branch": "fx-team", 05:19:30 INFO - "repo_path": "integration/fx-team", 05:19:30 INFO - "revision": "f8c0dd78206cac5a132b164ebacfa8ffbac9713c", 05:19:30 INFO - "stage_platform": "macosx64", 05:19:30 INFO - "builduid": "6fadf322d07d4224be63ab6f3180c7ee", 05:19:30 INFO - "slavebuilddir": "test" 05:19:30 INFO - } 05:19:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:19:30 INFO - Running post-action listener: _resource_record_post_action 05:19:30 INFO - ##### 05:19:30 INFO - ##### Running download-and-extract step. 05:19:30 INFO - ##### 05:19:30 INFO - Running pre-action listener: _resource_record_pre_action 05:19:30 INFO - Running main action method: download_and_extract 05:19:30 INFO - mkdir: /builds/slave/test/build/tests 05:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:30 INFO - https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:19:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:19:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:19:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:20:00 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json: timed out 05:20:00 INFO - retry: attempt #1 caught exception: timed out 05:20:00 INFO - retry: Failed, sleeping 30 seconds before retrying 05:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #2 05:20:39 INFO - Downloaded 1199 bytes. 05:20:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:20:39 INFO - Using the following test package requirements: 05:20:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:20:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:20:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:20:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'jsshell-mac.zip'], 05:20:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:20:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:20:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:20:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:20:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:20:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:20:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:20:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:39 INFO - https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:20:42 INFO - Downloaded 18031984 bytes. 05:20:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:20:45 INFO - Return code: 0 05:20:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:45 INFO - https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:20:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:20:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:20:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:20:58 INFO - Downloaded 18031984 bytes. 05:20:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:02 INFO - Return code: 0 05:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:02 INFO - https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:21:02 INFO - Downloaded 10841076 bytes. 05:21:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:21:03 INFO - Return code: 0 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:21:06 INFO - Downloaded 109840507 bytes. 05:21:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:06 INFO - mkdir: /builds/slave/test/properties 05:21:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:06 INFO - Contents: 05:21:06 INFO - build_url:https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:07 INFO - Running post-action listener: _resource_record_post_action 05:21:07 INFO - Running post-action listener: set_extra_try_arguments 05:21:07 INFO - ##### 05:21:07 INFO - ##### Running populate-webroot step. 05:21:07 INFO - ##### 05:21:07 INFO - Running pre-action listener: _resource_record_pre_action 05:21:07 INFO - Running main action method: populate_webroot 05:21:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:07 INFO - '--tppagecycles', 05:21:07 INFO - '7'], 05:21:07 INFO - 'tests': ['tsvgm']}}, 05:21:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['damp', 'tps']}, 05:21:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'tests': ['damp', 'tps']}, 05:21:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['dromaeo_dom']}, 05:21:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['a11yr', 05:21:07 INFO - 'ts_paint', 05:21:07 INFO - 'tpaint', 05:21:07 INFO - 'sessionrestore', 05:21:07 INFO - 'sessionrestore_no_auto_restore', 05:21:07 INFO - 'tabpaint']}, 05:21:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:07 INFO - 'ts_paint', 05:21:07 INFO - 'tpaint', 05:21:07 INFO - 'sessionrestore', 05:21:07 INFO - 'sessionrestore_no_auto_restore', 05:21:07 INFO - 'tabpaint']}, 05:21:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:07 INFO - 'ts_paint', 05:21:07 INFO - 'tpaint', 05:21:07 INFO - 'sessionrestore', 05:21:07 INFO - 'sessionrestore_no_auto_restore', 05:21:07 INFO - 'tabpaint']}, 05:21:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:07 INFO - 'ts_paint', 05:21:07 INFO - 'tpaint', 05:21:07 INFO - 'sessionrestore', 05:21:07 INFO - 'sessionrestore_no_auto_restore', 05:21:07 INFO - 'tabpaint']}, 05:21:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['a11yr', 05:21:07 INFO - 'ts_paint', 05:21:07 INFO - 'tpaint', 05:21:07 INFO - 'sessionrestore', 05:21:07 INFO - 'sessionrestore_no_auto_restore', 05:21:07 INFO - 'tabpaint']}, 05:21:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['a11yr', 05:21:07 INFO - 'ts_paint', 05:21:07 INFO - 'tpaint', 05:21:07 INFO - 'sessionrestore', 05:21:07 INFO - 'sessionrestore_no_auto_restore', 05:21:07 INFO - 'tabpaint']}, 05:21:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['tsvgx', 05:21:07 INFO - 'tsvgr_opacity', 05:21:07 INFO - 'tart', 05:21:07 INFO - 'tscrollx', 05:21:07 INFO - 'cart']}, 05:21:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:07 INFO - 'tsvgr_opacity', 05:21:07 INFO - 'tart', 05:21:07 INFO - 'tscrollx', 05:21:07 INFO - 'cart']}, 05:21:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'talos_options': ['--disable-e10s'], 05:21:07 INFO - 'tests': ['tp5o']}, 05:21:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'tests': ['tp5o']}, 05:21:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'talos_options': ['--disable-e10s', 05:21:07 INFO - '--xperf_path', 05:21:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:07 INFO - 'tests': ['tp5n']}, 05:21:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:07 INFO - 'talos_options': ['--xperf_path', 05:21:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:07 INFO - 'tests': ['tp5n']}}, 05:21:07 INFO - 'talos.zip': {'path': '', 05:21:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:07 INFO - Running post-action listener: _resource_record_post_action 05:21:07 INFO - ##### 05:21:07 INFO - ##### Running create-virtualenv step. 05:21:07 INFO - ##### 05:21:07 INFO - Running pre-action listener: _resource_record_pre_action 05:21:07 INFO - Running main action method: create_virtualenv 05:21:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:21:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:07 INFO - Using real prefix '/tools/python27' 05:21:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:11 INFO - Installing pip.................done. 05:21:11 INFO - Return code: 0 05:21:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:11 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 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:11 INFO - 'HOME': '/Users/cltbld', 05:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:11 INFO - 'LOGNAME': 'cltbld', 05:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:11 INFO - 'MOZ_NO_REMOTE': '1', 05:21:11 INFO - 'NO_EM_RESTART': '1', 05:21:11 INFO - 'PAGER': '/bin/cat', 05:21:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:11 INFO - 'PWD': '/builds/slave/test', 05:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:11 INFO - 'SHELL': '/bin/bash', 05:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:11 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:11 INFO - 'USER': 'cltbld', 05:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:11 INFO - 'XPC_FLAGS': '0x0', 05:21:11 INFO - 'XPC_SERVICE_NAME': '0', 05:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:21:11 INFO - Cleaning up... 05:21:11 INFO - Return code: 0 05:21:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:11 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:11 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>=0.7.1'] in /builds/slave/test/build 05:21:11 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>=0.7.1 05:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:11 INFO - 'HOME': '/Users/cltbld', 05:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:11 INFO - 'LOGNAME': 'cltbld', 05:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:11 INFO - 'MOZ_NO_REMOTE': '1', 05:21:11 INFO - 'NO_EM_RESTART': '1', 05:21:11 INFO - 'PAGER': '/bin/cat', 05:21:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:11 INFO - 'PWD': '/builds/slave/test', 05:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:11 INFO - 'SHELL': '/bin/bash', 05:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:11 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:11 INFO - 'USER': 'cltbld', 05:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:11 INFO - 'XPC_FLAGS': '0x0', 05:21:11 INFO - 'XPC_SERVICE_NAME': '0', 05:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:11 INFO - Downloading/unpacking psutil>=0.7.1 05:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:14 INFO - Installing collected packages: psutil 05:21:14 INFO - Running setup.py install for psutil 05:21:14 INFO - building 'psutil._psutil_osx' extension 05:21:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:21:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:21:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:21:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:21:15 INFO - building 'psutil._psutil_posix' extension 05:21:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:21:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:21:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:21:15 INFO - ^ 05:21:15 INFO - 1 warning generated. 05:21:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:21:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:15 INFO - Successfully installed psutil 05:21:15 INFO - Cleaning up... 05:21:15 INFO - Return code: 0 05:21:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:15 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:15 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.0.0'] in /builds/slave/test/build 05:21:15 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.0.0 05:21:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:15 INFO - 'HOME': '/Users/cltbld', 05:21:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:15 INFO - 'LOGNAME': 'cltbld', 05:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:15 INFO - 'MOZ_NO_REMOTE': '1', 05:21:15 INFO - 'NO_EM_RESTART': '1', 05:21:15 INFO - 'PAGER': '/bin/cat', 05:21:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:15 INFO - 'PWD': '/builds/slave/test', 05:21:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:15 INFO - 'SHELL': '/bin/bash', 05:21:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:15 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:15 INFO - 'USER': 'cltbld', 05:21:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:15 INFO - 'XPC_FLAGS': '0x0', 05:21:15 INFO - 'XPC_SERVICE_NAME': '0', 05:21:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:21:18 INFO - Installing collected packages: mozsystemmonitor 05:21:18 INFO - Running setup.py install for mozsystemmonitor 05:21:18 INFO - Successfully installed mozsystemmonitor 05:21:18 INFO - Cleaning up... 05:21:18 INFO - Return code: 0 05:21:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:18 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 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:18 INFO - 'HOME': '/Users/cltbld', 05:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:18 INFO - 'LOGNAME': 'cltbld', 05:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:18 INFO - 'MOZ_NO_REMOTE': '1', 05:21:18 INFO - 'NO_EM_RESTART': '1', 05:21:18 INFO - 'PAGER': '/bin/cat', 05:21:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:18 INFO - 'PWD': '/builds/slave/test', 05:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:18 INFO - 'SHELL': '/bin/bash', 05:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:18 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:18 INFO - 'USER': 'cltbld', 05:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:18 INFO - 'XPC_FLAGS': '0x0', 05:21:18 INFO - 'XPC_SERVICE_NAME': '0', 05:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:22 INFO - Downloading docopt-0.6.1.tar.gz 05:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:22 INFO - Running setup.py install for blobuploader 05:21:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:22 INFO - Running setup.py install for requests 05:21:23 INFO - Running setup.py install for docopt 05:21:23 INFO - Successfully installed blobuploader requests docopt 05:21:23 INFO - Cleaning up... 05:21:23 INFO - Return code: 0 05:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:23 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 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:23 INFO - 'HOME': '/Users/cltbld', 05:21:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:23 INFO - 'LOGNAME': 'cltbld', 05:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:23 INFO - 'MOZ_NO_REMOTE': '1', 05:21:23 INFO - 'NO_EM_RESTART': '1', 05:21:23 INFO - 'PAGER': '/bin/cat', 05:21:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:23 INFO - 'PWD': '/builds/slave/test', 05:21:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:23 INFO - 'SHELL': '/bin/bash', 05:21:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:23 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:23 INFO - 'USER': 'cltbld', 05:21:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:23 INFO - 'XPC_FLAGS': '0x0', 05:21:23 INFO - 'XPC_SERVICE_NAME': '0', 05:21:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-I9Ap9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-O7M13r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-1Ltdux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Zbv0vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-n1Ivu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ShXsrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-iWAkqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-1ogGfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-L2JYhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZeBeTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-fMEWNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-a5jAC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_mHVBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-wZynbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Blpdcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-V_mOqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DmceP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:25 INFO - Running setup.py install for manifestparser 05:21:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:25 INFO - Running setup.py install for mozcrash 05:21:25 INFO - Running setup.py install for mozdebug 05:21:25 INFO - Running setup.py install for mozdevice 05:21:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozfile 05:21:26 INFO - Running setup.py install for mozhttpd 05:21:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozinfo 05:21:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozInstall 05:21:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozleak 05:21:26 INFO - Running setup.py install for mozlog 05:21:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for moznetwork 05:21:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for mozprocess 05:21:27 INFO - Running setup.py install for mozprofile 05:21:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for mozrunner 05:21:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for mozscreenshot 05:21:27 INFO - Running setup.py install for moztest 05:21:27 INFO - Running setup.py install for mozversion 05:21:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:28 INFO - Cleaning up... 05:21:28 INFO - Return code: 0 05:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 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 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:28 INFO - 'HOME': '/Users/cltbld', 05:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:28 INFO - 'LOGNAME': 'cltbld', 05:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:28 INFO - 'MOZ_NO_REMOTE': '1', 05:21:28 INFO - 'NO_EM_RESTART': '1', 05:21:28 INFO - 'PAGER': '/bin/cat', 05:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:28 INFO - 'PWD': '/builds/slave/test', 05:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:28 INFO - 'SHELL': '/bin/bash', 05:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:28 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:28 INFO - 'USER': 'cltbld', 05:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:28 INFO - 'XPC_FLAGS': '0x0', 05:21:28 INFO - 'XPC_SERVICE_NAME': '0', 05:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2qKFTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-RO_P0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-55K0Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KBGWKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OlRE5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-nNfO09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-fMoq_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-sTBXps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2fyzOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-rveQAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-aLpJHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7AxB3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DWkokq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-B7R0Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-cL0w54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-HbyIby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-UQpBGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:32 INFO - Downloading blessings-1.6.tar.gz 05:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:32 INFO - Installing collected packages: blessings 05:21:32 INFO - Running setup.py install for blessings 05:21:32 INFO - Successfully installed blessings 05:21:32 INFO - Cleaning up... 05:21:32 INFO - Return code: 0 05:21:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:33 INFO - Reading from file tmpfile_stdout 05:21:33 INFO - Current package versions: 05:21:33 INFO - blessings == 1.6 05:21:33 INFO - blobuploader == 1.2.4 05:21:33 INFO - docopt == 0.6.1 05:21:33 INFO - manifestparser == 1.1 05:21:33 INFO - mozInstall == 1.12 05:21:33 INFO - mozcrash == 0.17 05:21:33 INFO - mozdebug == 0.1 05:21:33 INFO - mozdevice == 0.48 05:21:33 INFO - mozfile == 1.2 05:21:33 INFO - mozhttpd == 0.7 05:21:33 INFO - mozinfo == 0.9 05:21:33 INFO - mozleak == 0.1 05:21:33 INFO - mozlog == 3.1 05:21:33 INFO - moznetwork == 0.27 05:21:33 INFO - mozprocess == 0.22 05:21:33 INFO - mozprofile == 0.28 05:21:33 INFO - mozrunner == 6.11 05:21:33 INFO - mozscreenshot == 0.1 05:21:33 INFO - mozsystemmonitor == 0.0 05:21:33 INFO - moztest == 0.7 05:21:33 INFO - mozversion == 1.4 05:21:33 INFO - psutil == 3.1.1 05:21:33 INFO - requests == 1.2.3 05:21:33 INFO - wsgiref == 0.1.2 05:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:33 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 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:33 INFO - 'HOME': '/Users/cltbld', 05:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:33 INFO - 'LOGNAME': 'cltbld', 05:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:33 INFO - 'MOZ_NO_REMOTE': '1', 05:21:33 INFO - 'NO_EM_RESTART': '1', 05:21:33 INFO - 'PAGER': '/bin/cat', 05:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:33 INFO - 'PWD': '/builds/slave/test', 05:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:33 INFO - 'SHELL': '/bin/bash', 05:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:33 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:33 INFO - 'USER': 'cltbld', 05:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:33 INFO - 'XPC_FLAGS': '0x0', 05:21:33 INFO - 'XPC_SERVICE_NAME': '0', 05:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:33 INFO - Cleaning up... 05:21:33 INFO - Return code: 0 05:21:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:33 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 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:33 INFO - 'HOME': '/Users/cltbld', 05:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:33 INFO - 'LOGNAME': 'cltbld', 05:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:33 INFO - 'MOZ_NO_REMOTE': '1', 05:21:33 INFO - 'NO_EM_RESTART': '1', 05:21:33 INFO - 'PAGER': '/bin/cat', 05:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:33 INFO - 'PWD': '/builds/slave/test', 05:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:33 INFO - 'SHELL': '/bin/bash', 05:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:33 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:33 INFO - 'USER': 'cltbld', 05:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:33 INFO - 'XPC_FLAGS': '0x0', 05:21:33 INFO - 'XPC_SERVICE_NAME': '0', 05:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:33 INFO - Downloading/unpacking jsonschema 05:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:36 INFO - Downloading/unpacking functools32 (from jsonschema) 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:36 INFO - warning: no files found matching '*.txt' 05:21:36 INFO - no previously-included directories found matching 'build' 05:21:36 INFO - no previously-included directories found matching 'dist' 05:21:36 INFO - no previously-included directories found matching '.git*' 05:21:36 INFO - Installing collected packages: jsonschema, functools32 05:21:36 INFO - Running setup.py install for functools32 05:21:36 INFO - warning: no files found matching '*.txt' 05:21:36 INFO - no previously-included directories found matching 'build' 05:21:36 INFO - no previously-included directories found matching 'dist' 05:21:36 INFO - no previously-included directories found matching '.git*' 05:21:36 INFO - Successfully installed jsonschema functools32 05:21:36 INFO - Cleaning up... 05:21:36 INFO - Return code: 0 05:21:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:36 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 0x108b3fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b4f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf21caf0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, '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.0rqCbLoRym/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.q0qq2SXu1j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:36 INFO - 'HOME': '/Users/cltbld', 05:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:36 INFO - 'LOGNAME': 'cltbld', 05:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:36 INFO - 'MOZ_NO_REMOTE': '1', 05:21:36 INFO - 'NO_EM_RESTART': '1', 05:21:36 INFO - 'PAGER': '/bin/cat', 05:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:36 INFO - 'PWD': '/builds/slave/test', 05:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:36 INFO - 'SHELL': '/bin/bash', 05:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:21:36 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:36 INFO - 'USER': 'cltbld', 05:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:36 INFO - 'XPC_FLAGS': '0x0', 05:21:36 INFO - 'XPC_SERVICE_NAME': '0', 05:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:37 INFO - Downloading/unpacking flake8 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:40 INFO - no previously-included directories found matching 'docs/_build' 05:21:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:41 INFO - Running setup.py install for pep8 05:21:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:41 INFO - no previously-included directories found matching 'docs/_build' 05:21:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:41 INFO - Cleaning up... 05:21:41 INFO - Return code: 0 05:21:41 INFO - Running post-action listener: _resource_record_post_action 05:21:41 INFO - Running post-action listener: _start_resource_monitoring 05:21:41 INFO - Starting resource monitoring. 05:21:41 INFO - ##### 05:21:41 INFO - ##### Running install step. 05:21:41 INFO - ##### 05:21:41 INFO - Running pre-action listener: _resource_record_pre_action 05:21:41 INFO - Running main action method: install 05:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:41 INFO - Reading from file tmpfile_stdout 05:21:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:41 INFO - Reading from file tmpfile_stdout 05:21:41 INFO - Output received: 05:21:41 INFO - Usage: mozinstall [options] installer 05:21:41 INFO - Options: 05:21:41 INFO - -h, --help show this help message and exit 05:21:41 INFO - -d DEST, --destination=DEST 05:21:41 INFO - Directory to install application into. [default: 05:21:41 INFO - "/builds/slave/test"] 05:21:41 INFO - --app=APP Application being installed. [default: firefox] 05:21:41 INFO - mkdir: /builds/slave/test/build/application 05:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:22:15 INFO - Reading from file tmpfile_stdout 05:22:15 INFO - Output received: 05:22:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:22:15 INFO - Running post-action listener: _resource_record_post_action 05:22:15 INFO - ##### 05:22:15 INFO - ##### Running run-tests step. 05:22:15 INFO - ##### 05:22:15 INFO - Running pre-action listener: _resource_record_pre_action 05:22:15 INFO - Running main action method: run_tests 05:22:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:22:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:22:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:22:15 INFO - 2016-04-17 05:22:15.118 screenresolution[1679:11738] starting screenresolution argv=screenresolution get 05:22:15 INFO - 2016-04-17 05:22:15.120 screenresolution[1679:11738] Display 0: 1600x1200x32@60 05:22:15 INFO - 2016-04-17 05:22:15.126 screenresolution[1680:11740] starting screenresolution argv=screenresolution list 05:22:15 INFO - Available Modes on Display 0 05:22:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:22:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:22:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:22:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:22:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:22:15 INFO - Intel Iris: 05:22:15 INFO - Chipset Model: Intel Iris 05:22:15 INFO - Type: GPU 05:22:15 INFO - Bus: Built-In 05:22:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:22:15 INFO - Vendor: Intel (0x8086) 05:22:15 INFO - Device ID: 0x0a2e 05:22:15 INFO - Revision ID: 0x0009 05:22:15 INFO - Displays: 05:22:15 INFO - Display: 05:22:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:22:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:22:15 INFO - Display Serial Number: 1600x1200 60 05:22:15 INFO - Main Display: Yes 05:22:15 INFO - Mirror: Off 05:22:15 INFO - Online: Yes 05:22:15 INFO - Rotation: Supported 05:22:15 INFO - Return code: 0 05:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:15 INFO - Python 2.7.3 05:22:15 INFO - Return code: 0 05:22:15 INFO - grabbing minidump binary from tooltool 05:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089dee00>, '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 0x108847db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089d9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:22:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:22:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:15 INFO - Return code: 0 05:22:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:22:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:22:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:16 INFO - Return code: 0 05:22:16 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/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:22:16 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/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rqCbLoRym/Render', 05:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:16 INFO - 'HOME': '/Users/cltbld', 05:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:16 INFO - 'LOGNAME': 'cltbld', 05:22:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:16 INFO - 'MOZ_NO_REMOTE': '1', 05:22:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:16 INFO - 'NO_EM_RESTART': '1', 05:22:16 INFO - 'PAGER': '/bin/cat', 05:22:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:16 INFO - 'PWD': '/builds/slave/test', 05:22:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:16 INFO - 'SHELL': '/bin/bash', 05:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q0qq2SXu1j/Listeners', 05:22:16 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:16 INFO - 'USER': 'cltbld', 05:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:16 INFO - 'XPC_FLAGS': '0x0', 05:22:16 INFO - 'XPC_SERVICE_NAME': '0', 05:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:16 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/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:22:16 INFO - mozversion application_buildid: 20160417032814 05:22:16 INFO - mozversion application_changeset: f8c0dd78206cac5a132b164ebacfa8ffbac9713c 05:22:16 INFO - mozversion application_display_name: Nightly 05:22:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:16 INFO - mozversion application_name: Firefox 05:22:16 INFO - mozversion application_remotingname: firefox 05:22:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:16 INFO - mozversion application_vendor: Mozilla 05:22:16 INFO - mozversion application_version: 48.0a1 05:22:16 INFO - mozversion platform_buildid: 20160417032814 05:22:16 INFO - mozversion platform_changeset: f8c0dd78206cac5a132b164ebacfa8ffbac9713c 05:22:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:16 INFO - mozversion platform_version: 48.0a1 05:22:16 INFO - using testdate: 1460895736 05:22:16 INFO - actual date: 1460895736 05:22:16 INFO - starting webserver on 'localhost:49278' 05:22:16 INFO - SUITE-START | Running 2 tests 05:22:16 INFO - TEST-START | dromaeo_css 05:22:16 INFO - operating with platform_type : mac_ 05:22:16 INFO - Initialising browser for dromaeo_css test... 05:22:16 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpyluJpG/profile http://localhost:49278/getInfo.html) 05:22:19 INFO - PROCESS | 1698 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:22:19 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 05:22:19 INFO - PROCESS | 1698 | colorDepth:24 05:22:19 INFO - PROCESS | 1698 | Browser inner width/height: 1024/689 05:22:19 INFO - PROCESS | 1698 | __metrics 05:22:20 ERROR - PROCESS | 1698 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:22:20 INFO - TEST-INFO | 1698: exit 0 05:22:20 INFO - Browser initialized. 05:22:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:20 INFO - TEST-INFO | started process 1702 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpyluJpG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:32 INFO - PROCESS | 1702 | RSS: Main: 247795712 05:22:32 INFO - PROCESS | 1702 | 05:23:22 INFO - PROCESS | 1702 | 1460895802219 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:25:34 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:25:35 INFO - PROCESS | 1702 | RSS: Main: 259624960 05:25:35 INFO - PROCESS | 1702 | 05:28:37 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:28:37 INFO - PROCESS | 1702 | RSS: Main: 271626240 05:28:37 INFO - PROCESS | 1702 | 05:31:39 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:31:40 INFO - PROCESS | 1702 | RSS: Main: 273584128 05:31:40 INFO - PROCESS | 1702 | 05:34:42 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 05:34:42 INFO - PROCESS | 1702 | RSS: Main: 275202048 05:34:42 INFO - PROCESS | 1702 | 05:37:45 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:37:46 INFO - PROCESS | 1702 | RSS: Main: 278114304 05:37:46 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:40:48 INFO - PROCESS | 1702 | RSS: Main: 279126016 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | __start_tp_report 05:40:48 INFO - PROCESS | 1702 | _x_x_mozilla_page_load 05:40:48 INFO - PROCESS | 1702 | _x_x_mozilla_page_load_details 05:40:48 INFO - PROCESS | 1702 | |i|pagename|runs| 05:40:48 INFO - PROCESS | 1702 | |0;dojo.html;3472.2013936794538;3480.2343484433427;3495.4756786482026;3521.943416974907;3562.519059926911;4975.328330675357;5485.835424937253;5772.249607551023;5797.913031304529;5814.186013958049;5701.600887937836;5777.335606405265;5826.388229235933;5841.2114364560775;5970.641761494313;4634.606058485016;5029.899402011957;5242.18746094355;5317.042932272189;5375.489328513785;5351.277577527023;5357.892842143155;5376.059189641816;5403.729813509329;5414.3232095988005;5149.948500515022;5176.611754118438;5328;5386.676799392049;5430.972845135749;4553.590176884063;5044.949550504484;5275.788968441258;5299.231611416323;5339.466053394668;4673.784815947878;4988.5260900214425;5210.010098081352;5281.445448227919;5288.471152884719;4486.147631949919;5463.087919228278;5692.686902220376;5726.055200891848;5766.452187042224;6158.3841615838055;6205.503559715212;6233.407826256498;6237.376262373727;6244.906326405107;6096.024636058254;6159.661218632973;6243.469305109071;6268.686565671698;6281.59169653971;5984.401559843981;5987.9101813472835;5988.940110598838;6005;6059.818205453844;6371.396328095031;6398.136251606066;6409.903851442232;6419.325970773095;6428.228612566429;6092.870172099287;6105.095857753072;6113.174721412642;6198.163247961557;6201.627902325785;6095.831308332361;6172.105044768484;6208.627482351073;6237.313895471494;6266.843328916813;6113.5414843886;6137.0794380842335;6194.690265486708;6208.751649934043;6227.782027629011;6124.502994489374;6134;6165.352637972948;6201.224846894138;6204.751809927552;4981.078500477423;4981.950180498148;4987.700737955734;4998.350214472095;5020.7740651670765;4461.955380446154;4466.307722303049;4475.753833539186;4483.439570053743;4492.820287188541;5692.516136128393;5857.355690874;5892.1161825726485;5944.64332140073;5963.165156878041;6181.598196117238;6213.130161777355;6224.688765561704;6235.158253635701;6248.843778905472;5910.911336329958;5923.200367950358;5924.407559244128;5938.851528711817;5943.61366511184;5333.759980800874;5406.053940560386;5444.128939369682;5458.208559758813;5476.1511965644595;6456.870862582722;6468.741250349934;6472.838179045561;6485.740570377132;6514.674266286762;4979.3526841510375;6187.628742275298;6240.251169859646;6249.531285153723;6340.714667839866;6273.52948528853;6376.553641245068;6455.128557644845;6458.1281526995135;6459.967700161469;5694.54789028795;5729.71351432435;5738.010590955357;5751;6208.410201030895;6209.316975132641;6224.782132625336;6240.00159974402;6248.593841400295;6265.373462653698;5154.53609175176;6098.878022439615;6112.266528016667;6225.066240064027;6257.1552840367785;6190.628562286277;6227.06594010902;6232.127502149612;6238.189035425547;6255.530835187288;4825.469198388245;5753.626014309224;6048.727807248596;6049.727762250621;6050.425209605257;6148.139260503443;6189.690515474118;6189.96905015472;6198.039303907902;6210.782622608368;5999.460048595647;6101.5118790497545;6142.170806941006;6145.0782382642965;6157.815265542041 05:40:48 INFO - PROCESS | 1702 | |1;ext.html;490.9509049095089;552.1744991238099;552.4034043233308;563.8393057978477;579.0561384942545;37110.62889371105;37845;37923.81038094806;37967.62032379676;37976.81011594938;38662.22675546487;39328.60671393285;39377.818665440085;39413.21173576527;39431.81704548861;9375.765605859857;9485.668001619944;9588.904110958905;9622.278329125309;9631.229501639851;9486.478243696594;9639.469829159394;9661.806763864719;9734.56194471247;9735.415875047483;9637.759056023586;9694.854577181348;9719.076687714656;9721.90278097217;9728.416295022285;9625.085616866421;9646.75883102921;9659.420434773936;9717.757056073584;9739;9527.09492598209;9637.132658060738;9660.227181825507;9669.468179250209;9684.273679474067;37652;37680.62319376826;38098;38147;38220.80889595562;3163.2531790991525;3332.7667063305335;3442.1050526863196;3469.3581687387914;3548.432250839879;26876;28251.434971300663;28504.714952850412;28533.28666783347;28551.714482855114;2638.7888968882444;2663.5738281874806;2700.1899430171065;2819.154253723895;2828.8444135572536;352330;353554;354620;356558;357188;55000;61919.38080619226;64467;66036;66137;61925.38074619286;61955.38044619496;61964.380356196765;62291.065634015526;62566.18452169572;16353.26410311515;16475.505734827973;16654.916725416297;16659.50064494177;16722.24749886258;10695.251332406813;12579.308138052495;12757.234565926074;12845.550405735754;13046.152000119962;19331.806681933;19341.51646208828;19469.415917522496;19520.609587808165;19594.90202548978;7942.285194332538;8072.596370181467;8100.635471403801;8117.431779775359;8228.753137405887;751.305042835375;856.6978193146383;943.9764005899907;950.3870003847479;1179.3808250668467;29341.093203292272;29415.852920735688;29580.704192958226;29851.552226716616;30240.243993900327;865.9954452834681;1080.7946490166844;1109.5062697099875;1149.6148790155225;1164.9009834164021;14356.85643143576;14476.34856431463;14484.203368814817;14772.778408323884;14893.404263829541;592480;624293;630139;631904;633504;58676;59584;59668.80662386815;59683;59750.402495974486;1460.5618314505605;1498.655309278872;1504.6689728259985;1509.7282489152058;1514.2655811931204;28019.439611207254;28195.26715879701;28388.43223135567;28548.286292842844;28678.56982145311;49250.50749492459;49296.50703492919;49509;49655.75860603514;49692;457907;460122;462119;524189;524975;24072;25906.611400828624;26571.734282656926;26865.328366790985;27001.324966875985;45977.62067137991;46064;46119.538804611526;46974.53025469838;47368.289475657206;36547.26905461929;37759.49745737274;37923.620763793115;38412;38439;27837.443251135268;28017.859910700317;34278.48582271318;36731.44902826406;38351;31738;33873.661263388036;36622.45066323954;37370.626293736714;38173;32320.676793231767;32366;32415.86544470932;32434.83782581072;32782.68869245204;19480.51298717487;23701.762982370645;23893.880530597235;23980.80095995228;24432.389190269674 05:40:48 INFO - PROCESS | 1702 | |2;jquery.html;390.984360625575;396.32426712455265;400.6494317472212;401.853323536909;407.5761208343323;14180.574582762534;19617.50956226095;19643.410697679057;19814.504637384074;20153.496162595904;19935.60128797423;20023.899880500576;20065.09707063182;20526.178952841867;21169.153233870627;5696.373398926125;5700.37295897453;5814.331351894544;5848.210491583624;5912.260967379078;5220.981908527839;5818.389069147742;5864.2962844458725;5865.178874957509;5915.438033386843;5727.484526392624;5790.189373487715;5916.940830591703;5954.2259506264345;5964.642121472725;5608.186812912105;5815.273090863663;5872.970635146797;5895.292564892197;5964.97017514914;5073;5111.386633603955;5174.534291913708;5185.714785686786;5190.844274671766;11967.820482692767;25201.747982520123;25508;25530.489390212093;25589;2096.790320967891;2319.8492098013576;2480.779702166551;2599.7010343810325;2625.5142798582324;9915.702528924072;9915.950420247924;10024.699259022242;10133.442660653662;10226;1748.5715999580184;1749.685056689808;1754.8558617542647;1777.297967302908;1780.6883795335893;68813;83963.16036839614;123360.38319808434;123756;129973.35013324967;11466.73865874753;11516.539338426537;11721.296722196696;11737.53280839895;11808.232464889754;14993;15048.849511504965;15070.397184112731;15198.848011519744;15209.315580798891;8680.522571258642;8778.692745753868;8838.337124715672;8851.20339169465;8969.058248883774;8713.52075635846;8744.562771861381;8771.824563508693;8783.385163038654;8880.644774208959;4609.446866376056;4612.930806037912;4664.323673067386;4669.60308373792;4748.430188377417;1537.438834825303;1818.7726534183228;1825.9908700456413;1971.5268335599353;1994.6037773558567;920.861870719384;955.9187469065068;979.2998006425298;1017.7583348315044;1022.3508072373947;18747.25010999572;19278.13248403825;19880.403587892386;20136;20267.797322026887;874.9475031498131;952.8332541805156;960.2366118935463;989.1592146675413;1018.3584341864578;10314.690559283234;10572.577096916191;10582.20994858624;10647.148228141885;10675.733106672395;464622.6768866134;533611;575362;577354;623679;102571;113523;114924.42537787424;116706.41646791712;119858.80141198651;768;858.6479543387181;994.4679596415883;1001.2590682894605;1014.0265345268477;14216.857831421967;17597.560060998578;17837.286508539513;17928.731069034235;17944.21009119013;48467.757661212876;50271;50576;52417.475825242786;52923;76703.61648191723;76823;76935.61532192303;78422;79654;7076.540024898365;7524.05949256343;7963.92036079655;8036.919630803851;8343.749687509384;11564.710882228012;12569.937150314556;12667.87332126667;12849.357532123544;12874.098813082994;9563.234941204826;11018.724531886446;11037.779244415227;11129.054030407506;11311.773764524827;10805.567777288821;11002.559897604326;11045.558177673125;11189.608363707232;11263.436828158723;10587.788244235226;10620.150387969099;11558.457139429313;11634.476448559666;11713.238639488405;8104.27061564462;8129.9187008129165;8132.959335203286;8353.707620233263;8559.844421003334;8907.51008694528;9563.569639366106;9914.851277230702;10150.49247537635;11160.665180044612 05:40:48 INFO - PROCESS | 1702 | |3;mootools.html;1284.997701792602;1554.0675594643214;1818.972715409269;1968.5373937124764;1981.7126516655076;7947.165547617489;8453.57732113395;8509.936257967754;8757.60590773415;8782.033976262606;8473.703420380289;8511.446755960858;8550.615222314995;8626.525541095238;8627.13728627137;2435.585950388434;2463.3718401807514;2465.802735781142;2467.679201703776;2473.579491486452;2396.1373905394044;2433.598456254716;2447.951040979179;2448.5470188015183;2477.4054226985486;2060.9484762880898;2443.1815341860497;2463.815213858959;2467.247489515697;2476.6656501372263;2024.3218521795216;2401.3396316013063;2422.672939153218;2425.6604075429454;2443.4013666651695;2368.7868091871815;2372.5373552157334;2390.6294524348755;2420.612701967694;2421.7457166997388;8705.47767133974;8728.956355218183;8760;8819.250363719028;8863.423877447945;5232.476752324776;5364.597655175878;5423.755930983115;5429.212764149176;5432.809851655173;3563.3051554946796;3589.46158076288;3597.6582224688614;3647.069997150736;3656.7988760618155;1038.5949479702922;1048.5124417146064;1060.4697651174413;1069.326324415621;1099.5381939585313;11342.489587968561;11493.367864767435;11493.482793274323;11507.021903138244;11529.884701152965;4124.319487284564;4737.786799594027;4789;4802.586692770898;4906.337644417958;9806.264530160266;9829.803403932025;9872.35829671069;9913.851292230622;9915.553800079013;5209.505097015777;5266.289050978069;5320.946790532123;5329.866753331198;5336.279602253724;4102.528209255914;4409.184300904343;4754.477007529169;4826.8069277228515;4899.338589290472;3725.1059745661387;3764.0778009387327;3804.961950380516;3810.657040866335;3837.6737977271687;1163.4473625028045;1344.5764584155959;1345.6972181259334;1352.9255890925897;1363.2025265219957;807.6284908941952;832.820943497151;841.9957900210583;884.1644645809777;959.8416261316804;5464.016477034172;5614.438556144353;5988.161657367972;6036.426539478743;6126.754929802758;960.1550635440767;961.3174646001418;997.8004399120205;1006.4917216805612;1006.5420233793607;3063.6323641163203;3965.8810235692977;3974.324364857981;3988.760674359548;4041.777702226347;8663.653453861774;8738.86891696625;10114.089731924161;10501.002404771534;10520.684379468476;10118.836333821557;10332.483375831178;10526;10602.25784195099;10623.734406639742;7739.3034626883855;7815.101263354673;7968.402369822286;8182.386321025947;8204.220599043081;5932.762689492372;5948.345681975065;5972.462478376793;6027.457528822427;6076.237891011557;9469.573869176042;9756.658516951873;9797.510124493889;9801.607935682778;9865.358751681119;9444.811103778024;9957.452340121363;9963.651272205438;9977.60089596408;9997.60009599637;6938.410235130071;7234.457415693739;7568.508046977149;7964.283214510722;8277.710280140167;8200.466969646954;8294.212049855254;8324.916750832414;8339.624716887876;8342.916570834213;7209.35115839577;7285;7378.815529611803;7499.362554182955;7528.284812942762;7255.2019277880445;7286.214877355082;7289.5261807982315;7322.780316590511;7377.26227377258;6849.554778939353;6898.827529311808;6928.792136235921;7024.578525288499;7034.929650703428;4759.048190362011;4797.64017698667;4807.807687692453;4886.315915771866;5088.440271570198;4404.295312750073;4971.502849715;4982.451930287593;5006.349174607423;5258.631895767259 05:40:48 INFO - PROCESS | 1702 | |4;prototype.html;317.92846609512856;319.98400079996;326.7810566920163;331.6037335384217;332.52116951589693;5238.790448382065;5423.884684972863;5932.576181716389;6187.38126187381;6198.101275315076;6082.99630560958;6111.877762444748;6122.35715249899;6126.509879209652;6135.386461353863;4348.391225228463;4462.174497717916;4562.4753153387455;4600.1259760645535;4633.351330813672;3905.3556163233034;4551.476580193287;4564.109998550284;4577.839775607855;4585.81656733732;4524.34397012433;4544.681872268942;4545.931811022837;4576.931346029813;4583.977080114595;3630.2739452109554;4394.780260986954;4517.186906356855;4519.807893171809;4561.315802629632;3278.262520863946;3576.535050443452;3717.3457811273993;3923.431102490123;3933.5083114610675;4916.508349165055;5594.440555944373;5759.3376761672525;5762.250907382014;5783.161441590988;4406.250937340627;4694.924824240128;4699.78850951708;4832.9758351208375;5312.3093997780425;6383.585066970632;6393;6419.51853610981;6459.674517173814;6500.674966251716;4181.038361176916;4385.364122202294;4406.757628330441;4416.580424859633;4436.378906953029;6336.873262534769;6815.352541508549;6868.656567171622;6872.793816185523;6877.828054298632;3901.96098039016;4094.263032654091;4266.466691663542;4312.159128969821;4316.417283666665;3747.9402806211942;3841.5006049213425;4273.145370925828;4370.672199585044;4406.625436837905;5150.27896094547;5160.174372100446;5189.455107213764;5198.324217851655;5200.271961925334;5425.430329815392;6320.735852829453;6466.482681385478;6477.4170324671;6483.3192514786215;1506.006036016224;1506.7739839024234;1566.6240102375348;1580.0677600215927;1594.3224129744813;888.7200531832452;1022.3610243597751;1037.5331101004579;1044.300318786415;1054.6783231114584;5837.883242335214;5905.852353691193;5960.910586341209;5986.940130598726;6062.969685151546;6453.998520917062;6463.773767918195;6612.983040172793;6621.768238111739;6657.400833924873;5161.786980059683;5194.792208311701;5861;5905.675187864708;5940.34656187819;2889.9711002889703;3399.218179818606;3434.708049815794;3492.441209406483;3518.612952575215;6586.2666993198245;6863.553868998499;6886.24251332353;6929.376356127973;6930.618815965069;5197.038547868657;6635.435987940982;6852.554583952126;6860.5540639858245;6929.133858267716;6635.601863888182;6841.863162736817;6882.518223724492;6898.7240510380025;6928.293363050844;5491.341039075336;6572.34276572339;6599.934000659932;6605.834854128685;6612.272650008592;6157.9223635862645;6298.968505157445;6314.589551679126;6456.096146539582;6527.706253218522;6814.182298124257;6870.828229294308;6882.311768823078;6884.931150688429;6922.965385173042;3795.81020948957;4152.875413737593;4491.865244042684;4507.932381014353;4508.346289788028;5112.463191364853;6589;6597.637129957707;6604.933950660432;6651.600903945779;6355.777547785805;6399.8240598196835;6402.343027643662;6438.581492202992;6443.162388889415;6171.228596425447;6330.873382532415;6371.23545174582;6427.228732552124;6452.9677351612945;6018.946684330137;6120.846978825565;6156.384361563808;6229.283632382334;6323.399277068671;6428.485721142204;6452.774152904626;6459.483241340776;6500;6510.3489651034515;6116;6357.936420635734;6362.745490180341;6364.586301890362;6433.839154021187 05:40:48 INFO - PROCESS | 1702 | |5;yui.html;679.8742232686953;680.7141000779674;752.4582300743463;772.1930582541244;773.9690412383505;14843.332050057747;15184.240787960613;15237.619059523504;15257;15388.538343849688;14266.072705274177;14343.64140896478;14381.1371317721;14381.568552943403;14411.855881441183;724.626817189148;903.7424334064809;907.1110311894347;918.8805455290836;935.7379933618598;887.9556022198897;918;922.9815403691922;930.7393929699695;932.1936524905941;810.5177419435427;906.1165363770305;929.665320484625;933.2021121940745;935.4200395754642;909.1090731083542;921.3964853021282;926.7405126564573;928.0951072704127;935.0789472369711;681.7102731339161;694.9930500694979;698.9231184569693;699.993000070003;702.6908160409404;14869.330880110312;14925.2537373132;14962.251887405586;14970.326335314938;14991.250437478191;12947.805782913263;12968.80546791799;13000.609981700563;13110.341985172521;13134.474621015148;8087.797805054862;9961.75095622608;10183;10251;10281.485925703684;3497.3355062538035;3527.94708079379;3529.594096678889;3560.5223832109646;3646.7629604075914;76315.85526217111;78475.43049139042;80724.38551228943;81466;81727.5913620428;9445.338826282094;9623.278254130968;9687.70936871895;9769.658061967797;9790.804183916423;22588.32235032919;22700.97845596952;22766;22832.543349132924;22948;7664.195259497673;7717.073951125901;7837.216278372117;7959;8025.197480252044;4189.2459357315975;4191.811368488365;4226.915461690749;4233.5131459881895;4292.5707429257445;3645.9270814584092;3750.5499340079364;3753.0617345663586;3767.6609105180664;3771.9622803771613;650.7039297119799;653.4315145823165;656.8948968165071;657.1752450674373;668.9966550167316;502.5627703897633;508.83208541181324;556.2240674259385;573.8221151443066;615.8398816307792;7370.115586129698;7682.732349162326;8071.07182674;8093.271605555528;8165.2243036911395;479.6330806932699;522.1958184395987;562.2129019372829;580.9542822918813;615.8614311779813;3840.4431357453573;3843.080058340477;3927.7054220933546;3938.783366914847;4003.899902502461;91086.08913910776;93390.53304733433;93756.0624393761;93889.0611093894;95158.0484195163;79630.6018469904;80923.19076809274;81183;81368.59315703383;82051.7692234617;70320;70400.99999999898;70473;70666;71401;7535.886961695469;7551.962240188764;7768.184340644377;7791.805204869697;7883.921160788548;43900.56099439092;44877.32684009677;45087;45598.63204103882;45893;57396.71301643465;63255.36744632495;64717;64821.67589162024;65069;9960.601575936882;10102.242331824995;10302.639407620996;10477.895221047693;10964.616238431616;10568.682939511827;10629.787404252027;10690.786184276427;10815;11119.944400277947;10232.23258255619;10425.687229383131;10557.472126393803;10677.985591368808;10701.090407315465;10142.137918277029;10303.227257955834;10608.416537090534;10615.469226538797;10713.089387402159;8732.388732788644;9018.23345015681;9880.604775809175;10001.149672343347;10284.537195826057;6544.901826472702;8531.402801803813;8770.25452836516;9142.680006199751;9205.079492050741;7267.927320726936;7787.162835172553;8894.777630559287;8924.464532128093;9005.504697241715 05:40:48 INFO - PROCESS | 1702 | __end_tp_report 05:40:48 INFO - PROCESS | 1702 | __start_cc_report 05:40:48 INFO - PROCESS | 1702 | _x_x_mozilla_cycle_collect,412 05:40:48 INFO - PROCESS | 1702 | __end_cc_report 05:40:48 INFO - PROCESS | 1702 | __startTimestamp1460896848745__endTimestamp 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | ------- Summary: start ------- 05:40:48 INFO - PROCESS | 1702 | Number of tests: 6 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | [#0] dojo.html Cycles:165 Average:5755.39 Median:6005.00 stddev:656.60 (10.9%) stddev-sans-first:633.71 05:40:48 INFO - PROCESS | 1702 | Values: 3472.2 3480.2 3495.5 3521.9 3562.5 4975.3 5485.8 5772.2 5797.9 5814.2 5701.6 5777.3 5826.4 5841.2 5970.6 4634.6 5029.9 5242.2 5317.0 5375.5 5351.3 5357.9 5376.1 5403.7 5414.3 5149.9 5176.6 5328.0 5386.7 5431.0 4553.6 5044.9 5275.8 5299.2 5339.5 4673.8 4988.5 5210.0 5281.4 5288.5 4486.1 5463.1 5692.7 5726.1 5766.5 6158.4 6205.5 6233.4 6237.4 6244.9 6096.0 6159.7 6243.5 6268.7 6281.6 5984.4 5987.9 5988.9 6005.0 6059.8 6371.4 6398.1 6409.9 6419.3 6428.2 6092.9 6105.1 6113.2 6198.2 6201.6 6095.8 6172.1 6208.6 6237.3 6266.8 6113.5 6137.1 6194.7 6208.8 6227.8 6124.5 6134.0 6165.4 6201.2 6204.8 4981.1 4982.0 4987.7 4998.4 5020.8 4462.0 4466.3 4475.8 4483.4 4492.8 5692.5 5857.4 5892.1 5944.6 5963.2 6181.6 6213.1 6224.7 6235.2 6248.8 5910.9 5923.2 5924.4 5938.9 5943.6 5333.8 5406.1 5444.1 5458.2 5476.2 6456.9 6468.7 6472.8 6485.7 6514.7 4979.4 6187.6 6240.3 6249.5 6340.7 6273.5 6376.6 6455.1 6458.1 6460.0 5694.5 5729.7 5738.0 5751.0 6208.4 6209.3 6224.8 6240.0 6248.6 6265.4 5154.5 6098.9 6112.3 6225.1 6257.2 6190.6 6227.1 6232.1 6238.2 6255.5 4825.5 5753.6 6048.7 6049.7 6050.4 6148.1 6189.7 6190.0 6198.0 6210.8 5999.5 6101.5 6142.2 6145.1 6157.8 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | [#1] ext.html Cycles:180 Average:62838.53 Median:37945.72 stddev:133604.12 (352.1%) stddev-sans-first:133896.91 05:40:48 INFO - PROCESS | 1702 | Values: 491.0 552.2 552.4 563.8 579.1 37110.6 37845.0 37923.8 37967.6 37976.8 38662.2 39328.6 39377.8 39413.2 39431.8 9375.8 9485.7 9588.9 9622.3 9631.2 9486.5 9639.5 9661.8 9734.6 9735.4 9637.8 9694.9 9719.1 9721.9 9728.4 9625.1 9646.8 9659.4 9717.8 9739.0 9527.1 9637.1 9660.2 9669.5 9684.3 37652.0 37680.6 38098.0 38147.0 38220.8 3163.3 3332.8 3442.1 3469.4 3548.4 26876.0 28251.4 28504.7 28533.3 28551.7 2638.8 2663.6 2700.2 2819.2 2828.8 352330.0 353554.0 354620.0 356558.0 357188.0 55000.0 61919.4 64467.0 66036.0 66137.0 61925.4 61955.4 61964.4 62291.1 62566.2 16353.3 16475.5 16654.9 16659.5 16722.2 10695.3 12579.3 12757.2 12845.6 13046.2 19331.8 19341.5 19469.4 19520.6 19594.9 7942.3 8072.6 8100.6 8117.4 8228.8 751.3 856.7 944.0 950.4 1179.4 29341.1 29415.9 29580.7 29851.6 30240.2 866.0 1080.8 1109.5 1149.6 1164.9 14356.9 14476.3 14484.2 14772.8 14893.4 592480.0 624293.0 630139.0 631904.0 633504.0 58676.0 59584.0 59668.8 59683.0 59750.4 1460.6 1498.7 1504.7 1509.7 1514.3 28019.4 28195.3 28388.4 28548.3 28678.6 49250.5 49296.5 49509.0 49655.8 49692.0 457907.0 460122.0 462119.0 524189.0 524975.0 24072.0 25906.6 26571.7 26865.3 27001.3 45977.6 46064.0 46119.5 46974.5 47368.3 36547.3 37759.5 37923.6 38412.0 38439.0 27837.4 28017.9 34278.5 36731.4 38351.0 31738.0 33873.7 36622.5 37370.6 38173.0 32320.7 32366.0 32415.9 32434.8 32782.7 19480.5 23701.8 23893.9 23980.8 24432.4 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | [#2] jquery.html Cycles:180 Average:32790.93 Median:2612.61 stddev:92929.03 (3556.9%) stddev-sans-first:93157.88 05:40:48 INFO - PROCESS | 1702 | Values: 391.0 396.3 400.6 401.9 407.6 14180.6 19617.5 19643.4 19814.5 20153.5 19935.6 20023.9 20065.1 20526.2 21169.2 5696.4 5700.4 5814.3 5848.2 5912.3 5221.0 5818.4 5864.3 5865.2 5915.4 5727.5 5790.2 5916.9 5954.2 5964.6 5608.2 5815.3 5873.0 5895.3 5965.0 5073.0 5111.4 5174.5 5185.7 5190.8 11967.8 25201.7 25508.0 25530.5 25589.0 2096.8 2319.8 2480.8 2599.7 2625.5 9915.7 9916.0 10024.7 10133.4 10226.0 1748.6 1749.7 1754.9 1777.3 1780.7 68813.0 83963.2 123360.4 123756.0 129973.4 11466.7 11516.5 11721.3 11737.5 11808.2 14993.0 15048.8 15070.4 15198.8 15209.3 8680.5 8778.7 8838.3 8851.2 8969.1 8713.5 8744.6 8771.8 8783.4 8880.6 4609.4 4612.9 4664.3 4669.6 4748.4 1537.4 1818.8 1826.0 1971.5 1994.6 920.9 955.9 979.3 1017.8 1022.4 18747.3 19278.1 19880.4 20136.0 20267.8 874.9 952.8 960.2 989.2 1018.4 10314.7 10572.6 10582.2 10647.1 10675.7 464622.7 533611.0 575362.0 577354.0 623679.0 102571.0 113523.0 114924.4 116706.4 119858.8 768.0 858.6 994.5 1001.3 1014.0 14216.9 17597.6 17837.3 17928.7 17944.2 48467.8 50271.0 50576.0 52417.5 52923.0 76703.6 76823.0 76935.6 78422.0 79654.0 7076.5 7524.1 7963.9 8036.9 8343.7 11564.7 12569.9 12667.9 12849.4 12874.1 9563.2 11018.7 11037.8 11129.1 11311.8 10805.6 11002.6 11045.6 11189.6 11263.4 10587.8 10620.2 11558.5 11634.5 11713.2 8104.3 8129.9 8133.0 8353.7 8559.8 8907.5 9563.6 9914.9 10150.5 11160.7 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | [#3] mootools.html Cycles:180 Average:5643.91 Median:5245.55 stddev:3102.32 (59.1%) stddev-sans-first:3093.72 05:40:48 INFO - PROCESS | 1702 | Values: 1285.0 1554.1 1819.0 1968.5 1981.7 7947.2 8453.6 8509.9 8757.6 8782.0 8473.7 8511.4 8550.6 8626.5 8627.1 2435.6 2463.4 2465.8 2467.7 2473.6 2396.1 2433.6 2448.0 2448.5 2477.4 2060.9 2443.2 2463.8 2467.2 2476.7 2024.3 2401.3 2422.7 2425.7 2443.4 2368.8 2372.5 2390.6 2420.6 2421.7 8705.5 8729.0 8760.0 8819.3 8863.4 5232.5 5364.6 5423.8 5429.2 5432.8 3563.3 3589.5 3597.7 3647.1 3656.8 1038.6 1048.5 1060.5 1069.3 1099.5 11342.5 11493.4 11493.5 11507.0 11529.9 4124.3 4737.8 4789.0 4802.6 4906.3 9806.3 9829.8 9872.4 9913.9 9915.6 5209.5 5266.3 5320.9 5329.9 5336.3 4102.5 4409.2 4754.5 4826.8 4899.3 3725.1 3764.1 3805.0 3810.7 3837.7 1163.4 1344.6 1345.7 1352.9 1363.2 807.6 832.8 842.0 884.2 959.8 5464.0 5614.4 5988.2 6036.4 6126.8 960.2 961.3 997.8 1006.5 1006.5 3063.6 3965.9 3974.3 3988.8 4041.8 8663.7 8738.9 10114.1 10501.0 10520.7 10118.8 10332.5 10526.0 10602.3 10623.7 7739.3 7815.1 7968.4 8182.4 8204.2 5932.8 5948.3 5972.5 6027.5 6076.2 9469.6 9756.7 9797.5 9801.6 9865.4 9444.8 9957.5 9963.7 9977.6 9997.6 6938.4 7234.5 7568.5 7964.3 8277.7 8200.5 8294.2 8324.9 8339.6 8342.9 7209.4 7285.0 7378.8 7499.4 7528.3 7255.2 7286.2 7289.5 7322.8 7377.3 6849.6 6898.8 6928.8 7024.6 7034.9 4759.0 4797.6 4807.8 4886.3 5088.4 4404.3 4971.5 4982.5 5006.3 5258.6 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | [#4] prototype.html Cycles:180 Average:5208.90 Median:5919.21 stddev:1655.16 (28.0%) stddev-sans-first:1618.58 05:40:48 INFO - PROCESS | 1702 | Values: 317.9 320.0 326.8 331.6 332.5 5238.8 5423.9 5932.6 6187.4 6198.1 6083.0 6111.9 6122.4 6126.5 6135.4 4348.4 4462.2 4562.5 4600.1 4633.4 3905.4 4551.5 4564.1 4577.8 4585.8 4524.3 4544.7 4545.9 4576.9 4584.0 3630.3 4394.8 4517.2 4519.8 4561.3 3278.3 3576.5 3717.3 3923.4 3933.5 4916.5 5594.4 5759.3 5762.3 5783.2 4406.3 4694.9 4699.8 4833.0 5312.3 6383.6 6393.0 6419.5 6459.7 6500.7 4181.0 4385.4 4406.8 4416.6 4436.4 6336.9 6815.4 6868.7 6872.8 6877.8 3902.0 4094.3 4266.5 4312.2 4316.4 3747.9 3841.5 4273.1 4370.7 4406.6 5150.3 5160.2 5189.5 5198.3 5200.3 5425.4 6320.7 6466.5 6477.4 6483.3 1506.0 1506.8 1566.6 1580.1 1594.3 888.7 1022.4 1037.5 1044.3 1054.7 5837.9 5905.9 5960.9 5986.9 6063.0 6454.0 6463.8 6613.0 6621.8 6657.4 5161.8 5194.8 5861.0 5905.7 5940.3 2890.0 3399.2 3434.7 3492.4 3518.6 6586.3 6863.6 6886.2 6929.4 6930.6 5197.0 6635.4 6852.6 6860.6 6929.1 6635.6 6841.9 6882.5 6898.7 6928.3 5491.3 6572.3 6599.9 6605.8 6612.3 6157.9 6299.0 6314.6 6456.1 6527.7 6814.2 6870.8 6882.3 6884.9 6923.0 3795.8 4152.9 4491.9 4507.9 4508.3 5112.5 6589.0 6597.6 6604.9 6651.6 6355.8 6399.8 6402.3 6438.6 6443.2 6171.2 6330.9 6371.2 6427.2 6453.0 6018.9 6120.8 6156.4 6229.3 6323.4 6428.5 6452.8 6459.5 6500.0 6510.3 6116.0 6357.9 6362.7 6364.6 6433.8 05:40:48 INFO - PROCESS | 1702 | 05:40:48 INFO - PROCESS | 1702 | [#5] yui.html Cycles:180 Average:17969.07 Median:3599.17 stddev:25628.28 (712.1%) stddev-sans-first:25667.30 05:40:48 INFO - PROCESS | 1702 | Values: 679.9 680.7 752.5 772.2 774.0 14843.3 15184.2 15237.6 15257.0 15388.5 14266.1 14343.6 14381.1 14381.6 14411.9 724.6 903.7 907.1 918.9 935.7 888.0 918.0 923.0 930.7 932.2 810.5 906.1 929.7 933.2 935.4 909.1 921.4 926.7 928.1 935.1 681.7 695.0 698.9 700.0 702.7 14869.3 14925.3 14962.3 14970.3 14991.3 12947.8 12968.8 13000.6 13110.3 13134.5 8087.8 9961.8 10183.0 10251.0 10281.5 3497.3 3527.9 3529.6 3560.5 3646.8 76315.9 78475.4 80724.4 81466.0 81727.6 9445.3 9623.3 9687.7 9769.7 9790.8 22588.3 22701.0 22766.0 22832.5 22948.0 7664.2 7717.1 7837.2 7959.0 8025.2 4189.2 4191.8 4226.9 4233.5 4292.6 3645.9 3750.5 3753.1 3767.7 3772.0 650.7 653.4 656.9 657.2 669.0 502.6 508.8 556.2 573.8 615.8 7370.1 7682.7 8071.1 8093.3 8165.2 479.6 522.2 562.2 581.0 615.9 3840.4 3843.1 3927.7 3938.8 4003.9 91086.1 93390.5 93756.1 93889.1 95158.0 79630.6 80923.2 81183.0 81368.6 82051.8 70320.0 70401.0 70473.0 70666.0 71401.0 7535.9 7552.0 7768.2 7791.8 7883.9 43900.6 44877.3 45087.0 45598.6 45893.0 57396.7 63255.4 64717.0 64821.7 65069.0 9960.6 10102.2 10302.6 10477.9 10964.6 10568.7 10629.8 10690.8 10815.0 11119.9 10232.2 10425.7 10557.5 10678.0 10701.1 10142.1 10303.2 10608.4 10615.5 10713.1 8732.4 9018.2 9880.6 10001.1 10284.5 6544.9 8531.4 8770.3 9142.7 9205.1 7267.9 7787.2 8894.8 8924.5 9005.5 05:40:48 INFO - PROCESS | 1702 | -------- Summary: end -------- 05:40:48 INFO - PROCESS | 1702 | 05:40:49 INFO - TEST-INFO | 1702: exit 0 05:40:49 INFO - TEST-OK | dromaeo_css | took 1112406ms 05:40:49 INFO - TEST-START | kraken 05:40:49 INFO - operating with platform_type : mac_ 05:40:49 INFO - Initialising browser for kraken test... 05:40:49 INFO - TEST-INFO | started process 1713 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpMUpqXK/profile http://localhost:49278/getInfo.html) 05:40:51 INFO - PROCESS | 1713 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:40:52 INFO - PROCESS | 1713 | __metrics Screen width/height:1600/1200 05:40:52 INFO - PROCESS | 1713 | colorDepth:24 05:40:52 INFO - PROCESS | 1713 | Browser inner width/height: 1024/689 05:40:52 INFO - PROCESS | 1713 | __metrics 05:40:52 ERROR - PROCESS | 1713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:40:52 INFO - TEST-INFO | 1713: exit 0 05:40:52 INFO - Browser initialized. 05:40:52 INFO - Running cycle 1/1 for kraken test... 05:40:52 INFO - TEST-INFO | started process 1716 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpMUpqXK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:04 INFO - PROCESS | 1716 | RSS: Main: 248053760 05:41:04 INFO - PROCESS | 1716 | 05:41:07 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:08 INFO - PROCESS | 1716 | RSS: Main: 260218880 05:41:08 INFO - PROCESS | 1716 | 05:41:11 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:41:11 INFO - PROCESS | 1716 | RSS: Main: 269672448 05:41:11 INFO - PROCESS | 1716 | 05:41:15 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:41:15 INFO - PROCESS | 1716 | RSS: Main: 272445440 05:41:15 INFO - PROCESS | 1716 | 05:41:17 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:41:18 INFO - PROCESS | 1716 | RSS: Main: 273420288 05:41:18 INFO - PROCESS | 1716 | 05:41:20 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:21 INFO - PROCESS | 1716 | RSS: Main: 273780736 05:41:21 INFO - PROCESS | 1716 | 05:41:24 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:24 INFO - PROCESS | 1716 | RSS: Main: 273731584 05:41:24 INFO - PROCESS | 1716 | 05:41:27 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:28 INFO - PROCESS | 1716 | RSS: Main: 273858560 05:41:28 INFO - PROCESS | 1716 | 05:41:31 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:41:31 INFO - PROCESS | 1716 | RSS: Main: 275529728 05:41:31 INFO - PROCESS | 1716 | 05:41:33 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:34 INFO - PROCESS | 1716 | RSS: Main: 275075072 05:41:34 INFO - PROCESS | 1716 | 05:41:35 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:36 INFO - PROCESS | 1716 | RSS: Main: 275107840 05:41:36 INFO - PROCESS | 1716 | 05:41:38 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:39 INFO - PROCESS | 1716 | RSS: Main: 275378176 05:41:39 INFO - PROCESS | 1716 | 05:41:42 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:43 INFO - PROCESS | 1716 | RSS: Main: 275660800 05:41:43 INFO - PROCESS | 1716 | 05:41:46 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:46 INFO - PROCESS | 1716 | RSS: Main: 275628032 05:41:46 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:41:48 INFO - PROCESS | 1716 | RSS: Main: 277241856 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | __start_tp_report 05:41:48 INFO - PROCESS | 1716 | _x_x_mozilla_page_load 05:41:48 INFO - PROCESS | 1716 | _x_x_mozilla_page_load_details 05:41:48 INFO - PROCESS | 1716 | |i|pagename|runs| 05:41:48 INFO - PROCESS | 1716 | |0;ai-astar;120;158;143;116;115;128;116;117;117;115 05:41:48 INFO - PROCESS | 1716 | |1;audio-beat-detection;179;128;192;203;156;144;125;166;161;124 05:41:48 INFO - PROCESS | 1716 | |2;audio-dft;198;216;216;235;194;199;197;218;255;211 05:41:48 INFO - PROCESS | 1716 | |3;audio-fft;65;71;80;140;58;63;81;88;157;53 05:41:48 INFO - PROCESS | 1716 | |4;audio-oscillator;84;84;136;77;81;83;118;82;83;116 05:41:48 INFO - PROCESS | 1716 | |5;imaging-gaussian-blur;90;97;120;86;107;114;90;96;116;88 05:41:48 INFO - PROCESS | 1716 | |6;imaging-darkroom;111;152;152;97;97;124;95;94;95;96 05:41:48 INFO - PROCESS | 1716 | |7;imaging-desaturate;96;94;89;92;95;89;91;95;91;92 05:41:48 INFO - PROCESS | 1716 | |8;json-parse-financial;62;65;64;62;62;62;61;80;64;61 05:41:48 INFO - PROCESS | 1716 | |9;json-stringify-tinderbox;65;67;71;70;77;75;73;69;67;66 05:41:48 INFO - PROCESS | 1716 | |10;stanford-crypto-aes;87;83;85;84;80;85;85;111;78;85 05:41:48 INFO - PROCESS | 1716 | |11;stanford-crypto-ccm;136;151;168;165;140;163;166;165;193;157 05:41:48 INFO - PROCESS | 1716 | |12;stanford-crypto-pbkdf2;180;169;169;175;175;200;227;172;174;204 05:41:48 INFO - PROCESS | 1716 | |13;stanford-crypto-sha256-iterative;71;68;70;69;68;66;69;72;72;67 05:41:48 INFO - PROCESS | 1716 | __end_tp_report 05:41:48 INFO - PROCESS | 1716 | __start_cc_report 05:41:48 INFO - PROCESS | 1716 | _x_x_mozilla_cycle_collect,1045 05:41:48 INFO - PROCESS | 1716 | __end_cc_report 05:41:48 INFO - PROCESS | 1716 | __startTimestamp1460896908732__endTimestamp 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | ------- Summary: start ------- 05:41:48 INFO - PROCESS | 1716 | Number of tests: 14 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#0] ai-astar Cycles:10 Average:124.50 Median:118.50 stddev:14.66 (12.4%) stddev-sans-first:15.46 05:41:48 INFO - PROCESS | 1716 | Values: 120.0 158.0 143.0 116.0 115.0 128.0 116.0 117.0 117.0 115.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:163.50 stddev:27.97 (17.1%) stddev-sans-first:28.59 05:41:48 INFO - PROCESS | 1716 | Values: 179.0 128.0 192.0 203.0 156.0 144.0 125.0 166.0 161.0 124.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#2] audio-dft Cycles:10 Average:213.90 Median:216.00 stddev:19.22 (8.9%) stddev-sans-first:19.51 05:41:48 INFO - PROCESS | 1716 | Values: 198.0 216.0 216.0 235.0 194.0 199.0 197.0 218.0 255.0 211.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#3] audio-fft Cycles:10 Average:85.60 Median:68.00 stddev:35.10 (51.6%) stddev-sans-first:36.43 05:41:48 INFO - PROCESS | 1716 | Values: 65.0 71.0 80.0 140.0 58.0 63.0 81.0 88.0 157.0 53.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:82.50 stddev:20.73 (25.1%) stddev-sans-first:21.64 05:41:48 INFO - PROCESS | 1716 | Values: 84.0 84.0 136.0 77.0 81.0 83.0 118.0 82.0 83.0 116.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#5] imaging-gaussian-blur Cycles:10 Average:100.40 Median:89.00 stddev:12.76 (14.3%) stddev-sans-first:12.96 05:41:48 INFO - PROCESS | 1716 | Values: 90.0 97.0 120.0 86.0 107.0 114.0 90.0 96.0 116.0 88.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#6] imaging-darkroom Cycles:10 Average:111.30 Median:95.00 stddev:23.45 (24.7%) stddev-sans-first:24.87 05:41:48 INFO - PROCESS | 1716 | Values: 111.0 152.0 152.0 97.0 97.0 124.0 95.0 94.0 95.0 96.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:93.00 stddev:2.50 (2.7%) stddev-sans-first:2.29 05:41:48 INFO - PROCESS | 1716 | Values: 96.0 94.0 89.0 92.0 95.0 89.0 91.0 95.0 91.0 92.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:63.00 stddev:5.68 (9.0%) stddev-sans-first:5.96 05:41:48 INFO - PROCESS | 1716 | Values: 62.0 65.0 64.0 62.0 62.0 62.0 61.0 80.0 64.0 61.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:4.00 (5.7%) stddev-sans-first:3.81 05:41:48 INFO - PROCESS | 1716 | Values: 65.0 67.0 71.0 70.0 77.0 75.0 73.0 69.0 67.0 66.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.00 stddev:9.08 (10.7%) stddev-sans-first:9.63 05:41:48 INFO - PROCESS | 1716 | Values: 87.0 83.0 85.0 84.0 80.0 85.0 85.0 111.0 78.0 85.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#11] stanford-crypto-ccm Cycles:10 Average:160.40 Median:165.00 stddev:16.03 (9.7%) stddev-sans-first:14.37 05:41:48 INFO - PROCESS | 1716 | Values: 136.0 151.0 168.0 165.0 140.0 163.0 166.0 165.0 193.0 157.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:177.50 stddev:19.36 (10.9%) stddev-sans-first:20.47 05:41:48 INFO - PROCESS | 1716 | Values: 180.0 169.0 169.0 175.0 175.0 200.0 227.0 172.0 174.0 204.0 05:41:48 INFO - PROCESS | 1716 | 05:41:48 INFO - PROCESS | 1716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:2.04 (2.9%) stddev-sans-first:2.06 05:41:48 INFO - PROCESS | 1716 | Values: 71.0 68.0 70.0 69.0 68.0 66.0 69.0 72.0 72.0 67.0 05:41:48 INFO - PROCESS | 1716 | -------- Summary: end -------- 05:41:48 INFO - PROCESS | 1716 | 05:41:49 INFO - TEST-INFO | 1716: exit 0 05:41:49 INFO - TEST-OK | kraken | took 60428ms 05:41:49 INFO - SUITE-END | took 1172s 05:41:49 INFO - Completed test suite (00:19:33) 05:41:49 INFO - javascript benchmark 05:41:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3472.2013936794538, 3480.2343484433427, 3495.4756786482026, 3521.943416974907, 3562.519059926911, 4975.328330675357, 5485.835424937253, 5772.249607551023, 5797.913031304529, 5814.186013958049, 5701.600887937836, 5777.335606405265, 5826.388229235933, 5841.2114364560775, 5970.641761494313, 4634.606058485016, 5029.899402011957, 5242.18746094355, 5317.042932272189, 5375.489328513785, 5351.277577527023, 5357.892842143155, 5376.059189641816, 5403.729813509329, 5414.3232095988005, 5149.948500515022, 5176.611754118438, 5328.0, 5386.676799392049, 5430.972845135749, 4553.590176884063, 5044.949550504484, 5275.788968441258, 5299.231611416323, 5339.466053394668, 4673.784815947878, 4988.5260900214425, 5210.010098081352, 5281.445448227919, 5288.471152884719, 4486.147631949919, 5463.087919228278, 5692.686902220376, 5726.055200891848, 5766.452187042224, 6158.3841615838055, 6205.503559715212, 6233.407826256498, 6237.376262373727, 6244.906326405107, 6096.024636058254, 6159.661218632973, 6243.469305109071, 6268.686565671698, 6281.59169653971, 5984.401559843981, 5987.9101813472835, 5988.940110598838, 6005.0, 6059.818205453844, 6371.396328095031, 6398.136251606066, 6409.903851442232, 6419.325970773095, 6428.228612566429, 6092.870172099287, 6105.095857753072, 6113.174721412642, 6198.163247961557, 6201.627902325785, 6095.831308332361, 6172.105044768484, 6208.627482351073, 6237.313895471494, 6266.843328916813, 6113.5414843886, 6137.0794380842335, 6194.690265486708, 6208.751649934043, 6227.782027629011, 6124.502994489374, 6134.0, 6165.352637972948, 6201.224846894138, 6204.751809927552, 4981.078500477423, 4981.950180498148, 4987.700737955734, 4998.350214472095, 5020.7740651670765, 4461.955380446154, 4466.307722303049, 4475.753833539186, 4483.439570053743, 4492.820287188541, 5692.516136128393, 5857.355690874, 5892.1161825726485, 5944.64332140073, 5963.165156878041, 6181.598196117238, 6213.130161777355, 6224.688765561704, 6235.158253635701, 6248.843778905472, 5910.911336329958, 5923.200367950358, 5924.407559244128, 5938.851528711817, 5943.61366511184, 5333.759980800874, 5406.053940560386, 5444.128939369682, 5458.208559758813, 5476.1511965644595, 6456.870862582722, 6468.741250349934, 6472.838179045561, 6485.740570377132, 6514.674266286762, 4979.3526841510375, 6187.628742275298, 6240.251169859646, 6249.531285153723, 6340.714667839866, 6273.52948528853, 6376.553641245068, 6455.128557644845, 6458.1281526995135, 6459.967700161469, 5694.54789028795, 5729.71351432435, 5738.010590955357, 5751.0, 6208.410201030895, 6209.316975132641, 6224.782132625336, 6240.00159974402, 6248.593841400295, 6265.373462653698, 5154.53609175176, 6098.878022439615, 6112.266528016667, 6225.066240064027, 6257.1552840367785, 6190.628562286277, 6227.06594010902, 6232.127502149612, 6238.189035425547, 6255.530835187288, 4825.469198388245, 5753.626014309224, 6048.727807248596, 6049.727762250621, 6050.425209605257, 6148.139260503443, 6189.690515474118, 6189.96905015472, 6198.039303907902, 6210.782622608368, 5999.460048595647, 6101.5118790497545, 6142.170806941006, 6145.0782382642965, 6157.815265542041], "value": 5716.0498610610175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.9509049095089, 552.1744991238099, 552.4034043233308, 563.8393057978477, 579.0561384942545, 37110.62889371105, 37845.0, 37923.81038094806, 37967.62032379676, 37976.81011594938, 38662.22675546487, 39328.60671393285, 39377.818665440085, 39413.21173576527, 39431.81704548861, 9375.765605859857, 9485.668001619944, 9588.904110958905, 9622.278329125309, 9631.229501639851, 9486.478243696594, 9639.469829159394, 9661.806763864719, 9734.56194471247, 9735.415875047483, 9637.759056023586, 9694.854577181348, 9719.076687714656, 9721.90278097217, 9728.416295022285, 9625.085616866421, 9646.75883102921, 9659.420434773936, 9717.757056073584, 9739.0, 9527.09492598209, 9637.132658060738, 9660.227181825507, 9669.468179250209, 9684.273679474067, 37652.0, 37680.62319376826, 38098.0, 38147.0, 38220.80889595562, 3163.2531790991525, 3332.7667063305335, 3442.1050526863196, 3469.3581687387914, 3548.432250839879, 26876.0, 28251.434971300663, 28504.714952850412, 28533.28666783347, 28551.714482855114, 2638.7888968882444, 2663.5738281874806, 2700.1899430171065, 2819.154253723895, 2828.8444135572536, 352330.0, 353554.0, 354620.0, 356558.0, 357188.0, 55000.0, 61919.38080619226, 64467.0, 66036.0, 66137.0, 61925.38074619286, 61955.38044619496, 61964.380356196765, 62291.065634015526, 62566.18452169572, 16353.26410311515, 16475.505734827973, 16654.916725416297, 16659.50064494177, 16722.24749886258, 10695.251332406813, 12579.308138052495, 12757.234565926074, 12845.550405735754, 13046.152000119962, 19331.806681933, 19341.51646208828, 19469.415917522496, 19520.609587808165, 19594.90202548978, 7942.285194332538, 8072.596370181467, 8100.635471403801, 8117.431779775359, 8228.753137405887, 751.305042835375, 856.6978193146383, 943.9764005899907, 950.3870003847479, 1179.3808250668467, 29341.093203292272, 29415.852920735688, 29580.704192958226, 29851.552226716616, 30240.243993900327, 865.9954452834681, 1080.7946490166844, 1109.5062697099875, 1149.6148790155225, 1164.9009834164021, 14356.85643143576, 14476.34856431463, 14484.203368814817, 14772.778408323884, 14893.404263829541, 592480.0, 624293.0, 630139.0, 631904.0, 633504.0, 58676.0, 59584.0, 59668.80662386815, 59683.0, 59750.402495974486, 1460.5618314505605, 1498.655309278872, 1504.6689728259985, 1509.7282489152058, 1514.2655811931204, 28019.439611207254, 28195.26715879701, 28388.43223135567, 28548.286292842844, 28678.56982145311, 49250.50749492459, 49296.50703492919, 49509.0, 49655.75860603514, 49692.0, 457907.0, 460122.0, 462119.0, 524189.0, 524975.0, 24072.0, 25906.611400828624, 26571.734282656926, 26865.328366790985, 27001.324966875985, 45977.62067137991, 46064.0, 46119.538804611526, 46974.53025469838, 47368.289475657206, 36547.26905461929, 37759.49745737274, 37923.620763793115, 38412.0, 38439.0, 27837.443251135268, 28017.859910700317, 34278.48582271318, 36731.44902826406, 38351.0, 31738.0, 33873.661263388036, 36622.45066323954, 37370.626293736714, 38173.0, 32320.676793231767, 32366.0, 32415.86544470932, 32434.83782581072, 32782.68869245204, 19480.51298717487, 23701.762982370645, 23893.880530597235, 23980.80095995228, 24432.389190269674], "value": 19325.479192588453, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.984360625575, 396.32426712455265, 400.6494317472212, 401.853323536909, 407.5761208343323, 14180.574582762534, 19617.50956226095, 19643.410697679057, 19814.504637384074, 20153.496162595904, 19935.60128797423, 20023.899880500576, 20065.09707063182, 20526.178952841867, 21169.153233870627, 5696.373398926125, 5700.37295897453, 5814.331351894544, 5848.210491583624, 5912.260967379078, 5220.981908527839, 5818.389069147742, 5864.2962844458725, 5865.178874957509, 5915.438033386843, 5727.484526392624, 5790.189373487715, 5916.940830591703, 5954.2259506264345, 5964.642121472725, 5608.186812912105, 5815.273090863663, 5872.970635146797, 5895.292564892197, 5964.97017514914, 5073.0, 5111.386633603955, 5174.534291913708, 5185.714785686786, 5190.844274671766, 11967.820482692767, 25201.747982520123, 25508.0, 25530.489390212093, 25589.0, 2096.790320967891, 2319.8492098013576, 2480.779702166551, 2599.7010343810325, 2625.5142798582324, 9915.702528924072, 9915.950420247924, 10024.699259022242, 10133.442660653662, 10226.0, 1748.5715999580184, 1749.685056689808, 1754.8558617542647, 1777.297967302908, 1780.6883795335893, 68813.0, 83963.16036839614, 123360.38319808434, 123756.0, 129973.35013324967, 11466.73865874753, 11516.539338426537, 11721.296722196696, 11737.53280839895, 11808.232464889754, 14993.0, 15048.849511504965, 15070.397184112731, 15198.848011519744, 15209.315580798891, 8680.522571258642, 8778.692745753868, 8838.337124715672, 8851.20339169465, 8969.058248883774, 8713.52075635846, 8744.562771861381, 8771.824563508693, 8783.385163038654, 8880.644774208959, 4609.446866376056, 4612.930806037912, 4664.323673067386, 4669.60308373792, 4748.430188377417, 1537.438834825303, 1818.7726534183228, 1825.9908700456413, 1971.5268335599353, 1994.6037773558567, 920.861870719384, 955.9187469065068, 979.2998006425298, 1017.7583348315044, 1022.3508072373947, 18747.25010999572, 19278.13248403825, 19880.403587892386, 20136.0, 20267.797322026887, 874.9475031498131, 952.8332541805156, 960.2366118935463, 989.1592146675413, 1018.3584341864578, 10314.690559283234, 10572.577096916191, 10582.20994858624, 10647.148228141885, 10675.733106672395, 464622.6768866134, 533611.0, 575362.0, 577354.0, 623679.0, 102571.0, 113523.0, 114924.42537787424, 116706.41646791712, 119858.80141198651, 768.0, 858.6479543387181, 994.4679596415883, 1001.2590682894605, 1014.0265345268477, 14216.857831421967, 17597.560060998578, 17837.286508539513, 17928.731069034235, 17944.21009119013, 48467.757661212876, 50271.0, 50576.0, 52417.475825242786, 52923.0, 76703.61648191723, 76823.0, 76935.61532192303, 78422.0, 79654.0, 7076.540024898365, 7524.05949256343, 7963.92036079655, 8036.919630803851, 8343.749687509384, 11564.710882228012, 12569.937150314556, 12667.87332126667, 12849.357532123544, 12874.098813082994, 9563.234941204826, 11018.724531886446, 11037.779244415227, 11129.054030407506, 11311.773764524827, 10805.567777288821, 11002.559897604326, 11045.558177673125, 11189.608363707232, 11263.436828158723, 10587.788244235226, 10620.150387969099, 11558.457139429313, 11634.476448559666, 11713.238639488405, 8104.27061564462, 8129.9187008129165, 8132.959335203286, 8353.707620233263, 8559.844421003334, 8907.51008694528, 9563.569639366106, 9914.851277230702, 10150.49247537635, 11160.665180044612], "value": 9350.169095936688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.997701792602, 1554.0675594643214, 1818.972715409269, 1968.5373937124764, 1981.7126516655076, 7947.165547617489, 8453.57732113395, 8509.936257967754, 8757.60590773415, 8782.033976262606, 8473.703420380289, 8511.446755960858, 8550.615222314995, 8626.525541095238, 8627.13728627137, 2435.585950388434, 2463.3718401807514, 2465.802735781142, 2467.679201703776, 2473.579491486452, 2396.1373905394044, 2433.598456254716, 2447.951040979179, 2448.5470188015183, 2477.4054226985486, 2060.9484762880898, 2443.1815341860497, 2463.815213858959, 2467.247489515697, 2476.6656501372263, 2024.3218521795216, 2401.3396316013063, 2422.672939153218, 2425.6604075429454, 2443.4013666651695, 2368.7868091871815, 2372.5373552157334, 2390.6294524348755, 2420.612701967694, 2421.7457166997388, 8705.47767133974, 8728.956355218183, 8760.0, 8819.250363719028, 8863.423877447945, 5232.476752324776, 5364.597655175878, 5423.755930983115, 5429.212764149176, 5432.809851655173, 3563.3051554946796, 3589.46158076288, 3597.6582224688614, 3647.069997150736, 3656.7988760618155, 1038.5949479702922, 1048.5124417146064, 1060.4697651174413, 1069.326324415621, 1099.5381939585313, 11342.489587968561, 11493.367864767435, 11493.482793274323, 11507.021903138244, 11529.884701152965, 4124.319487284564, 4737.786799594027, 4789.0, 4802.586692770898, 4906.337644417958, 9806.264530160266, 9829.803403932025, 9872.35829671069, 9913.851292230622, 9915.553800079013, 5209.505097015777, 5266.289050978069, 5320.946790532123, 5329.866753331198, 5336.279602253724, 4102.528209255914, 4409.184300904343, 4754.477007529169, 4826.8069277228515, 4899.338589290472, 3725.1059745661387, 3764.0778009387327, 3804.961950380516, 3810.657040866335, 3837.6737977271687, 1163.4473625028045, 1344.5764584155959, 1345.6972181259334, 1352.9255890925897, 1363.2025265219957, 807.6284908941952, 832.820943497151, 841.9957900210583, 884.1644645809777, 959.8416261316804, 5464.016477034172, 5614.438556144353, 5988.161657367972, 6036.426539478743, 6126.754929802758, 960.1550635440767, 961.3174646001418, 997.8004399120205, 1006.4917216805612, 1006.5420233793607, 3063.6323641163203, 3965.8810235692977, 3974.324364857981, 3988.760674359548, 4041.777702226347, 8663.653453861774, 8738.86891696625, 10114.089731924161, 10501.002404771534, 10520.684379468476, 10118.836333821557, 10332.483375831178, 10526.0, 10602.25784195099, 10623.734406639742, 7739.3034626883855, 7815.101263354673, 7968.402369822286, 8182.386321025947, 8204.220599043081, 5932.762689492372, 5948.345681975065, 5972.462478376793, 6027.457528822427, 6076.237891011557, 9469.573869176042, 9756.658516951873, 9797.510124493889, 9801.607935682778, 9865.358751681119, 9444.811103778024, 9957.452340121363, 9963.651272205438, 9977.60089596408, 9997.60009599637, 6938.410235130071, 7234.457415693739, 7568.508046977149, 7964.283214510722, 8277.710280140167, 8200.466969646954, 8294.212049855254, 8324.916750832414, 8339.624716887876, 8342.916570834213, 7209.35115839577, 7285.0, 7378.815529611803, 7499.362554182955, 7528.284812942762, 7255.2019277880445, 7286.214877355082, 7289.5261807982315, 7322.780316590511, 7377.26227377258, 6849.554778939353, 6898.827529311808, 6928.792136235921, 7024.578525288499, 7034.929650703428, 4759.048190362011, 4797.64017698667, 4807.807687692453, 4886.315915771866, 5088.440271570198, 4404.295312750073, 4971.502849715, 4982.451930287593, 5006.349174607423, 5258.631895767259], "value": 4573.185188850641, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.92846609512856, 319.98400079996, 326.7810566920163, 331.6037335384217, 332.52116951589693, 5238.790448382065, 5423.884684972863, 5932.576181716389, 6187.38126187381, 6198.101275315076, 6082.99630560958, 6111.877762444748, 6122.35715249899, 6126.509879209652, 6135.386461353863, 4348.391225228463, 4462.174497717916, 4562.4753153387455, 4600.1259760645535, 4633.351330813672, 3905.3556163233034, 4551.476580193287, 4564.109998550284, 4577.839775607855, 4585.81656733732, 4524.34397012433, 4544.681872268942, 4545.931811022837, 4576.931346029813, 4583.977080114595, 3630.2739452109554, 4394.780260986954, 4517.186906356855, 4519.807893171809, 4561.315802629632, 3278.262520863946, 3576.535050443452, 3717.3457811273993, 3923.431102490123, 3933.5083114610675, 4916.508349165055, 5594.440555944373, 5759.3376761672525, 5762.250907382014, 5783.161441590988, 4406.250937340627, 4694.924824240128, 4699.78850951708, 4832.9758351208375, 5312.3093997780425, 6383.585066970632, 6393.0, 6419.51853610981, 6459.674517173814, 6500.674966251716, 4181.038361176916, 4385.364122202294, 4406.757628330441, 4416.580424859633, 4436.378906953029, 6336.873262534769, 6815.352541508549, 6868.656567171622, 6872.793816185523, 6877.828054298632, 3901.96098039016, 4094.263032654091, 4266.466691663542, 4312.159128969821, 4316.417283666665, 3747.9402806211942, 3841.5006049213425, 4273.145370925828, 4370.672199585044, 4406.625436837905, 5150.27896094547, 5160.174372100446, 5189.455107213764, 5198.324217851655, 5200.271961925334, 5425.430329815392, 6320.735852829453, 6466.482681385478, 6477.4170324671, 6483.3192514786215, 1506.006036016224, 1506.7739839024234, 1566.6240102375348, 1580.0677600215927, 1594.3224129744813, 888.7200531832452, 1022.3610243597751, 1037.5331101004579, 1044.300318786415, 1054.6783231114584, 5837.883242335214, 5905.852353691193, 5960.910586341209, 5986.940130598726, 6062.969685151546, 6453.998520917062, 6463.773767918195, 6612.983040172793, 6621.768238111739, 6657.400833924873, 5161.786980059683, 5194.792208311701, 5861.0, 5905.675187864708, 5940.34656187819, 2889.9711002889703, 3399.218179818606, 3434.708049815794, 3492.441209406483, 3518.612952575215, 6586.2666993198245, 6863.553868998499, 6886.24251332353, 6929.376356127973, 6930.618815965069, 5197.038547868657, 6635.435987940982, 6852.554583952126, 6860.5540639858245, 6929.133858267716, 6635.601863888182, 6841.863162736817, 6882.518223724492, 6898.7240510380025, 6928.293363050844, 5491.341039075336, 6572.34276572339, 6599.934000659932, 6605.834854128685, 6612.272650008592, 6157.9223635862645, 6298.968505157445, 6314.589551679126, 6456.096146539582, 6527.706253218522, 6814.182298124257, 6870.828229294308, 6882.311768823078, 6884.931150688429, 6922.965385173042, 3795.81020948957, 4152.875413737593, 4491.865244042684, 4507.932381014353, 4508.346289788028, 5112.463191364853, 6589.0, 6597.637129957707, 6604.933950660432, 6651.600903945779, 6355.777547785805, 6399.8240598196835, 6402.343027643662, 6438.581492202992, 6443.162388889415, 6171.228596425447, 6330.873382532415, 6371.23545174582, 6427.228732552124, 6452.9677351612945, 6018.946684330137, 6120.846978825565, 6156.384361563808, 6229.283632382334, 6323.399277068671, 6428.485721142204, 6452.774152904626, 6459.483241340776, 6500.0, 6510.3489651034515, 6116.0, 6357.936420635734, 6362.745490180341, 6364.586301890362, 6433.839154021187], "value": 4673.889201192335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.8742232686953, 680.7141000779674, 752.4582300743463, 772.1930582541244, 773.9690412383505, 14843.332050057747, 15184.240787960613, 15237.619059523504, 15257.0, 15388.538343849688, 14266.072705274177, 14343.64140896478, 14381.1371317721, 14381.568552943403, 14411.855881441183, 724.626817189148, 903.7424334064809, 907.1110311894347, 918.8805455290836, 935.7379933618598, 887.9556022198897, 918.0, 922.9815403691922, 930.7393929699695, 932.1936524905941, 810.5177419435427, 906.1165363770305, 929.665320484625, 933.2021121940745, 935.4200395754642, 909.1090731083542, 921.3964853021282, 926.7405126564573, 928.0951072704127, 935.0789472369711, 681.7102731339161, 694.9930500694979, 698.9231184569693, 699.993000070003, 702.6908160409404, 14869.330880110312, 14925.2537373132, 14962.251887405586, 14970.326335314938, 14991.250437478191, 12947.805782913263, 12968.80546791799, 13000.609981700563, 13110.341985172521, 13134.474621015148, 8087.797805054862, 9961.75095622608, 10183.0, 10251.0, 10281.485925703684, 3497.3355062538035, 3527.94708079379, 3529.594096678889, 3560.5223832109646, 3646.7629604075914, 76315.85526217111, 78475.43049139042, 80724.38551228943, 81466.0, 81727.5913620428, 9445.338826282094, 9623.278254130968, 9687.70936871895, 9769.658061967797, 9790.804183916423, 22588.32235032919, 22700.97845596952, 22766.0, 22832.543349132924, 22948.0, 7664.195259497673, 7717.073951125901, 7837.216278372117, 7959.0, 8025.197480252044, 4189.2459357315975, 4191.811368488365, 4226.915461690749, 4233.5131459881895, 4292.5707429257445, 3645.9270814584092, 3750.5499340079364, 3753.0617345663586, 3767.6609105180664, 3771.9622803771613, 650.7039297119799, 653.4315145823165, 656.8948968165071, 657.1752450674373, 668.9966550167316, 502.5627703897633, 508.83208541181324, 556.2240674259385, 573.8221151443066, 615.8398816307792, 7370.115586129698, 7682.732349162326, 8071.07182674, 8093.271605555528, 8165.2243036911395, 479.6330806932699, 522.1958184395987, 562.2129019372829, 580.9542822918813, 615.8614311779813, 3840.4431357453573, 3843.080058340477, 3927.7054220933546, 3938.783366914847, 4003.899902502461, 91086.08913910776, 93390.53304733433, 93756.0624393761, 93889.0611093894, 95158.0484195163, 79630.6018469904, 80923.19076809274, 81183.0, 81368.59315703383, 82051.7692234617, 70320.0, 70400.99999999898, 70473.0, 70666.0, 71401.0, 7535.886961695469, 7551.962240188764, 7768.184340644377, 7791.805204869697, 7883.921160788548, 43900.56099439092, 44877.32684009677, 45087.0, 45598.63204103882, 45893.0, 57396.71301643465, 63255.36744632495, 64717.0, 64821.67589162024, 65069.0, 9960.601575936882, 10102.242331824995, 10302.639407620996, 10477.895221047693, 10964.616238431616, 10568.682939511827, 10629.787404252027, 10690.786184276427, 10815.0, 11119.944400277947, 10232.23258255619, 10425.687229383131, 10557.472126393803, 10677.985591368808, 10701.090407315465, 10142.137918277029, 10303.227257955834, 10608.416537090534, 10615.469226538797, 10713.089387402159, 8732.388732788644, 9018.23345015681, 9880.604775809175, 10001.149672343347, 10284.537195826057, 6544.901826472702, 8531.402801803813, 8770.25452836516, 9142.680006199751, 9205.079492050741, 7267.927320726936, 7787.162835172553, 8894.777630559287, 8924.464532128093, 9005.504697241715], "value": 6736.203443018004, "unit": "score"}], "name": "dromaeo_css", "value": 7278.908043445303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 158.0, 143.0, 116.0, 115.0, 128.0, 116.0, 117.0, 117.0, 115.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 128.0, 192.0, 203.0, 156.0, 144.0, 125.0, 166.0, 161.0, 124.0], "value": 157.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 216.0, 216.0, 235.0, 194.0, 199.0, 197.0, 218.0, 255.0, 211.0], "value": 213.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 80.0, 140.0, 58.0, 63.0, 81.0, 88.0, 157.0, 53.0], "value": 85.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 136.0, 77.0, 81.0, 83.0, 118.0, 82.0, 83.0, 116.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 97.0, 120.0, 86.0, 107.0, 114.0, 90.0, 96.0, 116.0, 88.0], "value": 100.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 152.0, 152.0, 97.0, 97.0, 124.0, 95.0, 94.0, 95.0, 96.0], "value": 111.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 89.0, 92.0, 95.0, 89.0, 91.0, 95.0, 91.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 62.0, 62.0, 62.0, 61.0, 80.0, 64.0, 61.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 71.0, 70.0, 77.0, 75.0, 73.0, 69.0, 67.0, 66.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 84.0, 80.0, 85.0, 85.0, 111.0, 78.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 151.0, 168.0, 165.0, 140.0, 163.0, 166.0, 165.0, 193.0, 157.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 169.0, 169.0, 175.0, 175.0, 200.0, 227.0, 172.0, 174.0, 204.0], "value": 184.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 69.0, 68.0, 66.0, 69.0, 72.0, 72.0, 67.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1615.0, "alertThreshold": 2.0}]} 05:41:49 INFO - Return code: 0 05:41:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:41:50 ERROR - # TBPL SUCCESS # 05:41:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:41:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:41:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:41:50 INFO - 2016-04-17 05:41:50.066 screenresolution[1721:14703] starting screenresolution argv=screenresolution get 05:41:50 INFO - 2016-04-17 05:41:50.068 screenresolution[1721:14703] Display 0: 1600x1200x32@60 05:41:50 INFO - 2016-04-17 05:41:50.075 screenresolution[1722:14706] starting screenresolution argv=screenresolution list 05:41:50 INFO - Available Modes on Display 0 05:41:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:41:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:41:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:41:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:41:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:41:50 INFO - Intel Iris: 05:41:50 INFO - Chipset Model: Intel Iris 05:41:50 INFO - Type: GPU 05:41:50 INFO - Bus: Built-In 05:41:50 INFO - VRAM (Dynamic, Max): 1536 MB 05:41:50 INFO - Vendor: Intel (0x8086) 05:41:50 INFO - Device ID: 0x0a2e 05:41:50 INFO - Revision ID: 0x0009 05:41:50 INFO - Displays: 05:41:50 INFO - Display: 05:41:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:41:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:41:50 INFO - Display Serial Number: 1600x1200 60 05:41:50 INFO - Main Display: Yes 05:41:50 INFO - Mirror: Off 05:41:50 INFO - Online: Yes 05:41:50 INFO - Rotation: Supported 05:41:50 INFO - Return code: 0 05:41:50 INFO - Running post-action listener: _resource_record_post_action 05:41:50 INFO - Running post-run listener: _resource_record_post_run 05:41:51 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 33062400; Write bytes: 698244096; Read time: 335; Write time: 1927 05:41:51 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377434624; Write bytes: 371746304; Read time: 28025; Write time: 705 05:41:51 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 32140800; Write bytes: 301340160; Read time: 322; Write time: 1172 05:41:51 INFO - Running post-run listener: _upload_blobber_files 05:41:51 INFO - Blob upload gear active. 05:41:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:52 INFO - (blobuploader) - INFO - Done attempting. 05:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:53 INFO - (blobuploader) - INFO - Done attempting. 05:41:53 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:53 INFO - Return code: 0 05:41:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0ceed29b5d867f8ae1d5f8a56c37f0ce9a8d9107f7b1045fa8eb8aff467e50beea9bf26f96c086c788587b103c5e0dabc90cf007febb7932db0df0bf37a6edb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de4f002d7e4ec7807bc08d1a7f3f711684aae83b1b2db43af44d7cdd5fe7287975495da36bf6019e417c57d28470c6f16cb9179ad8dda3770cce5526746cadf8"} 05:41:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:53 INFO - Contents: 05:41:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0ceed29b5d867f8ae1d5f8a56c37f0ce9a8d9107f7b1045fa8eb8aff467e50beea9bf26f96c086c788587b103c5e0dabc90cf007febb7932db0df0bf37a6edb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de4f002d7e4ec7807bc08d1a7f3f711684aae83b1b2db43af44d7cdd5fe7287975495da36bf6019e417c57d28470c6f16cb9179ad8dda3770cce5526746cadf8"} 05:41:53 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:53 INFO - Copying logs to upload dir... 05:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1345.495687 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-04-17 05:41:54.098104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 05:41:54.102698) ========= 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.0rqCbLoRym/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.q0qq2SXu1j/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/f0ceed29b5d867f8ae1d5f8a56c37f0ce9a8d9107f7b1045fa8eb8aff467e50beea9bf26f96c086c788587b103c5e0dabc90cf007febb7932db0df0bf37a6edb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de4f002d7e4ec7807bc08d1a7f3f711684aae83b1b2db43af44d7cdd5fe7287975495da36bf6019e417c57d28470c6f16cb9179ad8dda3770cce5526746cadf8"} build_url:https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010842 build_url: 'https://queue.taskcluster.net/v1/task/WDBFvXcxSNeHKZzJKRIM-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0ceed29b5d867f8ae1d5f8a56c37f0ce9a8d9107f7b1045fa8eb8aff467e50beea9bf26f96c086c788587b103c5e0dabc90cf007febb7932db0df0bf37a6edb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de4f002d7e4ec7807bc08d1a7f3f711684aae83b1b2db43af44d7cdd5fe7287975495da36bf6019e417c57d28470c6f16cb9179ad8dda3770cce5526746cadf8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 05:41:54.132662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 05:41:54.132974) ========= 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.0rqCbLoRym/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.q0qq2SXu1j/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.004999 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 05:41:54.181249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 05:41:54.181573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 05:41:54.181983) ========= ========= Total master_lag: 0.65 =========