builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0359 starttime: 1475023126.56 results: success (0) buildid: 20160927152620 builduid: 61ec22459a03480abd99a4c3a3a4ca9b revision: 3db11822d83f7a97cb882ec8338578f50b51a994 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:46.560189) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:46.560573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-09-27 17:38:46.560853) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-09-27 17:38:48.990147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-27 17:38:48.990454) ========= 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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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-09-27 17:38:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.00M=0.001s 2016-09-27 17:38:49 (8.00 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084904 ========= master_lag: 2.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-27 17:38:51.397654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:51.398081) ========= 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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.021481 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:51.440738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 17:38:51.441209) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3db11822d83f7a97cb882ec8338578f50b51a994 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3db11822d83f7a97cb882ec8338578f50b51a994 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5T1w5ymPnh/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.9RHWG40Qnc/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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-09-27 17:38:51,524 truncating revision to first 12 chars 2016-09-27 17:38:51,525 Setting DEBUG logging. 2016-09-27 17:38:51,525 attempt 1/10 2016-09-27 17:38:51,525 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3db11822d83f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 17:38:52,738 unpacking tar archive at: mozilla-aurora-3db11822d83f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.503825 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 17:38:52.966920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:52.967237) ========= script_repo_revision: 3db11822d83f7a97cb882ec8338578f50b51a994 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:52.967617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:52.967898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 17:38:52.985543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-27 17:38:52.985846) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5T1w5ymPnh/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.9RHWG40Qnc/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:38:53 INFO - MultiFileLogger online at 20160927 17:38:53 in /builds/slave/test 17:38:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:38:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:38:53 INFO - {'append_to_log': False, 17:38:53 INFO - 'base_work_dir': '/builds/slave/test', 17:38:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:38:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:38:53 INFO - 'branch': 'Mozilla-Aurora', 17:38:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:38:53 INFO - 'config_files': ('talos/mac_config.py',), 17:38:53 INFO - 'default_actions': ('clobber', 17:38:53 INFO - 'read-buildbot-config', 17:38:53 INFO - 'download-and-extract', 17:38:53 INFO - 'populate-webroot', 17:38:53 INFO - 'create-virtualenv', 17:38:53 INFO - 'install', 17:38:53 INFO - 'run-tests'), 17:38:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:38:53 INFO - 'download_minidump_stackwalk': True, 17:38:53 INFO - 'download_symbols': 'ondemand', 17:38:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:38:53 INFO - 'tooltool.py': '/tools/tooltool.py', 17:38:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:38:53 INFO - '/tools/misc-python/virtualenv.py')}, 17:38:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:38:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:38:53 INFO - 'installer_path': 'installer.exe', 17:38:53 INFO - 'log_level': 'info', 17:38:53 INFO - 'log_name': 'talos', 17:38:53 INFO - 'log_to_console': True, 17:38:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:38:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:38:53 INFO - 'opt_config_files': (), 17:38:53 INFO - 'pip_index': False, 17:38:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:38:53 INFO - 'cmd': ('bash', 17:38:53 INFO - '-c', 17:38:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:38:53 INFO - 'enabled': True, 17:38:53 INFO - 'halt_on_failure': False, 17:38:53 INFO - 'name': 'check_screen_resolution'},), 17:38:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:38:53 INFO - 'cmd': ('bash', 17:38:53 INFO - '-c', 17:38:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:38:53 INFO - 'enabled': True, 17:38:53 INFO - 'halt_on_failure': False, 17:38:53 INFO - 'name': 'check_screen_resolution'},), 17:38:53 INFO - 'run_cmd_checks_enabled': True, 17:38:53 INFO - 'sps_profile': False, 17:38:53 INFO - 'sps_profile_interval': 0, 17:38:53 INFO - 'suite': 'dromaeojs', 17:38:53 INFO - 'system_bits': '32', 17:38:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:38:53 INFO - 'title': 't-yosemite-r7-0359', 17:38:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:38:53 INFO - 'use_talos_json': True, 17:38:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:38:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:38:53 INFO - 'work_dir': 'build'} 17:38:53 INFO - [mozharness: 2016-09-28 00:38:53.182377Z] Running clobber step. 17:38:53 INFO - Running pre-action listener: _resource_record_pre_action 17:38:53 INFO - Running main action method: clobber 17:38:53 INFO - rmtree: /builds/slave/test/build 17:38:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:38:54 INFO - Running post-action listener: _resource_record_post_action 17:38:54 INFO - [mozharness: 2016-09-28 00:38:54.962868Z] Finished clobber step (success) 17:38:54 INFO - [mozharness: 2016-09-28 00:38:54.962991Z] Running read-buildbot-config step. 17:38:54 INFO - Running pre-action listener: _resource_record_pre_action 17:38:54 INFO - Running main action method: read_buildbot_config 17:38:54 INFO - Using buildbot properties: 17:38:54 INFO - { 17:38:54 INFO - "project": "", 17:38:54 INFO - "product": "firefox", 17:38:54 INFO - "script_repo_revision": "production", 17:38:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 17:38:54 INFO - "repository": "", 17:38:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 17:38:54 INFO - "buildid": "20160927152620", 17:38:54 INFO - "pgo_build": "False", 17:38:54 INFO - "basedir": "/builds/slave/test", 17:38:54 INFO - "buildnumber": 19, 17:38:54 INFO - "slavename": "t-yosemite-r7-0359", 17:38:54 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:38:54 INFO - "platform": "yosemite_r7", 17:38:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:38:54 INFO - "branch": "mozilla-aurora", 17:38:54 INFO - "repo_path": "releases/mozilla-aurora", 17:38:54 INFO - "revision": "3db11822d83f7a97cb882ec8338578f50b51a994", 17:38:54 INFO - "stage_platform": "macosx64", 17:38:54 INFO - "builduid": "61ec22459a03480abd99a4c3a3a4ca9b", 17:38:54 INFO - "slavebuilddir": "test" 17:38:54 INFO - } 17:38:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 17:38:54 INFO - Running post-action listener: _resource_record_post_action 17:38:54 INFO - [mozharness: 2016-09-28 00:38:54.966362Z] Finished read-buildbot-config step (success) 17:38:54 INFO - [mozharness: 2016-09-28 00:38:54.966475Z] Running download-and-extract step. 17:38:54 INFO - Running pre-action listener: _resource_record_pre_action 17:38:54 INFO - Running main action method: download_and_extract 17:38:54 INFO - mkdir: /builds/slave/test/build/tests 17:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:54 INFO - trying https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 17:38:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 17:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 17:38:55 INFO - Downloaded 1199 bytes. 17:38:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 17:38:55 INFO - Using the following test package requirements: 17:38:55 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 17:38:55 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 17:38:55 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 17:38:55 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'jsshell-mac.zip'], 17:38:55 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 17:38:55 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 17:38:55 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 17:38:55 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 17:38:55 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 17:38:55 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 17:38:55 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 17:38:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:38:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 17:38:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:38:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 17:38:56 INFO - Expected file size: 16431984 17:39:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:39:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 17:39:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:39:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 17:39:04 INFO - Expected file size: 16431984 17:39:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 17:39:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:39:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 17:39:11 INFO - Expected file size: 14414059 17:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:12 INFO - trying https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 17:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 17:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 17:39:15 INFO - Downloaded 115266632 bytes. 17:39:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 17:39:15 INFO - mkdir: /builds/slave/test/properties 17:39:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:39:15 INFO - Writing to file /builds/slave/test/properties/build_url 17:39:15 INFO - Contents: 17:39:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 17:39:15 INFO - Running post-action listener: _resource_record_post_action 17:39:15 INFO - Running post-action listener: set_extra_try_arguments 17:39:15 INFO - [mozharness: 2016-09-28 00:39:15.873132Z] Finished download-and-extract step (success) 17:39:15 INFO - [mozharness: 2016-09-28 00:39:15.873259Z] Running populate-webroot step. 17:39:15 INFO - Running pre-action listener: _resource_record_pre_action 17:39:15 INFO - Running main action method: populate_webroot 17:39:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:39:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:39:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:39:15 INFO - '--tppagecycles', 17:39:15 INFO - '7'], 17:39:15 INFO - 'tests': ['tsvgm']}}, 17:39:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:39:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:39:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:39:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:39:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['damp', 'tps']}, 17:39:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'tests': ['damp', 'tps']}, 17:39:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['dromaeo_dom']}, 17:39:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:39:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['basic_compositor_video']}, 17:39:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:39:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['a11yr', 17:39:15 INFO - 'ts_paint', 17:39:15 INFO - 'tpaint', 17:39:15 INFO - 'sessionrestore', 17:39:15 INFO - 'sessionrestore_no_auto_restore', 17:39:15 INFO - 'tabpaint']}, 17:39:15 INFO - 'other-e10s': {'tests': ['a11yr', 17:39:15 INFO - 'ts_paint', 17:39:15 INFO - 'tpaint', 17:39:15 INFO - 'sessionrestore', 17:39:15 INFO - 'sessionrestore_no_auto_restore', 17:39:15 INFO - 'tabpaint']}, 17:39:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:39:15 INFO - 'ts_paint', 17:39:15 INFO - 'tpaint', 17:39:15 INFO - 'sessionrestore', 17:39:15 INFO - 'sessionrestore_no_auto_restore', 17:39:15 INFO - 'tabpaint']}, 17:39:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:39:15 INFO - 'ts_paint', 17:39:15 INFO - 'tpaint', 17:39:15 INFO - 'sessionrestore', 17:39:15 INFO - 'sessionrestore_no_auto_restore', 17:39:15 INFO - 'tabpaint']}, 17:39:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['a11yr', 17:39:15 INFO - 'ts_paint', 17:39:15 INFO - 'tpaint', 17:39:15 INFO - 'sessionrestore', 17:39:15 INFO - 'sessionrestore_no_auto_restore', 17:39:15 INFO - 'tabpaint']}, 17:39:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['a11yr', 17:39:15 INFO - 'ts_paint', 17:39:15 INFO - 'tpaint', 17:39:15 INFO - 'sessionrestore', 17:39:15 INFO - 'sessionrestore_no_auto_restore', 17:39:15 INFO - 'tabpaint']}, 17:39:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['tsvgx', 17:39:15 INFO - 'tsvgr_opacity', 17:39:15 INFO - 'tart', 17:39:15 INFO - 'tscrollx', 17:39:15 INFO - 'cart']}, 17:39:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:39:15 INFO - 'tsvgr_opacity', 17:39:15 INFO - 'tart', 17:39:15 INFO - 'tscrollx', 17:39:15 INFO - 'cart']}, 17:39:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'talos_options': ['--disable-e10s'], 17:39:15 INFO - 'tests': ['tp5o']}, 17:39:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'tests': ['tp5o']}, 17:39:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'talos_options': ['--disable-e10s', 17:39:15 INFO - '--xperf_path', 17:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:15 INFO - 'tests': ['tp5n']}, 17:39:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:15 INFO - 'talos_options': ['--xperf_path', 17:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:15 INFO - 'tests': ['tp5n']}}, 17:39:15 INFO - 'talos.zip': {'path': '', 17:39:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:39:15 INFO - Running post-action listener: _resource_record_post_action 17:39:15 INFO - [mozharness: 2016-09-28 00:39:15.891895Z] Finished populate-webroot step (success) 17:39:15 INFO - [mozharness: 2016-09-28 00:39:15.892028Z] Running create-virtualenv step. 17:39:15 INFO - Running pre-action listener: _resource_record_pre_action 17:39:15 INFO - Running main action method: create_virtualenv 17:39:15 INFO - Creating virtualenv /builds/slave/test/build/venv 17:39:15 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 17:39:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:39:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:39:16 INFO - Using real prefix '/tools/python27' 17:39:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:39:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:39:19 INFO - Installing pip.................done. 17:39:19 INFO - Return code: 0 17:39:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:19 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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:19 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 17:39:19 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 17:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:19 INFO - 'HOME': '/Users/cltbld', 17:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:19 INFO - 'LOGNAME': 'cltbld', 17:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:19 INFO - 'MOZ_NO_REMOTE': '1', 17:39:19 INFO - 'NO_EM_RESTART': '1', 17:39:19 INFO - 'PAGER': '/bin/cat', 17:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:19 INFO - 'PWD': '/builds/slave/test', 17:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:19 INFO - 'SHELL': '/bin/bash', 17:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:19 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:19 INFO - 'USER': 'cltbld', 17:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:19 INFO - 'XPC_FLAGS': '0x0', 17:39:19 INFO - 'XPC_SERVICE_NAME': '0', 17:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:19 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 17:39:19 INFO - Cleaning up... 17:39:19 INFO - Return code: 0 17:39:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:19 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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:19 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 17:39:19 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 17:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:19 INFO - 'HOME': '/Users/cltbld', 17:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:19 INFO - 'LOGNAME': 'cltbld', 17:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:19 INFO - 'MOZ_NO_REMOTE': '1', 17:39:19 INFO - 'NO_EM_RESTART': '1', 17:39:19 INFO - 'PAGER': '/bin/cat', 17:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:19 INFO - 'PWD': '/builds/slave/test', 17:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:19 INFO - 'SHELL': '/bin/bash', 17:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:19 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:19 INFO - 'USER': 'cltbld', 17:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:19 INFO - 'XPC_FLAGS': '0x0', 17:39:19 INFO - 'XPC_SERVICE_NAME': '0', 17:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:20 INFO - Downloading/unpacking psutil>=3.1.1 17:39:20 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 17:39:20 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 17:39:20 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 17:39:20 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 17:39:20 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 17:39:20 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 17:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:39:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:23 INFO - Installing collected packages: psutil 17:39:23 INFO - Running setup.py install for psutil 17:39:23 INFO - building 'psutil._psutil_osx' extension 17:39:23 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 17:39:23 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 17:39:23 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 17:39:24 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 17:39:24 INFO - building 'psutil._psutil_posix' extension 17:39:24 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 17:39:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:39:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:39:24 INFO - ^ 17:39:24 INFO - 1 warning generated. 17:39:24 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 17:39:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:24 INFO - Successfully installed psutil 17:39:24 INFO - Cleaning up... 17:39:24 INFO - Return code: 0 17:39:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:24 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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:24 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 17:39:24 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 17:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:24 INFO - 'HOME': '/Users/cltbld', 17:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:24 INFO - 'LOGNAME': 'cltbld', 17:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:24 INFO - 'MOZ_NO_REMOTE': '1', 17:39:24 INFO - 'NO_EM_RESTART': '1', 17:39:24 INFO - 'PAGER': '/bin/cat', 17:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:24 INFO - 'PWD': '/builds/slave/test', 17:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:24 INFO - 'SHELL': '/bin/bash', 17:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:24 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:24 INFO - 'USER': 'cltbld', 17:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:24 INFO - 'XPC_FLAGS': '0x0', 17:39:24 INFO - 'XPC_SERVICE_NAME': '0', 17:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:39:24 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 17:39:24 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 17:39:24 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 17:39:24 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 17:39:24 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 17:39:24 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 17:39:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:39:27 INFO - Installing collected packages: mozsystemmonitor 17:39:27 INFO - Running setup.py install for mozsystemmonitor 17:39:27 INFO - Successfully installed mozsystemmonitor 17:39:27 INFO - Cleaning up... 17:39:27 INFO - Return code: 0 17:39:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:27 INFO - 'HOME': '/Users/cltbld', 17:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:27 INFO - 'LOGNAME': 'cltbld', 17:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:27 INFO - 'MOZ_NO_REMOTE': '1', 17:39:27 INFO - 'NO_EM_RESTART': '1', 17:39:27 INFO - 'PAGER': '/bin/cat', 17:39:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:27 INFO - 'PWD': '/builds/slave/test', 17:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:27 INFO - 'SHELL': '/bin/bash', 17:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:27 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:27 INFO - 'USER': 'cltbld', 17:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:27 INFO - 'XPC_FLAGS': '0x0', 17:39:27 INFO - 'XPC_SERVICE_NAME': '0', 17:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:27 INFO - Downloading/unpacking jsonschema==2.5.1 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:39:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:30 INFO - Downloading functools32-3.2.3-2.tar.gz 17:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:39:30 INFO - warning: no files found matching '*.txt' 17:39:30 INFO - no previously-included directories found matching 'build' 17:39:30 INFO - no previously-included directories found matching 'dist' 17:39:30 INFO - no previously-included directories found matching '.git*' 17:39:30 INFO - Installing collected packages: jsonschema, functools32 17:39:30 INFO - Running setup.py install for functools32 17:39:30 INFO - warning: no files found matching '*.txt' 17:39:30 INFO - no previously-included directories found matching 'build' 17:39:30 INFO - no previously-included directories found matching 'dist' 17:39:30 INFO - no previously-included directories found matching '.git*' 17:39:30 INFO - Successfully installed jsonschema functools32 17:39:30 INFO - Cleaning up... 17:39:30 INFO - Return code: 0 17:39:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:30 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:30 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:39:30 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 functools32==3.2.3-2 17:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:30 INFO - 'HOME': '/Users/cltbld', 17:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:30 INFO - 'LOGNAME': 'cltbld', 17:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:30 INFO - 'MOZ_NO_REMOTE': '1', 17:39:30 INFO - 'NO_EM_RESTART': '1', 17:39:30 INFO - 'PAGER': '/bin/cat', 17:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:30 INFO - 'PWD': '/builds/slave/test', 17:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:30 INFO - 'SHELL': '/bin/bash', 17:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:30 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:30 INFO - 'USER': 'cltbld', 17:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:30 INFO - 'XPC_FLAGS': '0x0', 17:39:30 INFO - 'XPC_SERVICE_NAME': '0', 17:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:39:31 INFO - Cleaning up... 17:39:31 INFO - Return code: 0 17:39:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:31 INFO - 'HOME': '/Users/cltbld', 17:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:31 INFO - 'LOGNAME': 'cltbld', 17:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:31 INFO - 'MOZ_NO_REMOTE': '1', 17:39:31 INFO - 'NO_EM_RESTART': '1', 17:39:31 INFO - 'PAGER': '/bin/cat', 17:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:31 INFO - 'PWD': '/builds/slave/test', 17:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:31 INFO - 'SHELL': '/bin/bash', 17:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:31 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:31 INFO - 'USER': 'cltbld', 17:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:31 INFO - 'XPC_FLAGS': '0x0', 17:39:31 INFO - 'XPC_SERVICE_NAME': '0', 17:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:31 INFO - Downloading/unpacking blobuploader==1.2.4 17:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:39:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:39:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:35 INFO - Downloading docopt-0.6.1.tar.gz 17:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:39:35 INFO - Installing collected packages: blobuploader, requests, docopt 17:39:35 INFO - Running setup.py install for blobuploader 17:39:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:39:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:39:35 INFO - Running setup.py install for requests 17:39:35 INFO - Running setup.py install for docopt 17:39:35 INFO - Successfully installed blobuploader requests docopt 17:39:35 INFO - Cleaning up... 17:39:36 INFO - Return code: 0 17:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:36 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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:36 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 17:39:36 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 17:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:36 INFO - 'HOME': '/Users/cltbld', 17:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:36 INFO - 'LOGNAME': 'cltbld', 17:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:36 INFO - 'MOZ_NO_REMOTE': '1', 17:39:36 INFO - 'NO_EM_RESTART': '1', 17:39:36 INFO - 'PAGER': '/bin/cat', 17:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:36 INFO - 'PWD': '/builds/slave/test', 17:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:36 INFO - 'SHELL': '/bin/bash', 17:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:36 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:36 INFO - 'USER': 'cltbld', 17:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:36 INFO - 'XPC_FLAGS': '0x0', 17:39:36 INFO - 'XPC_SERVICE_NAME': '0', 17:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:36 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-4KfutV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:36 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-52wJZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:36 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-cllQzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:36 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-XUkDe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:36 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-syMkyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:36 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-qPqfO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:36 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-w9m4Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-meKnUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-JQJdim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-nmFc2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-I2lgZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-yG6uLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-tioPC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-pKdsks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-EEAg5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-SD6lsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:37 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-GfWtrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:39:38 INFO - Running setup.py install for manifestparser 17:39:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozcrash 17:39:38 INFO - Running setup.py install for mozdebug 17:39:38 INFO - Running setup.py install for mozdevice 17:39:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozfile 17:39:38 INFO - Running setup.py install for mozhttpd 17:39:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozinfo 17:39:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for mozInstall 17:39:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for mozleak 17:39:39 INFO - Running setup.py install for mozlog 17:39:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for moznetwork 17:39:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for mozprocess 17:39:39 INFO - Running setup.py install for mozprofile 17:39:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:39:40 INFO - Running setup.py install for mozrunner 17:39:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:39:40 INFO - Running setup.py install for mozscreenshot 17:39:40 INFO - Running setup.py install for moztest 17:39:40 INFO - Running setup.py install for mozversion 17:39:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:39:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:39:40 INFO - Cleaning up... 17:39:40 INFO - Return code: 0 17:39:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:40 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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:40 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 17:39:40 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 17:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:40 INFO - 'HOME': '/Users/cltbld', 17:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:40 INFO - 'LOGNAME': 'cltbld', 17:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:40 INFO - 'MOZ_NO_REMOTE': '1', 17:39:40 INFO - 'NO_EM_RESTART': '1', 17:39:40 INFO - 'PAGER': '/bin/cat', 17:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:40 INFO - 'PWD': '/builds/slave/test', 17:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:40 INFO - 'SHELL': '/bin/bash', 17:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:40 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:40 INFO - 'USER': 'cltbld', 17:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:40 INFO - 'XPC_FLAGS': '0x0', 17:39:40 INFO - 'XPC_SERVICE_NAME': '0', 17:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:40 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-bozUEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-vbIfDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-iXzHib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-QwODp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-G_EBr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-kjHEqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-MVKRFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-UOrY7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-IvSyGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:41 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-U1y56O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 17:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:41 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-Tp7gTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:42 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)) 17:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:42 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-rKfIBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:42 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-xBBZnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:42 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)) 17:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:42 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-xnMCVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:42 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-dZAbWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:42 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)) 17:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:42 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-5U9Z2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:42 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)) 17:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:42 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-pMY3v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:42 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)) 17:39:42 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)) 17:39:42 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)) 17:39:42 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)) 17:39:42 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)) 17:39:42 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)) 17:39:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:45 INFO - Downloading blessings-1.6.tar.gz 17:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:39:45 INFO - Installing collected packages: blessings 17:39:45 INFO - Running setup.py install for blessings 17:39:45 INFO - Successfully installed blessings 17:39:45 INFO - Cleaning up... 17:39:45 INFO - Return code: 0 17:39:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:45 INFO - Reading from file tmpfile_stdout 17:39:45 INFO - Current package versions: 17:39:45 INFO - blessings == 1.6 17:39:45 INFO - blobuploader == 1.2.4 17:39:45 INFO - docopt == 0.6.1 17:39:45 INFO - functools32 == 3.2.3-2 17:39:45 INFO - jsonschema == 2.5.1 17:39:45 INFO - manifestparser == 1.1 17:39:45 INFO - mozInstall == 1.12 17:39:45 INFO - mozcrash == 0.17 17:39:45 INFO - mozdebug == 0.1 17:39:45 INFO - mozdevice == 0.48 17:39:45 INFO - mozfile == 1.2 17:39:45 INFO - mozhttpd == 0.7 17:39:45 INFO - mozinfo == 0.9 17:39:45 INFO - mozleak == 0.1 17:39:45 INFO - mozlog == 3.4 17:39:45 INFO - moznetwork == 0.27 17:39:45 INFO - mozprocess == 0.23 17:39:45 INFO - mozprofile == 0.28 17:39:45 INFO - mozrunner == 6.12 17:39:45 INFO - mozscreenshot == 0.1 17:39:45 INFO - mozsystemmonitor == 0.3 17:39:45 INFO - moztest == 0.7 17:39:45 INFO - mozversion == 1.4 17:39:45 INFO - psutil == 3.1.1 17:39:45 INFO - requests == 1.2.3 17:39:45 INFO - wsgiref == 0.1.2 17:39:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:45 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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:45 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 17:39:45 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 17:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:45 INFO - 'HOME': '/Users/cltbld', 17:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:45 INFO - 'LOGNAME': 'cltbld', 17:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:45 INFO - 'MOZ_NO_REMOTE': '1', 17:39:45 INFO - 'NO_EM_RESTART': '1', 17:39:45 INFO - 'PAGER': '/bin/cat', 17:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:45 INFO - 'PWD': '/builds/slave/test', 17:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:45 INFO - 'SHELL': '/bin/bash', 17:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:45 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:45 INFO - 'USER': 'cltbld', 17:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:45 INFO - 'XPC_FLAGS': '0x0', 17:39:45 INFO - 'XPC_SERVICE_NAME': '0', 17:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 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)) 17:39:46 INFO - Cleaning up... 17:39:46 INFO - Return code: 0 17:39:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:39:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:46 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 0x107d13490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c89570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaa2dc49d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, '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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 17:39:46 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 17:39:46 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 17:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:46 INFO - 'HOME': '/Users/cltbld', 17:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:46 INFO - 'LOGNAME': 'cltbld', 17:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:46 INFO - 'MOZ_NO_REMOTE': '1', 17:39:46 INFO - 'NO_EM_RESTART': '1', 17:39:46 INFO - 'PAGER': '/bin/cat', 17:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:46 INFO - 'PWD': '/builds/slave/test', 17:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:46 INFO - 'SHELL': '/bin/bash', 17:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:39:46 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:46 INFO - 'USER': 'cltbld', 17:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:46 INFO - 'XPC_FLAGS': '0x0', 17:39:46 INFO - 'XPC_SERVICE_NAME': '0', 17:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:39:46 INFO - Cleaning up... 17:39:46 INFO - Return code: 0 17:39:46 INFO - Running post-action listener: _resource_record_post_action 17:39:46 INFO - Running post-action listener: _start_resource_monitoring 17:39:46 INFO - Starting resource monitoring. 17:39:46 INFO - [mozharness: 2016-09-28 00:39:46.424898Z] Finished create-virtualenv step (success) 17:39:46 INFO - [mozharness: 2016-09-28 00:39:46.425984Z] Running install step. 17:39:46 INFO - Running pre-action listener: _resource_record_pre_action 17:39:46 INFO - Running main action method: install 17:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:46 INFO - Reading from file tmpfile_stdout 17:39:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:39:46 INFO - Reading from file tmpfile_stdout 17:39:46 INFO - Output received: 17:39:46 INFO - Usage: mozinstall [options] installer 17:39:46 INFO - Options: 17:39:46 INFO - -h, --help show this help message and exit 17:39:46 INFO - -d DEST, --destination=DEST 17:39:46 INFO - Directory to install application into. [default: 17:39:46 INFO - "/builds/slave/test"] 17:39:46 INFO - --app=APP Application being installed. [default: firefox] 17:39:46 INFO - mkdir: /builds/slave/test/build/application 17:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:40:18 INFO - Reading from file tmpfile_stdout 17:40:18 INFO - Output received: 17:40:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:40:18 INFO - Running post-action listener: _resource_record_post_action 17:40:18 INFO - [mozharness: 2016-09-28 00:40:18.829587Z] Finished install step (success) 17:40:18 INFO - [mozharness: 2016-09-28 00:40:18.829690Z] Running run-tests step. 17:40:18 INFO - Running pre-action listener: _resource_record_pre_action 17:40:18 INFO - Running main action method: run_tests 17:40:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:40:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:40:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:40:18 INFO - 2016-09-27 17:40:18.844 screenresolution[2266:21217] starting screenresolution argv=screenresolution get 17:40:18 INFO - 2016-09-27 17:40:18.846 screenresolution[2266:21217] Display 0: 1600x1200x32@60 17:40:18 INFO - 2016-09-27 17:40:18.853 screenresolution[2267:21219] starting screenresolution argv=screenresolution list 17:40:18 INFO - Available Modes on Display 0 17:40:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:40:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:40:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:40:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:40:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:40:19 INFO - Intel Iris: 17:40:19 INFO - Chipset Model: Intel Iris 17:40:19 INFO - Type: GPU 17:40:19 INFO - Bus: Built-In 17:40:19 INFO - VRAM (Dynamic, Max): 1536 MB 17:40:19 INFO - Vendor: Intel (0x8086) 17:40:19 INFO - Device ID: 0x0a2e 17:40:19 INFO - Revision ID: 0x0009 17:40:19 INFO - Displays: 17:40:19 INFO - Display: 17:40:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:40:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:40:19 INFO - Display Serial Number: 1600x1200 60 17:40:19 INFO - Main Display: Yes 17:40:19 INFO - Mirror: Off 17:40:19 INFO - Online: Yes 17:40:19 INFO - Rotation: Supported 17:40:19 INFO - Return code: 0 17:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:40:19 INFO - Python 2.7.3 17:40:19 INFO - Return code: 0 17:40:19 INFO - grabbing minidump binary from tooltool 17:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:19 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 0x107b27d30>, '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 0x10798ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b1fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:40:19 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 17:40:19 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 17:40:19 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 17:40:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:40:19 INFO - Return code: 0 17:40:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:40:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:40:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:40:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:40:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 17:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0359 --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 17:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5T1w5ymPnh/Render', 17:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:19 INFO - 'HOME': '/Users/cltbld', 17:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:19 INFO - 'LOGNAME': 'cltbld', 17:40:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:40:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:19 INFO - 'MOZ_NO_REMOTE': '1', 17:40:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:40:19 INFO - 'NO_EM_RESTART': '1', 17:40:19 INFO - 'PAGER': '/bin/cat', 17:40:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:19 INFO - 'PWD': '/builds/slave/test', 17:40:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:19 INFO - 'SHELL': '/bin/bash', 17:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9RHWG40Qnc/Listeners', 17:40:19 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 17:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:19 INFO - 'USER': 'cltbld', 17:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:19 INFO - 'XPC_FLAGS': '0x0', 17:40:19 INFO - 'XPC_SERVICE_NAME': '0', 17:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 17:40:19 INFO - mozversion application_buildid: 20160927152620 17:40:19 INFO - mozversion application_changeset: 3db11822d83f7a97cb882ec8338578f50b51a994 17:40:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:40:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:40:19 INFO - mozversion application_name: Firefox 17:40:19 INFO - mozversion application_remotingname: firefox-dev 17:40:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:40:19 INFO - mozversion application_vendor: Mozilla 17:40:19 INFO - mozversion application_version: 51.0a2 17:40:19 INFO - mozversion platform_buildid: 20160927152620 17:40:19 INFO - mozversion platform_changeset: 3db11822d83f7a97cb882ec8338578f50b51a994 17:40:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:40:19 INFO - mozversion platform_version: 51.0a2 17:40:19 INFO - using testdate: 1475023219 17:40:19 INFO - actual date: 1475023219 17:40:19 INFO - starting webserver on 'localhost:55802' 17:40:19 INFO - SUITE-START | Running 2 tests 17:40:19 INFO - TEST-START | dromaeo_css 17:40:19 INFO - operating with platform_type : mac_ 17:40:19 INFO - Initialising browser for dromaeo_css test... 17:40:19 INFO - TEST-INFO | started process 2277 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmps84jxD/profile http://localhost:55802/getInfo.html) 17:40:21 INFO - PROCESS | 2277 | __metrics Screen width/height:1600/1200 17:40:21 INFO - PROCESS | 2277 | colorDepth:24 17:40:21 INFO - PROCESS | 2277 | Browser inner width/height: 1024/689 17:40:21 INFO - PROCESS | 2277 | __metrics 17:40:21 INFO - PROCESS | 2277 | 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" 17:40:21 INFO - PROCESS | 2277 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:40:22 INFO - TEST-INFO | 2277: exit 0 17:40:22 INFO - Browser initialized. 17:40:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:40:22 INFO - TEST-INFO | started process 2279 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmps84jxD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:34 INFO - PROCESS | 2279 | RSS: Main: 219181056 17:40:34 INFO - PROCESS | 2279 | 17:41:25 INFO - PROCESS | 2279 | 1475023285573 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] 17:43:38 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55802/tests/dromaeo/cssquery-ext.html) 17:43:39 INFO - PROCESS | 2279 | RSS: Main: 363323392 17:43:39 INFO - PROCESS | 2279 | 17:46:42 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-ext.html (next: http://localhost:55802/tests/dromaeo/cssquery-jquery.html) 17:46:43 INFO - PROCESS | 2279 | RSS: Main: 360321024 17:46:43 INFO - PROCESS | 2279 | 17:49:45 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55802/tests/dromaeo/cssquery-mootools.html) 17:49:46 INFO - PROCESS | 2279 | RSS: Main: 313970688 17:49:46 INFO - PROCESS | 2279 | 17:52:48 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55802/tests/dromaeo/cssquery-prototype.html) 17:52:49 INFO - PROCESS | 2279 | RSS: Main: 315482112 17:52:49 INFO - PROCESS | 2279 | 17:55:52 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55802/tests/dromaeo/cssquery-yui.html) 17:55:53 INFO - PROCESS | 2279 | RSS: Main: 311029760 17:55:53 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-yui.html (next: http://localhost:55802/tests/dromaeo/cssquery-dojo.html) 17:58:56 INFO - PROCESS | 2279 | RSS: Main: 424620032 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | __start_tp_report 17:58:56 INFO - PROCESS | 2279 | _x_x_mozilla_page_load 17:58:56 INFO - PROCESS | 2279 | _x_x_mozilla_page_load_details 17:58:56 INFO - PROCESS | 2279 | |i|pagename|runs| 17:58:56 INFO - PROCESS | 2279 | |0;dojo.html;3295.390352784735;3318.585176852894;3342.1310459280594;3377.864885404584;3383.6108847482546;5809.593328467009;5825.766969321227;5841.328247251557;5859.355470898197;5890.087036509342;5737.770489180438;5791.739371728272;5832.154337621042;5837.8832423351505;5848.590598658096;5218.8695282617955;5273.393559740641;5273.80537146843;5312.893742125155;5342.519173274404;5233.502817232356;5235.973820130894;5251.343582052244;5358.59810514211;5362.43694412087;5322.547583455411;5332.386775520826;5335.039692855285;5338.786448542053;5352.5182733553975;5329.440408757064;5329.493698098674;5334.093204155264;5334.1732031535175;5345.037893179227;5148.974255128738;5275.261463395128;5275.709835959021;5291.126964050927;5328;5890.793822216202;5897.852553686149;5898.8820223595285;5900.586958912878;5926.436988486087;6111.105587097678;6120.8120562959275;6145.293291271516;6146.832101900669;6160.907586386208;6094.155344910546;6131.10674721555;6137.202163718688;6138.664296166084;6154.922888494496;5816.1275808628625;5869.8239052828485;5896.204012458349;5910.67491287979;5926.822195334147;6129.022607377628;6156.815295541141;6164.106204600308;6208.037754148114;6274.780382686584;6100.48145907594;6200.410960958701;6201.534884883652;6202.007678771375;6203.596766210182;6198;6201.503879689614;6220.533459990428;6221;6226.315105338409;6091.305081214083;6142.938570614237;6149.2620885494025;6160.10678451631;6163.044728067157;6113.841195312599;6160.445559899541;6182.6599537024995;6187.84530386735;6200.162977998003;4868.95131048692;4980.5019498049905;4996.7001979881325;4998.650094493423;5008.624353173526;4403.647708183337;4446.466424029137;4465.843695470708;4473.7986790594505;4474.32885067236;5813.186153938452;5858.238429004287;5890.440408161217;5948.256467941507;5954.46409823118;6188.659623720649;6209.565330426827;6211.81364559064;6214.347493513116;6214.564980451325;5929.199558059693;5941.31674857397;5956.583039187215;5967.9701601491715;5996.970015149984;4580.97709511457;5278.551323137576;5380.058489764276;5406.78372865081;5464.26232458613;6294.71673774672;6323.747050117944;6390.233172019387;6394;6398.456131228898;6185.536084793568;6187.721552530057;6187.81436556904;6192.81421557354;6199.659018754011;5868.855573163192;6187.504999600112;6245.812625621239;6312.905306420315;6374.968125159345;6110.4980065817745;6124.014786914997;6157.445829875153;6193.752249909953;6258.405451482102;6285.214348206474;6289.874202516015;6308.842278943063;6313.116163736989;6314.368563143649;6080.513558915188;6082.3613520581475;6121.051237058263;6152.876942461216;6165.229346331708;5651.378348381592;5882.176495290748;6045.153678484928;6063.272407311151;6141.385861414002;5943.613665111927;5952.345242023461;5979.4618484336615;5989.2812862456785;6025.728842202024;6134.04922237054;6149.323574406722;6156.1381406604005;6170.753169873155;6184.474319682878;5788.189653448605;5831.562632802472;5849.736761845812;5897.233359663216;5973.253343332083 17:58:56 INFO - PROCESS | 2279 | |1;ext.html;442.371831998562;455.8290641009621;464.47282334550283;527.2223470381189;532.8294945617403;31466.213344666394;42085;43501.78249108754;43516;43641;44629.77685111578;44971;45025.54974450255;45073.7746311268;45104.3234351485;9825.950870245639;10003.899571047179;10007.29948903577;10009.699709008704;10062.295639305252;9726.70819875405;9844.064813842673;9844.360116592434;9854.211663066937;9860.704178874645;8480.660773569081;9812.607495700164;9849.359791613559;9901.950490247575;9902.05930436611;9795.363301385423;9860.260480463921;9860.457674827881;9861;9886.9505652472;9865;9947.5026248688;9982.201423886145;9985.251106167067;9994.550245238981;42243.155136897396;42666.78666606678;42671.57328426707;42693.78653106745;42777.7166685;3455.809930453824;3511.4206155984234;3512.8594856205723;3777.433384992273;3853.537575490931;31421.528677069862;32609;32936.505952410735;32951.50572741411;33626.49560256598;3260.8206548639814;3270.411325961326;3310.851011704455;3332.683395077488;3344.6989770920736;518362;520101;521523;521662;522546.8726563657;64332;64721;64758.676206618664;64801.35198648048;64894.67552662301;35626.64373356285;36219.818900905324;36308.003059831964;37543.62456375456;37558;17495.38766143179;17624.647507050042;17628.823711762976;17654.205560749797;17696.026718530346;13260;13322.267275299952;13323.866761332263;13358.866411335763;13364.799528007088;19692.40922772319;20100.19599216015;20122.89938550298;20127.29554465616;20209.49476263076;7989.7203597873795;8021.478603890845;8026.5986700664735;8069.556174410346;8146.266835984671;834.7871292820413;978.7846673731767;988.4350111460748;998.3111652959435;1087.9401632910267;27151.91392344284;29966.101016969526;30991.070267892;31319.90380336677;31547;850.4472093139385;998.8463324859654;1031.4069410089228;1066.36018388966;1166.8891455311732;12988.220706757626;13230.536931207362;14816.481423150353;16186.352545898033;16321.347146114022;701957;758908;759147;995098;998623.0068849609;61187;62082.37917620766;62095;62134;62433;1236.5548402575066;1276.699975505774;1277.0358379423476;1278.0797825565764;1382.592135320083;25863.353416164748;26981.0556630517;32451.701931923402;32862.675126220885;34544.48183277303;58911.41088589059;59802.70098649479;59823.812333136266;59947;59989;593765;602314;602853;603712;603969;43984.560154398045;44726.10547789091;45767.855803603845;45872;45926;49606;49863.00273994427;50423.74788126183;50554.241686374;51860.70348241324;39446.60553394429;41595.1680966385;42094.94958583797;42338.57661423346;42685;40885.795571021954;41020.79489602652;41224.79387603043;42301.36547951722;42799;33874;34541;34559.13602159966;37921.2415751689;40475.98810029773;25210;35654.64345356617;36212.676035229866;36820;38152.42771358376;26245.73754262433;26613.20160395191;26660.333491662088;26664.866675666497;27142.72857271481 17:58:56 INFO - PROCESS | 2279 | |2;jquery.html;307.81223453693246;358.6503159419565;371.7973704331138;382.0982481344026;404.1452328325592;19865.60268794625;19986.800131998676;20149.29477468289;20772.584548309045;20935.267265645707;19651;20053.699194512094;20277.69583456249;20306.492337691565;20411.183552657876;4394.989152494928;5300.681959082448;5760.596758226936;6049.971504844165;6061.575689701723;5838.21184140142;5895.145203945425;5969.403059694017;5992.191054207669;6025.849353766147;5615.298087739033;5894.292684877821;5941.851453713649;5970.402959704038;5987.461128498434;5478.698671573062;5510.724463776815;5910.586258961875;5945.108233764927;5960.433758792908;4930.186519224324;5073.8731531712;5132.153194722903;5141.460146684619;5149.0989076911765;25002.874985624956;25067.37331566707;25147.748522514725;25157;25410.491790164277;2457.5576396248666;2528.696556413224;2850.315924178203;3149.889753858604;3202.407554602406;15298;15299;15339;15356.308966096552;15773.68452630941;1816.1191821966468;1862.1341076399403;1914.6457905287566;1937.8255956963942;1949.2592814730313;85194;102621.89512419494;107925.38111928328;129710;132963.33518332348;10558.736031599117;10709.518071686636;10829.566817327377;10885.945570272099;11012.559497620005;13400.994925380635;13402.664933376744;13420.127691700009;13426.865731342757;13444.857187139007;8272.545010024507;8614.569271536398;8639.870401943976;8695.347848911357;8714;8757.649694012169;8767.386282960259;8774;8926.910730892738;8931.642734290686;6390.329015453403;6454.806355809239;6510.609363438114;6527.706253218616;6610.636414997221;1566.451741890352;1828.168183476515;1836.5583017331599;1841.9539511512319;1873.484791682271;882.4925667741074;939.736873675372;949.5489642419795;955.6798472511647;1015.7816069545083;20267;21964.450888727908;21967.890160549094;21971.450713732283;22007.339779806633;973.8539219117189;1012.3065699995526;1023.2530252915413;1042.5517027678172;1044.4725413666201;8752.862127923328;10189.54147063369;11606.651800446;11623.941880290544;11652.766944661229;626948.8652556709;627548;637092;651270;656589;71256.64371678108;92341;118996;119856;132842.33578832043;849.3163003782015;989.4508547756064;993.9801203976025;1008.9646862359929;1012.6810054832704;14950.925245373703;17518.562035949202;19399.127039283547;19639.509012274808;19647.607047858677;55985;57232.42767572271;57950.84098318094;58519.82960340854;58873;65449.01826472511;79284.20715792768;80034.199658005;82911.5854420724;83436.58281708552;6111.5110791137495;7271;7580.886286705593;7795.4543181976715;8045.517268963881;12603.684907877376;13025.804612930624;13247.006474514257;13278.80081798793;13430.925525958095;11309.20835541537;11364.829527557258;11387.829182562102;11660.53357865676;11792.29246245228;11128.610498632834;11156.721081972692;11282.323060616389;11282.661520154408;11342;10595.258331916692;10737.624183153552;11307;11420.885791141982;11558.595449159238;6815.454763618799;7067.399271062018;7245.818854528679;7800.6099695016155;7831.84336313282;10658.62694805678;10805.405702686428;10947.20846184218;11037.889621104008;11238.55045798159 17:58:56 INFO - PROCESS | 2279 | |3;mootools.html;1506.3823832228784;1524.3826250368602;1715.322447633185;1886.188938756336;1899.3352326685663;7913.129555748863;8189.3857960652895;8433.536155511452;8984.685536006242;9003.054679258681;8101.513909165439;8204.835903281932;8209.850620913063;8465.280451161658;8707.216350528452;2360.221127028081;2398.4603464220586;2399.8320117591775;2406.085687438771;2406.085687438771;2362.5865473542062;2380.75002124777;2406.602910519762;2412.3124909400826;2416.3838221253554;2050.1389416445127;2120.936371908845;2250.3024062540585;2366.420227044368;2391.2826152154285;2029.725986991752;2301.091069027733;2351.5061837014246;2351.5649604822993;2355.4111472131967;2172.706684597575;2211.8672879627275;2213.302809614966;2214.5903007943584;2215.1471683401846;8923.464592124494;8971.147740964598;8980.96718877331;8981.910180898172;8986.955065224698;5166.715830629314;5392.164214546751;5400.891982160335;5408.378036525771;5417.783288668448;3568.571771387424;3588.1747198144312;3657.5428071491065;3715.8327875245677;3715.981420092909;1107.9279846809932;1109.7336639206612;1115.397685249964;1137.033521506721;1141.1042331769604;11772.117091218193;11899.643010709606;11919.582814601446;11919.82120268188;11928.165028448013;4639.814407423665;4654.953450465519;4854.441739199967;4861.246506791453;4881.170201065827;10120.797584048278;10135;10138.442385668859;10153.086222240034;10154.746131346628;4296.3125899856495;5375.19372094189;5379.811706590329;5380.596455265871;5396;4789.808407663724;4900.583450406755;4900.607951363882;4932.827351042696;4933.333999909966;3931.8230679619487;3988.4216788565495;4025.765700036508;4045.939310910339;4102.630763231324;1280.7438512297579;1296.235221219485;1297.3772589157256;1309.594025851989;1311.9016073794503;578.2187921107436;769.1078349114999;790.115071120349;793.9722109726132;882.9558522073999;4650.4186976627925;5706.28671416073;5962.880742385128;6003.3996600339615;6148.893199224182;857.2327766648814;897.0088052701801;900.8153328567628;902.7517432706059;907.1835348186553;3637.94543081854;3821.216650586623;3914.9608503915165;3962.2471730371135;3971.3447281198855;10441;10808.297460665031;10963.232573719923;11004.22970392081;11005.834912476319;10948.835767463494;10952.835707464394;10953.616623418142;10954.699513102338;10955.068819150301;7840.41196910234;8203.466774659628;8255.917440825515;8358.540280284522;8369.539675317916;5876.41235876409;5917.526597872074;5936.050231963038;6012.5791194617705;6033.064874944391;9786.314957952874;9791.216702663627;10218.693439196539;10227.28409011362;10297.3821570706;9936.354136981074;10289.125424339016;10375.429351385445;10468.790624187626;10488.68533943983;7582.469227154046;7725.690972361267;7742.4193185510185;7829.647665855164;7833.177516360928;8441.957790211256;8498.447600905922;8524.573771311534;8529.701460448854;8551.61517731716;7388.712023149862;7629.7329593463965;7646.502977306457;7706.614669266626;7781.105172905189;7394.7781566553085;7440.627968601657;7445.367143792621;7474.065741782278;7502.137254215617;7039.788806335818;7168.709632266242;7170.96414517924;7171.928280717126;7181.892271615826;4863.95136048635;4926.729029903389;4947.930851775023;5051.116054690341;5196.726801933551;5043.823466178666;5052.924206136838;5080.669756465966;5099.79600815978;5187.974060129675 17:58:56 INFO - PROCESS | 2279 | |4;prototype.html;303.7463717795641;314.1423912718278;315.0501238765124;320.7017473749415;326.42549113560125;5443.8496793766435;5507.889842203159;5545.639533430324;5560.972195139018;5588.329400471944;4576.954230457694;4735.976320118403;5062.822801201959;5305.310309659739;5352.4477901408545;3222.30720395115;3347.380734564101;4048.9270343359035;4094.3008651409627;4131.892734705307;3417;4146.6268035876765;4147.543770185277;4153.148604536078;4176.728512646669;3428.6228514863346;3805.325656711052;4089.386592011207;4097.3239415496555;4118.341065429532;3380;4053.97973010136;4067.613576710208;4128.091819799639;4159.646430053449;3032.8626764963137;3387.2209391840015;3498.2828520153307;3500.457429098494;3511.2801875615437;4323.762193079379;4854.49027852074;5198.168293073128;5245.527902488794;5295.841124766263;3580;3889.6273273303264;4227.182311606039;4648.976755116203;4654.417498050645;4717.882052948669;5637.605367624268;5642.266505354319;5676.489115979582;5726.599138060337;3820.1977584707247;3842.634949679776;3865.942010869839;3885.669718073939;3903.9264202344298;4519.774011299488;4815;5401.297831281948;5476.864023031021;5568.99758043552;3315.6684331567135;3701.722370822199;3895.0846551060476;3901.51231096113;3931.68546516278;3488.5290485784603;3966.682665386762;3983.6016398359934;3990.7206495545033;4014.197160567898;4108.630223279919;4545.045540436546;4691.085238378483;4721.362616046858;4731.313959475857;4615.561521655437;4949.935763810798;5720.1991721159075;5843.2695913010875;5886.558508111909;1197.6526807225807;1320.5510126557017;1344.7713888638955;1347.7910923806826;1351.3310911098872;816.4366587054913;817.2195553246635;825.5459497276594;831.264331066998;855.268745222838;4392.824287028547;5304.575633949275;5346.594032685307;5369.24830523727;5524.723763811793;5389.892202156013;5836.4747172753805;5868.823935281948;5881.676507792027;5882.176495290662;5102.846914592568;5264.684118952875;5325.4940780625775;5418.91871621926;5515.7242137893745;2594.494073655619;2745.68424631166;2845.5020371434916;3076.415481058592;3086.891958781432;5799.594028417971;5802.274715660543;5949.732262048218;6061.363556826558;6093.6039157454625;5187.688738675692;5607.243022191952;5921.585489015813;5963.403659634002;5998.400159984054;4505.954940450553;5489.945100549024;6021.668808215415;6087.756489740449;6138.943453942889;4822.9758851206925;5039.286642541553;5055.6713813602;5308.920366194433;5815.244018277597;5276;5412.350517937873;5699.7435115419075;5728.283964504437;5759.539236861125;5911.3201981772645;5951.095649392153;6008.339082700812;6023.578349515492;6035.456808887046;3756.812159391965;3884.8251828668344;3892.455056292065;3909;3920.5295364556437;5205.297284866495;5836;5869.647821130575;5916.792912248051;5918.141869428995;4467.530909254481;4912.38595175603;5397.842262276612;5697.54419646419;5789.8263052108505;5011.437304591973;5514.834554963358;5623.522000629992;5658.688772117573;5678.20505129274;4482.951592916847;4687.601553867959;5536.197251398444;5543.560833233364;5550.087188532156;5168.870778230575;5208.244804503402;5571.66570005801;5603.663780173202;5629.802956896489;4993.3259010034635;5350.277712508761;5595.0208713475795;5602.411746766531;5622.5381400836895 17:58:56 INFO - PROCESS | 2279 | |5;yui.html;700.9544379615324;711.7153138744502;753.781403393016;793.5000949401878;813.4387272781777;15535.223238838069;16445.342186312533;16499.752503712454;16502;16515.339386424545;14876.553703388916;14938.701225975474;14953.775693364609;14964.476243331486;14981.550553483386;686.9690863911111;700.4431476975816;841.3395484544618;847.0470720439506;867.3668222197799;850.4472093139447;852.9445586036919;858.3690987124459;862.5428522882883;863;913.1325241021024;913.4656226107735;913.5980168725773;913.6162811619103;914.7072936660271;714.1216303946176;901.5582364641278;904.1681652879366;908.0238743350891;910.5083255042302;555.7193617223317;660.1385192324016;679.9626020568867;681.6898311268361;684.0457561701448;14652.267386630625;14684.70630587393;15118.319675614624;15188.620284492865;15507.844921550866;13911.304434778322;14256.287185640676;14321.283935803272;14335.781458576033;14341.641458963504;12323.5070597176;12485.188462749893;12602.117851750381;12838.80741788874;13328.133671311334;3989.4813674222455;4636.072785442925;4652;4824;4832.251001094836;122899;131227;131296.34351828275;131298;131719;10690.144788417063;11017.83473247902;11250.606228781953;11272.323660580392;11407.48666310018;18697.252109915724;21576.35270941874;22492.100315987504;23253.860728801395;23402.7659723404;7997.480163789335;8074.071481779553;8104.39217058723;8159.551224682581;8333.208345207195;4414.381986521889;4433.8226470941445;4526.592606665416;4585.312203169551;4660.4174478190225;3390.6100798408497;3523.9119022024656;3802.7147963902817;3921.745086569364;3935.4883865097354;710.4387533848202;713.2225873797586;721.0842230367404;723.8298999735058;731.5464412064554;615.6060121522229;622.5455417545218;651.2413038809829;655.3822897605287;663.7709990053423;8828.382013259139;9317.90682093184;9489.335746497816;9551.856722149174;9633.951830240803;629.8425393651587;650.6584043377264;664.7606861529846;682.6484360554318;697.9461013869094;4450.577195166454;4875.611450042186;4929.531694489017;4945.431275403303;5047.293378926953;96399.51800240955;97027.51486242664;149395;151140.9315441077;151233;120479.39760301143;124084;125268;128161;128936.35531822468;104425;108599.45700271607;110607.89392106138;111084;111880;8621.568921554022;9826.16477599412;9883;9916.553755080895;10001.399916005063;61245.69377153086;61356;62125.068123977275;62963.6851815738;63459.730805384555;90483.09516904746;90558;93417;93969.12061758863;96877;12852.807207892076;12880.549180778627;13085.149465285107;13215.207087574776;13456;14115.082519636191;14444.277786110863;14582.635434114232;15146;15609.21953902323;12338;12973.610791676265;13439.596812095653;13447.394867230802;14115.576532704035;13952.790708139182;13988.440462381392;14356.497522587077;14582.781258280922;14644.974851760275;13639.659008524866;13891.791623125864;13893;14435.711285774016;14483.637909052359;10673.281431339416;11114.760298171666;11324.773504530029;11718.945294923498;11892.10809189297;10634.73413164646;11415.37215453158;11450.885491144982;11467.4266286687;11709.882901170879 17:58:56 INFO - PROCESS | 2279 | __end_tp_report 17:58:56 INFO - PROCESS | 2279 | __start_cc_report 17:58:56 INFO - PROCESS | 2279 | _x_x_mozilla_cycle_collect,1330 17:58:56 INFO - PROCESS | 2279 | __end_cc_report 17:58:56 INFO - PROCESS | 2279 | __startTimestamp1475024336478__endTimestamp 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | ------- Summary: start ------- 17:58:56 INFO - PROCESS | 2279 | Number of tests: 6 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | [#0] dojo.html Cycles:165 Average:5771.50 Median:5967.97 stddev:623.85 (10.5%) stddev-sans-first:594.75 17:58:56 INFO - PROCESS | 2279 | Values: 3295.4 3318.6 3342.1 3377.9 3383.6 5809.6 5825.8 5841.3 5859.4 5890.1 5737.8 5791.7 5832.2 5837.9 5848.6 5218.9 5273.4 5273.8 5312.9 5342.5 5233.5 5236.0 5251.3 5358.6 5362.4 5322.5 5332.4 5335.0 5338.8 5352.5 5329.4 5329.5 5334.1 5334.2 5345.0 5149.0 5275.3 5275.7 5291.1 5328.0 5890.8 5897.9 5898.9 5900.6 5926.4 6111.1 6120.8 6145.3 6146.8 6160.9 6094.2 6131.1 6137.2 6138.7 6154.9 5816.1 5869.8 5896.2 5910.7 5926.8 6129.0 6156.8 6164.1 6208.0 6274.8 6100.5 6200.4 6201.5 6202.0 6203.6 6198.0 6201.5 6220.5 6221.0 6226.3 6091.3 6142.9 6149.3 6160.1 6163.0 6113.8 6160.4 6182.7 6187.8 6200.2 4869.0 4980.5 4996.7 4998.7 5008.6 4403.6 4446.5 4465.8 4473.8 4474.3 5813.2 5858.2 5890.4 5948.3 5954.5 6188.7 6209.6 6211.8 6214.3 6214.6 5929.2 5941.3 5956.6 5968.0 5997.0 4581.0 5278.6 5380.1 5406.8 5464.3 6294.7 6323.7 6390.2 6394.0 6398.5 6185.5 6187.7 6187.8 6192.8 6199.7 5868.9 6187.5 6245.8 6312.9 6375.0 6110.5 6124.0 6157.4 6193.8 6258.4 6285.2 6289.9 6308.8 6313.1 6314.4 6080.5 6082.4 6121.1 6152.9 6165.2 5651.4 5882.2 6045.2 6063.3 6141.4 5943.6 5952.3 5979.5 5989.3 6025.7 6134.0 6149.3 6156.1 6170.8 6184.5 5788.2 5831.6 5849.7 5897.2 5973.3 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | [#1] ext.html Cycles:180 Average:78327.97 Median:42678.29 stddev:181003.12 (424.1%) stddev-sans-first:181416.41 17:58:56 INFO - PROCESS | 2279 | Values: 442.4 455.8 464.5 527.2 532.8 31466.2 42085.0 43501.8 43516.0 43641.0 44629.8 44971.0 45025.5 45073.8 45104.3 9826.0 10003.9 10007.3 10009.7 10062.3 9726.7 9844.1 9844.4 9854.2 9860.7 8480.7 9812.6 9849.4 9902.0 9902.1 9795.4 9860.3 9860.5 9861.0 9887.0 9865.0 9947.5 9982.2 9985.3 9994.6 42243.2 42666.8 42671.6 42693.8 42777.7 3455.8 3511.4 3512.9 3777.4 3853.5 31421.5 32609.0 32936.5 32951.5 33626.5 3260.8 3270.4 3310.9 3332.7 3344.7 518362.0 520101.0 521523.0 521662.0 522546.9 64332.0 64721.0 64758.7 64801.4 64894.7 35626.6 36219.8 36308.0 37543.6 37558.0 17495.4 17624.6 17628.8 17654.2 17696.0 13260.0 13322.3 13323.9 13358.9 13364.8 19692.4 20100.2 20122.9 20127.3 20209.5 7989.7 8021.5 8026.6 8069.6 8146.3 834.8 978.8 988.4 998.3 1087.9 27151.9 29966.1 30991.1 31319.9 31547.0 850.4 998.8 1031.4 1066.4 1166.9 12988.2 13230.5 14816.5 16186.4 16321.3 701957.0 758908.0 759147.0 995098.0 998623.0 61187.0 62082.4 62095.0 62134.0 62433.0 1236.6 1276.7 1277.0 1278.1 1382.6 25863.4 26981.1 32451.7 32862.7 34544.5 58911.4 59802.7 59823.8 59947.0 59989.0 593765.0 602314.0 602853.0 603712.0 603969.0 43984.6 44726.1 45767.9 45872.0 45926.0 49606.0 49863.0 50423.7 50554.2 51860.7 39446.6 41595.2 42094.9 42338.6 42685.0 40885.8 41020.8 41224.8 42301.4 42799.0 33874.0 34541.0 34559.1 37921.2 40476.0 25210.0 35654.6 36212.7 36820.0 38152.4 26245.7 26613.2 26660.3 26664.9 27142.7 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | [#2] jquery.html Cycles:180 Average:35695.34 Median:25107.56 stddev:105972.11 (422.1%) stddev-sans-first:106236.08 17:58:56 INFO - PROCESS | 2279 | Values: 307.8 358.7 371.8 382.1 404.1 19865.6 19986.8 20149.3 20772.6 20935.3 19651.0 20053.7 20277.7 20306.5 20411.2 4395.0 5300.7 5760.6 6050.0 6061.6 5838.2 5895.1 5969.4 5992.2 6025.8 5615.3 5894.3 5941.9 5970.4 5987.5 5478.7 5510.7 5910.6 5945.1 5960.4 4930.2 5073.9 5132.2 5141.5 5149.1 25002.9 25067.4 25147.7 25157.0 25410.5 2457.6 2528.7 2850.3 3149.9 3202.4 15298.0 15299.0 15339.0 15356.3 15773.7 1816.1 1862.1 1914.6 1937.8 1949.3 85194.0 102621.9 107925.4 129710.0 132963.3 10558.7 10709.5 10829.6 10885.9 11012.6 13401.0 13402.7 13420.1 13426.9 13444.9 8272.5 8614.6 8639.9 8695.3 8714.0 8757.6 8767.4 8774.0 8926.9 8931.6 6390.3 6454.8 6510.6 6527.7 6610.6 1566.5 1828.2 1836.6 1842.0 1873.5 882.5 939.7 949.5 955.7 1015.8 20267.0 21964.5 21967.9 21971.5 22007.3 973.9 1012.3 1023.3 1042.6 1044.5 8752.9 10189.5 11606.7 11623.9 11652.8 626948.9 627548.0 637092.0 651270.0 656589.0 71256.6 92341.0 118996.0 119856.0 132842.3 849.3 989.5 994.0 1009.0 1012.7 14950.9 17518.6 19399.1 19639.5 19647.6 55985.0 57232.4 57950.8 58519.8 58873.0 65449.0 79284.2 80034.2 82911.6 83436.6 6111.5 7271.0 7580.9 7795.5 8045.5 12603.7 13025.8 13247.0 13278.8 13430.9 11309.2 11364.8 11387.8 11660.5 11792.3 11128.6 11156.7 11282.3 11282.7 11342.0 10595.3 10737.6 11307.0 11420.9 11558.6 6815.5 7067.4 7245.8 7800.6 7831.8 10658.6 10805.4 10947.2 11037.9 11238.6 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | [#3] mootools.html Cycles:180 Average:5762.61 Median:4890.88 stddev:3261.49 (66.7%) stddev-sans-first:3254.96 17:58:56 INFO - PROCESS | 2279 | Values: 1506.4 1524.4 1715.3 1886.2 1899.3 7913.1 8189.4 8433.5 8984.7 9003.1 8101.5 8204.8 8209.9 8465.3 8707.2 2360.2 2398.5 2399.8 2406.1 2406.1 2362.6 2380.8 2406.6 2412.3 2416.4 2050.1 2120.9 2250.3 2366.4 2391.3 2029.7 2301.1 2351.5 2351.6 2355.4 2172.7 2211.9 2213.3 2214.6 2215.1 8923.5 8971.1 8981.0 8981.9 8987.0 5166.7 5392.2 5400.9 5408.4 5417.8 3568.6 3588.2 3657.5 3715.8 3716.0 1107.9 1109.7 1115.4 1137.0 1141.1 11772.1 11899.6 11919.6 11919.8 11928.2 4639.8 4655.0 4854.4 4861.2 4881.2 10120.8 10135.0 10138.4 10153.1 10154.7 4296.3 5375.2 5379.8 5380.6 5396.0 4789.8 4900.6 4900.6 4932.8 4933.3 3931.8 3988.4 4025.8 4045.9 4102.6 1280.7 1296.2 1297.4 1309.6 1311.9 578.2 769.1 790.1 794.0 883.0 4650.4 5706.3 5962.9 6003.4 6148.9 857.2 897.0 900.8 902.8 907.2 3637.9 3821.2 3915.0 3962.2 3971.3 10441.0 10808.3 10963.2 11004.2 11005.8 10948.8 10952.8 10953.6 10954.7 10955.1 7840.4 8203.5 8255.9 8358.5 8369.5 5876.4 5917.5 5936.1 6012.6 6033.1 9786.3 9791.2 10218.7 10227.3 10297.4 9936.4 10289.1 10375.4 10468.8 10488.7 7582.5 7725.7 7742.4 7829.6 7833.2 8442.0 8498.4 8524.6 8529.7 8551.6 7388.7 7629.7 7646.5 7706.6 7781.1 7394.8 7440.6 7445.4 7474.1 7502.1 7039.8 7168.7 7171.0 7171.9 7181.9 4864.0 4926.7 4947.9 5051.1 5196.7 5043.8 5052.9 5080.7 5099.8 5188.0 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | [#4] prototype.html Cycles:180 Average:4526.62 Median:5082.83 stddev:1419.02 (27.9%) stddev-sans-first:1387.15 17:58:56 INFO - PROCESS | 2279 | Values: 303.7 314.1 315.1 320.7 326.4 5443.8 5507.9 5545.6 5561.0 5588.3 4577.0 4736.0 5062.8 5305.3 5352.4 3222.3 3347.4 4048.9 4094.3 4131.9 3417.0 4146.6 4147.5 4153.1 4176.7 3428.6 3805.3 4089.4 4097.3 4118.3 3380.0 4054.0 4067.6 4128.1 4159.6 3032.9 3387.2 3498.3 3500.5 3511.3 4323.8 4854.5 5198.2 5245.5 5295.8 3580.0 3889.6 4227.2 4649.0 4654.4 4717.9 5637.6 5642.3 5676.5 5726.6 3820.2 3842.6 3865.9 3885.7 3903.9 4519.8 4815.0 5401.3 5476.9 5569.0 3315.7 3701.7 3895.1 3901.5 3931.7 3488.5 3966.7 3983.6 3990.7 4014.2 4108.6 4545.0 4691.1 4721.4 4731.3 4615.6 4949.9 5720.2 5843.3 5886.6 1197.7 1320.6 1344.8 1347.8 1351.3 816.4 817.2 825.5 831.3 855.3 4392.8 5304.6 5346.6 5369.2 5524.7 5389.9 5836.5 5868.8 5881.7 5882.2 5102.8 5264.7 5325.5 5418.9 5515.7 2594.5 2745.7 2845.5 3076.4 3086.9 5799.6 5802.3 5949.7 6061.4 6093.6 5187.7 5607.2 5921.6 5963.4 5998.4 4506.0 5489.9 6021.7 6087.8 6138.9 4823.0 5039.3 5055.7 5308.9 5815.2 5276.0 5412.4 5699.7 5728.3 5759.5 5911.3 5951.1 6008.3 6023.6 6035.5 3756.8 3884.8 3892.5 3909.0 3920.5 5205.3 5836.0 5869.6 5916.8 5918.1 4467.5 4912.4 5397.8 5697.5 5789.8 5011.4 5514.8 5623.5 5658.7 5678.2 4483.0 4687.6 5536.2 5543.6 5550.1 5168.9 5208.2 5571.7 5603.7 5629.8 4993.3 5350.3 5595.0 5602.4 5622.5 17:58:56 INFO - PROCESS | 2279 | 17:58:56 INFO - PROCESS | 2279 | [#5] yui.html Cycles:180 Average:24967.66 Median:3663.31 stddev:39270.14 (1072.0%) stddev-sans-first:39338.03 17:58:56 INFO - PROCESS | 2279 | Values: 701.0 711.7 753.8 793.5 813.4 15535.2 16445.3 16499.8 16502.0 16515.3 14876.6 14938.7 14953.8 14964.5 14981.6 687.0 700.4 841.3 847.0 867.4 850.4 852.9 858.4 862.5 863.0 913.1 913.5 913.6 913.6 914.7 714.1 901.6 904.2 908.0 910.5 555.7 660.1 680.0 681.7 684.0 14652.3 14684.7 15118.3 15188.6 15507.8 13911.3 14256.3 14321.3 14335.8 14341.6 12323.5 12485.2 12602.1 12838.8 13328.1 3989.5 4636.1 4652.0 4824.0 4832.3 122899.0 131227.0 131296.3 131298.0 131719.0 10690.1 11017.8 11250.6 11272.3 11407.5 18697.3 21576.4 22492.1 23253.9 23402.8 7997.5 8074.1 8104.4 8159.6 8333.2 4414.4 4433.8 4526.6 4585.3 4660.4 3390.6 3523.9 3802.7 3921.7 3935.5 710.4 713.2 721.1 723.8 731.5 615.6 622.5 651.2 655.4 663.8 8828.4 9317.9 9489.3 9551.9 9634.0 629.8 650.7 664.8 682.6 697.9 4450.6 4875.6 4929.5 4945.4 5047.3 96399.5 97027.5 149395.0 151140.9 151233.0 120479.4 124084.0 125268.0 128161.0 128936.4 104425.0 108599.5 110607.9 111084.0 111880.0 8621.6 9826.2 9883.0 9916.6 10001.4 61245.7 61356.0 62125.1 62963.7 63459.7 90483.1 90558.0 93417.0 93969.1 96877.0 12852.8 12880.5 13085.1 13215.2 13456.0 14115.1 14444.3 14582.6 15146.0 15609.2 12338.0 12973.6 13439.6 13447.4 14115.6 13952.8 13988.4 14356.5 14582.8 14645.0 13639.7 13891.8 13893.0 14435.7 14483.6 10673.3 11114.8 11324.8 11718.9 11892.1 10634.7 11415.4 11450.9 11467.4 11709.9 17:58:56 INFO - PROCESS | 2279 | -------- Summary: end -------- 17:58:56 INFO - PROCESS | 2279 | 17:58:57 INFO - TEST-INFO | 2279: exit 0 17:58:57 INFO - TEST-OK | dromaeo_css | took 1117694ms 17:58:57 INFO - TEST-START | kraken 17:58:57 INFO - operating with platform_type : mac_ 17:58:57 INFO - Initialising browser for kraken test... 17:58:57 INFO - TEST-INFO | started process 2281 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpf9TT8h/profile http://localhost:55802/getInfo.html) 17:58:59 INFO - PROCESS | 2281 | __metrics Screen width/height:1600/1200 17:58:59 INFO - PROCESS | 2281 | colorDepth:24 17:58:59 INFO - PROCESS | 2281 | Browser inner width/height: 1024/689 17:58:59 INFO - PROCESS | 2281 | __metrics 17:58:59 INFO - PROCESS | 2281 | 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" 17:58:59 INFO - PROCESS | 2281 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:59:00 INFO - TEST-INFO | 2281: exit 0 17:59:00 INFO - Browser initialized. 17:59:00 INFO - Running cycle 1/1 for kraken test... 17:59:00 INFO - TEST-INFO | started process 2282 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmpf9TT8h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:59:12 INFO - PROCESS | 2282 | RSS: Main: 219955200 17:59:12 INFO - PROCESS | 2282 | 17:59:15 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-beat-detection) 17:59:16 INFO - PROCESS | 2282 | RSS: Main: 271679488 17:59:16 INFO - PROCESS | 2282 | 17:59:18 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-dft) 17:59:19 INFO - PROCESS | 2282 | RSS: Main: 283553792 17:59:19 INFO - PROCESS | 2282 | 17:59:22 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-fft) 17:59:23 INFO - PROCESS | 2282 | RSS: Main: 378019840 17:59:23 INFO - PROCESS | 2282 | 17:59:25 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-oscillator) 17:59:25 INFO - PROCESS | 2282 | RSS: Main: 281219072 17:59:25 INFO - PROCESS | 2282 | 17:59:27 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:59:28 INFO - PROCESS | 2282 | RSS: Main: 282062848 17:59:28 INFO - PROCESS | 2282 | 17:59:31 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-darkroom) 17:59:31 INFO - PROCESS | 2282 | RSS: Main: 319684608 17:59:31 INFO - PROCESS | 2282 | 17:59:34 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-desaturate) 17:59:35 INFO - PROCESS | 2282 | RSS: Main: 320172032 17:59:35 INFO - PROCESS | 2282 | 17:59:38 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55802/tests/kraken/driver.html?testName=json-parse-financial) 17:59:38 INFO - PROCESS | 2282 | RSS: Main: 318963712 17:59:38 INFO - PROCESS | 2282 | 17:59:40 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:59:41 INFO - PROCESS | 2282 | RSS: Main: 290013184 17:59:41 INFO - PROCESS | 2282 | 17:59:43 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:59:43 INFO - PROCESS | 2282 | RSS: Main: 294219776 17:59:43 INFO - PROCESS | 2282 | 17:59:45 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:59:46 INFO - PROCESS | 2282 | RSS: Main: 304238592 17:59:46 INFO - PROCESS | 2282 | 17:59:49 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:59:50 INFO - PROCESS | 2282 | RSS: Main: 306135040 17:59:50 INFO - PROCESS | 2282 | 17:59:53 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:59:53 INFO - PROCESS | 2282 | RSS: Main: 307740672 17:59:53 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55802/tests/kraken/driver.html?testName=ai-astar) 17:59:55 INFO - PROCESS | 2282 | RSS: Main: 351404032 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | __start_tp_report 17:59:55 INFO - PROCESS | 2282 | _x_x_mozilla_page_load 17:59:55 INFO - PROCESS | 2282 | _x_x_mozilla_page_load_details 17:59:55 INFO - PROCESS | 2282 | |i|pagename|runs| 17:59:55 INFO - PROCESS | 2282 | |0;ai-astar;114;114;113;120;165;155;112;113;111;113 17:59:55 INFO - PROCESS | 2282 | |1;audio-beat-detection;178;140;139;140;109;109;107;110;137;109 17:59:55 INFO - PROCESS | 2282 | |2;audio-dft;182;184;186;183;185;185;183;186;185;185 17:59:55 INFO - PROCESS | 2282 | |3;audio-fft;80;59;58;88;60;59;58;59;80;57 17:59:55 INFO - PROCESS | 2282 | |4;audio-oscillator;88;71;94;70;67;69;92;67;68;90 17:59:55 INFO - PROCESS | 2282 | |5;imaging-gaussian-blur;86;84;86;84;87;83;86;83;86;83 17:59:55 INFO - PROCESS | 2282 | |6;imaging-darkroom;143;93;92;93;92;120;93;92;93;103 17:59:55 INFO - PROCESS | 2282 | |7;imaging-desaturate;85;99;141;133;83;86;85;87;86;86 17:59:55 INFO - PROCESS | 2282 | |8;json-parse-financial;56;52;48;50;51;55;57;57;56;56 17:59:55 INFO - PROCESS | 2282 | |9;json-stringify-tinderbox;65;71;71;75;75;73;71;73;72;73 17:59:55 INFO - PROCESS | 2282 | |10;stanford-crypto-aes;83;85;85;82;84;82;84;89;87;112 17:59:55 INFO - PROCESS | 2282 | |11;stanford-crypto-ccm;138;135;137;134;138;136;134;137;156;157 17:59:55 INFO - PROCESS | 2282 | |12;stanford-crypto-pbkdf2;170;224;193;166;164;170;225;206;162;161 17:59:55 INFO - PROCESS | 2282 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;65;67;66;67;65 17:59:55 INFO - PROCESS | 2282 | __end_tp_report 17:59:55 INFO - PROCESS | 2282 | __start_cc_report 17:59:55 INFO - PROCESS | 2282 | _x_x_mozilla_cycle_collect,1988 17:59:55 INFO - PROCESS | 2282 | __end_cc_report 17:59:55 INFO - PROCESS | 2282 | __startTimestamp1475024395680__endTimestamp 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | ------- Summary: start ------- 17:59:55 INFO - PROCESS | 2282 | Number of tests: 14 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#0] ai-astar Cycles:10 Average:123.00 Median:114.00 stddev:19.79 (17.4%) stddev-sans-first:20.72 17:59:55 INFO - PROCESS | 2282 | Values: 114.0 114.0 113.0 120.0 165.0 155.0 112.0 113.0 111.0 113.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:138.00 stddev:23.18 (16.8%) stddev-sans-first:15.96 17:59:55 INFO - PROCESS | 2282 | Values: 178.0 140.0 139.0 140.0 109.0 109.0 107.0 110.0 137.0 109.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.35 (0.7%) stddev-sans-first:1.12 17:59:55 INFO - PROCESS | 2282 | Values: 182.0 184.0 186.0 183.0 185.0 185.0 183.0 186.0 185.0 185.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#3] audio-fft Cycles:10 Average:65.80 Median:59.50 stddev:11.87 (19.9%) stddev-sans-first:11.42 17:59:55 INFO - PROCESS | 2282 | Values: 80.0 59.0 58.0 88.0 60.0 59.0 58.0 59.0 80.0 57.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.50 stddev:11.69 (14.7%) stddev-sans-first:11.78 17:59:55 INFO - PROCESS | 2282 | Values: 88.0 71.0 94.0 70.0 67.0 69.0 92.0 67.0 68.0 90.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.58 17:59:55 INFO - PROCESS | 2282 | Values: 86.0 84.0 86.0 84.0 87.0 83.0 86.0 83.0 86.0 83.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:92.50 stddev:17.08 (18.5%) stddev-sans-first:9.38 17:59:55 INFO - PROCESS | 2282 | Values: 143.0 93.0 92.0 93.0 92.0 120.0 93.0 92.0 93.0 103.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:86.00 stddev:21.56 (25.1%) stddev-sans-first:22.42 17:59:55 INFO - PROCESS | 2282 | Values: 85.0 99.0 141.0 133.0 83.0 86.0 85.0 87.0 86.0 86.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:56.00 stddev:3.26 (5.8%) stddev-sans-first:3.36 17:59:55 INFO - PROCESS | 2282 | Values: 56.0 52.0 48.0 50.0 51.0 55.0 57.0 57.0 56.0 56.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:73.00 stddev:2.85 (3.9%) stddev-sans-first:1.58 17:59:55 INFO - PROCESS | 2282 | Values: 65.0 71.0 71.0 75.0 75.0 73.0 71.0 73.0 72.0 73.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.50 stddev:8.94 (10.6%) stddev-sans-first:9.35 17:59:55 INFO - PROCESS | 2282 | Values: 83.0 85.0 85.0 82.0 84.0 82.0 84.0 89.0 87.0 112.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:137.50 stddev:8.72 (6.3%) stddev-sans-first:9.21 17:59:55 INFO - PROCESS | 2282 | Values: 138.0 135.0 137.0 134.0 138.0 136.0 134.0 137.0 156.0 157.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.10 Median:181.50 stddev:25.77 (14.2%) stddev-sans-first:26.82 17:59:55 INFO - PROCESS | 2282 | Values: 170.0 224.0 193.0 166.0 164.0 170.0 225.0 206.0 162.0 161.0 17:59:55 INFO - PROCESS | 2282 | 17:59:55 INFO - PROCESS | 2282 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 17:59:55 INFO - PROCESS | 2282 | Values: 66.0 66.0 68.0 67.0 67.0 65.0 67.0 66.0 67.0 65.0 17:59:55 INFO - PROCESS | 2282 | -------- Summary: end -------- 17:59:55 INFO - PROCESS | 2282 | 17:59:56 INFO - TEST-INFO | 2282: exit 0 17:59:56 INFO - TEST-OK | kraken | took 59387ms 17:59:56 INFO - SUITE-END | took 1177s 17:59:56 INFO - Completed test suite (00:19:37) 17:59:56 INFO - javascript benchmark 17:59:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.390352784735, 3318.585176852894, 3342.1310459280594, 3377.864885404584, 3383.6108847482546, 5809.593328467009, 5825.766969321227, 5841.328247251557, 5859.355470898197, 5890.087036509342, 5737.770489180438, 5791.739371728272, 5832.154337621042, 5837.8832423351505, 5848.590598658096, 5218.8695282617955, 5273.393559740641, 5273.80537146843, 5312.893742125155, 5342.519173274404, 5233.502817232356, 5235.973820130894, 5251.343582052244, 5358.59810514211, 5362.43694412087, 5322.547583455411, 5332.386775520826, 5335.039692855285, 5338.786448542053, 5352.5182733553975, 5329.440408757064, 5329.493698098674, 5334.093204155264, 5334.1732031535175, 5345.037893179227, 5148.974255128738, 5275.261463395128, 5275.709835959021, 5291.126964050927, 5328.0, 5890.793822216202, 5897.852553686149, 5898.8820223595285, 5900.586958912878, 5926.436988486087, 6111.105587097678, 6120.8120562959275, 6145.293291271516, 6146.832101900669, 6160.907586386208, 6094.155344910546, 6131.10674721555, 6137.202163718688, 6138.664296166084, 6154.922888494496, 5816.1275808628625, 5869.8239052828485, 5896.204012458349, 5910.67491287979, 5926.822195334147, 6129.022607377628, 6156.815295541141, 6164.106204600308, 6208.037754148114, 6274.780382686584, 6100.48145907594, 6200.410960958701, 6201.534884883652, 6202.007678771375, 6203.596766210182, 6198.0, 6201.503879689614, 6220.533459990428, 6221.0, 6226.315105338409, 6091.305081214083, 6142.938570614237, 6149.2620885494025, 6160.10678451631, 6163.044728067157, 6113.841195312599, 6160.445559899541, 6182.6599537024995, 6187.84530386735, 6200.162977998003, 4868.95131048692, 4980.5019498049905, 4996.7001979881325, 4998.650094493423, 5008.624353173526, 4403.647708183337, 4446.466424029137, 4465.843695470708, 4473.7986790594505, 4474.32885067236, 5813.186153938452, 5858.238429004287, 5890.440408161217, 5948.256467941507, 5954.46409823118, 6188.659623720649, 6209.565330426827, 6211.81364559064, 6214.347493513116, 6214.564980451325, 5929.199558059693, 5941.31674857397, 5956.583039187215, 5967.9701601491715, 5996.970015149984, 4580.97709511457, 5278.551323137576, 5380.058489764276, 5406.78372865081, 5464.26232458613, 6294.71673774672, 6323.747050117944, 6390.233172019387, 6394.0, 6398.456131228898, 6185.536084793568, 6187.721552530057, 6187.81436556904, 6192.81421557354, 6199.659018754011, 5868.855573163192, 6187.504999600112, 6245.812625621239, 6312.905306420315, 6374.968125159345, 6110.4980065817745, 6124.014786914997, 6157.445829875153, 6193.752249909953, 6258.405451482102, 6285.214348206474, 6289.874202516015, 6308.842278943063, 6313.116163736989, 6314.368563143649, 6080.513558915188, 6082.3613520581475, 6121.051237058263, 6152.876942461216, 6165.229346331708, 5651.378348381592, 5882.176495290748, 6045.153678484928, 6063.272407311151, 6141.385861414002, 5943.613665111927, 5952.345242023461, 5979.4618484336615, 5989.2812862456785, 6025.728842202024, 6134.04922237054, 6149.323574406722, 6156.1381406604005, 6170.753169873155, 6184.474319682878, 5788.189653448605, 5831.562632802472, 5849.736761845812, 5897.233359663216, 5973.253343332083], "value": 5731.363072053197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.371831998562, 455.8290641009621, 464.47282334550283, 527.2223470381189, 532.8294945617403, 31466.213344666394, 42085.0, 43501.78249108754, 43516.0, 43641.0, 44629.77685111578, 44971.0, 45025.54974450255, 45073.7746311268, 45104.3234351485, 9825.950870245639, 10003.899571047179, 10007.29948903577, 10009.699709008704, 10062.295639305252, 9726.70819875405, 9844.064813842673, 9844.360116592434, 9854.211663066937, 9860.704178874645, 8480.660773569081, 9812.607495700164, 9849.359791613559, 9901.950490247575, 9902.05930436611, 9795.363301385423, 9860.260480463921, 9860.457674827881, 9861.0, 9886.9505652472, 9865.0, 9947.5026248688, 9982.201423886145, 9985.251106167067, 9994.550245238981, 42243.155136897396, 42666.78666606678, 42671.57328426707, 42693.78653106745, 42777.7166685, 3455.809930453824, 3511.4206155984234, 3512.8594856205723, 3777.433384992273, 3853.537575490931, 31421.528677069862, 32609.0, 32936.505952410735, 32951.50572741411, 33626.49560256598, 3260.8206548639814, 3270.411325961326, 3310.851011704455, 3332.683395077488, 3344.6989770920736, 518362.0, 520101.0, 521523.0, 521662.0, 522546.8726563657, 64332.0, 64721.0, 64758.676206618664, 64801.35198648048, 64894.67552662301, 35626.64373356285, 36219.818900905324, 36308.003059831964, 37543.62456375456, 37558.0, 17495.38766143179, 17624.647507050042, 17628.823711762976, 17654.205560749797, 17696.026718530346, 13260.0, 13322.267275299952, 13323.866761332263, 13358.866411335763, 13364.799528007088, 19692.40922772319, 20100.19599216015, 20122.89938550298, 20127.29554465616, 20209.49476263076, 7989.7203597873795, 8021.478603890845, 8026.5986700664735, 8069.556174410346, 8146.266835984671, 834.7871292820413, 978.7846673731767, 988.4350111460748, 998.3111652959435, 1087.9401632910267, 27151.91392344284, 29966.101016969526, 30991.070267892, 31319.90380336677, 31547.0, 850.4472093139385, 998.8463324859654, 1031.4069410089228, 1066.36018388966, 1166.8891455311732, 12988.220706757626, 13230.536931207362, 14816.481423150353, 16186.352545898033, 16321.347146114022, 701957.0, 758908.0, 759147.0, 995098.0, 998623.0068849609, 61187.0, 62082.37917620766, 62095.0, 62134.0, 62433.0, 1236.5548402575066, 1276.699975505774, 1277.0358379423476, 1278.0797825565764, 1382.592135320083, 25863.353416164748, 26981.0556630517, 32451.701931923402, 32862.675126220885, 34544.48183277303, 58911.41088589059, 59802.70098649479, 59823.812333136266, 59947.0, 59989.0, 593765.0, 602314.0, 602853.0, 603712.0, 603969.0, 43984.560154398045, 44726.10547789091, 45767.855803603845, 45872.0, 45926.0, 49606.0, 49863.00273994427, 50423.74788126183, 50554.241686374, 51860.70348241324, 39446.60553394429, 41595.1680966385, 42094.94958583797, 42338.57661423346, 42685.0, 40885.795571021954, 41020.79489602652, 41224.79387603043, 42301.36547951722, 42799.0, 33874.0, 34541.0, 34559.13602159966, 37921.2415751689, 40475.98810029773, 25210.0, 35654.64345356617, 36212.676035229866, 36820.0, 38152.42771358376, 26245.73754262433, 26613.20160395191, 26660.333491662088, 26664.866675666497, 27142.72857271481], "value": 20792.82109009996, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.81223453693246, 358.6503159419565, 371.7973704331138, 382.0982481344026, 404.1452328325592, 19865.60268794625, 19986.800131998676, 20149.29477468289, 20772.584548309045, 20935.267265645707, 19651.0, 20053.699194512094, 20277.69583456249, 20306.492337691565, 20411.183552657876, 4394.989152494928, 5300.681959082448, 5760.596758226936, 6049.971504844165, 6061.575689701723, 5838.21184140142, 5895.145203945425, 5969.403059694017, 5992.191054207669, 6025.849353766147, 5615.298087739033, 5894.292684877821, 5941.851453713649, 5970.402959704038, 5987.461128498434, 5478.698671573062, 5510.724463776815, 5910.586258961875, 5945.108233764927, 5960.433758792908, 4930.186519224324, 5073.8731531712, 5132.153194722903, 5141.460146684619, 5149.0989076911765, 25002.874985624956, 25067.37331566707, 25147.748522514725, 25157.0, 25410.491790164277, 2457.5576396248666, 2528.696556413224, 2850.315924178203, 3149.889753858604, 3202.407554602406, 15298.0, 15299.0, 15339.0, 15356.308966096552, 15773.68452630941, 1816.1191821966468, 1862.1341076399403, 1914.6457905287566, 1937.8255956963942, 1949.2592814730313, 85194.0, 102621.89512419494, 107925.38111928328, 129710.0, 132963.33518332348, 10558.736031599117, 10709.518071686636, 10829.566817327377, 10885.945570272099, 11012.559497620005, 13400.994925380635, 13402.664933376744, 13420.127691700009, 13426.865731342757, 13444.857187139007, 8272.545010024507, 8614.569271536398, 8639.870401943976, 8695.347848911357, 8714.0, 8757.649694012169, 8767.386282960259, 8774.0, 8926.910730892738, 8931.642734290686, 6390.329015453403, 6454.806355809239, 6510.609363438114, 6527.706253218616, 6610.636414997221, 1566.451741890352, 1828.168183476515, 1836.5583017331599, 1841.9539511512319, 1873.484791682271, 882.4925667741074, 939.736873675372, 949.5489642419795, 955.6798472511647, 1015.7816069545083, 20267.0, 21964.450888727908, 21967.890160549094, 21971.450713732283, 22007.339779806633, 973.8539219117189, 1012.3065699995526, 1023.2530252915413, 1042.5517027678172, 1044.4725413666201, 8752.862127923328, 10189.54147063369, 11606.651800446, 11623.941880290544, 11652.766944661229, 626948.8652556709, 627548.0, 637092.0, 651270.0, 656589.0, 71256.64371678108, 92341.0, 118996.0, 119856.0, 132842.33578832043, 849.3163003782015, 989.4508547756064, 993.9801203976025, 1008.9646862359929, 1012.6810054832704, 14950.925245373703, 17518.562035949202, 19399.127039283547, 19639.509012274808, 19647.607047858677, 55985.0, 57232.42767572271, 57950.84098318094, 58519.82960340854, 58873.0, 65449.01826472511, 79284.20715792768, 80034.199658005, 82911.5854420724, 83436.58281708552, 6111.5110791137495, 7271.0, 7580.886286705593, 7795.4543181976715, 8045.517268963881, 12603.684907877376, 13025.804612930624, 13247.006474514257, 13278.80081798793, 13430.925525958095, 11309.20835541537, 11364.829527557258, 11387.829182562102, 11660.53357865676, 11792.29246245228, 11128.610498632834, 11156.721081972692, 11282.323060616389, 11282.661520154408, 11342.0, 10595.258331916692, 10737.624183153552, 11307.0, 11420.885791141982, 11558.595449159238, 6815.454763618799, 7067.399271062018, 7245.818854528679, 7800.6099695016155, 7831.84336313282, 10658.62694805678, 10805.405702686428, 10947.20846184218, 11037.889621104008, 11238.55045798159], "value": 9711.196575026377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.3823832228784, 1524.3826250368602, 1715.322447633185, 1886.188938756336, 1899.3352326685663, 7913.129555748863, 8189.3857960652895, 8433.536155511452, 8984.685536006242, 9003.054679258681, 8101.513909165439, 8204.835903281932, 8209.850620913063, 8465.280451161658, 8707.216350528452, 2360.221127028081, 2398.4603464220586, 2399.8320117591775, 2406.085687438771, 2406.085687438771, 2362.5865473542062, 2380.75002124777, 2406.602910519762, 2412.3124909400826, 2416.3838221253554, 2050.1389416445127, 2120.936371908845, 2250.3024062540585, 2366.420227044368, 2391.2826152154285, 2029.725986991752, 2301.091069027733, 2351.5061837014246, 2351.5649604822993, 2355.4111472131967, 2172.706684597575, 2211.8672879627275, 2213.302809614966, 2214.5903007943584, 2215.1471683401846, 8923.464592124494, 8971.147740964598, 8980.96718877331, 8981.910180898172, 8986.955065224698, 5166.715830629314, 5392.164214546751, 5400.891982160335, 5408.378036525771, 5417.783288668448, 3568.571771387424, 3588.1747198144312, 3657.5428071491065, 3715.8327875245677, 3715.981420092909, 1107.9279846809932, 1109.7336639206612, 1115.397685249964, 1137.033521506721, 1141.1042331769604, 11772.117091218193, 11899.643010709606, 11919.582814601446, 11919.82120268188, 11928.165028448013, 4639.814407423665, 4654.953450465519, 4854.441739199967, 4861.246506791453, 4881.170201065827, 10120.797584048278, 10135.0, 10138.442385668859, 10153.086222240034, 10154.746131346628, 4296.3125899856495, 5375.19372094189, 5379.811706590329, 5380.596455265871, 5396.0, 4789.808407663724, 4900.583450406755, 4900.607951363882, 4932.827351042696, 4933.333999909966, 3931.8230679619487, 3988.4216788565495, 4025.765700036508, 4045.939310910339, 4102.630763231324, 1280.7438512297579, 1296.235221219485, 1297.3772589157256, 1309.594025851989, 1311.9016073794503, 578.2187921107436, 769.1078349114999, 790.115071120349, 793.9722109726132, 882.9558522073999, 4650.4186976627925, 5706.28671416073, 5962.880742385128, 6003.3996600339615, 6148.893199224182, 857.2327766648814, 897.0088052701801, 900.8153328567628, 902.7517432706059, 907.1835348186553, 3637.94543081854, 3821.216650586623, 3914.9608503915165, 3962.2471730371135, 3971.3447281198855, 10441.0, 10808.297460665031, 10963.232573719923, 11004.22970392081, 11005.834912476319, 10948.835767463494, 10952.835707464394, 10953.616623418142, 10954.699513102338, 10955.068819150301, 7840.41196910234, 8203.466774659628, 8255.917440825515, 8358.540280284522, 8369.539675317916, 5876.41235876409, 5917.526597872074, 5936.050231963038, 6012.5791194617705, 6033.064874944391, 9786.314957952874, 9791.216702663627, 10218.693439196539, 10227.28409011362, 10297.3821570706, 9936.354136981074, 10289.125424339016, 10375.429351385445, 10468.790624187626, 10488.68533943983, 7582.469227154046, 7725.690972361267, 7742.4193185510185, 7829.647665855164, 7833.177516360928, 8441.957790211256, 8498.447600905922, 8524.573771311534, 8529.701460448854, 8551.61517731716, 7388.712023149862, 7629.7329593463965, 7646.502977306457, 7706.614669266626, 7781.105172905189, 7394.7781566553085, 7440.627968601657, 7445.367143792621, 7474.065741782278, 7502.137254215617, 7039.788806335818, 7168.709632266242, 7170.96414517924, 7171.928280717126, 7181.892271615826, 4863.95136048635, 4926.729029903389, 4947.930851775023, 5051.116054690341, 5196.726801933551, 5043.823466178666, 5052.924206136838, 5080.669756465966, 5099.79600815978, 5187.974060129675], "value": 4599.218148308288, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.7463717795641, 314.1423912718278, 315.0501238765124, 320.7017473749415, 326.42549113560125, 5443.8496793766435, 5507.889842203159, 5545.639533430324, 5560.972195139018, 5588.329400471944, 4576.954230457694, 4735.976320118403, 5062.822801201959, 5305.310309659739, 5352.4477901408545, 3222.30720395115, 3347.380734564101, 4048.9270343359035, 4094.3008651409627, 4131.892734705307, 3417.0, 4146.6268035876765, 4147.543770185277, 4153.148604536078, 4176.728512646669, 3428.6228514863346, 3805.325656711052, 4089.386592011207, 4097.3239415496555, 4118.341065429532, 3380.0, 4053.97973010136, 4067.613576710208, 4128.091819799639, 4159.646430053449, 3032.8626764963137, 3387.2209391840015, 3498.2828520153307, 3500.457429098494, 3511.2801875615437, 4323.762193079379, 4854.49027852074, 5198.168293073128, 5245.527902488794, 5295.841124766263, 3580.0, 3889.6273273303264, 4227.182311606039, 4648.976755116203, 4654.417498050645, 4717.882052948669, 5637.605367624268, 5642.266505354319, 5676.489115979582, 5726.599138060337, 3820.1977584707247, 3842.634949679776, 3865.942010869839, 3885.669718073939, 3903.9264202344298, 4519.774011299488, 4815.0, 5401.297831281948, 5476.864023031021, 5568.99758043552, 3315.6684331567135, 3701.722370822199, 3895.0846551060476, 3901.51231096113, 3931.68546516278, 3488.5290485784603, 3966.682665386762, 3983.6016398359934, 3990.7206495545033, 4014.197160567898, 4108.630223279919, 4545.045540436546, 4691.085238378483, 4721.362616046858, 4731.313959475857, 4615.561521655437, 4949.935763810798, 5720.1991721159075, 5843.2695913010875, 5886.558508111909, 1197.6526807225807, 1320.5510126557017, 1344.7713888638955, 1347.7910923806826, 1351.3310911098872, 816.4366587054913, 817.2195553246635, 825.5459497276594, 831.264331066998, 855.268745222838, 4392.824287028547, 5304.575633949275, 5346.594032685307, 5369.24830523727, 5524.723763811793, 5389.892202156013, 5836.4747172753805, 5868.823935281948, 5881.676507792027, 5882.176495290662, 5102.846914592568, 5264.684118952875, 5325.4940780625775, 5418.91871621926, 5515.7242137893745, 2594.494073655619, 2745.68424631166, 2845.5020371434916, 3076.415481058592, 3086.891958781432, 5799.594028417971, 5802.274715660543, 5949.732262048218, 6061.363556826558, 6093.6039157454625, 5187.688738675692, 5607.243022191952, 5921.585489015813, 5963.403659634002, 5998.400159984054, 4505.954940450553, 5489.945100549024, 6021.668808215415, 6087.756489740449, 6138.943453942889, 4822.9758851206925, 5039.286642541553, 5055.6713813602, 5308.920366194433, 5815.244018277597, 5276.0, 5412.350517937873, 5699.7435115419075, 5728.283964504437, 5759.539236861125, 5911.3201981772645, 5951.095649392153, 6008.339082700812, 6023.578349515492, 6035.456808887046, 3756.812159391965, 3884.8251828668344, 3892.455056292065, 3909.0, 3920.5295364556437, 5205.297284866495, 5836.0, 5869.647821130575, 5916.792912248051, 5918.141869428995, 4467.530909254481, 4912.38595175603, 5397.842262276612, 5697.54419646419, 5789.8263052108505, 5011.437304591973, 5514.834554963358, 5623.522000629992, 5658.688772117573, 5678.20505129274, 4482.951592916847, 4687.601553867959, 5536.197251398444, 5543.560833233364, 5550.087188532156, 5168.870778230575, 5208.244804503402, 5571.66570005801, 5603.663780173202, 5629.802956896489, 4993.3259010034635, 5350.277712508761, 5595.0208713475795, 5602.411746766531, 5622.5381400836895], "value": 4076.0848910956156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9544379615324, 711.7153138744502, 753.781403393016, 793.5000949401878, 813.4387272781777, 15535.223238838069, 16445.342186312533, 16499.752503712454, 16502.0, 16515.339386424545, 14876.553703388916, 14938.701225975474, 14953.775693364609, 14964.476243331486, 14981.550553483386, 686.9690863911111, 700.4431476975816, 841.3395484544618, 847.0470720439506, 867.3668222197799, 850.4472093139447, 852.9445586036919, 858.3690987124459, 862.5428522882883, 863.0, 913.1325241021024, 913.4656226107735, 913.5980168725773, 913.6162811619103, 914.7072936660271, 714.1216303946176, 901.5582364641278, 904.1681652879366, 908.0238743350891, 910.5083255042302, 555.7193617223317, 660.1385192324016, 679.9626020568867, 681.6898311268361, 684.0457561701448, 14652.267386630625, 14684.70630587393, 15118.319675614624, 15188.620284492865, 15507.844921550866, 13911.304434778322, 14256.287185640676, 14321.283935803272, 14335.781458576033, 14341.641458963504, 12323.5070597176, 12485.188462749893, 12602.117851750381, 12838.80741788874, 13328.133671311334, 3989.4813674222455, 4636.072785442925, 4652.0, 4824.0, 4832.251001094836, 122899.0, 131227.0, 131296.34351828275, 131298.0, 131719.0, 10690.144788417063, 11017.83473247902, 11250.606228781953, 11272.323660580392, 11407.48666310018, 18697.252109915724, 21576.35270941874, 22492.100315987504, 23253.860728801395, 23402.7659723404, 7997.480163789335, 8074.071481779553, 8104.39217058723, 8159.551224682581, 8333.208345207195, 4414.381986521889, 4433.8226470941445, 4526.592606665416, 4585.312203169551, 4660.4174478190225, 3390.6100798408497, 3523.9119022024656, 3802.7147963902817, 3921.745086569364, 3935.4883865097354, 710.4387533848202, 713.2225873797586, 721.0842230367404, 723.8298999735058, 731.5464412064554, 615.6060121522229, 622.5455417545218, 651.2413038809829, 655.3822897605287, 663.7709990053423, 8828.382013259139, 9317.90682093184, 9489.335746497816, 9551.856722149174, 9633.951830240803, 629.8425393651587, 650.6584043377264, 664.7606861529846, 682.6484360554318, 697.9461013869094, 4450.577195166454, 4875.611450042186, 4929.531694489017, 4945.431275403303, 5047.293378926953, 96399.51800240955, 97027.51486242664, 149395.0, 151140.9315441077, 151233.0, 120479.39760301143, 124084.0, 125268.0, 128161.0, 128936.35531822468, 104425.0, 108599.45700271607, 110607.89392106138, 111084.0, 111880.0, 8621.568921554022, 9826.16477599412, 9883.0, 9916.553755080895, 10001.399916005063, 61245.69377153086, 61356.0, 62125.068123977275, 62963.6851815738, 63459.730805384555, 90483.09516904746, 90558.0, 93417.0, 93969.12061758863, 96877.0, 12852.807207892076, 12880.549180778627, 13085.149465285107, 13215.207087574776, 13456.0, 14115.082519636191, 14444.277786110863, 14582.635434114232, 15146.0, 15609.21953902323, 12338.0, 12973.610791676265, 13439.596812095653, 13447.394867230802, 14115.576532704035, 13952.790708139182, 13988.440462381392, 14356.497522587077, 14582.781258280922, 14644.974851760275, 13639.659008524866, 13891.791623125864, 13893.0, 14435.711285774016, 14483.637909052359, 10673.281431339416, 11114.760298171666, 11324.773504530029, 11718.945294923498, 11892.10809189297, 10634.73413164646, 11415.37215453158, 11450.885491144982, 11467.4266286687, 11709.882901170879], "value": 7997.272096720946, "unit": "score"}], "name": "dromaeo_css", "value": 7468.387124603956, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 120.0, 165.0, 155.0, 112.0, 113.0, 111.0, 113.0], "value": 123.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 140.0, 139.0, 140.0, 109.0, 109.0, 107.0, 110.0, 137.0, 109.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 186.0, 183.0, 185.0, 185.0, 183.0, 186.0, 185.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 60.0, 59.0, 58.0, 59.0, 80.0, 57.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 94.0, 70.0, 67.0, 69.0, 92.0, 67.0, 68.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 84.0, 87.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 93.0, 92.0, 93.0, 92.0, 120.0, 93.0, 92.0, 93.0, 103.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 99.0, 141.0, 133.0, 83.0, 86.0, 85.0, 87.0, 86.0, 86.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 48.0, 50.0, 51.0, 55.0, 57.0, 57.0, 56.0, 56.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 71.0, 75.0, 75.0, 73.0, 71.0, 73.0, 72.0, 73.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 82.0, 84.0, 82.0, 84.0, 89.0, 87.0, 112.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 137.0, 134.0, 138.0, 136.0, 134.0, 137.0, 156.0, 157.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 224.0, 193.0, 166.0, 164.0, 170.0, 225.0, 206.0, 162.0, 161.0], "value": 184.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 65.0, 67.0, 66.0, 67.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1465.6, "alertThreshold": 2.0}]} 17:59:56 INFO - Return code: 0 17:59:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:59:56 INFO - # TBPL SUCCESS # 17:59:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:57 INFO - 2016-09-27 17:59:57.006 screenresolution[2286:23232] starting screenresolution argv=screenresolution get 17:59:57 INFO - 2016-09-27 17:59:57.008 screenresolution[2286:23232] Display 0: 1600x1200x32@60 17:59:57 INFO - 2016-09-27 17:59:57.014 screenresolution[2287:23235] starting screenresolution argv=screenresolution list 17:59:57 INFO - Available Modes on Display 0 17:59:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:57 INFO - Intel Iris: 17:59:57 INFO - Chipset Model: Intel Iris 17:59:57 INFO - Type: GPU 17:59:57 INFO - Bus: Built-In 17:59:57 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:57 INFO - Vendor: Intel (0x8086) 17:59:57 INFO - Device ID: 0x0a2e 17:59:57 INFO - Revision ID: 0x0009 17:59:57 INFO - Displays: 17:59:57 INFO - Display: 17:59:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:57 INFO - Display Serial Number: 1600x1200 60 17:59:57 INFO - Main Display: Yes 17:59:57 INFO - Mirror: Off 17:59:57 INFO - Online: Yes 17:59:57 INFO - Rotation: Supported 17:59:57 INFO - Return code: 0 17:59:57 INFO - Running post-action listener: _resource_record_post_action 17:59:57 INFO - [mozharness: 2016-09-28 00:59:57.250024Z] Finished run-tests step (success) 17:59:57 INFO - Running post-run listener: _resource_record_post_run 17:59:57 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 233472; Write bytes: 662857728; Read time: 4; Write time: 1859 17:59:57 INFO - TinderboxPrint: CPU usage
53.4% 17:59:57 INFO - TinderboxPrint: I/O read bytes / time
233,472 / 4 17:59:57 INFO - TinderboxPrint: I/O write bytes / time
662,857,728 / 1,859 17:59:57 INFO - TinderboxPrint: CPU idle
2,256.6 (46.6%) 17:59:57 INFO - TinderboxPrint: CPU system
969.2 (20.0%) 17:59:57 INFO - TinderboxPrint: CPU user
1,615.9 (33.4%) 17:59:57 INFO - TinderboxPrint: Swap in / out
362,467,328 / 0 17:59:57 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 359868928; Write bytes: 356677120; Read time: 27617; Write time: 718 17:59:57 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 229376; Write bytes: 294949376; Read time: 3; Write time: 1101 17:59:57 INFO - Running post-run listener: _upload_blobber_files 17:59:57 INFO - Blob upload gear active. 17:59:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:57 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 17:59:57 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:59:57 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:59:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:58 INFO - (blobuploader) - INFO - Done attempting. 17:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:00 INFO - (blobuploader) - INFO - Done attempting. 18:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:05 INFO - (blobuploader) - INFO - Done attempting. 18:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 18:00:05 INFO - Return code: 0 18:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49d30bc6f1a556282125fadc6a90d2bfac988ef73ab11e8e038913d2ef5cbba3c13958c10cdc85fbc4d06884e020fed56a03115cd89bc4171306e36500c90c9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c4f74888a479de753f5feb2dead040a7ecfaa091e064291f21085d0df01304596b515dba71552552eb8966da3c41028ca917e764724749b324903be17b5d95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d4f217dbe8df9312454537476ec1d540109808c29ceafd6d9c6265ca52b4e4e0a1f84a3dec88cb9c2811d89b0150fd19918f1c9c5400943a657d7bd8f7fb46c"} 18:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:00:05 INFO - Contents: 18:00:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49d30bc6f1a556282125fadc6a90d2bfac988ef73ab11e8e038913d2ef5cbba3c13958c10cdc85fbc4d06884e020fed56a03115cd89bc4171306e36500c90c9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c4f74888a479de753f5feb2dead040a7ecfaa091e064291f21085d0df01304596b515dba71552552eb8966da3c41028ca917e764724749b324903be17b5d95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d4f217dbe8df9312454537476ec1d540109808c29ceafd6d9c6265ca52b4e4e0a1f84a3dec88cb9c2811d89b0150fd19918f1c9c5400943a657d7bd8f7fb46c"} 18:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 18:00:05 INFO - Copying logs to upload dir... 18:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 18:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.168292 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-27 18:00:05.229413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 18:00:05.238271) ========= 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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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/Mozilla-Aurora/sha512/49d30bc6f1a556282125fadc6a90d2bfac988ef73ab11e8e038913d2ef5cbba3c13958c10cdc85fbc4d06884e020fed56a03115cd89bc4171306e36500c90c9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c4f74888a479de753f5feb2dead040a7ecfaa091e064291f21085d0df01304596b515dba71552552eb8966da3c41028ca917e764724749b324903be17b5d95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d4f217dbe8df9312454537476ec1d540109808c29ceafd6d9c6265ca52b4e4e0a1f84a3dec88cb9c2811d89b0150fd19918f1c9c5400943a657d7bd8f7fb46c"} build_url:https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010729 build_url: 'https://queue.taskcluster.net/v1/task/Cdn-TfFpSFyG1heouN79Mg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49d30bc6f1a556282125fadc6a90d2bfac988ef73ab11e8e038913d2ef5cbba3c13958c10cdc85fbc4d06884e020fed56a03115cd89bc4171306e36500c90c9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c4f74888a479de753f5feb2dead040a7ecfaa091e064291f21085d0df01304596b515dba71552552eb8966da3c41028ca917e764724749b324903be17b5d95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d4f217dbe8df9312454537476ec1d540109808c29ceafd6d9c6265ca52b4e4e0a1f84a3dec88cb9c2811d89b0150fd19918f1c9c5400943a657d7bd8f7fb46c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 18:00:05.270563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:00:05.273941) ========= 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.5T1w5ymPnh/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.9RHWG40Qnc/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.005027 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 18:00:05.322632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 18:00:05.322981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 18:00:05.323292) ========= ========= Total master_lag: 2.51 =========