builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0299 starttime: 1467638816.49 results: success (0) buildid: 20160704040324 builduid: c19e637935174a778c8bdfda1f635856 revision: 4191df8e4b8e1e2dd0593132dac25915f987f797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:56.493443) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:56.493833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:56.494132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:56.517693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:56.517971) ========= 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.Qra02u9H3j/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.1TN9XHxz1T/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-07-04 06:26:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2016-07-04 06:26:56 (135 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161196 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:56.948086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:56.948482) ========= 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.Qra02u9H3j/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.1TN9XHxz1T/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.027131 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:57.081849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 06:26:57.082196) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4191df8e4b8e1e2dd0593132dac25915f987f797 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4191df8e4b8e1e2dd0593132dac25915f987f797 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qra02u9H3j/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.1TN9XHxz1T/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-07-04 06:26:57,163 truncating revision to first 12 chars 2016-07-04 06:26:57,163 Setting DEBUG logging. 2016-07-04 06:26:57,163 attempt 1/10 2016-07-04 06:26:57,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4191df8e4b8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 06:26:57,906 unpacking tar archive at: mozilla-central-4191df8e4b8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.999708 ========= master_lag: 0.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 06:26:58.618435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:58.618793) ========= script_repo_revision: 4191df8e4b8e1e2dd0593132dac25915f987f797 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:58.619204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:58.619479) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 06:26:58.638065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-04 06:26:58.638365) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qra02u9H3j/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.1TN9XHxz1T/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:26:58 INFO - MultiFileLogger online at 20160704 06:26:58 in /builds/slave/test 06:26:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:26:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:58 INFO - {'append_to_log': False, 06:26:58 INFO - 'base_work_dir': '/builds/slave/test', 06:26:58 INFO - 'blob_upload_branch': 'Firefox', 06:26:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:58 INFO - 'branch': 'Firefox', 06:26:58 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:58 INFO - 'config_files': ('talos/mac_config.py',), 06:26:58 INFO - 'default_actions': ('clobber', 06:26:58 INFO - 'read-buildbot-config', 06:26:58 INFO - 'download-and-extract', 06:26:58 INFO - 'populate-webroot', 06:26:58 INFO - 'create-virtualenv', 06:26:58 INFO - 'install', 06:26:58 INFO - 'run-tests'), 06:26:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:58 INFO - 'download_minidump_stackwalk': True, 06:26:58 INFO - 'download_symbols': 'ondemand', 06:26:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:58 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:58 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:58 INFO - 'installer_path': 'installer.exe', 06:26:58 INFO - 'log_level': 'info', 06:26:58 INFO - 'log_name': 'talos', 06:26:58 INFO - 'log_to_console': True, 06:26:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:26:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:26:58 INFO - 'opt_config_files': (), 06:26:58 INFO - 'pip_index': False, 06:26:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:58 INFO - 'cmd': ('bash', 06:26:58 INFO - '-c', 06:26:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:58 INFO - 'enabled': True, 06:26:58 INFO - 'halt_on_failure': False, 06:26:58 INFO - 'name': 'check_screen_resolution'},), 06:26:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:58 INFO - 'cmd': ('bash', 06:26:58 INFO - '-c', 06:26:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:58 INFO - 'enabled': True, 06:26:58 INFO - 'halt_on_failure': False, 06:26:58 INFO - 'name': 'check_screen_resolution'},), 06:26:58 INFO - 'run_cmd_checks_enabled': True, 06:26:58 INFO - 'sps_profile': False, 06:26:58 INFO - 'sps_profile_interval': 0, 06:26:58 INFO - 'suite': 'dromaeojs', 06:26:58 INFO - 'system_bits': '32', 06:26:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:58 INFO - 'title': 't-yosemite-r7-0299', 06:26:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:58 INFO - 'use_talos_json': True, 06:26:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:58 INFO - 'work_dir': 'build'} 06:26:58 INFO - ##### 06:26:58 INFO - ##### Running clobber step. 06:26:58 INFO - ##### 06:26:58 INFO - Running pre-action listener: _resource_record_pre_action 06:26:58 INFO - Running main action method: clobber 06:26:58 INFO - rmtree: /builds/slave/test/build 06:26:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:27:00 INFO - Running post-action listener: _resource_record_post_action 06:27:00 INFO - ##### 06:27:00 INFO - ##### Finished clobber step (success) 06:27:00 INFO - ##### 06:27:00 INFO - ##### 06:27:00 INFO - ##### Running read-buildbot-config step. 06:27:00 INFO - ##### 06:27:00 INFO - Running pre-action listener: _resource_record_pre_action 06:27:00 INFO - Running main action method: read_buildbot_config 06:27:00 INFO - Using buildbot properties: 06:27:00 INFO - { 06:27:00 INFO - "project": "", 06:27:00 INFO - "product": "firefox", 06:27:00 INFO - "script_repo_revision": "production", 06:27:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:27:00 INFO - "repository": "", 06:27:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:27:00 INFO - "buildid": "20160704040324", 06:27:00 INFO - "pgo_build": "False", 06:27:00 INFO - "basedir": "/builds/slave/test", 06:27:00 INFO - "buildnumber": 2, 06:27:00 INFO - "slavename": "t-yosemite-r7-0299", 06:27:00 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 06:27:00 INFO - "platform": "yosemite_r7", 06:27:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:27:00 INFO - "branch": "mozilla-central", 06:27:00 INFO - "repo_path": "mozilla-central", 06:27:00 INFO - "revision": "4191df8e4b8e1e2dd0593132dac25915f987f797", 06:27:00 INFO - "stage_platform": "macosx64", 06:27:00 INFO - "builduid": "c19e637935174a778c8bdfda1f635856", 06:27:00 INFO - "slavebuilddir": "test" 06:27:00 INFO - } 06:27:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 06:27:00 INFO - Running post-action listener: _resource_record_post_action 06:27:00 INFO - ##### 06:27:00 INFO - ##### Finished read-buildbot-config step (success) 06:27:00 INFO - ##### 06:27:00 INFO - ##### 06:27:00 INFO - ##### Running download-and-extract step. 06:27:00 INFO - ##### 06:27:00 INFO - Running pre-action listener: _resource_record_pre_action 06:27:00 INFO - Running main action method: download_and_extract 06:27:00 INFO - mkdir: /builds/slave/test/build/tests 06:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:00 INFO - https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:27:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:27:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:27:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 06:27:02 INFO - Downloaded 1199 bytes. 06:27:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:27:02 INFO - Using the following test package requirements: 06:27:02 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:27:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 06:27:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 06:27:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'jsshell-mac.zip'], 06:27:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 06:27:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:27:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 06:27:02 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 06:27:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 06:27:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:27:02 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 06:27:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:27: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')]} 06:27:02 INFO - https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:27:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:27:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:27:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:27:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:27:03 INFO - Downloaded 18795216 bytes. 06:27:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:27:06 INFO - Return code: 0 06:27:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:06 INFO - https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:27:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:27:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:27:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:27:09 INFO - Downloaded 18795216 bytes. 06:27:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:27:12 INFO - Return code: 0 06:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:12 INFO - https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:27:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:27:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:27:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:27:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:27:13 INFO - Downloaded 14403333 bytes. 06:27:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:27:14 INFO - Return code: 0 06:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:14 INFO - https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:27:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:27:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:27:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 06:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 06:27:17 INFO - Downloaded 112416774 bytes. 06:27:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:27:17 INFO - mkdir: /builds/slave/test/properties 06:27:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:27:17 INFO - Writing to file /builds/slave/test/properties/build_url 06:27:17 INFO - Contents: 06:27:17 INFO - build_url:https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:27:18 INFO - Running post-action listener: _resource_record_post_action 06:27:18 INFO - Running post-action listener: set_extra_try_arguments 06:27:18 INFO - ##### 06:27:18 INFO - ##### Finished download-and-extract step (success) 06:27:18 INFO - ##### 06:27:18 INFO - ##### 06:27:18 INFO - ##### Running populate-webroot step. 06:27:18 INFO - ##### 06:27:18 INFO - Running pre-action listener: _resource_record_pre_action 06:27:18 INFO - Running main action method: populate_webroot 06:27:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:27:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:27:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:27:18 INFO - '--tppagecycles', 06:27:18 INFO - '7'], 06:27:18 INFO - 'tests': ['tsvgm']}}, 06:27:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:27:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:27:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:27:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:27:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['damp', 'tps']}, 06:27:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'tests': ['damp', 'tps']}, 06:27:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['dromaeo_dom']}, 06:27:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:27:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['basic_compositor_video']}, 06:27:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:27:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['a11yr', 06:27:18 INFO - 'ts_paint', 06:27:18 INFO - 'tpaint', 06:27:18 INFO - 'sessionrestore', 06:27:18 INFO - 'sessionrestore_no_auto_restore', 06:27:18 INFO - 'tabpaint']}, 06:27:18 INFO - 'other-e10s': {'tests': ['a11yr', 06:27:18 INFO - 'ts_paint', 06:27:18 INFO - 'tpaint', 06:27:18 INFO - 'sessionrestore', 06:27:18 INFO - 'sessionrestore_no_auto_restore', 06:27:18 INFO - 'tabpaint']}, 06:27:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:27:18 INFO - 'ts_paint', 06:27:18 INFO - 'tpaint', 06:27:18 INFO - 'sessionrestore', 06:27:18 INFO - 'sessionrestore_no_auto_restore', 06:27:18 INFO - 'tabpaint']}, 06:27:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:27:18 INFO - 'ts_paint', 06:27:18 INFO - 'tpaint', 06:27:18 INFO - 'sessionrestore', 06:27:18 INFO - 'sessionrestore_no_auto_restore', 06:27:18 INFO - 'tabpaint']}, 06:27:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['a11yr', 06:27:18 INFO - 'ts_paint', 06:27:18 INFO - 'tpaint', 06:27:18 INFO - 'sessionrestore', 06:27:18 INFO - 'sessionrestore_no_auto_restore', 06:27:18 INFO - 'tabpaint']}, 06:27:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['a11yr', 06:27:18 INFO - 'ts_paint', 06:27:18 INFO - 'tpaint', 06:27:18 INFO - 'sessionrestore', 06:27:18 INFO - 'sessionrestore_no_auto_restore', 06:27:18 INFO - 'tabpaint']}, 06:27:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['tsvgx', 06:27:18 INFO - 'tsvgr_opacity', 06:27:18 INFO - 'tart', 06:27:18 INFO - 'tscrollx', 06:27:18 INFO - 'cart']}, 06:27:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:27:18 INFO - 'tsvgr_opacity', 06:27:18 INFO - 'tart', 06:27:18 INFO - 'tscrollx', 06:27:18 INFO - 'cart']}, 06:27:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'talos_options': ['--disable-e10s'], 06:27:18 INFO - 'tests': ['tp5o']}, 06:27:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'tests': ['tp5o']}, 06:27:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'talos_options': ['--disable-e10s', 06:27:18 INFO - '--xperf_path', 06:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:18 INFO - 'tests': ['tp5n']}, 06:27:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:18 INFO - 'talos_options': ['--xperf_path', 06:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:18 INFO - 'tests': ['tp5n']}}, 06:27:18 INFO - 'talos.zip': {'path': '', 06:27:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:27:18 INFO - Running post-action listener: _resource_record_post_action 06:27:18 INFO - ##### 06:27:18 INFO - ##### Finished populate-webroot step (success) 06:27:18 INFO - ##### 06:27:18 INFO - ##### 06:27:18 INFO - ##### Running create-virtualenv step. 06:27:18 INFO - ##### 06:27:18 INFO - Running pre-action listener: _resource_record_pre_action 06:27:18 INFO - Running main action method: create_virtualenv 06:27:18 INFO - Creating virtualenv /builds/slave/test/build/venv 06:27:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:27:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:27:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:27:18 INFO - Using real prefix '/tools/python27' 06:27:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:27:19 INFO - Installing distribute.............................................................................................................................................................................................done. 06:27:22 INFO - Installing pip.................done. 06:27:22 INFO - Return code: 0 06:27:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:22 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 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:22 INFO - 'HOME': '/Users/cltbld', 06:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:22 INFO - 'LOGNAME': 'cltbld', 06:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:22 INFO - 'MOZ_NO_REMOTE': '1', 06:27:22 INFO - 'NO_EM_RESTART': '1', 06:27:22 INFO - 'PAGER': '/bin/cat', 06:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:22 INFO - 'PWD': '/builds/slave/test', 06:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:22 INFO - 'SHELL': '/bin/bash', 06:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:22 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:22 INFO - 'USER': 'cltbld', 06:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:22 INFO - 'XPC_FLAGS': '0x0', 06:27:22 INFO - 'XPC_SERVICE_NAME': '0', 06:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:27:22 INFO - Cleaning up... 06:27:22 INFO - Return code: 0 06:27:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:22 INFO - 'HOME': '/Users/cltbld', 06:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:22 INFO - 'LOGNAME': 'cltbld', 06:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:22 INFO - 'MOZ_NO_REMOTE': '1', 06:27:22 INFO - 'NO_EM_RESTART': '1', 06:27:22 INFO - 'PAGER': '/bin/cat', 06:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:22 INFO - 'PWD': '/builds/slave/test', 06:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:22 INFO - 'SHELL': '/bin/bash', 06:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:22 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:22 INFO - 'USER': 'cltbld', 06:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:22 INFO - 'XPC_FLAGS': '0x0', 06:27:22 INFO - 'XPC_SERVICE_NAME': '0', 06:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:22 INFO - Downloading/unpacking psutil>=3.1.1 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:27:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:25 INFO - Installing collected packages: psutil 06:27:25 INFO - Running setup.py install for psutil 06:27:25 INFO - building 'psutil._psutil_osx' extension 06:27:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:27:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:27:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:27:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:27:26 INFO - building 'psutil._psutil_posix' extension 06:27:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:27:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:27:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:27:26 INFO - ^ 06:27:26 INFO - 1 warning generated. 06:27:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:27:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:26 INFO - Successfully installed psutil 06:27:26 INFO - Cleaning up... 06:27:26 INFO - Return code: 0 06:27:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:26 INFO - 'HOME': '/Users/cltbld', 06:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:26 INFO - 'LOGNAME': 'cltbld', 06:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:26 INFO - 'MOZ_NO_REMOTE': '1', 06:27:26 INFO - 'NO_EM_RESTART': '1', 06:27:26 INFO - 'PAGER': '/bin/cat', 06:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:26 INFO - 'PWD': '/builds/slave/test', 06:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:26 INFO - 'SHELL': '/bin/bash', 06:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:26 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:26 INFO - 'USER': 'cltbld', 06:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:26 INFO - 'XPC_FLAGS': '0x0', 06:27:26 INFO - 'XPC_SERVICE_NAME': '0', 06:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:27:29 INFO - Installing collected packages: mozsystemmonitor 06:27:29 INFO - Running setup.py install for mozsystemmonitor 06:27:29 INFO - Successfully installed mozsystemmonitor 06:27:29 INFO - Cleaning up... 06:27:29 INFO - Return code: 0 06:27:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:29 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:29 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==2.5.1'] in /builds/slave/test/build 06:27:29 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==2.5.1 06:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:29 INFO - 'HOME': '/Users/cltbld', 06:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:29 INFO - 'LOGNAME': 'cltbld', 06:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:29 INFO - 'MOZ_NO_REMOTE': '1', 06:27:29 INFO - 'NO_EM_RESTART': '1', 06:27:29 INFO - 'PAGER': '/bin/cat', 06:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:29 INFO - 'PWD': '/builds/slave/test', 06:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:29 INFO - 'SHELL': '/bin/bash', 06:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:29 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:29 INFO - 'USER': 'cltbld', 06:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:29 INFO - 'XPC_FLAGS': '0x0', 06:27:29 INFO - 'XPC_SERVICE_NAME': '0', 06:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:29 INFO - Downloading/unpacking jsonschema==2.5.1 06:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:27:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:32 INFO - Downloading functools32-3.2.3-2.tar.gz 06:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:27:32 INFO - warning: no files found matching '*.txt' 06:27:32 INFO - no previously-included directories found matching 'build' 06:27:32 INFO - no previously-included directories found matching 'dist' 06:27:32 INFO - no previously-included directories found matching '.git*' 06:27:32 INFO - Installing collected packages: jsonschema, functools32 06:27:32 INFO - Running setup.py install for functools32 06:27:32 INFO - warning: no files found matching '*.txt' 06:27:32 INFO - no previously-included directories found matching 'build' 06:27:32 INFO - no previously-included directories found matching 'dist' 06:27:32 INFO - no previously-included directories found matching '.git*' 06:27:33 INFO - Successfully installed jsonschema functools32 06:27:33 INFO - Cleaning up... 06:27:33 INFO - Return code: 0 06:27:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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', '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 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:27: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 blobuploader==1.2.4 06:27:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:33 INFO - 'HOME': '/Users/cltbld', 06:27:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:33 INFO - 'LOGNAME': 'cltbld', 06:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:33 INFO - 'MOZ_NO_REMOTE': '1', 06:27:33 INFO - 'NO_EM_RESTART': '1', 06:27:33 INFO - 'PAGER': '/bin/cat', 06:27:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:33 INFO - 'PWD': '/builds/slave/test', 06:27:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:33 INFO - 'SHELL': '/bin/bash', 06:27:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:33 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:33 INFO - 'USER': 'cltbld', 06:27:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:33 INFO - 'XPC_FLAGS': '0x0', 06:27:33 INFO - 'XPC_SERVICE_NAME': '0', 06:27:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:33 INFO - Downloading/unpacking blobuploader==1.2.4 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:27:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:27:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:36 INFO - Downloading docopt-0.6.1.tar.gz 06:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:27:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:27:37 INFO - Running setup.py install for blobuploader 06:27:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:27:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:27:37 INFO - Running setup.py install for requests 06:27:37 INFO - Running setup.py install for docopt 06:27:37 INFO - Successfully installed blobuploader requests docopt 06:27:37 INFO - Cleaning up... 06:27:37 INFO - Return code: 0 06:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:37 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 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:37 INFO - 'HOME': '/Users/cltbld', 06:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:37 INFO - 'LOGNAME': 'cltbld', 06:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:37 INFO - 'MOZ_NO_REMOTE': '1', 06:27:37 INFO - 'NO_EM_RESTART': '1', 06:27:37 INFO - 'PAGER': '/bin/cat', 06:27:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:37 INFO - 'PWD': '/builds/slave/test', 06:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:37 INFO - 'SHELL': '/bin/bash', 06:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:37 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:37 INFO - 'USER': 'cltbld', 06:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:37 INFO - 'XPC_FLAGS': '0x0', 06:27:37 INFO - 'XPC_SERVICE_NAME': '0', 06:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-6ycrvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-L0dXqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-20lg1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-WSXBcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-XbDboT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-IZh0IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-z0ahyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-nZOqmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:38 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-2B0BjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-SnJjtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-lZLXKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-NLot3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-4MQCHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-vrKQLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-N2tRX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-KYq7XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-0BylWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:39 INFO - Running setup.py install for manifestparser 06:27:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:40 INFO - Running setup.py install for mozcrash 06:27:40 INFO - Running setup.py install for mozdebug 06:27:40 INFO - Running setup.py install for mozdevice 06:27:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:27:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:40 INFO - Running setup.py install for mozfile 06:27:40 INFO - Running setup.py install for mozhttpd 06:27:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:40 INFO - Running setup.py install for mozinfo 06:27:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:40 INFO - Running setup.py install for mozInstall 06:27:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Running setup.py install for mozleak 06:27:41 INFO - Running setup.py install for mozlog 06:27:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Running setup.py install for moznetwork 06:27:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Running setup.py install for mozprocess 06:27:41 INFO - Running setup.py install for mozprofile 06:27:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:41 INFO - Running setup.py install for mozrunner 06:27:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:42 INFO - Running setup.py install for mozscreenshot 06:27:42 INFO - Running setup.py install for moztest 06:27:42 INFO - Running setup.py install for mozversion 06:27:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:42 INFO - Cleaning up... 06:27:42 INFO - Return code: 0 06:27:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:42 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 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:42 INFO - 'HOME': '/Users/cltbld', 06:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:42 INFO - 'LOGNAME': 'cltbld', 06:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:42 INFO - 'MOZ_NO_REMOTE': '1', 06:27:42 INFO - 'NO_EM_RESTART': '1', 06:27:42 INFO - 'PAGER': '/bin/cat', 06:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:42 INFO - 'PWD': '/builds/slave/test', 06:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:42 INFO - 'SHELL': '/bin/bash', 06:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:42 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:42 INFO - 'USER': 'cltbld', 06:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:42 INFO - 'XPC_FLAGS': '0x0', 06:27:42 INFO - 'XPC_SERVICE_NAME': '0', 06:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:42 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-z68SfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:42 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-mISeek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:42 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-PTBLzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Io1L5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-or1cIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-hamOP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-qy4Jj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-qibrNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-iGx3Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-aeM9On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-TThoLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Wzi0WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-jch95r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-1PZ3Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Tik8vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-ncbXh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-DafHGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:27:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:46 INFO - Downloading blessings-1.6.tar.gz 06:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:27:47 INFO - Installing collected packages: blessings 06:27:47 INFO - Running setup.py install for blessings 06:27:47 INFO - Successfully installed blessings 06:27:47 INFO - Cleaning up... 06:27:47 INFO - Return code: 0 06:27:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:27:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:47 INFO - Reading from file tmpfile_stdout 06:27:47 INFO - Current package versions: 06:27:47 INFO - blessings == 1.6 06:27:47 INFO - blobuploader == 1.2.4 06:27:47 INFO - docopt == 0.6.1 06:27:47 INFO - functools32 == 3.2.3-2 06:27:47 INFO - jsonschema == 2.5.1 06:27:47 INFO - manifestparser == 1.1 06:27:47 INFO - mozInstall == 1.12 06:27:47 INFO - mozcrash == 0.17 06:27:47 INFO - mozdebug == 0.1 06:27:47 INFO - mozdevice == 0.48 06:27:47 INFO - mozfile == 1.2 06:27:47 INFO - mozhttpd == 0.7 06:27:47 INFO - mozinfo == 0.9 06:27:47 INFO - mozleak == 0.1 06:27:47 INFO - mozlog == 3.2 06:27:47 INFO - moznetwork == 0.27 06:27:47 INFO - mozprocess == 0.22 06:27:47 INFO - mozprofile == 0.28 06:27:47 INFO - mozrunner == 6.11 06:27:47 INFO - mozscreenshot == 0.1 06:27:47 INFO - mozsystemmonitor == 0.3 06:27:47 INFO - moztest == 0.7 06:27:47 INFO - mozversion == 1.4 06:27:47 INFO - psutil == 3.1.1 06:27:47 INFO - requests == 1.2.3 06:27:47 INFO - wsgiref == 0.1.2 06:27:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:47 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 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:47 INFO - 'HOME': '/Users/cltbld', 06:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:47 INFO - 'LOGNAME': 'cltbld', 06:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:47 INFO - 'MOZ_NO_REMOTE': '1', 06:27:47 INFO - 'NO_EM_RESTART': '1', 06:27:47 INFO - 'PAGER': '/bin/cat', 06:27:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:47 INFO - 'PWD': '/builds/slave/test', 06:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:47 INFO - 'SHELL': '/bin/bash', 06:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:47 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:47 INFO - 'USER': 'cltbld', 06:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:47 INFO - 'XPC_FLAGS': '0x0', 06:27:47 INFO - 'XPC_SERVICE_NAME': '0', 06:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:27:47 INFO - Cleaning up... 06:27:47 INFO - Return code: 0 06:27:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10831fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083b4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd922d8d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, '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.Qra02u9H3j/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.1TN9XHxz1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:47 INFO - 'HOME': '/Users/cltbld', 06:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:47 INFO - 'LOGNAME': 'cltbld', 06:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:47 INFO - 'MOZ_NO_REMOTE': '1', 06:27:47 INFO - 'NO_EM_RESTART': '1', 06:27:47 INFO - 'PAGER': '/bin/cat', 06:27:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:47 INFO - 'PWD': '/builds/slave/test', 06:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:47 INFO - 'SHELL': '/bin/bash', 06:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:27:47 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:47 INFO - 'USER': 'cltbld', 06:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:47 INFO - 'XPC_FLAGS': '0x0', 06:27:47 INFO - 'XPC_SERVICE_NAME': '0', 06:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:27:48 INFO - Cleaning up... 06:27:48 INFO - Return code: 0 06:27:48 INFO - Running post-action listener: _resource_record_post_action 06:27:48 INFO - Running post-action listener: _start_resource_monitoring 06:27:48 INFO - Starting resource monitoring. 06:27:48 INFO - ##### 06:27:48 INFO - ##### Finished create-virtualenv step (success) 06:27:48 INFO - ##### 06:27:48 INFO - ##### 06:27:48 INFO - ##### Running install step. 06:27:48 INFO - ##### 06:27:48 INFO - Running pre-action listener: _resource_record_pre_action 06:27:48 INFO - Running main action method: install 06:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:48 INFO - Reading from file tmpfile_stdout 06:27:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:27:48 INFO - Reading from file tmpfile_stdout 06:27:48 INFO - Output received: 06:27:48 INFO - Usage: mozinstall [options] installer 06:27:48 INFO - Options: 06:27:48 INFO - -h, --help show this help message and exit 06:27:48 INFO - -d DEST, --destination=DEST 06:27:48 INFO - Directory to install application into. [default: 06:27:48 INFO - "/builds/slave/test"] 06:27:48 INFO - --app=APP Application being installed. [default: firefox] 06:27:48 INFO - mkdir: /builds/slave/test/build/application 06:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:28:22 INFO - Reading from file tmpfile_stdout 06:28:22 INFO - Output received: 06:28:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:28:22 INFO - Running post-action listener: _resource_record_post_action 06:28:22 INFO - ##### 06:28:22 INFO - ##### Finished install step (success) 06:28:22 INFO - ##### 06:28:22 INFO - ##### 06:28:22 INFO - ##### Running run-tests step. 06:28:22 INFO - ##### 06:28:22 INFO - Running pre-action listener: _resource_record_pre_action 06:28:22 INFO - Running main action method: run_tests 06:28:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:28:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:28:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:28:22 INFO - 2016-07-04 06:28:22.992 screenresolution[1639:7477] starting screenresolution argv=screenresolution get 06:28:22 INFO - 2016-07-04 06:28:22.995 screenresolution[1639:7477] Display 0: 1600x1200x32@60 06:28:23 INFO - 2016-07-04 06:28:23.001 screenresolution[1640:7480] starting screenresolution argv=screenresolution list 06:28:23 INFO - Available Modes on Display 0 06:28:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:28:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:28:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:28:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:28:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:28:23 INFO - Intel Iris: 06:28:23 INFO - Chipset Model: Intel Iris 06:28:23 INFO - Type: GPU 06:28:23 INFO - Bus: Built-In 06:28:23 INFO - VRAM (Dynamic, Max): 1536 MB 06:28:23 INFO - Vendor: Intel (0x8086) 06:28:23 INFO - Device ID: 0x0a2e 06:28:23 INFO - Revision ID: 0x0009 06:28:23 INFO - Displays: 06:28:23 INFO - Display: 06:28:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:28:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:28:23 INFO - Display Serial Number: 1600x1200 60 06:28:23 INFO - Main Display: Yes 06:28:23 INFO - Mirror: Off 06:28:23 INFO - Online: Yes 06:28:23 INFO - Rotation: Supported 06:28:23 INFO - Return code: 0 06:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:23 INFO - Python 2.7.3 06:28:23 INFO - Return code: 0 06:28:23 INFO - grabbing minidump binary from tooltool 06:28: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')]} 06:28:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108283d30>, '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 0x107fe8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10827bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:28:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:28:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:28:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:23 INFO - Return code: 0 06:28:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:28:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:28:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0299 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:28:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qra02u9H3j/Render', 06:28:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:23 INFO - 'HOME': '/Users/cltbld', 06:28:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:23 INFO - 'LOGNAME': 'cltbld', 06:28:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:23 INFO - 'MOZ_NO_REMOTE': '1', 06:28:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:23 INFO - 'NO_EM_RESTART': '1', 06:28:23 INFO - 'PAGER': '/bin/cat', 06:28:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:23 INFO - 'PWD': '/builds/slave/test', 06:28:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:23 INFO - 'SHELL': '/bin/bash', 06:28:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1TN9XHxz1T/Listeners', 06:28:23 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 06:28:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:23 INFO - 'USER': 'cltbld', 06:28:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:23 INFO - 'XPC_FLAGS': '0x0', 06:28:23 INFO - 'XPC_SERVICE_NAME': '0', 06:28:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:28:23 INFO - mozversion application_buildid: 20160704040324 06:28:23 INFO - mozversion application_changeset: 4191df8e4b8e1e2dd0593132dac25915f987f797 06:28:23 INFO - mozversion application_display_name: Nightly 06:28:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:23 INFO - mozversion application_name: Firefox 06:28:23 INFO - mozversion application_remotingname: firefox 06:28:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:28:23 INFO - mozversion application_vendor: Mozilla 06:28:23 INFO - mozversion application_version: 50.0a1 06:28:23 INFO - mozversion platform_buildid: 20160704040324 06:28:23 INFO - mozversion platform_changeset: 4191df8e4b8e1e2dd0593132dac25915f987f797 06:28:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:28:23 INFO - mozversion platform_version: 50.0a1 06:28:23 INFO - using testdate: 1467638903 06:28:23 INFO - actual date: 1467638903 06:28:23 INFO - starting webserver on 'localhost:49271' 06:28:23 INFO - SUITE-START | Running 2 tests 06:28:23 INFO - TEST-START | dromaeo_css 06:28:23 INFO - operating with platform_type : mac_ 06:28:23 INFO - Initialising browser for dromaeo_css test... 06:28:23 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpx8O0xj/profile http://localhost:49271/getInfo.html) 06:28:25 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 06:28:25 INFO - PROCESS | 1650 | colorDepth:24 06:28:25 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 06:28:25 INFO - PROCESS | 1650 | __metrics 06:28:25 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:28:25 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:28:26 INFO - TEST-INFO | 1650: exit 0 06:28:26 INFO - Browser initialized. 06:28:26 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:26 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpx8O0xj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:38 INFO - PROCESS | 1652 | RSS: Main: 244609024 06:28:38 INFO - PROCESS | 1652 | 06:29:29 INFO - PROCESS | 1652 | 1467638969394 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:31:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:31:42 INFO - PROCESS | 1652 | RSS: Main: 396587008 06:31:42 INFO - PROCESS | 1652 | 06:34:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:34:46 INFO - PROCESS | 1652 | RSS: Main: 380030976 06:34:46 INFO - PROCESS | 1652 | 06:37:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:37:49 INFO - PROCESS | 1652 | RSS: Main: 368074752 06:37:49 INFO - PROCESS | 1652 | 06:40:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:40:52 INFO - PROCESS | 1652 | RSS: Main: 372891648 06:40:52 INFO - PROCESS | 1652 | 06:43:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:43:56 INFO - PROCESS | 1652 | RSS: Main: 333488128 06:43:56 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:46:59 INFO - PROCESS | 1652 | RSS: Main: 388505600 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | __start_tp_report 06:46:59 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 06:46:59 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 06:46:59 INFO - PROCESS | 1652 | |i|pagename|runs| 06:46:59 INFO - PROCESS | 1652 | |0;dojo.html;2595.5976823592346;3264.8694052237906;3354.7483938704604;3387.847546860391;3413.7439692023104;5621.213030175779;5674.744636491358;5693.686847223406;5734.541236701064;5794.39158888317;5693.174489698991;5745.023346031175;5751.281089863767;5752.424757524245;5758.942410575893;5146.794128234885;5172.586193104561;5208.817691380802;5220.843374698765;5262.894742105155;5198.870028249286;5274.4461831507715;5325.334333208349;5330.013947419739;5384.757685904124;4833.564979151875;4897.951020489803;5309.177077552966;5317.627766056377;5380.192971054334;5270.367555893298;5296.311479507639;5309.734513274359;5313.123334649778;5362.8123015694655;4998.12532806761;5041.596672266247;5188.403333616607;5224.52979231871;5246.501582349671;5669.489745922887;5765.567582431335;5768.163616275617;5822.184894114827;5849;6299.433051025429;6299.496040316763;6301.905471417932;6315.810525684191;6344.619322840645;6207.689615519251;6269.153664255358;6281.811545653638;6340.556161068727;6343.524235682296;5785.595008349417;5785.855353616109;5820.563457740686;5837.562182836305;5842.2405087338375;6274.121622972787;6328.462080723098;6345.17512723343;6349.2698339690605;6355.014972679242;6087.96956015226;6124.938750612437;6251.156093927352;6270.2789179244055;6278.246610406781;5242.239875218072;6198.938010619836;6253;6262.5929314594405;6321;6253.749850005949;6292.528060395489;6292.779752708725;6296.5592408530965;6310.810675679737;6135.875804921915;6221.440070393686;6254.695250272448;6322.71547780351;6323.30443651198;4909.803607855717;4919.4834542373255;4955.653104282737;4956.677815942025;4970.17992031318;4496.910061798746;4507.5943165115295;4524.457065152137;4529.411176547093;4536.387587675622;5792.507636850914;5820.243368362086;5839.941600583939;5849.912251316148;5931.822045338647;6328.240611126602;6342.682865856688;6359.554831161867;6368.64972426521;6369.076483909807;5824.242848429677;5862.589618726648;5869.882602347929;5874.206982057453;5931.6441013539325;5364.570834333244;5407;5458.072127738294;5460.972695136578;5521.1442226454965;6375.330590288046;6375.649339286384;6381.680915954184;6398.776042838478;6401.071844582602;5678.858028549319;6347.238331400077;6363.5545511813725;6363.936360636334;6372.203474565679;5592.133219351007;6272.18461599989;6294.71673774672;6327.810165695037;6383.808485745435;6276.623402595859;6289.276733175743;6289.779857704958;6290.24517057956;6302.117703521419;5404.567634589302;5694.572907031907;6264.091706702594;6337.493000560036;6345.3654634538025;6060.545459090497;6082.60463069899;6134.202553667995;6135.141080248858;6158.291796443466;6167;6182.258129024546;6196.287426945959;6197.597156184834;6200.627962322275;6017.729202185825;6033.888555546231;6043.519337762101;6101.38986101404;6102.603330783485;6053.75784968614;6091.7563297467605;6124.326324104256;6152.692365381802;6169.105479705508;6092.634441933498;6101.328853826164;6101.60339577926;6105.419985101408;6136.23297087864 06:46:59 INFO - PROCESS | 1652 | |1;ext.html;482.6331987689356;504.9925398829336;505.8710028942619;513.6994858008065;530.3979982719613;23998.640020399685;30680.77276908924;31353.372932541362;38159.427608585895;42797;44356.778216108956;44505.77747111268;44699.77650111753;44730;44753.104937901226;9742.074502922229;9888.307818452675;9890.15933645641;9893.25800564957;9911.553980070914;8765.95617021914;8947.64209431622;9680.75798105046;11952.701182470464;12151.27092374456;12060.457279422448;12131.878681213164;12133.211341262833;12134.817977730341;12140;8799.164079412445;12069.698257543543;12100.576479823252;12123.454444550016;12156;11671;11984.101192410604;12003.459844306939;12227.938860305641;12235.388230588434;40816.387754183714;41208.587914121075;41277.380839287136;41281.72950487722;41397.37903931444;3583.140046388874;3718.721095917817;3756.267527832074;3923.7606615793816;3943.684505239574;31405.84297078523;32145.51781723276;32838.83580582106;32853.342933141204;32994;3087.9073627791204;3211.951820722691;3346.849391777376;3399.9150021249666;3419.059758566389;363760;365222;366078;366587;366984;63615.6819215901;64112;64494;64499;64513;61482;61848.07227891585;61929;61980;62035.379646203866;16127.435539756052;16944.322227110777;16987.830121698626;17385.391511297297;17390.47828565145;11848.94075529634;12062.155649104478;12947.611571652677;12964.22214667123;13066.0200484964;19566.804331956497;19608.50978725515;20342.389728308175;20342.491437714176;20347.389578312675;6860.965695171492;8025.678972841021;8105.2705256526015;8108.2297181767635;8209.466384684976;962.259060523393;1036.616451912782;1078.3637653784306;1090.3457925244948;1091.0943916549245;24395.462657914504;30743.69256307453;30876.53685194724;31532.684673153435;31536.684633153374;1078.428432930548;1119.7088756923097;1121.6915348279126;1126.0709914320719;1131.4682099413262;16820.74768878468;16926.153692315336;16969.83030169707;17277.963322200707;17304.65390692179;732513;736308;736999;737079;737695;60639;62813.37186628167;62847;62870.37129628737;63017.68491157515;1429.4996751137228;1434.2040167707023;1464.3630020940925;1466.3767898643034;1466.7213229486363;29680.851595741882;30898.845505772326;31070.53394199134;31190.532142017433;31903.521447177845;52606.73696631492;52651.47348526466;53470.73264633652;53520.73239633933;53562.46437535575;666956;667698.9690309298;669599;670272;670772;23165.42086447785;25580.48839023172;26134.607980880683;26210.86894565515;26396.472070558866;46830.76584617055;47170;47230.76384618192;47890.52109478861;48066;34682.826585867915;37356.252874941805;37932;39227.803860980515;39983.40024899687;38809.417858732704;39043.609563904;39585.406218907316;39671;40209.19581608293;37484.93953316267;37913.4312985311;38165.427518586686;38216.42675359928;38481.615183848924;32784.016479505655;33908.49137262894;34194.82902585471;34435.4834677475;34641.48037779385;25312.74687253104;25320.873395632905;25341.87329063343;26027.869860650575;26377.340566485993 06:46:59 INFO - PROCESS | 1652 | |2;jquery.html;352.429064914838;382.9368154254548;389.61817418929456;393.7912906159735;401.3257727018608;19313.903430482846;21352.786472135314;21667.241646542374;21683.45791355217;21684.3494695159;11762.647120586396;12007.699807504794;12284.692882677937;12288.324142172178;12355.258684478915;5360.571154307666;5480.424555421683;5547.500724934755;5551.306086739158;5554.028045092113;3908.335582950905;4143.150654115914;4900.754962251873;6851.965740171292;6863.313668633146;6829;6844;6867.519273650846;6869.381755641991;6871.553349032297;6646.202455705298;6718.8992165117315;6821.69302381394;6837.863242735142;6843.486738494633;3785.6403641653997;3955.960440395588;4004.5394779600138;5550.972245138749;5961.880762384728;13040.934795326057;13560.389782459813;13657.112287701368;16057.598560035976;26108;2221.7000704904794;2248.7076680031655;2370.111208296889;2385.3559538924565;2447.0701133569128;9959.302848800588;9993.950030249875;10038.648647297383;10179.134773544258;10312.948435257851;1724.4567961092216;1788.534980904961;1819.8453131483839;1849.6300739852084;1878.2674756844706;90274.99999999935;127675;133869.99195012084;138276;140722;9021.60165174399;9317.437704631146;11571.537138514534;11623.895729905646;11753.294802311888;14597.78103328451;14654.56036318912;14674.55976320712;14678.853211467962;14714.264286785618;8515;8678.00202976653;8686.313809912677;8773.122687731304;8797.956010219908;8716.869246961302;8779.561021948877;8793.296536277083;8902.688405905763;8905.975812781484;4456.220161471794;4526.140033393711;4531.501534831166;4606.930896036562;4607.884802879955;1724.6205834716343;1758.441467664545;1911.130435651775;1934.5937353155714;1937.2638397408894;884.2439714044529;902.4224496322358;952.2096659772373;965.666844938495;987.6345752071779;20192.899035504728;21359.893200533897;21716.674249886266;22101;22110.668339974913;934;939.6664184214505;955.2883102088988;956.9043095690514;993;9433.386829856037;11467.369294688706;11674.94162529182;11689.064874809996;11690.824637630443;642768;645536;648785;650658;657720;96218.51890740501;152231;154781.2260938688;155627;158550.20724896534;856.9014563325297;973.5910917414703;1005.653049697853;1005.9547320370601;1008.294194064158;19033;19397.51506212356;19570.80429195747;19776.703349449483;19807.801921980597;50220.74889625528;50635;56580.71709641426;58937.70531147317;59338.40661593501;87785.56107219424;87898;88026.06031413496;88566.55716721374;90782.54608727178;7667.271609197117;7882.408819338458;7938.64276107565;7979.84040319202;8131.146229646039;9083.545822708971;12598.370081496072;12764.375167326305;12778.552750653682;13395.933020334836;9506.809863802824;10583;11018.50416731233;11193.27243729155;11197.60808371703;10269.53787079598;10727.517261723397;10901.291416057931;11022.614208502664;11146.442677866236;5700.059490184073;7774.339181169664;9871.802563948537;10719.464026798785;11465.254758441008;6929.757458488929;7420.332170104716;7511.248875112445;7540.585267810323;7598.734044308423;11149.331040137293;11647.708807279885;11657.300561966309;11658.475368608264;11665.35840528745 06:46:59 INFO - PROCESS | 1652 | |3;mootools.html;1418.6595217147885;1560.3758496601358;1784.1525275494134;1923.230707716914;1964.4401345616493;8589.957050214747;8856.202941735242;9023.909760902388;9027.774305642353;9040.638374465014;6595.439387652055;7775.922240777591;7791;8757.343199260049;8835.95582022089;2355.9764402356013;2381.3213234228247;2382.2376839411395;2384.3204686664303;2385.6063749481314;2367.360812580611;2381.7022872140983;2402;2404.879756012201;2406.95186096278;2108.0724481228285;2179.4442417183595;2180.890955452229;2186.4533866533366;2189.737231532218;2309.2956648222284;2381.142788596104;2385.9284221473386;2386.0575072846127;2386.773256540626;2370.7629237076153;2381.118985975183;2387.85672859629;2401.0995876546294;2401.78383945444;9035.909640903637;9073.45559266446;9082.77293067672;9085.273178145733;9113.134252246093;5230.529252367267;5325.4940780625775;5386.2997810284805;5387.81142660005;5388.703621300827;3209.6629853865243;3575.66031227033;3687.3731465650635;3692.8522859085606;3700.4264339027495;1043.7651528406047;1077.0414331245197;1081.734974931139;1805.3951926104771;1872.3446793622259;11729.53081876724;11803.763924721543;11821.94089029558;11827.112966527458;11852.111091668074;4413.8234470621455;4428.446444194476;4602.792874320664;4625.398698169217;4627.838025669085;9201.769955751026;9206.355555111079;9207.26341892647;9208.907910920805;9210.677626283048;5270.472952704698;5271.1302635064785;5278.97360513195;5281.234221038005;5283.920741188886;4061.756294622332;4926.876828079255;4937.136001199776;4941.728204948762;4942.35749352589;3091.412631599989;3627.238279961185;3699.963000370016;3740.756850804689;3794.8482060717815;964.3249725192394;1134.13805507813;1139.9943000284945;1141.4121727310442;1155.4338374196584;836.3560058754725;848.9575521223915;898.6854600889767;942.2744486745167;977.6382738386842;5846.356900740915;6079.05774604937;6090.939090609126;6134.4172303631085;6225.315215326311;422.628087283195;423.9788010599458;432.18964441671864;433.56643356643355;433.64874451694226;3636.4908912752235;3681.0981309579324;3683.5027271318563;3705.9073523161596;3718.2749363874327;8886.644534218689;10600.310979786289;10857.2942758722;11019.118470522339;11036.889631103746;10954.726131846768;10973;10985.01134897863;10995;10999.23005389615;8001.839963200703;8423.747287581382;8437.789055273668;8466.365022623328;8477.279431248413;5880.26496687914;5994.250718660168;6004.8498787528915;6065.54508411862;6117.327094019565;9917.45454000037;10280.845787313347;10284.023017813295;10287.691369258935;10287.794244114926;8287.295579875778;8560.486370817522;8718.258947989492;10477.63328283537;10518.211134164816;6981.406580440516;6985.79042628722;7057.012018317337;7078.716851325889;7102.112235970504;8366.24703776663;8371.288440482627;8397.95801020991;8420.62107205165;8432.156784321518;7605.353544948742;7642.465027448247;7666.310032097138;7728.072631284057;7776.766696999099;7508.361789247975;7509.812254693677;7564.357029652321;7657.042869641295;7671.347935425328;6847.6576171190245;7126.251743566851;7153.3919616833155;7175.282471752992;7223.8555228896175;5023.8492845214705;5030.748462576783;5058.7976480941825;5058.873528161826;5156.5616922562;5056.494350564914;5138.845834624967;5176.1200595898035;5199.532042116077;5279.920801187908 06:46:59 INFO - PROCESS | 1652 | |4;prototype.html;258.90808762889174;282.1704189682334;288.86423381010945;305.9388122375525;313.7584060273589;4507.467461063238;5246.842594722155;5339.424869663449;5453.481919217673;5531.944680553193;4260.488741351034;4512.646206138162;5484.7531861066245;5518.448155184479;5538.6399884007515;3400.64293249209;4096.160287141144;4139.834406623731;4158.293090174678;4166.437530933315;3543.94684079739;3906.199229158016;4039.919201615966;4075.714699971003;4076.9796151019204;3947.960520394802;4124.845043387856;4125.463689720332;4125.876223713279;4127.030147915238;3374.358871814372;4112.917741645166;4128.60778226068;4132.607402296777;4160.83356665733;2984.552317152423;3598.892033239007;3620.855165793365;3624.855005799765;3632.418812989909;4440.711353761995;4539.773011349419;4772.379590653228;4899.387576552931;5119.616028797818;4700.1539722849875;4734.55021772931;4759.4764575896625;4761.904761904742;4763.618910487153;4692.601128904047;4942;5165.63840531163;5545.972270138664;5740.7703691852275;3593.94609080864;3746.83139258734;3776.9244615107546;3780.319542482352;3781.962180378216;5753.231633280208;5760.366359700472;5827.388124246935;5830.650160990354;5851.356350801409;3714.9628503715157;3842.4620553122586;3860.189360234326;3884.2132618995015;3900.531936167678;3690.2988432198335;3797.8290976906105;3839.347310957144;4037.0109323216;4038.757674539537;3913.373860182357;4560.153137979124;4671.789769460383;4672.2057250267535;4686.882827929329;4775.976120119447;5767.64460351817;5777.94222057774;5806.477417032487;5823;1323.9470421183046;1347.4946894914408;1374.3609221711952;1374.8863420629123;1376.1742954227584;825.8018075661918;840.5461051032374;842.4061036969044;844.5566077809076;849.4605925237395;3949.9012524686536;4328.718633288826;4576.832907608538;4598.82729903879;4669.696469729457;4314.697971142053;4506.662000349987;4894.681845680019;5025.597952163818;5098.685854194729;4100.65144462718;4285.871423857289;4359.237133501624;4578.587927086578;4648.48866624671;2146.173723116611;2310.9075636974667;2587.8576678282498;2632.5129850977246;2644.801639877017;4442.244818380883;5144.331236939174;5165.638405311592;5166.870828229249;5180.81867134656;3949.8420063197723;4363.781810909441;4392.298736277166;4479.350494178391;5073.847784566469;4373.497047839475;4775.594074503567;5172.017546489183;5197.558207552401;5211.687298762086;4383.517813040627;4600.688803690932;4756.310335001336;4876.634542328012;4921.827736029221;4039.929418703987;4514.616257618008;4573.748443835621;4788.688735232199;4795.20879054952;4402.911941761211;5081.8475445736685;5102.545774454263;5115.718635474936;5160.064975634137;3062.17321323237;3453.9654603453646;3463.8787642433404;3480.460528618068;3484.581850177995;4909.219900676388;5228.928069745769;5637.915431268452;5790.623609465371;5866.472017518444;5210.6613070150315;5673.489385955284;5701.486866182064;5734.569907256889;5736.713164341682;4657.206975314461;5277.498637629419;5670.688112153871;5697.344805347272;5744.563859035241;5459;5590.832275031756;5596.272484577142;5600.299962504687;5624.156376543551;4796.712197268175;4860.975695121501;5095.522298533384;5321.7227865312825;5738.368779434176;5277.102892508206;5628.099504079328;5636.463591383812;5645.661260324394;5661.25429166862 06:46:59 INFO - PROCESS | 1652 | |5;yui.html;742.6509540515957;744.0550500863903;806.8910697055895;838.513662075996;875.2910142784345;15104.546863594082;15903.363865445383;15903.761443578327;15924.044557326553;15948.521544353687;14692.926535367309;14738.410463581444;14790.556283311491;14811.703765924674;14841.925790371033;712.8752468318063;736.7531876821245;885.3536918049796;913.1507697841005;922.2667978956746;879.8680197970292;894.8836651235363;896.7444278380631;897.5601955042048;898.5641963647626;942.8397172480695;942.8444306689388;943.1605870775015;944.0653752784729;946.9857952130689;751.1774606805567;931.5388882503204;939.9906000940006;963.9180669643089;967.8983706710765;712.9322714342129;714.032485981498;714.3606472207397;715.0168518287355;715.4240836126916;14938.551843444715;14973.251337433085;14980.550583482513;14985.400583976629;14997.625059373493;14233.28833558318;14395.136291822419;14449.422023119063;14459.566213013626;14478.058926169766;12954.157979731288;13212.933935330359;13269.734605307936;13530.864691353157;13531.661708457268;4070.29702970297;4564.630610816742;4713.552212539803;4843.2250839865455;4856.708597484162;103716.44425333626;104120.99999999924;104383;104685;104961;11173.162012849069;11318.660440186808;11321.433928303552;11333.716657083638;11351.148663850245;22305.776942230696;22398.55202895933;22407.663885041737;22421.55156896853;22864.199753008565;7874.606269686493;7948.642311096015;7955.443118981616;8042.839143217103;8054.5569993650915;4320;4361;4433.667474939392;4443.422355093881;4458.086092351125;3076.292452735883;3436.862525499002;3565.8395372208315;3583.050491619723;3601.5858176309534;665.896785998171;669.3039239191284;675.9864802704017;676.6853413162903;678.372505432473;552.3068548971015;599.2150283129027;638.2500561839912;645.7955912223763;653.4282502810041;8588.484690918565;9036.728898133066;9037.548122593844;9104.681336153335;9212.216961558208;489.82836136018994;633.7971849008273;634.3339493531773;645.3610925184034;647.5920170292685;4290.506591741927;4392.538783427758;4408.404865343137;4461.843835465808;4498.910021799546;106674;119835;154418;154518;157526;90285.54857225803;108259.7522074339;118754;119802.40098799624;121642;63084.36915630877;72388.63805680937;98186.0181398177;100690;101157;9517.23862091045;9714.591384249386;9771.218302535637;9867.40795552269;10025.398476091166;46657;60674.48313792014;63303.683481582295;65233;67831.98252026322;65148;69740.65129674319;70052.64973675099;71344.5731085365;75449.6227518859;13440.865591344353;13536.661583460493;13555.796663049865;13578.185308881499;14131.434742610181;15095.245237738289;15142.848571514143;15307.234638267819;15376.923115384352;16042.117683527518;14283.928580357031;14335.56993290203;14449.927750361181;14485.92757036208;14787.630309242355;14057;14373.353199105855;14461.13233206011;14849.183294918883;14877.107373557621;13824.930875345559;13853.445862165401;13867.72264554683;13910.791338130139;14004.649883752987;9737.561809718722;11302.604408845651;11521.88478115208;11533.135014874086;11930.821037684269;11216.943915280372;11627.59303424376;11817.172797904064;11849.170558060852;11879.643610691694 06:46:59 INFO - PROCESS | 1652 | __end_tp_report 06:46:59 INFO - PROCESS | 1652 | __start_cc_report 06:46:59 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1491 06:46:59 INFO - PROCESS | 1652 | __end_cc_report 06:46:59 INFO - PROCESS | 1652 | __startTimestamp1467640019838__endTimestamp 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | ------- Summary: start ------- 06:46:59 INFO - PROCESS | 1652 | Number of tests: 6 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5779.38 Median:6043.52 stddev:673.08 (11.1%) stddev-sans-first:627.09 06:46:59 INFO - PROCESS | 1652 | Values: 2595.6 3264.9 3354.7 3387.8 3413.7 5621.2 5674.7 5693.7 5734.5 5794.4 5693.2 5745.0 5751.3 5752.4 5758.9 5146.8 5172.6 5208.8 5220.8 5262.9 5198.9 5274.4 5325.3 5330.0 5384.8 4833.6 4898.0 5309.2 5317.6 5380.2 5270.4 5296.3 5309.7 5313.1 5362.8 4998.1 5041.6 5188.4 5224.5 5246.5 5669.5 5765.6 5768.2 5822.2 5849.0 6299.4 6299.5 6301.9 6315.8 6344.6 6207.7 6269.2 6281.8 6340.6 6343.5 5785.6 5785.9 5820.6 5837.6 5842.2 6274.1 6328.5 6345.2 6349.3 6355.0 6088.0 6124.9 6251.2 6270.3 6278.2 5242.2 6198.9 6253.0 6262.6 6321.0 6253.7 6292.5 6292.8 6296.6 6310.8 6135.9 6221.4 6254.7 6322.7 6323.3 4909.8 4919.5 4955.7 4956.7 4970.2 4496.9 4507.6 4524.5 4529.4 4536.4 5792.5 5820.2 5839.9 5849.9 5931.8 6328.2 6342.7 6359.6 6368.6 6369.1 5824.2 5862.6 5869.9 5874.2 5931.6 5364.6 5407.0 5458.1 5461.0 5521.1 6375.3 6375.6 6381.7 6398.8 6401.1 5678.9 6347.2 6363.6 6363.9 6372.2 5592.1 6272.2 6294.7 6327.8 6383.8 6276.6 6289.3 6289.8 6290.2 6302.1 5404.6 5694.6 6264.1 6337.5 6345.4 6060.5 6082.6 6134.2 6135.1 6158.3 6167.0 6182.3 6196.3 6197.6 6200.6 6017.7 6033.9 6043.5 6101.4 6102.6 6053.8 6091.8 6124.3 6152.7 6169.1 6092.6 6101.3 6101.6 6105.4 6136.2 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:72623.66 Median:364491.00 stddev:164338.44 (45.1%) stddev-sans-first:164710.20 06:46:59 INFO - PROCESS | 1652 | Values: 482.6 505.0 505.9 513.7 530.4 23998.6 30680.8 31353.4 38159.4 42797.0 44356.8 44505.8 44699.8 44730.0 44753.1 9742.1 9888.3 9890.2 9893.3 9911.6 8766.0 8947.6 9680.8 11952.7 12151.3 12060.5 12131.9 12133.2 12134.8 12140.0 8799.2 12069.7 12100.6 12123.5 12156.0 11671.0 11984.1 12003.5 12227.9 12235.4 40816.4 41208.6 41277.4 41281.7 41397.4 3583.1 3718.7 3756.3 3923.8 3943.7 31405.8 32145.5 32838.8 32853.3 32994.0 3087.9 3212.0 3346.8 3399.9 3419.1 363760.0 365222.0 366078.0 366587.0 366984.0 63615.7 64112.0 64494.0 64499.0 64513.0 61482.0 61848.1 61929.0 61980.0 62035.4 16127.4 16944.3 16987.8 17385.4 17390.5 11848.9 12062.2 12947.6 12964.2 13066.0 19566.8 19608.5 20342.4 20342.5 20347.4 6861.0 8025.7 8105.3 8108.2 8209.5 962.3 1036.6 1078.4 1090.3 1091.1 24395.5 30743.7 30876.5 31532.7 31536.7 1078.4 1119.7 1121.7 1126.1 1131.5 16820.7 16926.2 16969.8 17278.0 17304.7 732513.0 736308.0 736999.0 737079.0 737695.0 60639.0 62813.4 62847.0 62870.4 63017.7 1429.5 1434.2 1464.4 1466.4 1466.7 29680.9 30898.8 31070.5 31190.5 31903.5 52606.7 52651.5 53470.7 53520.7 53562.5 666956.0 667699.0 669599.0 670272.0 670772.0 23165.4 25580.5 26134.6 26210.9 26396.5 46830.8 47170.0 47230.8 47890.5 48066.0 34682.8 37356.3 37932.0 39227.8 39983.4 38809.4 39043.6 39585.4 39671.0 40209.2 37484.9 37913.4 38165.4 38216.4 38481.6 32784.0 33908.5 34194.8 34435.5 34641.5 25312.7 25320.9 25341.9 26027.9 26377.3 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:36942.16 Median:2151.06 stddev:108817.11 (5058.8%) stddev-sans-first:109087.69 06:46:59 INFO - PROCESS | 1652 | Values: 352.4 382.9 389.6 393.8 401.3 19313.9 21352.8 21667.2 21683.5 21684.3 11762.6 12007.7 12284.7 12288.3 12355.3 5360.6 5480.4 5547.5 5551.3 5554.0 3908.3 4143.2 4900.8 6852.0 6863.3 6829.0 6844.0 6867.5 6869.4 6871.6 6646.2 6718.9 6821.7 6837.9 6843.5 3785.6 3956.0 4004.5 5551.0 5961.9 13040.9 13560.4 13657.1 16057.6 26108.0 2221.7 2248.7 2370.1 2385.4 2447.1 9959.3 9994.0 10038.6 10179.1 10312.9 1724.5 1788.5 1819.8 1849.6 1878.3 90275.0 127675.0 133870.0 138276.0 140722.0 9021.6 9317.4 11571.5 11623.9 11753.3 14597.8 14654.6 14674.6 14678.9 14714.3 8515.0 8678.0 8686.3 8773.1 8798.0 8716.9 8779.6 8793.3 8902.7 8906.0 4456.2 4526.1 4531.5 4606.9 4607.9 1724.6 1758.4 1911.1 1934.6 1937.3 884.2 902.4 952.2 965.7 987.6 20192.9 21359.9 21716.7 22101.0 22110.7 934.0 939.7 955.3 956.9 993.0 9433.4 11467.4 11674.9 11689.1 11690.8 642768.0 645536.0 648785.0 650658.0 657720.0 96218.5 152231.0 154781.2 155627.0 158550.2 856.9 973.6 1005.7 1006.0 1008.3 19033.0 19397.5 19570.8 19776.7 19807.8 50220.7 50635.0 56580.7 58937.7 59338.4 87785.6 87898.0 88026.1 88566.6 90782.5 7667.3 7882.4 7938.6 7979.8 8131.1 9083.5 12598.4 12764.4 12778.6 13395.9 9506.8 10583.0 11018.5 11193.3 11197.6 10269.5 10727.5 10901.3 11022.6 11146.4 5700.1 7774.3 9871.8 10719.5 11465.3 6929.8 7420.3 7511.2 7540.6 7598.7 11149.3 11647.7 11657.3 11658.5 11665.4 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5679.00 Median:5043.62 stddev:3207.51 (63.6%) stddev-sans-first:3200.53 06:46:59 INFO - PROCESS | 1652 | Values: 1418.7 1560.4 1784.2 1923.2 1964.4 8590.0 8856.2 9023.9 9027.8 9040.6 6595.4 7775.9 7791.0 8757.3 8836.0 2356.0 2381.3 2382.2 2384.3 2385.6 2367.4 2381.7 2402.0 2404.9 2407.0 2108.1 2179.4 2180.9 2186.5 2189.7 2309.3 2381.1 2385.9 2386.1 2386.8 2370.8 2381.1 2387.9 2401.1 2401.8 9035.9 9073.5 9082.8 9085.3 9113.1 5230.5 5325.5 5386.3 5387.8 5388.7 3209.7 3575.7 3687.4 3692.9 3700.4 1043.8 1077.0 1081.7 1805.4 1872.3 11729.5 11803.8 11821.9 11827.1 11852.1 4413.8 4428.4 4602.8 4625.4 4627.8 9201.8 9206.4 9207.3 9208.9 9210.7 5270.5 5271.1 5279.0 5281.2 5283.9 4061.8 4926.9 4937.1 4941.7 4942.4 3091.4 3627.2 3700.0 3740.8 3794.8 964.3 1134.1 1140.0 1141.4 1155.4 836.4 849.0 898.7 942.3 977.6 5846.4 6079.1 6090.9 6134.4 6225.3 422.6 424.0 432.2 433.6 433.6 3636.5 3681.1 3683.5 3705.9 3718.3 8886.6 10600.3 10857.3 11019.1 11036.9 10954.7 10973.0 10985.0 10995.0 10999.2 8001.8 8423.7 8437.8 8466.4 8477.3 5880.3 5994.3 6004.8 6065.5 6117.3 9917.5 10280.8 10284.0 10287.7 10287.8 8287.3 8560.5 8718.3 10477.6 10518.2 6981.4 6985.8 7057.0 7078.7 7102.1 8366.2 8371.3 8398.0 8420.6 8432.2 7605.4 7642.5 7666.3 7728.1 7776.8 7508.4 7509.8 7564.4 7657.0 7671.3 6847.7 7126.3 7153.4 7175.3 7223.9 5023.8 5030.7 5058.8 5058.9 5156.6 5056.5 5138.8 5176.1 5199.5 5279.9 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4311.61 Median:4663.45 stddev:1315.79 (28.2%) stddev-sans-first:1283.84 06:46:59 INFO - PROCESS | 1652 | Values: 258.9 282.2 288.9 305.9 313.8 4507.5 5246.8 5339.4 5453.5 5531.9 4260.5 4512.6 5484.8 5518.4 5538.6 3400.6 4096.2 4139.8 4158.3 4166.4 3543.9 3906.2 4039.9 4075.7 4077.0 3948.0 4124.8 4125.5 4125.9 4127.0 3374.4 4112.9 4128.6 4132.6 4160.8 2984.6 3598.9 3620.9 3624.9 3632.4 4440.7 4539.8 4772.4 4899.4 5119.6 4700.2 4734.6 4759.5 4761.9 4763.6 4692.6 4942.0 5165.6 5546.0 5740.8 3593.9 3746.8 3776.9 3780.3 3782.0 5753.2 5760.4 5827.4 5830.7 5851.4 3715.0 3842.5 3860.2 3884.2 3900.5 3690.3 3797.8 3839.3 4037.0 4038.8 3913.4 4560.2 4671.8 4672.2 4686.9 4776.0 5767.6 5777.9 5806.5 5823.0 1323.9 1347.5 1374.4 1374.9 1376.2 825.8 840.5 842.4 844.6 849.5 3949.9 4328.7 4576.8 4598.8 4669.7 4314.7 4506.7 4894.7 5025.6 5098.7 4100.7 4285.9 4359.2 4578.6 4648.5 2146.2 2310.9 2587.9 2632.5 2644.8 4442.2 5144.3 5165.6 5166.9 5180.8 3949.8 4363.8 4392.3 4479.4 5073.8 4373.5 4775.6 5172.0 5197.6 5211.7 4383.5 4600.7 4756.3 4876.6 4921.8 4039.9 4514.6 4573.7 4788.7 4795.2 4402.9 5081.8 5102.5 5115.7 5160.1 3062.2 3454.0 3463.9 3480.5 3484.6 4909.2 5228.9 5637.9 5790.6 5866.5 5210.7 5673.5 5701.5 5734.6 5736.7 4657.2 5277.5 5670.7 5697.3 5744.6 5459.0 5590.8 5596.3 5600.3 5624.2 4796.7 4861.0 5095.5 5321.7 5738.4 5277.1 5628.1 5636.5 5645.7 5661.3 06:46:59 INFO - PROCESS | 1652 | 06:46:59 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:22925.80 Median:3835.94 stddev:35108.94 (915.3%) stddev-sans-first:35167.92 06:46:59 INFO - PROCESS | 1652 | Values: 742.7 744.1 806.9 838.5 875.3 15104.5 15903.4 15903.8 15924.0 15948.5 14692.9 14738.4 14790.6 14811.7 14841.9 712.9 736.8 885.4 913.2 922.3 879.9 894.9 896.7 897.6 898.6 942.8 942.8 943.2 944.1 947.0 751.2 931.5 940.0 963.9 967.9 712.9 714.0 714.4 715.0 715.4 14938.6 14973.3 14980.6 14985.4 14997.6 14233.3 14395.1 14449.4 14459.6 14478.1 12954.2 13212.9 13269.7 13530.9 13531.7 4070.3 4564.6 4713.6 4843.2 4856.7 103716.4 104121.0 104383.0 104685.0 104961.0 11173.2 11318.7 11321.4 11333.7 11351.1 22305.8 22398.6 22407.7 22421.6 22864.2 7874.6 7948.6 7955.4 8042.8 8054.6 4320.0 4361.0 4433.7 4443.4 4458.1 3076.3 3436.9 3565.8 3583.1 3601.6 665.9 669.3 676.0 676.7 678.4 552.3 599.2 638.3 645.8 653.4 8588.5 9036.7 9037.5 9104.7 9212.2 489.8 633.8 634.3 645.4 647.6 4290.5 4392.5 4408.4 4461.8 4498.9 106674.0 119835.0 154418.0 154518.0 157526.0 90285.5 108259.8 118754.0 119802.4 121642.0 63084.4 72388.6 98186.0 100690.0 101157.0 9517.2 9714.6 9771.2 9867.4 10025.4 46657.0 60674.5 63303.7 65233.0 67832.0 65148.0 69740.7 70052.6 71344.6 75449.6 13440.9 13536.7 13555.8 13578.2 14131.4 15095.2 15142.8 15307.2 15376.9 16042.1 14283.9 14335.6 14449.9 14485.9 14787.6 14057.0 14373.4 14461.1 14849.2 14877.1 13824.9 13853.4 13867.7 13910.8 14004.6 9737.6 11302.6 11521.9 11533.1 11930.8 11216.9 11627.6 11817.2 11849.2 11879.6 06:46:59 INFO - PROCESS | 1652 | -------- Summary: end -------- 06:46:59 INFO - PROCESS | 1652 | 06:47:00 INFO - TEST-INFO | 1652: exit 0 06:47:00 INFO - TEST-OK | dromaeo_css | took 1116979ms 06:47:00 INFO - TEST-START | kraken 06:47:00 INFO - operating with platform_type : mac_ 06:47:00 INFO - Initialising browser for kraken test... 06:47:00 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpMgWSX7/profile http://localhost:49271/getInfo.html) 06:47:02 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 06:47:02 INFO - PROCESS | 1663 | colorDepth:24 06:47:02 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 06:47:02 INFO - PROCESS | 1663 | __metrics 06:47:02 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:47:02 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:03 INFO - TEST-INFO | 1663: exit 0 06:47:03 INFO - Browser initialized. 06:47:03 INFO - Running cycle 1/1 for kraken test... 06:47:03 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpMgWSX7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:15 INFO - PROCESS | 1664 | RSS: Main: 244764672 06:47:15 INFO - PROCESS | 1664 | 06:47:18 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:47:19 INFO - PROCESS | 1664 | RSS: Main: 294109184 06:47:19 INFO - PROCESS | 1664 | 06:47:21 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:47:22 INFO - PROCESS | 1664 | RSS: Main: 304353280 06:47:22 INFO - PROCESS | 1664 | 06:47:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:47:26 INFO - PROCESS | 1664 | RSS: Main: 388890624 06:47:26 INFO - PROCESS | 1664 | 06:47:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:47:29 INFO - PROCESS | 1664 | RSS: Main: 291274752 06:47:29 INFO - PROCESS | 1664 | 06:47:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:47:31 INFO - PROCESS | 1664 | RSS: Main: 295276544 06:47:31 INFO - PROCESS | 1664 | 06:47:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:35 INFO - PROCESS | 1664 | RSS: Main: 331665408 06:47:35 INFO - PROCESS | 1664 | 06:47:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:47:38 INFO - PROCESS | 1664 | RSS: Main: 333688832 06:47:38 INFO - PROCESS | 1664 | 06:47:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:47:42 INFO - PROCESS | 1664 | RSS: Main: 333119488 06:47:42 INFO - PROCESS | 1664 | 06:47:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:47:44 INFO - PROCESS | 1664 | RSS: Main: 313450496 06:47:44 INFO - PROCESS | 1664 | 06:47:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:47:47 INFO - PROCESS | 1664 | RSS: Main: 320548864 06:47:47 INFO - PROCESS | 1664 | 06:47:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:47:50 INFO - PROCESS | 1664 | RSS: Main: 317894656 06:47:50 INFO - PROCESS | 1664 | 06:47:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:47:53 INFO - PROCESS | 1664 | RSS: Main: 328069120 06:47:53 INFO - PROCESS | 1664 | 06:47:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:47:57 INFO - PROCESS | 1664 | RSS: Main: 330489856 06:47:57 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:47:59 INFO - PROCESS | 1664 | RSS: Main: 373981184 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | __start_tp_report 06:47:59 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 06:47:59 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 06:47:59 INFO - PROCESS | 1664 | |i|pagename|runs| 06:47:59 INFO - PROCESS | 1664 | |0;ai-astar;101;116;113;112;114;111;113;114;114;161 06:47:59 INFO - PROCESS | 1664 | |1;audio-beat-detection;141;106;106;157;111;120;153;136;158;107 06:47:59 INFO - PROCESS | 1664 | |2;audio-dft;181;185;183;186;183;183;182;179;179;182 06:47:59 INFO - PROCESS | 1664 | |3;audio-fft;80;74;49;109;73;48;62;79;109;80 06:47:59 INFO - PROCESS | 1664 | |4;audio-oscillator;86;93;92;70;69;68;96;70;68;101 06:47:59 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;94;115;136;130;89;86;88;86;88;85 06:47:59 INFO - PROCESS | 1664 | |6;imaging-darkroom;94;94;106;149;121;91;94;93;93;93 06:47:59 INFO - PROCESS | 1664 | |7;imaging-desaturate;86;102;133;117;83;117;141;86;84;83 06:47:59 INFO - PROCESS | 1664 | |8;json-parse-financial;56;51;55;53;55;54;55;53;56;56 06:47:59 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;66;75;86;110;107;80;69;70;69;69 06:47:59 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;85;84;82;82;82;80;83;82;83;84 06:47:59 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;139;137;135;140;156;149;139;137;246;144 06:47:59 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;163;176;164;161;161;225;217;164;162;161 06:47:59 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;65;65;69;64;84;65;65;67;65;66 06:47:59 INFO - PROCESS | 1664 | __end_tp_report 06:47:59 INFO - PROCESS | 1664 | __start_cc_report 06:47:59 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2013 06:47:59 INFO - PROCESS | 1664 | __end_cc_report 06:47:59 INFO - PROCESS | 1664 | __startTimestamp1467640079346__endTimestamp 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | ------- Summary: start ------- 06:47:59 INFO - PROCESS | 1664 | Number of tests: 14 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:116.90 Median:114.00 stddev:16.03 (14.1%) stddev-sans-first:15.94 06:47:59 INFO - PROCESS | 1664 | Values: 101.0 116.0 113.0 112.0 114.0 111.0 113.0 114.0 114.0 161.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:138.50 stddev:21.96 (15.9%) stddev-sans-first:22.89 06:47:59 INFO - PROCESS | 1664 | Values: 141.0 106.0 106.0 157.0 111.0 120.0 153.0 136.0 158.0 107.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:2.26 (1.2%) stddev-sans-first:2.35 06:47:59 INFO - PROCESS | 1664 | Values: 181.0 185.0 183.0 186.0 183.0 183.0 182.0 179.0 179.0 182.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:76.30 Median:73.50 stddev:20.92 (28.5%) stddev-sans-first:22.15 06:47:59 INFO - PROCESS | 1664 | Values: 80.0 74.0 49.0 109.0 73.0 48.0 62.0 79.0 109.0 80.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:78.00 stddev:13.49 (17.3%) stddev-sans-first:14.20 06:47:59 INFO - PROCESS | 1664 | Values: 86.0 93.0 92.0 70.0 69.0 68.0 96.0 70.0 68.0 101.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:87.00 stddev:19.67 (22.6%) stddev-sans-first:20.75 06:47:59 INFO - PROCESS | 1664 | Values: 94.0 115.0 136.0 130.0 89.0 86.0 88.0 86.0 88.0 85.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:93.00 stddev:18.67 (20.1%) stddev-sans-first:19.52 06:47:59 INFO - PROCESS | 1664 | Values: 94.0 94.0 106.0 149.0 121.0 91.0 94.0 93.0 93.0 93.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:103.20 Median:83.00 stddev:22.30 (26.9%) stddev-sans-first:22.77 06:47:59 INFO - PROCESS | 1664 | Values: 86.0 102.0 133.0 117.0 83.0 117.0 141.0 86.0 84.0 83.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.65 (3.0%) stddev-sans-first:1.64 06:47:59 INFO - PROCESS | 1664 | Values: 56.0 51.0 55.0 53.0 55.0 54.0 55.0 53.0 56.0 56.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:69.50 stddev:16.16 (23.2%) stddev-sans-first:16.31 06:47:59 INFO - PROCESS | 1664 | Values: 66.0 75.0 86.0 110.0 107.0 80.0 69.0 70.0 69.0 69.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.42 (1.7%) stddev-sans-first:1.24 06:47:59 INFO - PROCESS | 1664 | Values: 85.0 84.0 82.0 82.0 82.0 80.0 83.0 82.0 83.0 84.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:142.00 stddev:33.58 (23.6%) stddev-sans-first:35.27 06:47:59 INFO - PROCESS | 1664 | Values: 139.0 137.0 135.0 140.0 156.0 149.0 139.0 137.0 246.0 144.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:164.00 stddev:24.51 (14.9%) stddev-sans-first:25.58 06:47:59 INFO - PROCESS | 1664 | Values: 163.0 176.0 164.0 161.0 161.0 225.0 217.0 164.0 162.0 161.0 06:47:59 INFO - PROCESS | 1664 | 06:47:59 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:65.50 stddev:5.97 (9.1%) stddev-sans-first:6.26 06:47:59 INFO - PROCESS | 1664 | Values: 65.0 65.0 69.0 64.0 84.0 65.0 65.0 67.0 65.0 66.0 06:47:59 INFO - PROCESS | 1664 | -------- Summary: end -------- 06:47:59 INFO - PROCESS | 1664 | 06:48:00 INFO - TEST-INFO | 1664: exit 0 06:48:00 INFO - TEST-OK | kraken | took 59613ms 06:48:00 INFO - SUITE-END | took 1176s 06:48:00 INFO - Completed test suite (00:19:36) 06:48:00 INFO - javascript benchmark 06:48:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.5976823592346, 3264.8694052237906, 3354.7483938704604, 3387.847546860391, 3413.7439692023104, 5621.213030175779, 5674.744636491358, 5693.686847223406, 5734.541236701064, 5794.39158888317, 5693.174489698991, 5745.023346031175, 5751.281089863767, 5752.424757524245, 5758.942410575893, 5146.794128234885, 5172.586193104561, 5208.817691380802, 5220.843374698765, 5262.894742105155, 5198.870028249286, 5274.4461831507715, 5325.334333208349, 5330.013947419739, 5384.757685904124, 4833.564979151875, 4897.951020489803, 5309.177077552966, 5317.627766056377, 5380.192971054334, 5270.367555893298, 5296.311479507639, 5309.734513274359, 5313.123334649778, 5362.8123015694655, 4998.12532806761, 5041.596672266247, 5188.403333616607, 5224.52979231871, 5246.501582349671, 5669.489745922887, 5765.567582431335, 5768.163616275617, 5822.184894114827, 5849.0, 6299.433051025429, 6299.496040316763, 6301.905471417932, 6315.810525684191, 6344.619322840645, 6207.689615519251, 6269.153664255358, 6281.811545653638, 6340.556161068727, 6343.524235682296, 5785.595008349417, 5785.855353616109, 5820.563457740686, 5837.562182836305, 5842.2405087338375, 6274.121622972787, 6328.462080723098, 6345.17512723343, 6349.2698339690605, 6355.014972679242, 6087.96956015226, 6124.938750612437, 6251.156093927352, 6270.2789179244055, 6278.246610406781, 5242.239875218072, 6198.938010619836, 6253.0, 6262.5929314594405, 6321.0, 6253.749850005949, 6292.528060395489, 6292.779752708725, 6296.5592408530965, 6310.810675679737, 6135.875804921915, 6221.440070393686, 6254.695250272448, 6322.71547780351, 6323.30443651198, 4909.803607855717, 4919.4834542373255, 4955.653104282737, 4956.677815942025, 4970.17992031318, 4496.910061798746, 4507.5943165115295, 4524.457065152137, 4529.411176547093, 4536.387587675622, 5792.507636850914, 5820.243368362086, 5839.941600583939, 5849.912251316148, 5931.822045338647, 6328.240611126602, 6342.682865856688, 6359.554831161867, 6368.64972426521, 6369.076483909807, 5824.242848429677, 5862.589618726648, 5869.882602347929, 5874.206982057453, 5931.6441013539325, 5364.570834333244, 5407.0, 5458.072127738294, 5460.972695136578, 5521.1442226454965, 6375.330590288046, 6375.649339286384, 6381.680915954184, 6398.776042838478, 6401.071844582602, 5678.858028549319, 6347.238331400077, 6363.5545511813725, 6363.936360636334, 6372.203474565679, 5592.133219351007, 6272.18461599989, 6294.71673774672, 6327.810165695037, 6383.808485745435, 6276.623402595859, 6289.276733175743, 6289.779857704958, 6290.24517057956, 6302.117703521419, 5404.567634589302, 5694.572907031907, 6264.091706702594, 6337.493000560036, 6345.3654634538025, 6060.545459090497, 6082.60463069899, 6134.202553667995, 6135.141080248858, 6158.291796443466, 6167.0, 6182.258129024546, 6196.287426945959, 6197.597156184834, 6200.627962322275, 6017.729202185825, 6033.888555546231, 6043.519337762101, 6101.38986101404, 6102.603330783485, 6053.75784968614, 6091.7563297467605, 6124.326324104256, 6152.692365381802, 6169.105479705508, 6092.634441933498, 6101.328853826164, 6101.60339577926, 6105.419985101408, 6136.23297087864], "value": 5733.753240136333, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.6331987689356, 504.9925398829336, 505.8710028942619, 513.6994858008065, 530.3979982719613, 23998.640020399685, 30680.77276908924, 31353.372932541362, 38159.427608585895, 42797.0, 44356.778216108956, 44505.77747111268, 44699.77650111753, 44730.0, 44753.104937901226, 9742.074502922229, 9888.307818452675, 9890.15933645641, 9893.25800564957, 9911.553980070914, 8765.95617021914, 8947.64209431622, 9680.75798105046, 11952.701182470464, 12151.27092374456, 12060.457279422448, 12131.878681213164, 12133.211341262833, 12134.817977730341, 12140.0, 8799.164079412445, 12069.698257543543, 12100.576479823252, 12123.454444550016, 12156.0, 11671.0, 11984.101192410604, 12003.459844306939, 12227.938860305641, 12235.388230588434, 40816.387754183714, 41208.587914121075, 41277.380839287136, 41281.72950487722, 41397.37903931444, 3583.140046388874, 3718.721095917817, 3756.267527832074, 3923.7606615793816, 3943.684505239574, 31405.84297078523, 32145.51781723276, 32838.83580582106, 32853.342933141204, 32994.0, 3087.9073627791204, 3211.951820722691, 3346.849391777376, 3399.9150021249666, 3419.059758566389, 363760.0, 365222.0, 366078.0, 366587.0, 366984.0, 63615.6819215901, 64112.0, 64494.0, 64499.0, 64513.0, 61482.0, 61848.07227891585, 61929.0, 61980.0, 62035.379646203866, 16127.435539756052, 16944.322227110777, 16987.830121698626, 17385.391511297297, 17390.47828565145, 11848.94075529634, 12062.155649104478, 12947.611571652677, 12964.22214667123, 13066.0200484964, 19566.804331956497, 19608.50978725515, 20342.389728308175, 20342.491437714176, 20347.389578312675, 6860.965695171492, 8025.678972841021, 8105.2705256526015, 8108.2297181767635, 8209.466384684976, 962.259060523393, 1036.616451912782, 1078.3637653784306, 1090.3457925244948, 1091.0943916549245, 24395.462657914504, 30743.69256307453, 30876.53685194724, 31532.684673153435, 31536.684633153374, 1078.428432930548, 1119.7088756923097, 1121.6915348279126, 1126.0709914320719, 1131.4682099413262, 16820.74768878468, 16926.153692315336, 16969.83030169707, 17277.963322200707, 17304.65390692179, 732513.0, 736308.0, 736999.0, 737079.0, 737695.0, 60639.0, 62813.37186628167, 62847.0, 62870.37129628737, 63017.68491157515, 1429.4996751137228, 1434.2040167707023, 1464.3630020940925, 1466.3767898643034, 1466.7213229486363, 29680.851595741882, 30898.845505772326, 31070.53394199134, 31190.532142017433, 31903.521447177845, 52606.73696631492, 52651.47348526466, 53470.73264633652, 53520.73239633933, 53562.46437535575, 666956.0, 667698.9690309298, 669599.0, 670272.0, 670772.0, 23165.42086447785, 25580.48839023172, 26134.607980880683, 26210.86894565515, 26396.472070558866, 46830.76584617055, 47170.0, 47230.76384618192, 47890.52109478861, 48066.0, 34682.826585867915, 37356.252874941805, 37932.0, 39227.803860980515, 39983.40024899687, 38809.417858732704, 39043.609563904, 39585.406218907316, 39671.0, 40209.19581608293, 37484.93953316267, 37913.4312985311, 38165.427518586686, 38216.42675359928, 38481.615183848924, 32784.016479505655, 33908.49137262894, 34194.82902585471, 34435.4834677475, 34641.48037779385, 25312.74687253104, 25320.873395632905, 25341.87329063343, 26027.869860650575, 26377.340566485993], "value": 20787.18807427981, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.429064914838, 382.9368154254548, 389.61817418929456, 393.7912906159735, 401.3257727018608, 19313.903430482846, 21352.786472135314, 21667.241646542374, 21683.45791355217, 21684.3494695159, 11762.647120586396, 12007.699807504794, 12284.692882677937, 12288.324142172178, 12355.258684478915, 5360.571154307666, 5480.424555421683, 5547.500724934755, 5551.306086739158, 5554.028045092113, 3908.335582950905, 4143.150654115914, 4900.754962251873, 6851.965740171292, 6863.313668633146, 6829.0, 6844.0, 6867.519273650846, 6869.381755641991, 6871.553349032297, 6646.202455705298, 6718.8992165117315, 6821.69302381394, 6837.863242735142, 6843.486738494633, 3785.6403641653997, 3955.960440395588, 4004.5394779600138, 5550.972245138749, 5961.880762384728, 13040.934795326057, 13560.389782459813, 13657.112287701368, 16057.598560035976, 26108.0, 2221.7000704904794, 2248.7076680031655, 2370.111208296889, 2385.3559538924565, 2447.0701133569128, 9959.302848800588, 9993.950030249875, 10038.648647297383, 10179.134773544258, 10312.948435257851, 1724.4567961092216, 1788.534980904961, 1819.8453131483839, 1849.6300739852084, 1878.2674756844706, 90274.99999999935, 127675.0, 133869.99195012084, 138276.0, 140722.0, 9021.60165174399, 9317.437704631146, 11571.537138514534, 11623.895729905646, 11753.294802311888, 14597.78103328451, 14654.56036318912, 14674.55976320712, 14678.853211467962, 14714.264286785618, 8515.0, 8678.00202976653, 8686.313809912677, 8773.122687731304, 8797.956010219908, 8716.869246961302, 8779.561021948877, 8793.296536277083, 8902.688405905763, 8905.975812781484, 4456.220161471794, 4526.140033393711, 4531.501534831166, 4606.930896036562, 4607.884802879955, 1724.6205834716343, 1758.441467664545, 1911.130435651775, 1934.5937353155714, 1937.2638397408894, 884.2439714044529, 902.4224496322358, 952.2096659772373, 965.666844938495, 987.6345752071779, 20192.899035504728, 21359.893200533897, 21716.674249886266, 22101.0, 22110.668339974913, 934.0, 939.6664184214505, 955.2883102088988, 956.9043095690514, 993.0, 9433.386829856037, 11467.369294688706, 11674.94162529182, 11689.064874809996, 11690.824637630443, 642768.0, 645536.0, 648785.0, 650658.0, 657720.0, 96218.51890740501, 152231.0, 154781.2260938688, 155627.0, 158550.20724896534, 856.9014563325297, 973.5910917414703, 1005.653049697853, 1005.9547320370601, 1008.294194064158, 19033.0, 19397.51506212356, 19570.80429195747, 19776.703349449483, 19807.801921980597, 50220.74889625528, 50635.0, 56580.71709641426, 58937.70531147317, 59338.40661593501, 87785.56107219424, 87898.0, 88026.06031413496, 88566.55716721374, 90782.54608727178, 7667.271609197117, 7882.408819338458, 7938.64276107565, 7979.84040319202, 8131.146229646039, 9083.545822708971, 12598.370081496072, 12764.375167326305, 12778.552750653682, 13395.933020334836, 9506.809863802824, 10583.0, 11018.50416731233, 11193.27243729155, 11197.60808371703, 10269.53787079598, 10727.517261723397, 10901.291416057931, 11022.614208502664, 11146.442677866236, 5700.059490184073, 7774.339181169664, 9871.802563948537, 10719.464026798785, 11465.254758441008, 6929.757458488929, 7420.332170104716, 7511.248875112445, 7540.585267810323, 7598.734044308423, 11149.331040137293, 11647.708807279885, 11657.300561966309, 11658.475368608264, 11665.35840528745], "value": 9354.689067987027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.6595217147885, 1560.3758496601358, 1784.1525275494134, 1923.230707716914, 1964.4401345616493, 8589.957050214747, 8856.202941735242, 9023.909760902388, 9027.774305642353, 9040.638374465014, 6595.439387652055, 7775.922240777591, 7791.0, 8757.343199260049, 8835.95582022089, 2355.9764402356013, 2381.3213234228247, 2382.2376839411395, 2384.3204686664303, 2385.6063749481314, 2367.360812580611, 2381.7022872140983, 2402.0, 2404.879756012201, 2406.95186096278, 2108.0724481228285, 2179.4442417183595, 2180.890955452229, 2186.4533866533366, 2189.737231532218, 2309.2956648222284, 2381.142788596104, 2385.9284221473386, 2386.0575072846127, 2386.773256540626, 2370.7629237076153, 2381.118985975183, 2387.85672859629, 2401.0995876546294, 2401.78383945444, 9035.909640903637, 9073.45559266446, 9082.77293067672, 9085.273178145733, 9113.134252246093, 5230.529252367267, 5325.4940780625775, 5386.2997810284805, 5387.81142660005, 5388.703621300827, 3209.6629853865243, 3575.66031227033, 3687.3731465650635, 3692.8522859085606, 3700.4264339027495, 1043.7651528406047, 1077.0414331245197, 1081.734974931139, 1805.3951926104771, 1872.3446793622259, 11729.53081876724, 11803.763924721543, 11821.94089029558, 11827.112966527458, 11852.111091668074, 4413.8234470621455, 4428.446444194476, 4602.792874320664, 4625.398698169217, 4627.838025669085, 9201.769955751026, 9206.355555111079, 9207.26341892647, 9208.907910920805, 9210.677626283048, 5270.472952704698, 5271.1302635064785, 5278.97360513195, 5281.234221038005, 5283.920741188886, 4061.756294622332, 4926.876828079255, 4937.136001199776, 4941.728204948762, 4942.35749352589, 3091.412631599989, 3627.238279961185, 3699.963000370016, 3740.756850804689, 3794.8482060717815, 964.3249725192394, 1134.13805507813, 1139.9943000284945, 1141.4121727310442, 1155.4338374196584, 836.3560058754725, 848.9575521223915, 898.6854600889767, 942.2744486745167, 977.6382738386842, 5846.356900740915, 6079.05774604937, 6090.939090609126, 6134.4172303631085, 6225.315215326311, 422.628087283195, 423.9788010599458, 432.18964441671864, 433.56643356643355, 433.64874451694226, 3636.4908912752235, 3681.0981309579324, 3683.5027271318563, 3705.9073523161596, 3718.2749363874327, 8886.644534218689, 10600.310979786289, 10857.2942758722, 11019.118470522339, 11036.889631103746, 10954.726131846768, 10973.0, 10985.01134897863, 10995.0, 10999.23005389615, 8001.839963200703, 8423.747287581382, 8437.789055273668, 8466.365022623328, 8477.279431248413, 5880.26496687914, 5994.250718660168, 6004.8498787528915, 6065.54508411862, 6117.327094019565, 9917.45454000037, 10280.845787313347, 10284.023017813295, 10287.691369258935, 10287.794244114926, 8287.295579875778, 8560.486370817522, 8718.258947989492, 10477.63328283537, 10518.211134164816, 6981.406580440516, 6985.79042628722, 7057.012018317337, 7078.716851325889, 7102.112235970504, 8366.24703776663, 8371.288440482627, 8397.95801020991, 8420.62107205165, 8432.156784321518, 7605.353544948742, 7642.465027448247, 7666.310032097138, 7728.072631284057, 7776.766696999099, 7508.361789247975, 7509.812254693677, 7564.357029652321, 7657.042869641295, 7671.347935425328, 6847.6576171190245, 7126.251743566851, 7153.3919616833155, 7175.282471752992, 7223.8555228896175, 5023.8492845214705, 5030.748462576783, 5058.7976480941825, 5058.873528161826, 5156.5616922562, 5056.494350564914, 5138.845834624967, 5176.1200595898035, 5199.532042116077, 5279.920801187908], "value": 4492.381362535335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.90808762889174, 282.1704189682334, 288.86423381010945, 305.9388122375525, 313.7584060273589, 4507.467461063238, 5246.842594722155, 5339.424869663449, 5453.481919217673, 5531.944680553193, 4260.488741351034, 4512.646206138162, 5484.7531861066245, 5518.448155184479, 5538.6399884007515, 3400.64293249209, 4096.160287141144, 4139.834406623731, 4158.293090174678, 4166.437530933315, 3543.94684079739, 3906.199229158016, 4039.919201615966, 4075.714699971003, 4076.9796151019204, 3947.960520394802, 4124.845043387856, 4125.463689720332, 4125.876223713279, 4127.030147915238, 3374.358871814372, 4112.917741645166, 4128.60778226068, 4132.607402296777, 4160.83356665733, 2984.552317152423, 3598.892033239007, 3620.855165793365, 3624.855005799765, 3632.418812989909, 4440.711353761995, 4539.773011349419, 4772.379590653228, 4899.387576552931, 5119.616028797818, 4700.1539722849875, 4734.55021772931, 4759.4764575896625, 4761.904761904742, 4763.618910487153, 4692.601128904047, 4942.0, 5165.63840531163, 5545.972270138664, 5740.7703691852275, 3593.94609080864, 3746.83139258734, 3776.9244615107546, 3780.319542482352, 3781.962180378216, 5753.231633280208, 5760.366359700472, 5827.388124246935, 5830.650160990354, 5851.356350801409, 3714.9628503715157, 3842.4620553122586, 3860.189360234326, 3884.2132618995015, 3900.531936167678, 3690.2988432198335, 3797.8290976906105, 3839.347310957144, 4037.0109323216, 4038.757674539537, 3913.373860182357, 4560.153137979124, 4671.789769460383, 4672.2057250267535, 4686.882827929329, 4775.976120119447, 5767.64460351817, 5777.94222057774, 5806.477417032487, 5823.0, 1323.9470421183046, 1347.4946894914408, 1374.3609221711952, 1374.8863420629123, 1376.1742954227584, 825.8018075661918, 840.5461051032374, 842.4061036969044, 844.5566077809076, 849.4605925237395, 3949.9012524686536, 4328.718633288826, 4576.832907608538, 4598.82729903879, 4669.696469729457, 4314.697971142053, 4506.662000349987, 4894.681845680019, 5025.597952163818, 5098.685854194729, 4100.65144462718, 4285.871423857289, 4359.237133501624, 4578.587927086578, 4648.48866624671, 2146.173723116611, 2310.9075636974667, 2587.8576678282498, 2632.5129850977246, 2644.801639877017, 4442.244818380883, 5144.331236939174, 5165.638405311592, 5166.870828229249, 5180.81867134656, 3949.8420063197723, 4363.781810909441, 4392.298736277166, 4479.350494178391, 5073.847784566469, 4373.497047839475, 4775.594074503567, 5172.017546489183, 5197.558207552401, 5211.687298762086, 4383.517813040627, 4600.688803690932, 4756.310335001336, 4876.634542328012, 4921.827736029221, 4039.929418703987, 4514.616257618008, 4573.748443835621, 4788.688735232199, 4795.20879054952, 4402.911941761211, 5081.8475445736685, 5102.545774454263, 5115.718635474936, 5160.064975634137, 3062.17321323237, 3453.9654603453646, 3463.8787642433404, 3480.460528618068, 3484.581850177995, 4909.219900676388, 5228.928069745769, 5637.915431268452, 5790.623609465371, 5866.472017518444, 5210.6613070150315, 5673.489385955284, 5701.486866182064, 5734.569907256889, 5736.713164341682, 4657.206975314461, 5277.498637629419, 5670.688112153871, 5697.344805347272, 5744.563859035241, 5459.0, 5590.832275031756, 5596.272484577142, 5600.299962504687, 5624.156376543551, 4796.712197268175, 4860.975695121501, 5095.522298533384, 5321.7227865312825, 5738.368779434176, 5277.102892508206, 5628.099504079328, 5636.463591383812, 5645.661260324394, 5661.25429166862], "value": 3895.499485585997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6509540515957, 744.0550500863903, 806.8910697055895, 838.513662075996, 875.2910142784345, 15104.546863594082, 15903.363865445383, 15903.761443578327, 15924.044557326553, 15948.521544353687, 14692.926535367309, 14738.410463581444, 14790.556283311491, 14811.703765924674, 14841.925790371033, 712.8752468318063, 736.7531876821245, 885.3536918049796, 913.1507697841005, 922.2667978956746, 879.8680197970292, 894.8836651235363, 896.7444278380631, 897.5601955042048, 898.5641963647626, 942.8397172480695, 942.8444306689388, 943.1605870775015, 944.0653752784729, 946.9857952130689, 751.1774606805567, 931.5388882503204, 939.9906000940006, 963.9180669643089, 967.8983706710765, 712.9322714342129, 714.032485981498, 714.3606472207397, 715.0168518287355, 715.4240836126916, 14938.551843444715, 14973.251337433085, 14980.550583482513, 14985.400583976629, 14997.625059373493, 14233.28833558318, 14395.136291822419, 14449.422023119063, 14459.566213013626, 14478.058926169766, 12954.157979731288, 13212.933935330359, 13269.734605307936, 13530.864691353157, 13531.661708457268, 4070.29702970297, 4564.630610816742, 4713.552212539803, 4843.2250839865455, 4856.708597484162, 103716.44425333626, 104120.99999999924, 104383.0, 104685.0, 104961.0, 11173.162012849069, 11318.660440186808, 11321.433928303552, 11333.716657083638, 11351.148663850245, 22305.776942230696, 22398.55202895933, 22407.663885041737, 22421.55156896853, 22864.199753008565, 7874.606269686493, 7948.642311096015, 7955.443118981616, 8042.839143217103, 8054.5569993650915, 4320.0, 4361.0, 4433.667474939392, 4443.422355093881, 4458.086092351125, 3076.292452735883, 3436.862525499002, 3565.8395372208315, 3583.050491619723, 3601.5858176309534, 665.896785998171, 669.3039239191284, 675.9864802704017, 676.6853413162903, 678.372505432473, 552.3068548971015, 599.2150283129027, 638.2500561839912, 645.7955912223763, 653.4282502810041, 8588.484690918565, 9036.728898133066, 9037.548122593844, 9104.681336153335, 9212.216961558208, 489.82836136018994, 633.7971849008273, 634.3339493531773, 645.3610925184034, 647.5920170292685, 4290.506591741927, 4392.538783427758, 4408.404865343137, 4461.843835465808, 4498.910021799546, 106674.0, 119835.0, 154418.0, 154518.0, 157526.0, 90285.54857225803, 108259.7522074339, 118754.0, 119802.40098799624, 121642.0, 63084.36915630877, 72388.63805680937, 98186.0181398177, 100690.0, 101157.0, 9517.23862091045, 9714.591384249386, 9771.218302535637, 9867.40795552269, 10025.398476091166, 46657.0, 60674.48313792014, 63303.683481582295, 65233.0, 67831.98252026322, 65148.0, 69740.65129674319, 70052.64973675099, 71344.5731085365, 75449.6227518859, 13440.865591344353, 13536.661583460493, 13555.796663049865, 13578.185308881499, 14131.434742610181, 15095.245237738289, 15142.848571514143, 15307.234638267819, 15376.923115384352, 16042.117683527518, 14283.928580357031, 14335.56993290203, 14449.927750361181, 14485.92757036208, 14787.630309242355, 14057.0, 14373.353199105855, 14461.13233206011, 14849.183294918883, 14877.107373557621, 13824.930875345559, 13853.445862165401, 13867.72264554683, 13910.791338130139, 14004.649883752987, 9737.561809718722, 11302.604408845651, 11521.88478115208, 11533.135014874086, 11930.821037684269, 11216.943915280372, 11627.59303424376, 11817.172797904064, 11849.170558060852, 11879.643610691694], "value": 7853.723398144564, "unit": "score"}], "name": "dromaeo_css", "value": 7315.4036643846775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 116.0, 113.0, 112.0, 114.0, 111.0, 113.0, 114.0, 114.0, 161.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 106.0, 157.0, 111.0, 120.0, 153.0, 136.0, 158.0, 107.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 183.0, 186.0, 183.0, 183.0, 182.0, 179.0, 179.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 49.0, 109.0, 73.0, 48.0, 62.0, 79.0, 109.0, 80.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 93.0, 92.0, 70.0, 69.0, 68.0, 96.0, 70.0, 68.0, 101.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 115.0, 136.0, 130.0, 89.0, 86.0, 88.0, 86.0, 88.0, 85.0], "value": 99.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 106.0, 149.0, 121.0, 91.0, 94.0, 93.0, 93.0, 93.0], "value": 102.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 102.0, 133.0, 117.0, 83.0, 117.0, 141.0, 86.0, 84.0, 83.0], "value": 103.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 55.0, 53.0, 55.0, 54.0, 55.0, 53.0, 56.0, 56.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 86.0, 110.0, 107.0, 80.0, 69.0, 70.0, 69.0, 69.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 82.0, 82.0, 82.0, 80.0, 83.0, 82.0, 83.0, 84.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 135.0, 140.0, 156.0, 149.0, 139.0, 137.0, 246.0, 144.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 176.0, 164.0, 161.0, 161.0, 225.0, 217.0, 164.0, 162.0, 161.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 64.0, 84.0, 65.0, 65.0, 67.0, 65.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1504.3000000000002, "alertThreshold": 2.0}]} 06:48:00 INFO - Return code: 0 06:48:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:48:00 INFO - # TBPL SUCCESS # 06:48:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:48:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:48:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:48:00 INFO - 2016-07-04 06:48:00.660 screenresolution[1668:9719] starting screenresolution argv=screenresolution get 06:48:00 INFO - 2016-07-04 06:48:00.663 screenresolution[1668:9719] Display 0: 1600x1200x32@60 06:48:00 INFO - 2016-07-04 06:48:00.668 screenresolution[1669:9723] starting screenresolution argv=screenresolution list 06:48:00 INFO - Available Modes on Display 0 06:48:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:48:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:48:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:48:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:48:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:48:00 INFO - Intel Iris: 06:48:00 INFO - Chipset Model: Intel Iris 06:48:00 INFO - Type: GPU 06:48:00 INFO - Bus: Built-In 06:48:00 INFO - VRAM (Dynamic, Max): 1536 MB 06:48:00 INFO - Vendor: Intel (0x8086) 06:48:00 INFO - Device ID: 0x0a2e 06:48:00 INFO - Revision ID: 0x0009 06:48:00 INFO - Displays: 06:48:00 INFO - Display: 06:48:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:48:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:48:00 INFO - Display Serial Number: 1600x1200 60 06:48:00 INFO - Main Display: Yes 06:48:00 INFO - Mirror: Off 06:48:00 INFO - Online: Yes 06:48:00 INFO - Rotation: Supported 06:48:00 INFO - Return code: 0 06:48:00 INFO - Running post-action listener: _resource_record_post_action 06:48:00 INFO - ##### 06:48:00 INFO - ##### Finished run-tests step (success) 06:48:00 INFO - ##### 06:48:00 INFO - Running post-run listener: _resource_record_post_run 06:48:00 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 36681216; Write bytes: 704248320; Read time: 235; Write time: 1979 06:48:00 INFO - TinderboxPrint: CPU usage
53.4% 06:48:00 INFO - TinderboxPrint: I/O read bytes / time
36,681,216 / 235 06:48:00 INFO - TinderboxPrint: I/O write bytes / time
704,248,320 / 1,979 06:48:00 INFO - TinderboxPrint: CPU idle
2,257.8 (46.6%) 06:48:00 INFO - TinderboxPrint: CPU system
964.0 (19.9%) 06:48:00 INFO - TinderboxPrint: CPU user
1,628.0 (33.6%) 06:48:00 INFO - TinderboxPrint: Swap in / out
443,924,480 / 0 06:48:00 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392274432; Write bytes: 386135552; Read time: 29176; Write time: 821 06:48:00 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 35726848; Write bytes: 294896640; Read time: 223; Write time: 1097 06:48:01 INFO - Running post-run listener: _upload_blobber_files 06:48:01 INFO - Blob upload gear active. 06:48:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:48:01 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:48:01 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:48:01 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:02 INFO - (blobuploader) - INFO - Done attempting. 06:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:03 INFO - (blobuploader) - INFO - Done attempting. 06:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:48:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:06 INFO - (blobuploader) - INFO - Done attempting. 06:48:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:06 INFO - Return code: 0 06:48:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35120cad6e81eb5fdfabad928c7d6fdaf139db25405a7f066cd45555fa1bea660421f045ceac7a383c1c3b735b4f01a94344cf03d37639274598a4c4ad1434b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7f1da4986f00ec68963ba44b10a6615709edb5021278b47525144e5edbbe84c3bf285feef328e2361e7dea7118c4a97c325aa20c2c557e8c476a91801a2c3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3279f08c26744604da64da1b55b83b097e4cde623406e3ede9f7e251c3ba2745ff753d6c9f21342092c5e35eefca3e776fc544d2a096de647a3f8993b6570da"} 06:48:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:06 INFO - Contents: 06:48:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35120cad6e81eb5fdfabad928c7d6fdaf139db25405a7f066cd45555fa1bea660421f045ceac7a383c1c3b735b4f01a94344cf03d37639274598a4c4ad1434b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7f1da4986f00ec68963ba44b10a6615709edb5021278b47525144e5edbbe84c3bf285feef328e2361e7dea7118c4a97c325aa20c2c557e8c476a91801a2c3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3279f08c26744604da64da1b55b83b097e4cde623406e3ede9f7e251c3ba2745ff753d6c9f21342092c5e35eefca3e776fc544d2a096de647a3f8993b6570da"} 06:48:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:06 INFO - Copying logs to upload dir... 06:48:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.569775 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-04 06:48:06.245628) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 06:48:06.249138) ========= 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.Qra02u9H3j/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.1TN9XHxz1T/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35120cad6e81eb5fdfabad928c7d6fdaf139db25405a7f066cd45555fa1bea660421f045ceac7a383c1c3b735b4f01a94344cf03d37639274598a4c4ad1434b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7f1da4986f00ec68963ba44b10a6615709edb5021278b47525144e5edbbe84c3bf285feef328e2361e7dea7118c4a97c325aa20c2c557e8c476a91801a2c3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3279f08c26744604da64da1b55b83b097e4cde623406e3ede9f7e251c3ba2745ff753d6c9f21342092c5e35eefca3e776fc544d2a096de647a3f8993b6570da"} build_url:https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/bFLXEPeNS3mKEjTGFQBFvg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35120cad6e81eb5fdfabad928c7d6fdaf139db25405a7f066cd45555fa1bea660421f045ceac7a383c1c3b735b4f01a94344cf03d37639274598a4c4ad1434b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7f1da4986f00ec68963ba44b10a6615709edb5021278b47525144e5edbbe84c3bf285feef328e2361e7dea7118c4a97c325aa20c2c557e8c476a91801a2c3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3279f08c26744604da64da1b55b83b097e4cde623406e3ede9f7e251c3ba2745ff753d6c9f21342092c5e35eefca3e776fc544d2a096de647a3f8993b6570da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 06:48:06.282170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:48:06.282487) ========= 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.Qra02u9H3j/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.1TN9XHxz1T/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.005077 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 06:48:06.331624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 06:48:06.331944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 06:48:06.332271) ========= ========= Total master_lag: 1.01 =========