builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0249 starttime: 1480687090.46 results: success (0) buildid: 20161202031843 builduid: 5f75a08dc24e4cc5a7c2ed51e5c8e8a6 revision: 53644cbfaf329366b6a91a776ecac02b5ee97c88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.458403) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.458853) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.459133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.559618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.559963) ========= 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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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-12-02 05:58:10-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 204M=0s 2016-12-02 05:58:10 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124543 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.713461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.713990) ========= 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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.032625 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:10.770618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 05:58:10.770974) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 53644cbfaf329366b6a91a776ecac02b5ee97c88 --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-beta --rev 53644cbfaf329366b6a91a776ecac02b5ee97c88 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VNJOeZGji3/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.Y08jyGiQ0J/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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-12-02 05:58:10,883 truncating revision to first 12 chars 2016-12-02 05:58:10,883 Setting DEBUG logging. 2016-12-02 05:58:10,883 attempt 1/10 2016-12-02 05:58:10,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/53644cbfaf32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 05:58:11,655 unpacking tar archive at: mozilla-beta-53644cbfaf32/testing/mozharness/ program finished with exit code 0 elapsedTime=1.061993 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 05:58:11.876816) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:11.877093) ========= script_repo_revision: 53644cbfaf329366b6a91a776ecac02b5ee97c88 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:11.877495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:11.877779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 05:58:11.922119) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-02 05:58:11.922484) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VNJOeZGji3/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.Y08jyGiQ0J/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:58:12 INFO - MultiFileLogger online at 20161202 05:58:12 in /builds/slave/test 05:58:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:58:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:12 INFO - {'append_to_log': False, 05:58:12 INFO - 'base_work_dir': '/builds/slave/test', 05:58:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:58:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:12 INFO - 'branch': 'Mozilla-Beta', 05:58:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:12 INFO - 'config_files': ('talos/mac_config.py',), 05:58:12 INFO - 'default_actions': ('clobber', 05:58:12 INFO - 'read-buildbot-config', 05:58:12 INFO - 'download-and-extract', 05:58:12 INFO - 'populate-webroot', 05:58:12 INFO - 'create-virtualenv', 05:58:12 INFO - 'install', 05:58:12 INFO - 'run-tests'), 05:58:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:12 INFO - 'download_minidump_stackwalk': True, 05:58:12 INFO - 'download_symbols': 'ondemand', 05:58:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:12 INFO - 'installer_path': 'installer.exe', 05:58:12 INFO - 'log_level': 'info', 05:58:12 INFO - 'log_name': 'talos', 05:58:12 INFO - 'log_to_console': True, 05:58:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:58:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:58:12 INFO - 'opt_config_files': (), 05:58:12 INFO - 'pip_index': False, 05:58:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:58:12 INFO - 'cmd': ('bash', 05:58:12 INFO - '-c', 05:58:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:58:12 INFO - 'enabled': True, 05:58:12 INFO - 'halt_on_failure': False, 05:58:12 INFO - 'name': 'check_screen_resolution'},), 05:58:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:58:12 INFO - 'cmd': ('bash', 05:58:12 INFO - '-c', 05:58:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:58:12 INFO - 'enabled': True, 05:58:12 INFO - 'halt_on_failure': False, 05:58:12 INFO - 'name': 'check_screen_resolution'},), 05:58:12 INFO - 'run_cmd_checks_enabled': True, 05:58:12 INFO - 'sps_profile': False, 05:58:12 INFO - 'sps_profile_interval': 0, 05:58:12 INFO - 'suite': 'dromaeojs', 05:58:12 INFO - 'system_bits': '32', 05:58:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:12 INFO - 'title': 't-yosemite-r7-0249', 05:58:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:12 INFO - 'use_talos_json': True, 05:58:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:12 INFO - 'work_dir': 'build'} 05:58:12 INFO - [mozharness: 2016-12-02 13:58:12.129290Z] Running clobber step. 05:58:12 INFO - Running pre-action listener: _resource_record_pre_action 05:58:12 INFO - Running main action method: clobber 05:58:12 INFO - rmtree: /builds/slave/test/build 05:58:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:14 INFO - Running post-action listener: _resource_record_post_action 05:58:14 INFO - [mozharness: 2016-12-02 13:58:14.547569Z] Finished clobber step (success) 05:58:14 INFO - [mozharness: 2016-12-02 13:58:14.547812Z] Running read-buildbot-config step. 05:58:14 INFO - Running pre-action listener: _resource_record_pre_action 05:58:14 INFO - Running main action method: read_buildbot_config 05:58:14 INFO - Using buildbot properties: 05:58:14 INFO - { 05:58:14 INFO - "project": "", 05:58:14 INFO - "product": "firefox", 05:58:14 INFO - "script_repo_revision": "production", 05:58:14 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:58:14 INFO - "repository": "", 05:58:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:58:14 INFO - "buildid": "20161202031843", 05:58:14 INFO - "pgo_build": "False", 05:58:14 INFO - "basedir": "/builds/slave/test", 05:58:14 INFO - "buildnumber": 50, 05:58:14 INFO - "slavename": "t-yosemite-r7-0249", 05:58:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:58:14 INFO - "platform": "yosemite_r7", 05:58:14 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:58:14 INFO - "branch": "mozilla-beta", 05:58:14 INFO - "repo_path": "releases/mozilla-beta", 05:58:14 INFO - "revision": "53644cbfaf329366b6a91a776ecac02b5ee97c88", 05:58:14 INFO - "stage_platform": "macosx64", 05:58:14 INFO - "builduid": "5f75a08dc24e4cc5a7c2ed51e5c8e8a6", 05:58:14 INFO - "slavebuilddir": "test" 05:58:14 INFO - } 05:58:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 05:58:14 INFO - Running post-action listener: _resource_record_post_action 05:58:14 INFO - [mozharness: 2016-12-02 13:58:14.555229Z] Finished read-buildbot-config step (success) 05:58:14 INFO - [mozharness: 2016-12-02 13:58:14.555387Z] Running download-and-extract step. 05:58:14 INFO - Running pre-action listener: _resource_record_pre_action 05:58:14 INFO - Running main action method: download_and_extract 05:58:14 INFO - mkdir: /builds/slave/test/build/tests 05:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:14 INFO - trying https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 05:58:14 INFO - Downloading https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 05:58:15 INFO - Downloaded 1165 bytes. 05:58:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:58:15 INFO - Using the following test package requirements: 05:58:15 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:58:15 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:58:15 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 05:58:15 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:58:15 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 05:58:15 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:58:15 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:58:15 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 05:58:15 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:58:15 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:58:15 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 05:58:15 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:58:15 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 05:58:15 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:58:15 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 05:58:15 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:58:15 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 05:58:15 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 05:58:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:58:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:58:15 INFO - Fetch https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:58:16 INFO - Expected file size: 16233303 05:58:23 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:58:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:58:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:58:23 INFO - Fetch https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:58:23 INFO - Expected file size: 16233303 05:58:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 05:58:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 05:58:30 INFO - Fetch https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 05:58:31 INFO - Expected file size: 14414089 05:58: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')]} 05:58:31 INFO - trying https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:58:31 INFO - Downloading https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 05:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 05:58:33 INFO - Downloaded 86062614 bytes. 05:58:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:58:33 INFO - mkdir: /builds/slave/test/properties 05:58:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:33 INFO - Contents: 05:58:33 INFO - build_url:https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:58:34 INFO - Running post-action listener: _resource_record_post_action 05:58:34 INFO - Running post-action listener: set_extra_try_arguments 05:58:34 INFO - [mozharness: 2016-12-02 13:58:34.600473Z] Finished download-and-extract step (success) 05:58:34 INFO - [mozharness: 2016-12-02 13:58:34.600632Z] Running populate-webroot step. 05:58:34 INFO - Running pre-action listener: _resource_record_pre_action 05:58:34 INFO - Running main action method: populate_webroot 05:58:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:34 INFO - '--tppagecycles', 05:58:34 INFO - '7'], 05:58:34 INFO - 'tests': ['tsvgm']}}, 05:58:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['damp', 'tps']}, 05:58:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'tests': ['damp', 'tps']}, 05:58:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['dromaeo_dom']}, 05:58:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['basic_compositor_video']}, 05:58:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['a11yr', 05:58:34 INFO - 'ts_paint', 05:58:34 INFO - 'tpaint', 05:58:34 INFO - 'sessionrestore', 05:58:34 INFO - 'sessionrestore_no_auto_restore', 05:58:34 INFO - 'tabpaint']}, 05:58:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:34 INFO - 'ts_paint', 05:58:34 INFO - 'tpaint', 05:58:34 INFO - 'sessionrestore', 05:58:34 INFO - 'sessionrestore_no_auto_restore', 05:58:34 INFO - 'tabpaint']}, 05:58:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:34 INFO - 'ts_paint', 05:58:34 INFO - 'tpaint', 05:58:34 INFO - 'sessionrestore', 05:58:34 INFO - 'sessionrestore_no_auto_restore', 05:58:34 INFO - 'tabpaint']}, 05:58:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:34 INFO - 'ts_paint', 05:58:34 INFO - 'tpaint', 05:58:34 INFO - 'sessionrestore', 05:58:34 INFO - 'sessionrestore_no_auto_restore', 05:58:34 INFO - 'tabpaint']}, 05:58:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['a11yr', 05:58:34 INFO - 'ts_paint', 05:58:34 INFO - 'tpaint', 05:58:34 INFO - 'sessionrestore', 05:58:34 INFO - 'sessionrestore_no_auto_restore', 05:58:34 INFO - 'tabpaint']}, 05:58:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['a11yr', 05:58:34 INFO - 'ts_paint', 05:58:34 INFO - 'tpaint', 05:58:34 INFO - 'sessionrestore', 05:58:34 INFO - 'sessionrestore_no_auto_restore', 05:58:34 INFO - 'tabpaint']}, 05:58:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['tsvgx', 05:58:34 INFO - 'tsvgr_opacity', 05:58:34 INFO - 'tart', 05:58:34 INFO - 'tscrollx', 05:58:34 INFO - 'cart']}, 05:58:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:34 INFO - 'tsvgr_opacity', 05:58:34 INFO - 'tart', 05:58:34 INFO - 'tscrollx', 05:58:34 INFO - 'cart']}, 05:58:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'talos_options': ['--disable-e10s'], 05:58:34 INFO - 'tests': ['tp5o']}, 05:58:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'tests': ['tp5o']}, 05:58:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'talos_options': ['--disable-e10s', 05:58:34 INFO - '--xperf_path', 05:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:34 INFO - 'tests': ['tp5n']}, 05:58:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:34 INFO - 'talos_options': ['--xperf_path', 05:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:34 INFO - 'tests': ['tp5n']}}, 05:58:34 INFO - 'talos.zip': {'path': '', 05:58:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:34 INFO - Running post-action listener: _resource_record_post_action 05:58:34 INFO - [mozharness: 2016-12-02 13:58:34.619239Z] Finished populate-webroot step (success) 05:58:34 INFO - [mozharness: 2016-12-02 13:58:34.619342Z] Running create-virtualenv step. 05:58:34 INFO - Running pre-action listener: _resource_record_pre_action 05:58:34 INFO - Running main action method: create_virtualenv 05:58:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:58:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:34 INFO - Using real prefix '/tools/python27' 05:58:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:38 INFO - Installing pip.................done. 05:58:38 INFO - Return code: 0 05:58:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:38 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')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:58:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:38 INFO - 'HOME': '/Users/cltbld', 05:58:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PAGER': '/bin/cat', 05:58:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test', 05:58:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:58:38 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:58:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - 'XPC_FLAGS': '0x0', 05:58:38 INFO - 'XPC_SERVICE_NAME': '0', 05:58:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:58:38 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:38 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')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:58:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:38 INFO - 'HOME': '/Users/cltbld', 05:58:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PAGER': '/bin/cat', 05:58:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test', 05:58:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:58:38 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:58:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - 'XPC_FLAGS': '0x0', 05:58:38 INFO - 'XPC_SERVICE_NAME': '0', 05:58:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 INFO - Downloading/unpacking psutil>=3.1.1 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:42 INFO - Installing collected packages: psutil 05:58:42 INFO - Running setup.py install for psutil 05:58:42 INFO - building 'psutil._psutil_osx' extension 05:58:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:58:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:58:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:58:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:58:43 INFO - building 'psutil._psutil_posix' extension 05:58:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:58:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:58:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:58:43 INFO - ^ 05:58:43 INFO - 1 warning generated. 05:58:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:58:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:43 INFO - Successfully installed psutil 05:58:43 INFO - Cleaning up... 05:58:43 INFO - Return code: 0 05:58:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:43 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:43 INFO - 'HOME': '/Users/cltbld', 05:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:43 INFO - 'LOGNAME': 'cltbld', 05:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:43 INFO - 'MOZ_NO_REMOTE': '1', 05:58:43 INFO - 'NO_EM_RESTART': '1', 05:58:43 INFO - 'PAGER': '/bin/cat', 05:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:43 INFO - 'PWD': '/builds/slave/test', 05:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:43 INFO - 'SHELL': '/bin/bash', 05:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:58:43 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:43 INFO - 'USER': 'cltbld', 05:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:43 INFO - 'XPC_FLAGS': '0x0', 05:58:43 INFO - 'XPC_SERVICE_NAME': '0', 05:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:46 INFO - Installing collected packages: mozsystemmonitor 05:58:46 INFO - Running setup.py install for mozsystemmonitor 05:58:46 INFO - Successfully installed mozsystemmonitor 05:58:46 INFO - Cleaning up... 05:58:46 INFO - Return code: 0 05:58:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:58: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==2.5.1'] in /builds/slave/test/build 05:58: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==2.5.1 05:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:46 INFO - 'HOME': '/Users/cltbld', 05:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:46 INFO - 'LOGNAME': 'cltbld', 05:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:46 INFO - 'MOZ_NO_REMOTE': '1', 05:58:46 INFO - 'NO_EM_RESTART': '1', 05:58:46 INFO - 'PAGER': '/bin/cat', 05:58:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:46 INFO - 'PWD': '/builds/slave/test', 05:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:46 INFO - 'SHELL': '/bin/bash', 05:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:58:46 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:46 INFO - 'USER': 'cltbld', 05:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:46 INFO - 'XPC_FLAGS': '0x0', 05:58:46 INFO - 'XPC_SERVICE_NAME': '0', 05:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:50 INFO - warning: no files found matching '*.txt' 05:58:50 INFO - no previously-included directories found matching 'build' 05:58:50 INFO - no previously-included directories found matching 'dist' 05:58:50 INFO - no previously-included directories found matching '.git*' 05:58:50 INFO - Installing collected packages: jsonschema, functools32 05:58:50 INFO - Running setup.py install for functools32 05:58:50 INFO - warning: no files found matching '*.txt' 05:58:50 INFO - no previously-included directories found matching 'build' 05:58:50 INFO - no previously-included directories found matching 'dist' 05:58:50 INFO - no previously-included directories found matching '.git*' 05:58:50 INFO - Successfully installed jsonschema functools32 05:58:50 INFO - Cleaning up... 05:58:50 INFO - Return code: 0 05:58:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58:50 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')]} 05:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:50 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')]} 05:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:50 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:58:50 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 05:58:50 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 05:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:50 INFO - 'HOME': '/Users/cltbld', 05:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:50 INFO - 'LOGNAME': 'cltbld', 05:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:50 INFO - 'MOZ_NO_REMOTE': '1', 05:58:50 INFO - 'NO_EM_RESTART': '1', 05:58:50 INFO - 'PAGER': '/bin/cat', 05:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:50 INFO - 'PWD': '/builds/slave/test', 05:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:50 INFO - 'SHELL': '/bin/bash', 05:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:58:50 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:50 INFO - 'USER': 'cltbld', 05:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:50 INFO - 'XPC_FLAGS': '0x0', 05:58:50 INFO - 'XPC_SERVICE_NAME': '0', 05:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:50 INFO - Cleaning up... 05:58:50 INFO - Return code: 0 05:58:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:50 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')]} 05:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:50 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')]} 05:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:50 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:50 INFO - 'HOME': '/Users/cltbld', 05:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:50 INFO - 'LOGNAME': 'cltbld', 05:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:50 INFO - 'MOZ_NO_REMOTE': '1', 05:58:50 INFO - 'NO_EM_RESTART': '1', 05:58:50 INFO - 'PAGER': '/bin/cat', 05:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:50 INFO - 'PWD': '/builds/slave/test', 05:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:50 INFO - 'SHELL': '/bin/bash', 05:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:58:50 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:50 INFO - 'USER': 'cltbld', 05:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:50 INFO - 'XPC_FLAGS': '0x0', 05:58:50 INFO - 'XPC_SERVICE_NAME': '0', 05:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:54 INFO - Downloading docopt-0.6.1.tar.gz 05:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:54 INFO - Running setup.py install for blobuploader 05:58:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:55 INFO - Running setup.py install for requests 05:58:55 INFO - Running setup.py install for docopt 05:58:55 INFO - Successfully installed blobuploader requests docopt 05:58:55 INFO - Cleaning up... 05:58:55 INFO - Return code: 0 05:58:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:55 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')]} 05:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:55 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')]} 05:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:55 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:58:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:55 INFO - 'HOME': '/Users/cltbld', 05:58:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:55 INFO - 'LOGNAME': 'cltbld', 05:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:55 INFO - 'MOZ_NO_REMOTE': '1', 05:58:55 INFO - 'NO_EM_RESTART': '1', 05:58:55 INFO - 'PAGER': '/bin/cat', 05:58:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:55 INFO - 'PWD': '/builds/slave/test', 05:58:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:55 INFO - 'SHELL': '/bin/bash', 05:58:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:58:55 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:58:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:55 INFO - 'USER': 'cltbld', 05:58:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:55 INFO - 'XPC_FLAGS': '0x0', 05:58:55 INFO - 'XPC_SERVICE_NAME': '0', 05:58:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-uwleZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-hcZHbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-EsuZUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-VUM_Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-OIwApx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-YxeWN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ck8mo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ccdZ_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-xmd3ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-f2EWkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-UUN8s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-o7LQa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-R2GKxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-D90SXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-DFz_Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-XRkvGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-8JpvGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:57 INFO - Running setup.py install for manifestparser 05:58:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:58 INFO - Running setup.py install for mozcrash 05:58:58 INFO - Running setup.py install for mozdebug 05:58:58 INFO - Running setup.py install for mozdevice 05:58:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:58 INFO - Running setup.py install for mozfile 05:58:58 INFO - Running setup.py install for mozhttpd 05:58:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:58 INFO - Running setup.py install for mozinfo 05:58:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:58 INFO - Running setup.py install for mozInstall 05:58:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozleak 05:58:59 INFO - Running setup.py install for mozlog 05:58:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for moznetwork 05:58:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozprocess 05:58:59 INFO - Running setup.py install for mozprofile 05:58:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:59 INFO - Running setup.py install for mozrunner 05:59:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Running setup.py install for mozscreenshot 05:59:00 INFO - Running setup.py install for moztest 05:59:00 INFO - Running setup.py install for mozversion 05:59:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:00 INFO - Cleaning up... 05:59:00 INFO - Return code: 0 05:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:00 INFO - 'HOME': '/Users/cltbld', 05:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:00 INFO - 'LOGNAME': 'cltbld', 05:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:00 INFO - 'MOZ_NO_REMOTE': '1', 05:59:00 INFO - 'NO_EM_RESTART': '1', 05:59:00 INFO - 'PAGER': '/bin/cat', 05:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:00 INFO - 'PWD': '/builds/slave/test', 05:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:00 INFO - 'SHELL': '/bin/bash', 05:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:59:00 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:00 INFO - 'USER': 'cltbld', 05:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:00 INFO - 'XPC_FLAGS': '0x0', 05:59:00 INFO - 'XPC_SERVICE_NAME': '0', 05:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:00 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-KQ4buL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:00 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-SsPE_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-QQJ5qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-_Skc04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Sra4Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-SFz96j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-qHKs53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-EKGtz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-1bwLJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-FxbvlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:01 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)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-RyCivP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:01 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-CPSVYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:02 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)) 05:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-s9jsUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-i4ETxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:02 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)) 05:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-TjOkb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-QpD9LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:02 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-jjH0vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:05 INFO - Downloading blessings-1.6.tar.gz 05:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:05 INFO - Installing collected packages: blessings 05:59:05 INFO - Running setup.py install for blessings 05:59:05 INFO - Successfully installed blessings 05:59:05 INFO - Cleaning up... 05:59:05 INFO - Return code: 0 05:59:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:05 INFO - Reading from file tmpfile_stdout 05:59:05 INFO - Current package versions: 05:59:05 INFO - blessings == 1.6 05:59:05 INFO - blobuploader == 1.2.4 05:59:05 INFO - docopt == 0.6.1 05:59:05 INFO - functools32 == 3.2.3-2 05:59:05 INFO - jsonschema == 2.5.1 05:59:05 INFO - manifestparser == 1.1 05:59:05 INFO - mozInstall == 1.12 05:59:05 INFO - mozcrash == 0.17 05:59:05 INFO - mozdebug == 0.1 05:59:05 INFO - mozdevice == 0.48 05:59:05 INFO - mozfile == 1.2 05:59:05 INFO - mozhttpd == 0.7 05:59:05 INFO - mozinfo == 0.9 05:59:05 INFO - mozleak == 0.1 05:59:05 INFO - mozlog == 3.4 05:59:05 INFO - moznetwork == 0.27 05:59:05 INFO - mozprocess == 0.23 05:59:05 INFO - mozprofile == 0.28 05:59:05 INFO - mozrunner == 6.12 05:59:05 INFO - mozscreenshot == 0.1 05:59:05 INFO - mozsystemmonitor == 0.3 05:59:05 INFO - moztest == 0.7 05:59:05 INFO - mozversion == 1.4 05:59:05 INFO - psutil == 3.1.1 05:59:05 INFO - requests == 1.2.3 05:59:05 INFO - wsgiref == 0.1.2 05:59:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:05 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:59:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:05 INFO - 'HOME': '/Users/cltbld', 05:59:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:05 INFO - 'LOGNAME': 'cltbld', 05:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:05 INFO - 'MOZ_NO_REMOTE': '1', 05:59:05 INFO - 'NO_EM_RESTART': '1', 05:59:05 INFO - 'PAGER': '/bin/cat', 05:59:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:05 INFO - 'PWD': '/builds/slave/test', 05:59:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:05 INFO - 'SHELL': '/bin/bash', 05:59:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:59:05 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:59:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:05 INFO - 'USER': 'cltbld', 05:59:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:05 INFO - 'XPC_FLAGS': '0x0', 05:59:05 INFO - 'XPC_SERVICE_NAME': '0', 05:59:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:06 INFO - Cleaning up... 05:59:06 INFO - Return code: 0 05:59:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:06 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 0x109594490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10950a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c248c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, '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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:06 INFO - 'HOME': '/Users/cltbld', 05:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:06 INFO - 'LOGNAME': 'cltbld', 05:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:06 INFO - 'MOZ_NO_REMOTE': '1', 05:59:06 INFO - 'NO_EM_RESTART': '1', 05:59:06 INFO - 'PAGER': '/bin/cat', 05:59:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:06 INFO - 'PWD': '/builds/slave/test', 05:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:06 INFO - 'SHELL': '/bin/bash', 05:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:59:06 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:06 INFO - 'USER': 'cltbld', 05:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:06 INFO - 'XPC_FLAGS': '0x0', 05:59:06 INFO - 'XPC_SERVICE_NAME': '0', 05:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:59:06 INFO - Cleaning up... 05:59:06 INFO - Return code: 0 05:59:06 INFO - Running post-action listener: _resource_record_post_action 05:59:06 INFO - Running post-action listener: _start_resource_monitoring 05:59:06 INFO - Starting resource monitoring. 05:59:06 INFO - [mozharness: 2016-12-02 13:59:06.441820Z] Finished create-virtualenv step (success) 05:59:06 INFO - [mozharness: 2016-12-02 13:59:06.442829Z] Running install step. 05:59:06 INFO - Running pre-action listener: _resource_record_pre_action 05:59:06 INFO - Running main action method: install 05:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:06 INFO - Reading from file tmpfile_stdout 05:59:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:06 INFO - Reading from file tmpfile_stdout 05:59:06 INFO - Output received: 05:59:06 INFO - Usage: mozinstall [options] installer 05:59:06 INFO - Options: 05:59:06 INFO - -h, --help show this help message and exit 05:59:06 INFO - -d DEST, --destination=DEST 05:59:06 INFO - Directory to install application into. [default: 05:59:06 INFO - "/builds/slave/test"] 05:59:06 INFO - --app=APP Application being installed. [default: firefox] 05:59:06 INFO - mkdir: /builds/slave/test/build/application 05:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:59:29 INFO - Reading from file tmpfile_stdout 05:59:29 INFO - Output received: 05:59:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:59:29 INFO - Running post-action listener: _resource_record_post_action 05:59:29 INFO - [mozharness: 2016-12-02 13:59:29.034712Z] Finished install step (success) 05:59:29 INFO - [mozharness: 2016-12-02 13:59:29.034839Z] Running run-tests step. 05:59:29 INFO - Running pre-action listener: _resource_record_pre_action 05:59:29 INFO - Running main action method: run_tests 05:59:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:29 INFO - 2016-12-02 05:59:29.047 screenresolution[1635:8284] starting screenresolution argv=screenresolution get 05:59:29 INFO - 2016-12-02 05:59:29.050 screenresolution[1635:8284] Display 0: 1600x1200x32@60 05:59:29 INFO - 2016-12-02 05:59:29.055 screenresolution[1636:8287] starting screenresolution argv=screenresolution list 05:59:29 INFO - Available Modes on Display 0 05:59:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:29 INFO - Intel Iris: 05:59:29 INFO - Chipset Model: Intel Iris 05:59:29 INFO - Type: GPU 05:59:29 INFO - Bus: Built-In 05:59:29 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:29 INFO - Vendor: Intel (0x8086) 05:59:29 INFO - Device ID: 0x0a2e 05:59:29 INFO - Revision ID: 0x0009 05:59:29 INFO - Displays: 05:59:29 INFO - Display: 05:59:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:29 INFO - Display Serial Number: 1600x1200 60 05:59:29 INFO - Main Display: Yes 05:59:29 INFO - Mirror: Off 05:59:29 INFO - Online: Yes 05:59:29 INFO - Rotation: Supported 05:59:29 INFO - Return code: 0 05:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:29 INFO - Python 2.7.3 05:59:29 INFO - Return code: 0 05:59:29 INFO - grabbing minidump binary from tooltool 05:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:29 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 0x1093a8d30>, '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 0x10920edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093a0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:59:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:59:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:59:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:29 INFO - Return code: 0 05:59:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:59:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:59:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 05:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0249 --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 05:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNJOeZGji3/Render', 05:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:29 INFO - 'HOME': '/Users/cltbld', 05:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:29 INFO - 'LOGNAME': 'cltbld', 05:59:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:29 INFO - 'MOZ_NO_REMOTE': '1', 05:59:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:29 INFO - 'NO_EM_RESTART': '1', 05:59:29 INFO - 'PAGER': '/bin/cat', 05:59:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:29 INFO - 'PWD': '/builds/slave/test', 05:59:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:29 INFO - 'SHELL': '/bin/bash', 05:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y08jyGiQ0J/Listeners', 05:59:29 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 05:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:29 INFO - 'USER': 'cltbld', 05:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:29 INFO - 'XPC_FLAGS': '0x0', 05:59:29 INFO - 'XPC_SERVICE_NAME': '0', 05:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 05:59:29 INFO - mozversion application_buildid: 20161202031843 05:59:29 INFO - mozversion application_changeset: 53644cbfaf329366b6a91a776ecac02b5ee97c88 05:59:29 INFO - mozversion application_display_name: Firefox 05:59:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:29 INFO - mozversion application_name: Firefox 05:59:29 INFO - mozversion application_remotingname: firefox 05:59:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:29 INFO - mozversion application_vendor: Mozilla 05:59:29 INFO - mozversion application_version: 51.0 05:59:29 INFO - mozversion platform_buildid: 20161202031843 05:59:29 INFO - mozversion platform_changeset: 53644cbfaf329366b6a91a776ecac02b5ee97c88 05:59:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:29 INFO - mozversion platform_version: 51.0 05:59:29 INFO - using testdate: 1480687169 05:59:29 INFO - actual date: 1480687169 05:59:29 INFO - starting webserver on 'localhost:49243' 05:59:29 INFO - SUITE-START | Running 2 tests 05:59:29 INFO - TEST-START | dromaeo_css 05:59:29 INFO - operating with platform_type : mac_ 05:59:29 INFO - Initialising browser for dromaeo_css test... 05:59:29 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpCtEtcM/profile http://localhost:49243/getInfo.html) 05:59:32 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 05:59:32 INFO - PROCESS | 1646 | colorDepth:24 05:59:32 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 05:59:32 INFO - PROCESS | 1646 | __metrics 05:59:32 INFO - PROCESS | 1646 | 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" 05:59:32 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:32 INFO - TEST-INFO | 1646: exit 0 05:59:32 INFO - Browser initialized. 05:59:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:32 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpCtEtcM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:44 INFO - PROCESS | 1650 | RSS: Main: 168214528 05:59:44 INFO - PROCESS | 1650 | 06:00:35 INFO - PROCESS | 1650 | 1480687235946 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:02:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 06:02:49 INFO - PROCESS | 1650 | RSS: Main: 274538496 06:02:49 INFO - PROCESS | 1650 | 06:05:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 06:05:52 INFO - PROCESS | 1650 | RSS: Main: 299544576 06:05:52 INFO - PROCESS | 1650 | 06:08:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 06:08:55 INFO - PROCESS | 1650 | RSS: Main: 295837696 06:08:55 INFO - PROCESS | 1650 | 06:11:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 06:11:58 INFO - PROCESS | 1650 | RSS: Main: 264790016 06:11:58 INFO - PROCESS | 1650 | 06:15:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 06:15:02 INFO - PROCESS | 1650 | RSS: Main: 265125888 06:15:02 INFO - PROCESS | 1650 | 06:18:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 06:18:05 INFO - PROCESS | 1650 | RSS: Main: 569204736 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | __start_tp_report 06:18:05 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 06:18:05 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 06:18:05 INFO - PROCESS | 1650 | |i|pagename|runs| 06:18:05 INFO - PROCESS | 1650 | |0;dojo.html;3487.7907325560464;3487.9651203487965;3518.208403109299;3533.5406397168363;3553.3603951288774;5778.653280803144;5798.971005144974;5872.76508939643;5882.941170588293;5910.734016969236;5843.620164689292;5894.528437724983;5913.083472061827;5936.614120082191;5939.613925094865;5298.549623282026;5327.360716714;5339.22581225722;5373.489518495737;5448.019356515845;5272.446393128724;5332.306800115999;5420.295361602986;5441.319835020622;5446.754896029668;5003.624728145385;5314.495122963332;5377.569794416457;5382.865428364283;5383.757730902099;5351.892962140774;5372.57019438444;5383.703896285702;5427.864303392407;5435.320584926884;5315.946840531623;5369.5167434931045;5373.59698022646;5380.542653874425;5393.541548968343;5716.514096301819;5737.254156959611;5746.051901436258;5787.797427090031;5801.245838041028;6278.340774218733;6308.179936608258;6314.147590075327;6351.460125889305;6355.078513615546;6260.40526150015;6302.086197501337;6303.495720342407;6325.399087086719;6341.714622841983;5806.274215723035;5857.648541087548;5876.44173803488;5919.9936010878255;6002.879942401171;6389.488840892717;6437.9678101610125;6441.0982462455295;6444.420002199825;6445.4199122079235;6291.056341548713;6293.433590976742;6293.496520278367;6311.779087731908;6325.462335701425;6247.96876015617;6292.2134733158355;6301.464375528039;6367.331430199855;6381.489480841522;6342.841428964312;6346.873062538723;6366.427021568081;6376.7130479128555;6403.743850246031;6310.2743184534365;6361.650109243943;6365.427111559982;6377.7767778127545;6385.2337719473035;5019.196928491424;5029.622778291643;5062.949370506248;5139.408967968657;5174.353205849269;4522.095580883836;4580.106879158532;4582.610478109398;4587.1972404829685;4605.953940460619;5988.28140623128;5990.820275391745;6019.067044608093;6019.909701354396;6032.638041717511;6200.441960223601;6321.778737744249;6333;6334;6353.30113687494;4952.801887924515;5873.383294754075;5890.852728681817;5945.1973983512535;6035.396460354017;5574.972125139429;5598.608097433141;5600.991821472174;5603.047481928082;5606.990741666539;6487.3836985486305;6490.675466226669;6496.935030649633;6505.316941721146;6516.674166291572;5281.339832520935;6192.59748116389;6295.3389894060465;6324.1146239527425;6340.334264902303;6432.807015789534;6455.289918108911;6457.741690332522;6471.25580558223;6475.384838440341;6265.624062556261;6269.404406581368;6298.464630506458;6298.748050077946;6337.96831015842;6242.625442473466;6299.937000629935;6312.337204593635;6324.968375158279;6391.424771770563;6141.700809433325;6195.008798592204;6279.623222606659;6345.936540634534;6348.492120630246;6289.40250676185;6303.432691057827;6322.841928951629;6326.778562750282;6335.841603959753;5084.5932325414615;6011.819645410645;6050.697465126814;6179.1040299155475;6201.782937597162;6174.8147555573405;6227.283862355887;6250.3749625037135;6262.185915830913;6352.968235158794;6167.352427994996;6215.751369945152;6219.315875253628;6223.284322302993;6238.282597501164 06:18:05 INFO - PROCESS | 1650 | |1;ext.html;467.6656190823561;515.1474310016923;539.2746755613698;547.6549773642607;555.9666420014797;31908;33999.4900076499;41158.38262426062;42935.570644293584;44799.77600112003;43422.56577434225;43971.56028439714;43998.12003759923;44034.33948490775;44040.339394909104;9923.603055877757;10123.190144788436;10123.797524049514;10136.189104871593;10140.543675534582;9309.813803723955;9626.807463850719;12087.335196564185;12492.562760303392;12513.562025329114;12405.379731013458;12481.625551233477;12497.812532812015;12508.437120329607;12513.124081314312;12385.752284954295;12446.75106497874;12454.439550220217;12458.314792686399;12473.376331183405;12281.201721888048;12321.753564928651;12343.691407714789;12345.197562158432;12348.38258087092;41401.58598414037;41683;41738;41740.791296043324;41777.79111104456;3468.7398445116464;3539.3983022885914;3669.211119609297;3709.239605880788;3735.34631439497;30794;31575.210619734462;31946.520802187984;32813.507797383056;32995;3367.0572239772905;3368.8484018219237;3460.3598334308235;3471.930561388758;3518.964810351915;381048;381644;383875;384745;387124.0643796791;34880.82559587186;61863;62299.13102606929;62339.68830155911;62480.68759656173;35716.64283357185;36710.449343259876;37074.62925370766;37127.62872371296;37882;15939.203039847962;16002.199890005453;16055.19724013818;16070.276837542338;16073.437429690139;12431.813522797165;12651.493940242472;13434.798478022838;13556.59330220095;13562.050656453954;7866.646000929972;8063.758087257392;8106.39202059836;8118.472299300644;8181.263686268265;3298.5052242163865;3342.799432034086;3347.5313456116164;3356.110630682871;3387.6951074402928;856.8928883889514;1009.268280496634;1073.7798751255973;1093.868735751715;1114.6990312615549;30002.849985750367;30922.226944326572;31120;31332;31471;1118.949647265875;1137.5790957345835;1167.8423412839159;1173.3898372846243;1188.6731148933939;15466.226688665522;16124.032558046554;16224;16561.585960351087;16592.668146637243;694429;705031;718928;721537;1000272;60603;61176.694116529135;61241.69379153076;61474.692626536584;61502;1284.1973766395815;1315.6381994951464;1390.958271251864;1406.3249640172774;1430.2562667412888;25477.617835732108;31858;32556.02331930046;33254.83372583122;33501;57972;58777.824443511745;58792.70603646954;58844;59029.40970590239;630882;640431;640911;641729;642803;25114.748852511242;27661.861690691418;28282.010129645365;28495;28861.27846803847;47643.047139057715;48023.279650804565;48199.5180048195;48411.03177936492;48656.5134348652;38915.61084389233;39380.60619393884;40642.59357406388;41322.58677413307;41366;34921.47617785786;39787.2042559153;39898.00254993532;41091.1781764369;41194.58805411908;36450;38348;39336.803315983234;39693.60306396899;39695.2060958785;33517.66482335146;34725.47911781376;34860.651393486754;35344.469832953044;35358.64641353657;25953.351166220997;26044.609330859672;26110.825012874848;26290.98135554303;26559.33601659974 06:18:05 INFO - PROCESS | 1650 | |2;jquery.html;333.9549160863284;378.4852600463371;380.8857342797161;399.64431655826337;409.1101853468705;15841.366345346201;16710.7493387599;19859.602807943833;21820.563588728215;22119.004644790963;21277;21690;21918.89040554799;21928.561428771416;22170.11319547216;5971.671558064305;6312.33720459352;6325.1777268954975;6332.113504109406;6339.778107766229;4364.140794187804;5209.7134657593815;6223.968880155593;6352.428281454668;7077.292270772933;7069.8939515907305;7108.218096009435;7109.822254443655;7113.181984071821;7121.679524421414;5947.732352044147;6252.812415627515;6289.119523266723;6341.239051313826;6345.777897773556;5951.851203719898;6163.845903852395;6177.04255840341;6219.68901554925;6247.812565622993;13758.65603359914;13809.930950345284;13902;14007.64980875476;14008.0194386393;2226.6326056200705;2262.151693115082;2275.101334972693;2423.1397853761837;2501.2121181827665;10127.696169114864;10600.204984626183;10687.412192329419;10920.890791092066;14152.720658414839;1740.2082052666008;1921.8366438852715;1973.6052789442026;2015.1737787507052;2031.4515080928215;127967.36016319953;135297;135416.32291838477;138880.9167862483;141309;11389.974902258837;11552.075833933266;11857.229280096766;11883.821742673867;11903.464344104535;13608.115472494255;14203.431862725376;15283.159426231441;15306.923465382824;15356.692866142615;7840.745480723171;8561.743147705454;8679.739607811776;8947.821043579092;9233.584488698025;7496.475246732785;8176.83646327082;8366.03790564093;9005.729828105168;9037.63849446028;3849.7690138591774;3901.4342920276968;4544.681872268976;4652.32541281519;4714.528547145326;1899.4776436479801;1945;1948.386258328622;1961.7645882493907;1986.1459572384013;832.7281048222579;842.9325653947669;976.6874600127891;981.6073570571829;1007.4257673126394;22016.119355225932;22538.887305563367;22651.372006407335;22817.657735133987;22839.543209135725;942.6088173407959;958.8561715742694;977.9608815647294;984.389678399397;1062.2327696827597;11101.44492775358;11707.76584468306;11937.880621193677;11979.760404791856;12071;628265;633730;655186;669192;673072;141167;149060;149290.25354873156;150578;152039;1008.5965613754557;1046.4767616191905;1055.5777688924338;1062.654637242899;1063.2504084620325;19289.5177620555;20285.08717107704;20464.69302960427;20715.274965376742;20747.688784667942;54466.727666363;55079;55743.16385254143;55915.44084559102;57074.714626428264;79596.2040379612;80448;80675;82274.58862705648;82767.58616206881;7911.683532658629;7961.283484486193;7975.601219939096;8359.289460395934;8482.660693572188;9340.159385655325;10673.733156670834;12548.498060077494;13307.733845323233;13417.66455838612;11269.053774818689;11474.967252947275;11761.705957351134;11813.936745692929;11850.881491184979;11125.207280282602;11280.759116497344;11441.656750297505;11513.194076414571;11577.6526704199;11045;11498.94250528742;11531.077513798708;11587.768244635228;11707.414629268673;8043;8112.391570632109;8232.62953167121;8315.584220788814;8336.833263334578;7947.046354437504;10418.218633602359;11067.612633557786;11149.888501114885;11640.35978021217 06:18:05 INFO - PROCESS | 1650 | |3;mootools.html;1391.6660001599619;1548.2026756220546;1564.6714190020095;1766.9734953975685;1894.3653875951557;8023.719169829057;8561.315094792417;8572.485650860952;8572.485650860952;8580.056193818675;8668.566571671423;8983.371164018521;8987.685431009915;9101.863472047924;9117.407368521042;2122.416335507732;2362.9409264768346;2401.207601491508;2432.1973748662986;2436.4274395517127;2149.344449942767;2297.897009435472;2403.555342261687;2432.2703189043305;2433.1362366359954;2407.205622144688;2427.325145649505;2436.0012394918085;2442.743511931248;2443;2393.964090538643;2414.95170096598;2429.246933450636;2433.245693834917;2444;2402.783749462539;2429.149797570854;2436.780689737914;2437.171361737018;2438.37821355555;9010.189082982562;9197.126273004054;9205.861912071325;9209.079092090804;9218.631254749802;5390.056740070472;5435.864103397407;5575.163725441175;5625.987322281988;5627.915581266284;3678.2275722098393;3777.697784177259;3841.1741475582603;3841.2317536492815;3854.7879866607327;1112.2158877990996;1132.1678566253797;1146.9426528673532;1151.2804497189256;1154.8267759836008;12221.388930553525;12245.387730613524;12316.692082697915;12319.07606929475;12349.567765128177;4295.4415925929425;4334.371516130143;4620.168369693421;4811.254255590389;4814.759262036884;9479.526023698787;9484.383515071499;9488;9494.810103797885;9526.237900968044;5447.237386765856;5461.617686761889;5461.6996065216;5462.289902312674;5464.9453505465235;4088.856890008895;4239.745615263094;4621;4750.596199323097;5142.665726727751;3058.648255450607;3917.5298964123917;3960.34654282046;4026.8389264429093;4028.4158796974275;1180.5395895600723;1185.6739396665987;1189.4885199364358;1197.090211439295;1200.9339486328336;800.5276886636796;848.5502683577714;909.3589019741066;952.0812416018575;962.153305091515;5919.644821310735;6086.513078953673;6122.6938653068055;6147.784827531015;6301.873962520815;968.9370190937567;975.2003357247131;993.3940296419179;1024.7130803375067;1034.2088302448633;3834.9616503835164;3969.206158768258;4030.717849750489;4082.9591704083173;4086.8160932758096;10257;11190;11286.209965302514;11299.94350028261;11316.094712422986;11256.718582035352;11259.943700281447;11273.549058037586;11287.266327688674;11329.09367250618;8174.67301307941;8516;8543.188397102265;8632.223099921162;8635.913640863511;6067.302260239952;6088.330283668704;6174.598651087665;6264.843378915563;6419.390157934989;10250.948745256524;10288.228382871464;10393.896061039293;10528.105111065644;10556.366618002638;9669.98465161148;10677.039066484054;10684.519196636014;10693.625723099654;10710.303830251009;7151.2848715128075;7408.9629551851895;7683.884741728767;7786.143524212219;7878.881816772868;8575.31397488187;8621.82756344857;8627.568621568771;8670.653173873226;8717.564121794012;7774.883376749466;7782.182870798485;7787.182828212535;7881.448298619041;7954.880676789737;7585.279398457138;7611.581363025087;7632.045994250719;7646.273604007611;7663.233676632292;7191.17301510333;7201.531900426456;7247.2390399007345;7337.889931650922;7343.228960959236;5069.5944324454695;5099.107656160231;5102.821401250939;5172.508611681884;5178;4975.701457912537;5011.473795251446;5164;5280.735963201748;5305.628605997543 06:18:05 INFO - PROCESS | 1650 | |4;prototype.html;264.4816160325762;305.76761661137533;310.45205212799414;318.7577441144731;320.7161661929195;4018.8995275118136;5380.24676545284;5385.7576409061585;5386.676799392039;5401.216823560581;5332.253484512162;5385.515303622673;5395.541378982791;5403.540699040576;5420.214068959998;3259.8044117353033;3654.5797233318176;3986.940195897064;4076.5923407659293;4171.186618609372;3396.507506411569;4188.853390131346;4211.305134652778;4218;4228.851990180345;3437.4156393413055;4154.937675934848;4166.666666666674;4172.70791044627;4191.958080419187;3153.9684603153905;3997.9805149686936;4094.7952602369764;4164.229617520753;4220.620144187023;2858.6712528059124;2991.2970451943775;3098.7140336760217;3355.1779813945495;3560.537130173087;4372.366006928977;5311.548518375943;5325.281087053237;5327.547158491533;5352.652077614943;3819.9304194825495;4682.705474317594;4683.782216623668;4696.379748986594;4696.882577935545;4921.975390123026;5034.874128146826;5655.915161272585;5711.4579063653;5752.654840709571;3896.3181443247317;3909.2963266612;3912.765234085964;3921.940980985006;3933.8623148189963;5767.961766881959;5856.736446859902;5997.850053748648;6042.939570604326;6101.481374083208;3457.8098204598987;3746.4380342948775;3853.6339047790416;3973.304671682444;3980.263651224475;3384.526166336715;4008.6392224699916;4010.6590939769862;4019.638232559084;4027.9930017495626;4689.601383882408;4689.929651055237;4694.084653492604;4704.435467743892;4710.175719249186;5318.70747108905;5726.455986681259;5754.482096611325;5797.246357973437;5848.678322692293;1169.316184694038;1230.3971054183385;1242.5837344489696;1278.5844600504872;1365.0581099041628;680.9727610895608;769.819092513259;780.2236774409386;795.9442839001214;834.4200780457523;5252.185911183773;5304.814331498456;5348.1442969124755;5388.784448622089;5558.416366281563;4974.5771609413605;5913.29040515141;5964.7315870785915;5976.910346344808;6017.969910150421;4397.890052748707;4683.5082316356975;4738.483685220696;5430.755615997289;5451.781928722886;2638.5092422781067;3002.8648710808066;3040.361524079968;3101;3108.0885255567664;5327.86680332987;5480.561555075585;5882.55880808941;6148.200733904564;6149.723262453201;5283.735813209324;5734.455226753452;5812.593118481665;5855.765769369177;6049.637021778707;5924.377940316291;5998.310194327708;6051.576389652682;6098.5426093042315;6100.511959043266;4942.629302802232;5105.566026887756;5223.712695801615;5460.232439616651;5939.732712027882;4964.429090654477;5280.3630874429045;5611.80358687444;5790.218320526675;5790.392008839011;5066.9239961401345;5291.3385826771655;5974.833338330692;6118.388161183846;6122.602030867979;3117.846396833186;3463.290025544707;3477.287156133037;3663.2856592964117;3920.9805450582485;5057.115004874058;5358.6871216550635;5383.946160538345;5390.110631745875;5844.357120716632;4781.235002399739;5239.476052394883;5690.743916523684;5702.173184888251;5793.652380857162;5285.497877701612;5400.216968539618;5702.7718891243885;5723.570732195185;5741.942580574141;4622.791974361095;4979.751012449291;5562.99330602461;5599.636023658449;5609.382967873612;4655.674102812771;5633.802816901552;5638.718064096696;5687.43125687428;5772.711364431678;4263.424437700871;5168.767405466839;5418.322709661293;5463.7814487420055;5625.043742563856 06:18:05 INFO - PROCESS | 1650 | |5;yui.html;711.6121713666055;748.2966011948768;764.5221736414741;797.4975765267881;819.2954059508824;15940.920295398535;17081.57296067599;17094.401695940644;17112.486625401227;17182.14089295535;15139.167345795977;15203.467878624251;15211.315490802912;15244.466443674473;15262.694746105099;704.8555046215539;722.238038868993;723.3345322303467;859.6174702257466;869.9130086991298;869.7347309070731;874.8600223964168;878.8725634782985;881.6693739847557;882.2192359761625;938.249400479617;939.0187254319219;940.2571968145157;940.534435454451;940.802431489388;932.7248461703746;932.827426926014;933.9866245124049;934.8223837470858;935.5415846235296;692.6225207262054;693.0574418790492;693.2582137113291;693.4521727835004;695.4957655699628;16250;16391.180440977903;16427.01437913729;16432.424865129662;16458.83541164585;13759.312034398341;13843.515476958359;13917.930410347984;14038;14188.787168192486;13488;13881.583552493441;14029.859701402956;14069.437222511087;14159.079659822182;4680;4684.484706682262;4767.570918617341;4867.36724225852;4952.579030782352;126029;131071;133973;140534.5946540532;141286;11157.94421027906;11176.608818691308;11385.715357116138;11482.59810906631;12001.459934302977;22102.22642207515;22115.557688846133;22116;22128;22130.336089917007;8009.839803203903;8028.11690714021;8139.430239883151;8499.150084991452;8507.574621268912;4538.160440318552;4585.95414045862;4697.671163018625;4777.116233496745;4839.080574690797;3574.160072382988;3654.0682126057686;3680.9263814723554;3681.0981309579324;3681.834317455721;641.3137942401679;673.0409166937095;694.4513834071028;713.9678714457862;742.38011260598;553.382977979558;578.5776383240258;578.9507891829157;612.7365232949785;668.3350066683681;9954.303198776017;10076.74808129788;10175.542100605491;10200;10217.846732299022;676.8088164829935;704.7145905908116;707.3527722134293;721.9350258476762;730.4047201530842;4719.85840424781;4869.123557759637;4883.609311255091;4885.65800393969;4937.925931111036;137111;174696;176395;176537.23462765207;179299.10350448164;97187;113125;129055;154849;158021.2098939498;126602.73397266094;128853.35573322073;129756.3512182452;132265;132873;9330.206932410822;9384.34309598349;9389.342746007715;9410.29422793307;9428.387154834914;63929.68035159794;66398.66800665966;68908.31091689019;70384;71223.28776712167;80465.79301310368;101164;102923;108126.45936770266;108829.45585272023;12134.635960921187;12758;13886.861131388558;14083.577492675236;14253.572392828231;15147.166905820286;15175.392984280947;15970.121643309729;16265.59336016609;16366.672666546365;14447.060941038799;14616.707665846836;14702;15521.39873185321;15791.605209869846;14167.64580885486;14200.644983875485;15318.157501337533;15706.136162510715;15852.286647101138;14198;14720.705585888008;15023.759476394971;15144.242787860783;15459.227038647798;11305.547778088785;12046.75906481883;12234.510619575472;12344.876551234373;12445.564405245774;8040.83918321642;10064.345817521838;11129.443527823414;11867.881321186678;12557.87442125567 06:18:05 INFO - PROCESS | 1650 | __end_tp_report 06:18:05 INFO - PROCESS | 1650 | __start_cc_report 06:18:05 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1434 06:18:05 INFO - PROCESS | 1650 | __end_cc_report 06:18:05 INFO - PROCESS | 1650 | __startTimestamp1480688285126__endTimestamp 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | ------- Summary: start ------- 06:18:05 INFO - PROCESS | 1650 | Number of tests: 6 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5880.03 Median:6179.10 stddev:639.08 (10.3%) stddev-sans-first:612.87 06:18:05 INFO - PROCESS | 1650 | Values: 3487.8 3488.0 3518.2 3533.5 3553.4 5778.7 5799.0 5872.8 5882.9 5910.7 5843.6 5894.5 5913.1 5936.6 5939.6 5298.5 5327.4 5339.2 5373.5 5448.0 5272.4 5332.3 5420.3 5441.3 5446.8 5003.6 5314.5 5377.6 5382.9 5383.8 5351.9 5372.6 5383.7 5427.9 5435.3 5315.9 5369.5 5373.6 5380.5 5393.5 5716.5 5737.3 5746.1 5787.8 5801.2 6278.3 6308.2 6314.1 6351.5 6355.1 6260.4 6302.1 6303.5 6325.4 6341.7 5806.3 5857.6 5876.4 5920.0 6002.9 6389.5 6438.0 6441.1 6444.4 6445.4 6291.1 6293.4 6293.5 6311.8 6325.5 6248.0 6292.2 6301.5 6367.3 6381.5 6342.8 6346.9 6366.4 6376.7 6403.7 6310.3 6361.7 6365.4 6377.8 6385.2 5019.2 5029.6 5062.9 5139.4 5174.4 4522.1 4580.1 4582.6 4587.2 4606.0 5988.3 5990.8 6019.1 6019.9 6032.6 6200.4 6321.8 6333.0 6334.0 6353.3 4952.8 5873.4 5890.9 5945.2 6035.4 5575.0 5598.6 5601.0 5603.0 5607.0 6487.4 6490.7 6496.9 6505.3 6516.7 5281.3 6192.6 6295.3 6324.1 6340.3 6432.8 6455.3 6457.7 6471.3 6475.4 6265.6 6269.4 6298.5 6298.7 6338.0 6242.6 6299.9 6312.3 6325.0 6391.4 6141.7 6195.0 6279.6 6345.9 6348.5 6289.4 6303.4 6322.8 6326.8 6335.8 5084.6 6011.8 6050.7 6179.1 6201.8 6174.8 6227.3 6250.4 6262.2 6353.0 6167.4 6215.8 6219.3 6223.3 6238.3 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:72365.66 Median:34793.07 stddev:167313.91 (480.9%) stddev-sans-first:167696.18 06:18:05 INFO - PROCESS | 1650 | Values: 467.7 515.1 539.3 547.7 556.0 31908.0 33999.5 41158.4 42935.6 44799.8 43422.6 43971.6 43998.1 44034.3 44040.3 9923.6 10123.2 10123.8 10136.2 10140.5 9309.8 9626.8 12087.3 12492.6 12513.6 12405.4 12481.6 12497.8 12508.4 12513.1 12385.8 12446.8 12454.4 12458.3 12473.4 12281.2 12321.8 12343.7 12345.2 12348.4 41401.6 41683.0 41738.0 41740.8 41777.8 3468.7 3539.4 3669.2 3709.2 3735.3 30794.0 31575.2 31946.5 32813.5 32995.0 3367.1 3368.8 3460.4 3471.9 3519.0 381048.0 381644.0 383875.0 384745.0 387124.1 34880.8 61863.0 62299.1 62339.7 62480.7 35716.6 36710.4 37074.6 37127.6 37882.0 15939.2 16002.2 16055.2 16070.3 16073.4 12431.8 12651.5 13434.8 13556.6 13562.1 7866.6 8063.8 8106.4 8118.5 8181.3 3298.5 3342.8 3347.5 3356.1 3387.7 856.9 1009.3 1073.8 1093.9 1114.7 30002.8 30922.2 31120.0 31332.0 31471.0 1118.9 1137.6 1167.8 1173.4 1188.7 15466.2 16124.0 16224.0 16561.6 16592.7 694429.0 705031.0 718928.0 721537.0 1000272.0 60603.0 61176.7 61241.7 61474.7 61502.0 1284.2 1315.6 1391.0 1406.3 1430.3 25477.6 31858.0 32556.0 33254.8 33501.0 57972.0 58777.8 58792.7 58844.0 59029.4 630882.0 640431.0 640911.0 641729.0 642803.0 25114.7 27661.9 28282.0 28495.0 28861.3 47643.0 48023.3 48199.5 48411.0 48656.5 38915.6 39380.6 40642.6 41322.6 41366.0 34921.5 39787.2 39898.0 41091.2 41194.6 36450.0 38348.0 39336.8 39693.6 39695.2 33517.7 34725.5 34860.7 35344.5 35358.6 25953.4 26044.6 26110.8 26291.0 26559.3 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:37665.70 Median:12198.37 stddev:109360.71 (896.5%) stddev-sans-first:109631.57 06:18:05 INFO - PROCESS | 1650 | Values: 334.0 378.5 380.9 399.6 409.1 15841.4 16710.7 19859.6 21820.6 22119.0 21277.0 21690.0 21918.9 21928.6 22170.1 5971.7 6312.3 6325.2 6332.1 6339.8 4364.1 5209.7 6224.0 6352.4 7077.3 7069.9 7108.2 7109.8 7113.2 7121.7 5947.7 6252.8 6289.1 6341.2 6345.8 5951.9 6163.8 6177.0 6219.7 6247.8 13758.7 13809.9 13902.0 14007.6 14008.0 2226.6 2262.2 2275.1 2423.1 2501.2 10127.7 10600.2 10687.4 10920.9 14152.7 1740.2 1921.8 1973.6 2015.2 2031.5 127967.4 135297.0 135416.3 138880.9 141309.0 11390.0 11552.1 11857.2 11883.8 11903.5 13608.1 14203.4 15283.2 15306.9 15356.7 7840.7 8561.7 8679.7 8947.8 9233.6 7496.5 8176.8 8366.0 9005.7 9037.6 3849.8 3901.4 4544.7 4652.3 4714.5 1899.5 1945.0 1948.4 1961.8 1986.1 832.7 842.9 976.7 981.6 1007.4 22016.1 22538.9 22651.4 22817.7 22839.5 942.6 958.9 978.0 984.4 1062.2 11101.4 11707.8 11937.9 11979.8 12071.0 628265.0 633730.0 655186.0 669192.0 673072.0 141167.0 149060.0 149290.3 150578.0 152039.0 1008.6 1046.5 1055.6 1062.7 1063.3 19289.5 20285.1 20464.7 20715.3 20747.7 54466.7 55079.0 55743.2 55915.4 57074.7 79596.2 80448.0 80675.0 82274.6 82767.6 7911.7 7961.3 7975.6 8359.3 8482.7 9340.2 10673.7 12548.5 13307.7 13417.7 11269.1 11475.0 11761.7 11813.9 11850.9 11125.2 11280.8 11441.7 11513.2 11577.7 11045.0 11498.9 11531.1 11587.8 11707.4 8043.0 8112.4 8232.6 8315.6 8336.8 7947.0 10418.2 11067.6 11149.9 11640.4 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5867.75 Median:4993.59 stddev:3322.79 (66.5%) stddev-sans-first:3315.08 06:18:05 INFO - PROCESS | 1650 | Values: 1391.7 1548.2 1564.7 1767.0 1894.4 8023.7 8561.3 8572.5 8572.5 8580.1 8668.6 8983.4 8987.7 9101.9 9117.4 2122.4 2362.9 2401.2 2432.2 2436.4 2149.3 2297.9 2403.6 2432.3 2433.1 2407.2 2427.3 2436.0 2442.7 2443.0 2394.0 2415.0 2429.2 2433.2 2444.0 2402.8 2429.1 2436.8 2437.2 2438.4 9010.2 9197.1 9205.9 9209.1 9218.6 5390.1 5435.9 5575.2 5626.0 5627.9 3678.2 3777.7 3841.2 3841.2 3854.8 1112.2 1132.2 1146.9 1151.3 1154.8 12221.4 12245.4 12316.7 12319.1 12349.6 4295.4 4334.4 4620.2 4811.3 4814.8 9479.5 9484.4 9488.0 9494.8 9526.2 5447.2 5461.6 5461.7 5462.3 5464.9 4088.9 4239.7 4621.0 4750.6 5142.7 3058.6 3917.5 3960.3 4026.8 4028.4 1180.5 1185.7 1189.5 1197.1 1200.9 800.5 848.6 909.4 952.1 962.2 5919.6 6086.5 6122.7 6147.8 6301.9 968.9 975.2 993.4 1024.7 1034.2 3835.0 3969.2 4030.7 4083.0 4086.8 10257.0 11190.0 11286.2 11299.9 11316.1 11256.7 11259.9 11273.5 11287.3 11329.1 8174.7 8516.0 8543.2 8632.2 8635.9 6067.3 6088.3 6174.6 6264.8 6419.4 10250.9 10288.2 10393.9 10528.1 10556.4 9670.0 10677.0 10684.5 10693.6 10710.3 7151.3 7409.0 7683.9 7786.1 7878.9 8575.3 8621.8 8627.6 8670.7 8717.6 7774.9 7782.2 7787.2 7881.4 7954.9 7585.3 7611.6 7632.0 7646.3 7663.2 7191.2 7201.5 7247.2 7337.9 7343.2 5069.6 5099.1 5102.8 5172.5 5178.0 4975.7 5011.5 5164.0 5280.7 5305.6 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4553.27 Median:5245.83 stddev:1445.12 (27.5%) stddev-sans-first:1412.87 06:18:05 INFO - PROCESS | 1650 | Values: 264.5 305.8 310.5 318.8 320.7 4018.9 5380.2 5385.8 5386.7 5401.2 5332.3 5385.5 5395.5 5403.5 5420.2 3259.8 3654.6 3986.9 4076.6 4171.2 3396.5 4188.9 4211.3 4218.0 4228.9 3437.4 4154.9 4166.7 4172.7 4192.0 3154.0 3998.0 4094.8 4164.2 4220.6 2858.7 2991.3 3098.7 3355.2 3560.5 4372.4 5311.5 5325.3 5327.5 5352.7 3819.9 4682.7 4683.8 4696.4 4696.9 4922.0 5034.9 5655.9 5711.5 5752.7 3896.3 3909.3 3912.8 3921.9 3933.9 5768.0 5856.7 5997.9 6042.9 6101.5 3457.8 3746.4 3853.6 3973.3 3980.3 3384.5 4008.6 4010.7 4019.6 4028.0 4689.6 4689.9 4694.1 4704.4 4710.2 5318.7 5726.5 5754.5 5797.2 5848.7 1169.3 1230.4 1242.6 1278.6 1365.1 681.0 769.8 780.2 795.9 834.4 5252.2 5304.8 5348.1 5388.8 5558.4 4974.6 5913.3 5964.7 5976.9 6018.0 4397.9 4683.5 4738.5 5430.8 5451.8 2638.5 3002.9 3040.4 3101.0 3108.1 5327.9 5480.6 5882.6 6148.2 6149.7 5283.7 5734.5 5812.6 5855.8 6049.6 5924.4 5998.3 6051.6 6098.5 6100.5 4942.6 5105.6 5223.7 5460.2 5939.7 4964.4 5280.4 5611.8 5790.2 5790.4 5066.9 5291.3 5974.8 6118.4 6122.6 3117.8 3463.3 3477.3 3663.3 3921.0 5057.1 5358.7 5383.9 5390.1 5844.4 4781.2 5239.5 5690.7 5702.2 5793.7 5285.5 5400.2 5702.8 5723.6 5741.9 4622.8 4979.8 5563.0 5599.6 5609.4 4655.7 5633.8 5638.7 5687.4 5772.7 4263.4 5168.8 5418.3 5463.8 5625.0 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:27555.99 Median:100700.66 stddev:44964.88 (44.7%) stddev-sans-first:45045.84 06:18:05 INFO - PROCESS | 1650 | Values: 711.6 748.3 764.5 797.5 819.3 15940.9 17081.6 17094.4 17112.5 17182.1 15139.2 15203.5 15211.3 15244.5 15262.7 704.9 722.2 723.3 859.6 869.9 869.7 874.9 878.9 881.7 882.2 938.2 939.0 940.3 940.5 940.8 932.7 932.8 934.0 934.8 935.5 692.6 693.1 693.3 693.5 695.5 16250.0 16391.2 16427.0 16432.4 16458.8 13759.3 13843.5 13917.9 14038.0 14188.8 13488.0 13881.6 14029.9 14069.4 14159.1 4680.0 4684.5 4767.6 4867.4 4952.6 126029.0 131071.0 133973.0 140534.6 141286.0 11157.9 11176.6 11385.7 11482.6 12001.5 22102.2 22115.6 22116.0 22128.0 22130.3 8009.8 8028.1 8139.4 8499.2 8507.6 4538.2 4586.0 4697.7 4777.1 4839.1 3574.2 3654.1 3680.9 3681.1 3681.8 641.3 673.0 694.5 714.0 742.4 553.4 578.6 579.0 612.7 668.3 9954.3 10076.7 10175.5 10200.0 10217.8 676.8 704.7 707.4 721.9 730.4 4719.9 4869.1 4883.6 4885.7 4937.9 137111.0 174696.0 176395.0 176537.2 179299.1 97187.0 113125.0 129055.0 154849.0 158021.2 126602.7 128853.4 129756.4 132265.0 132873.0 9330.2 9384.3 9389.3 9410.3 9428.4 63929.7 66398.7 68908.3 70384.0 71223.3 80465.8 101164.0 102923.0 108126.5 108829.5 12134.6 12758.0 13886.9 14083.6 14253.6 15147.2 15175.4 15970.1 16265.6 16366.7 14447.1 14616.7 14702.0 15521.4 15791.6 14167.6 14200.6 15318.2 15706.1 15852.3 14198.0 14720.7 15023.8 15144.2 15459.2 11305.5 12046.8 12234.5 12344.9 12445.6 8040.8 10064.3 11129.4 11867.9 12557.9 06:18:05 INFO - PROCESS | 1650 | -------- Summary: end -------- 06:18:05 INFO - PROCESS | 1650 | 06:18:05 INFO - TEST-INFO | 1650: exit 0 06:18:05 INFO - TEST-OK | dromaeo_css | took 1116090ms 06:18:05 INFO - TEST-START | kraken 06:18:05 INFO - operating with platform_type : mac_ 06:18:05 INFO - Initialising browser for kraken test... 06:18:05 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmp_BbGc8/profile http://localhost:49243/getInfo.html) 06:18:07 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 06:18:07 INFO - PROCESS | 1656 | colorDepth:24 06:18:07 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 06:18:07 INFO - PROCESS | 1656 | __metrics 06:18:07 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:07 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:08 INFO - TEST-INFO | 1656: exit 0 06:18:08 INFO - Browser initialized. 06:18:08 INFO - Running cycle 1/1 for kraken test... 06:18:08 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmp_BbGc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:20 INFO - PROCESS | 1658 | RSS: Main: 168865792 06:18:20 INFO - PROCESS | 1658 | 06:18:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:24 INFO - PROCESS | 1658 | RSS: Main: 218882048 06:18:24 INFO - PROCESS | 1658 | 06:18:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 06:18:27 INFO - PROCESS | 1658 | RSS: Main: 232620032 06:18:27 INFO - PROCESS | 1658 | 06:18:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 06:18:30 INFO - PROCESS | 1658 | RSS: Main: 331321344 06:18:30 INFO - PROCESS | 1658 | 06:18:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 06:18:33 INFO - PROCESS | 1658 | RSS: Main: 229388288 06:18:33 INFO - PROCESS | 1658 | 06:18:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:36 INFO - PROCESS | 1658 | RSS: Main: 229986304 06:18:36 INFO - PROCESS | 1658 | 06:18:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:39 INFO - PROCESS | 1658 | RSS: Main: 267587584 06:18:39 INFO - PROCESS | 1658 | 06:18:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:42 INFO - PROCESS | 1658 | RSS: Main: 268644352 06:18:42 INFO - PROCESS | 1658 | 06:18:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 06:18:46 INFO - PROCESS | 1658 | RSS: Main: 265895936 06:18:46 INFO - PROCESS | 1658 | 06:18:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:48 INFO - PROCESS | 1658 | RSS: Main: 240500736 06:18:48 INFO - PROCESS | 1658 | 06:18:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:50 INFO - PROCESS | 1658 | RSS: Main: 244723712 06:18:50 INFO - PROCESS | 1658 | 06:18:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:53 INFO - PROCESS | 1658 | RSS: Main: 252522496 06:18:53 INFO - PROCESS | 1658 | 06:18:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:56 INFO - PROCESS | 1658 | RSS: Main: 277229568 06:18:56 INFO - PROCESS | 1658 | 06:19:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:00 INFO - PROCESS | 1658 | RSS: Main: 263835648 06:19:00 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 06:19:02 INFO - PROCESS | 1658 | RSS: Main: 307748864 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | __start_tp_report 06:19:02 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 06:19:02 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 06:19:02 INFO - PROCESS | 1658 | |i|pagename|runs| 06:19:02 INFO - PROCESS | 1658 | |0;ai-astar;114;113;113;113;113;114;111;113;114;114 06:19:02 INFO - PROCESS | 1658 | |1;audio-beat-detection;143;107;108;141;108;110;106;110;165;134 06:19:02 INFO - PROCESS | 1658 | |2;audio-dft;183;182;181;183;183;183;181;183;183;184 06:19:02 INFO - PROCESS | 1658 | |3;audio-fft;81;58;58;91;60;58;60;58;81;57 06:19:02 INFO - PROCESS | 1658 | |4;audio-oscillator;86;69;92;69;69;68;92;69;69;90 06:19:02 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;90;86;89;86;89;85;90;86;89;85 06:19:02 INFO - PROCESS | 1658 | |6;imaging-darkroom;97;97;98;97;96;99;97;97;97;97 06:19:02 INFO - PROCESS | 1658 | |7;imaging-desaturate;85;86;87;85;83;84;84;90;87;85 06:19:02 INFO - PROCESS | 1658 | |8;json-parse-financial;57;51;53;52;55;56;56;56;56;54 06:19:02 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;71;66;67;70;69;64;66;67;67;67 06:19:02 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;79;82;84;82;81;83;82;88;88;98 06:19:02 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;134;135;134;134;139;140;145;147;149;147 06:19:02 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;199;225;158;208;216;194;165;159;201;165 06:19:02 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;65;64;65;74;80;85;81;65;65;64 06:19:02 INFO - PROCESS | 1658 | __end_tp_report 06:19:02 INFO - PROCESS | 1658 | __start_cc_report 06:19:02 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1960 06:19:02 INFO - PROCESS | 1658 | __end_cc_report 06:19:02 INFO - PROCESS | 1658 | __startTimestamp1480688342694__endTimestamp 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | ------- Summary: start ------- 06:19:02 INFO - PROCESS | 1658 | Number of tests: 14 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:0.92 (0.8%) stddev-sans-first:0.93 06:19:02 INFO - PROCESS | 1658 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 111.0 113.0 114.0 114.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:122.00 stddev:20.93 (17.2%) stddev-sans-first:20.93 06:19:02 INFO - PROCESS | 1658 | Values: 143.0 107.0 108.0 141.0 108.0 110.0 106.0 110.0 165.0 134.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:0.97 (0.5%) stddev-sans-first:1.01 06:19:02 INFO - PROCESS | 1658 | Values: 183.0 182.0 181.0 183.0 183.0 183.0 181.0 183.0 183.0 184.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:12.84 (21.4%) stddev-sans-first:12.45 06:19:02 INFO - PROCESS | 1658 | Values: 81.0 58.0 58.0 91.0 60.0 58.0 60.0 58.0 81.0 57.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.50 stddev:11.06 (14.3%) stddev-sans-first:11.27 06:19:02 INFO - PROCESS | 1658 | Values: 86.0 69.0 92.0 69.0 69.0 68.0 92.0 69.0 69.0 90.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:89.00 stddev:2.07 (2.3%) stddev-sans-first:1.99 06:19:02 INFO - PROCESS | 1658 | Values: 90.0 86.0 89.0 86.0 89.0 85.0 90.0 86.0 89.0 85.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 06:19:02 INFO - PROCESS | 1658 | Values: 97.0 97.0 98.0 97.0 96.0 99.0 97.0 97.0 97.0 97.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:2.01 (2.4%) stddev-sans-first:2.12 06:19:02 INFO - PROCESS | 1658 | Values: 85.0 86.0 87.0 85.0 83.0 84.0 84.0 90.0 87.0 85.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:56.00 stddev:2.01 (3.6%) stddev-sans-first:1.94 06:19:02 INFO - PROCESS | 1658 | Values: 57.0 51.0 53.0 52.0 55.0 56.0 56.0 56.0 56.0 54.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:1.73 06:19:02 INFO - PROCESS | 1658 | Values: 71.0 66.0 67.0 70.0 69.0 64.0 66.0 67.0 67.0 67.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.50 stddev:5.48 (6.6%) stddev-sans-first:5.41 06:19:02 INFO - PROCESS | 1658 | Values: 79.0 82.0 84.0 82.0 81.0 83.0 82.0 88.0 88.0 98.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:142.50 stddev:6.11 (4.3%) stddev-sans-first:6.03 06:19:02 INFO - PROCESS | 1658 | Values: 134.0 135.0 134.0 134.0 139.0 140.0 145.0 147.0 149.0 147.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.00 Median:200.00 stddev:25.10 (12.5%) stddev-sans-first:26.36 06:19:02 INFO - PROCESS | 1658 | Values: 199.0 225.0 158.0 208.0 216.0 194.0 165.0 159.0 201.0 165.0 06:19:02 INFO - PROCESS | 1658 | 06:19:02 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:69.50 stddev:8.35 (12.0%) stddev-sans-first:8.59 06:19:02 INFO - PROCESS | 1658 | Values: 65.0 64.0 65.0 74.0 80.0 85.0 81.0 65.0 65.0 64.0 06:19:02 INFO - PROCESS | 1658 | -------- Summary: end -------- 06:19:02 INFO - PROCESS | 1658 | 06:19:03 INFO - TEST-INFO | 1658: exit 0 06:19:03 INFO - TEST-OK | kraken | took 57726ms 06:19:03 INFO - SUITE-END | took 1173s 06:19:03 INFO - Completed test suite (00:19:34) 06:19:03 INFO - javascript benchmark 06:19:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3487.7907325560464, 3487.9651203487965, 3518.208403109299, 3533.5406397168363, 3553.3603951288774, 5778.653280803144, 5798.971005144974, 5872.76508939643, 5882.941170588293, 5910.734016969236, 5843.620164689292, 5894.528437724983, 5913.083472061827, 5936.614120082191, 5939.613925094865, 5298.549623282026, 5327.360716714, 5339.22581225722, 5373.489518495737, 5448.019356515845, 5272.446393128724, 5332.306800115999, 5420.295361602986, 5441.319835020622, 5446.754896029668, 5003.624728145385, 5314.495122963332, 5377.569794416457, 5382.865428364283, 5383.757730902099, 5351.892962140774, 5372.57019438444, 5383.703896285702, 5427.864303392407, 5435.320584926884, 5315.946840531623, 5369.5167434931045, 5373.59698022646, 5380.542653874425, 5393.541548968343, 5716.514096301819, 5737.254156959611, 5746.051901436258, 5787.797427090031, 5801.245838041028, 6278.340774218733, 6308.179936608258, 6314.147590075327, 6351.460125889305, 6355.078513615546, 6260.40526150015, 6302.086197501337, 6303.495720342407, 6325.399087086719, 6341.714622841983, 5806.274215723035, 5857.648541087548, 5876.44173803488, 5919.9936010878255, 6002.879942401171, 6389.488840892717, 6437.9678101610125, 6441.0982462455295, 6444.420002199825, 6445.4199122079235, 6291.056341548713, 6293.433590976742, 6293.496520278367, 6311.779087731908, 6325.462335701425, 6247.96876015617, 6292.2134733158355, 6301.464375528039, 6367.331430199855, 6381.489480841522, 6342.841428964312, 6346.873062538723, 6366.427021568081, 6376.7130479128555, 6403.743850246031, 6310.2743184534365, 6361.650109243943, 6365.427111559982, 6377.7767778127545, 6385.2337719473035, 5019.196928491424, 5029.622778291643, 5062.949370506248, 5139.408967968657, 5174.353205849269, 4522.095580883836, 4580.106879158532, 4582.610478109398, 4587.1972404829685, 4605.953940460619, 5988.28140623128, 5990.820275391745, 6019.067044608093, 6019.909701354396, 6032.638041717511, 6200.441960223601, 6321.778737744249, 6333.0, 6334.0, 6353.30113687494, 4952.801887924515, 5873.383294754075, 5890.852728681817, 5945.1973983512535, 6035.396460354017, 5574.972125139429, 5598.608097433141, 5600.991821472174, 5603.047481928082, 5606.990741666539, 6487.3836985486305, 6490.675466226669, 6496.935030649633, 6505.316941721146, 6516.674166291572, 5281.339832520935, 6192.59748116389, 6295.3389894060465, 6324.1146239527425, 6340.334264902303, 6432.807015789534, 6455.289918108911, 6457.741690332522, 6471.25580558223, 6475.384838440341, 6265.624062556261, 6269.404406581368, 6298.464630506458, 6298.748050077946, 6337.96831015842, 6242.625442473466, 6299.937000629935, 6312.337204593635, 6324.968375158279, 6391.424771770563, 6141.700809433325, 6195.008798592204, 6279.623222606659, 6345.936540634534, 6348.492120630246, 6289.40250676185, 6303.432691057827, 6322.841928951629, 6326.778562750282, 6335.841603959753, 5084.5932325414615, 6011.819645410645, 6050.697465126814, 6179.1040299155475, 6201.782937597162, 6174.8147555573405, 6227.283862355887, 6250.3749625037135, 6262.185915830913, 6352.968235158794, 6167.352427994996, 6215.751369945152, 6219.315875253628, 6223.284322302993, 6238.282597501164], "value": 5840.784846640225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.6656190823561, 515.1474310016923, 539.2746755613698, 547.6549773642607, 555.9666420014797, 31908.0, 33999.4900076499, 41158.38262426062, 42935.570644293584, 44799.77600112003, 43422.56577434225, 43971.56028439714, 43998.12003759923, 44034.33948490775, 44040.339394909104, 9923.603055877757, 10123.190144788436, 10123.797524049514, 10136.189104871593, 10140.543675534582, 9309.813803723955, 9626.807463850719, 12087.335196564185, 12492.562760303392, 12513.562025329114, 12405.379731013458, 12481.625551233477, 12497.812532812015, 12508.437120329607, 12513.124081314312, 12385.752284954295, 12446.75106497874, 12454.439550220217, 12458.314792686399, 12473.376331183405, 12281.201721888048, 12321.753564928651, 12343.691407714789, 12345.197562158432, 12348.38258087092, 41401.58598414037, 41683.0, 41738.0, 41740.791296043324, 41777.79111104456, 3468.7398445116464, 3539.3983022885914, 3669.211119609297, 3709.239605880788, 3735.34631439497, 30794.0, 31575.210619734462, 31946.520802187984, 32813.507797383056, 32995.0, 3367.0572239772905, 3368.8484018219237, 3460.3598334308235, 3471.930561388758, 3518.964810351915, 381048.0, 381644.0, 383875.0, 384745.0, 387124.0643796791, 34880.82559587186, 61863.0, 62299.13102606929, 62339.68830155911, 62480.68759656173, 35716.64283357185, 36710.449343259876, 37074.62925370766, 37127.62872371296, 37882.0, 15939.203039847962, 16002.199890005453, 16055.19724013818, 16070.276837542338, 16073.437429690139, 12431.813522797165, 12651.493940242472, 13434.798478022838, 13556.59330220095, 13562.050656453954, 7866.646000929972, 8063.758087257392, 8106.39202059836, 8118.472299300644, 8181.263686268265, 3298.5052242163865, 3342.799432034086, 3347.5313456116164, 3356.110630682871, 3387.6951074402928, 856.8928883889514, 1009.268280496634, 1073.7798751255973, 1093.868735751715, 1114.6990312615549, 30002.849985750367, 30922.226944326572, 31120.0, 31332.0, 31471.0, 1118.949647265875, 1137.5790957345835, 1167.8423412839159, 1173.3898372846243, 1188.6731148933939, 15466.226688665522, 16124.032558046554, 16224.0, 16561.585960351087, 16592.668146637243, 694429.0, 705031.0, 718928.0, 721537.0, 1000272.0, 60603.0, 61176.694116529135, 61241.69379153076, 61474.692626536584, 61502.0, 1284.1973766395815, 1315.6381994951464, 1390.958271251864, 1406.3249640172774, 1430.2562667412888, 25477.617835732108, 31858.0, 32556.02331930046, 33254.83372583122, 33501.0, 57972.0, 58777.824443511745, 58792.70603646954, 58844.0, 59029.40970590239, 630882.0, 640431.0, 640911.0, 641729.0, 642803.0, 25114.748852511242, 27661.861690691418, 28282.010129645365, 28495.0, 28861.27846803847, 47643.047139057715, 48023.279650804565, 48199.5180048195, 48411.03177936492, 48656.5134348652, 38915.61084389233, 39380.60619393884, 40642.59357406388, 41322.58677413307, 41366.0, 34921.47617785786, 39787.2042559153, 39898.00254993532, 41091.1781764369, 41194.58805411908, 36450.0, 38348.0, 39336.803315983234, 39693.60306396899, 39695.2060958785, 33517.66482335146, 34725.47911781376, 34860.651393486754, 35344.469832953044, 35358.64641353657, 25953.351166220997, 26044.609330859672, 26110.825012874848, 26290.98135554303, 26559.33601659974], "value": 19823.060963670017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.9549160863284, 378.4852600463371, 380.8857342797161, 399.64431655826337, 409.1101853468705, 15841.366345346201, 16710.7493387599, 19859.602807943833, 21820.563588728215, 22119.004644790963, 21277.0, 21690.0, 21918.89040554799, 21928.561428771416, 22170.11319547216, 5971.671558064305, 6312.33720459352, 6325.1777268954975, 6332.113504109406, 6339.778107766229, 4364.140794187804, 5209.7134657593815, 6223.968880155593, 6352.428281454668, 7077.292270772933, 7069.8939515907305, 7108.218096009435, 7109.822254443655, 7113.181984071821, 7121.679524421414, 5947.732352044147, 6252.812415627515, 6289.119523266723, 6341.239051313826, 6345.777897773556, 5951.851203719898, 6163.845903852395, 6177.04255840341, 6219.68901554925, 6247.812565622993, 13758.65603359914, 13809.930950345284, 13902.0, 14007.64980875476, 14008.0194386393, 2226.6326056200705, 2262.151693115082, 2275.101334972693, 2423.1397853761837, 2501.2121181827665, 10127.696169114864, 10600.204984626183, 10687.412192329419, 10920.890791092066, 14152.720658414839, 1740.2082052666008, 1921.8366438852715, 1973.6052789442026, 2015.1737787507052, 2031.4515080928215, 127967.36016319953, 135297.0, 135416.32291838477, 138880.9167862483, 141309.0, 11389.974902258837, 11552.075833933266, 11857.229280096766, 11883.821742673867, 11903.464344104535, 13608.115472494255, 14203.431862725376, 15283.159426231441, 15306.923465382824, 15356.692866142615, 7840.745480723171, 8561.743147705454, 8679.739607811776, 8947.821043579092, 9233.584488698025, 7496.475246732785, 8176.83646327082, 8366.03790564093, 9005.729828105168, 9037.63849446028, 3849.7690138591774, 3901.4342920276968, 4544.681872268976, 4652.32541281519, 4714.528547145326, 1899.4776436479801, 1945.0, 1948.386258328622, 1961.7645882493907, 1986.1459572384013, 832.7281048222579, 842.9325653947669, 976.6874600127891, 981.6073570571829, 1007.4257673126394, 22016.119355225932, 22538.887305563367, 22651.372006407335, 22817.657735133987, 22839.543209135725, 942.6088173407959, 958.8561715742694, 977.9608815647294, 984.389678399397, 1062.2327696827597, 11101.44492775358, 11707.76584468306, 11937.880621193677, 11979.760404791856, 12071.0, 628265.0, 633730.0, 655186.0, 669192.0, 673072.0, 141167.0, 149060.0, 149290.25354873156, 150578.0, 152039.0, 1008.5965613754557, 1046.4767616191905, 1055.5777688924338, 1062.654637242899, 1063.2504084620325, 19289.5177620555, 20285.08717107704, 20464.69302960427, 20715.274965376742, 20747.688784667942, 54466.727666363, 55079.0, 55743.16385254143, 55915.44084559102, 57074.714626428264, 79596.2040379612, 80448.0, 80675.0, 82274.58862705648, 82767.58616206881, 7911.683532658629, 7961.283484486193, 7975.601219939096, 8359.289460395934, 8482.660693572188, 9340.159385655325, 10673.733156670834, 12548.498060077494, 13307.733845323233, 13417.66455838612, 11269.053774818689, 11474.967252947275, 11761.705957351134, 11813.936745692929, 11850.881491184979, 11125.207280282602, 11280.759116497344, 11441.656750297505, 11513.194076414571, 11577.6526704199, 11045.0, 11498.94250528742, 11531.077513798708, 11587.768244635228, 11707.414629268673, 8043.0, 8112.391570632109, 8232.62953167121, 8315.584220788814, 8336.833263334578, 7947.046354437504, 10418.218633602359, 11067.612633557786, 11149.888501114885, 11640.35978021217], "value": 9790.113918393605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.6660001599619, 1548.2026756220546, 1564.6714190020095, 1766.9734953975685, 1894.3653875951557, 8023.719169829057, 8561.315094792417, 8572.485650860952, 8572.485650860952, 8580.056193818675, 8668.566571671423, 8983.371164018521, 8987.685431009915, 9101.863472047924, 9117.407368521042, 2122.416335507732, 2362.9409264768346, 2401.207601491508, 2432.1973748662986, 2436.4274395517127, 2149.344449942767, 2297.897009435472, 2403.555342261687, 2432.2703189043305, 2433.1362366359954, 2407.205622144688, 2427.325145649505, 2436.0012394918085, 2442.743511931248, 2443.0, 2393.964090538643, 2414.95170096598, 2429.246933450636, 2433.245693834917, 2444.0, 2402.783749462539, 2429.149797570854, 2436.780689737914, 2437.171361737018, 2438.37821355555, 9010.189082982562, 9197.126273004054, 9205.861912071325, 9209.079092090804, 9218.631254749802, 5390.056740070472, 5435.864103397407, 5575.163725441175, 5625.987322281988, 5627.915581266284, 3678.2275722098393, 3777.697784177259, 3841.1741475582603, 3841.2317536492815, 3854.7879866607327, 1112.2158877990996, 1132.1678566253797, 1146.9426528673532, 1151.2804497189256, 1154.8267759836008, 12221.388930553525, 12245.387730613524, 12316.692082697915, 12319.07606929475, 12349.567765128177, 4295.4415925929425, 4334.371516130143, 4620.168369693421, 4811.254255590389, 4814.759262036884, 9479.526023698787, 9484.383515071499, 9488.0, 9494.810103797885, 9526.237900968044, 5447.237386765856, 5461.617686761889, 5461.6996065216, 5462.289902312674, 5464.9453505465235, 4088.856890008895, 4239.745615263094, 4621.0, 4750.596199323097, 5142.665726727751, 3058.648255450607, 3917.5298964123917, 3960.34654282046, 4026.8389264429093, 4028.4158796974275, 1180.5395895600723, 1185.6739396665987, 1189.4885199364358, 1197.090211439295, 1200.9339486328336, 800.5276886636796, 848.5502683577714, 909.3589019741066, 952.0812416018575, 962.153305091515, 5919.644821310735, 6086.513078953673, 6122.6938653068055, 6147.784827531015, 6301.873962520815, 968.9370190937567, 975.2003357247131, 993.3940296419179, 1024.7130803375067, 1034.2088302448633, 3834.9616503835164, 3969.206158768258, 4030.717849750489, 4082.9591704083173, 4086.8160932758096, 10257.0, 11190.0, 11286.209965302514, 11299.94350028261, 11316.094712422986, 11256.718582035352, 11259.943700281447, 11273.549058037586, 11287.266327688674, 11329.09367250618, 8174.67301307941, 8516.0, 8543.188397102265, 8632.223099921162, 8635.913640863511, 6067.302260239952, 6088.330283668704, 6174.598651087665, 6264.843378915563, 6419.390157934989, 10250.948745256524, 10288.228382871464, 10393.896061039293, 10528.105111065644, 10556.366618002638, 9669.98465161148, 10677.039066484054, 10684.519196636014, 10693.625723099654, 10710.303830251009, 7151.2848715128075, 7408.9629551851895, 7683.884741728767, 7786.143524212219, 7878.881816772868, 8575.31397488187, 8621.82756344857, 8627.568621568771, 8670.653173873226, 8717.564121794012, 7774.883376749466, 7782.182870798485, 7787.182828212535, 7881.448298619041, 7954.880676789737, 7585.279398457138, 7611.581363025087, 7632.045994250719, 7646.273604007611, 7663.233676632292, 7191.17301510333, 7201.531900426456, 7247.2390399007345, 7337.889931650922, 7343.228960959236, 5069.5944324454695, 5099.107656160231, 5102.821401250939, 5172.508611681884, 5178.0, 4975.701457912537, 5011.473795251446, 5164.0, 5280.735963201748, 5305.628605997543], "value": 4696.573366404723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.4816160325762, 305.76761661137533, 310.45205212799414, 318.7577441144731, 320.7161661929195, 4018.8995275118136, 5380.24676545284, 5385.7576409061585, 5386.676799392039, 5401.216823560581, 5332.253484512162, 5385.515303622673, 5395.541378982791, 5403.540699040576, 5420.214068959998, 3259.8044117353033, 3654.5797233318176, 3986.940195897064, 4076.5923407659293, 4171.186618609372, 3396.507506411569, 4188.853390131346, 4211.305134652778, 4218.0, 4228.851990180345, 3437.4156393413055, 4154.937675934848, 4166.666666666674, 4172.70791044627, 4191.958080419187, 3153.9684603153905, 3997.9805149686936, 4094.7952602369764, 4164.229617520753, 4220.620144187023, 2858.6712528059124, 2991.2970451943775, 3098.7140336760217, 3355.1779813945495, 3560.537130173087, 4372.366006928977, 5311.548518375943, 5325.281087053237, 5327.547158491533, 5352.652077614943, 3819.9304194825495, 4682.705474317594, 4683.782216623668, 4696.379748986594, 4696.882577935545, 4921.975390123026, 5034.874128146826, 5655.915161272585, 5711.4579063653, 5752.654840709571, 3896.3181443247317, 3909.2963266612, 3912.765234085964, 3921.940980985006, 3933.8623148189963, 5767.961766881959, 5856.736446859902, 5997.850053748648, 6042.939570604326, 6101.481374083208, 3457.8098204598987, 3746.4380342948775, 3853.6339047790416, 3973.304671682444, 3980.263651224475, 3384.526166336715, 4008.6392224699916, 4010.6590939769862, 4019.638232559084, 4027.9930017495626, 4689.601383882408, 4689.929651055237, 4694.084653492604, 4704.435467743892, 4710.175719249186, 5318.70747108905, 5726.455986681259, 5754.482096611325, 5797.246357973437, 5848.678322692293, 1169.316184694038, 1230.3971054183385, 1242.5837344489696, 1278.5844600504872, 1365.0581099041628, 680.9727610895608, 769.819092513259, 780.2236774409386, 795.9442839001214, 834.4200780457523, 5252.185911183773, 5304.814331498456, 5348.1442969124755, 5388.784448622089, 5558.416366281563, 4974.5771609413605, 5913.29040515141, 5964.7315870785915, 5976.910346344808, 6017.969910150421, 4397.890052748707, 4683.5082316356975, 4738.483685220696, 5430.755615997289, 5451.781928722886, 2638.5092422781067, 3002.8648710808066, 3040.361524079968, 3101.0, 3108.0885255567664, 5327.86680332987, 5480.561555075585, 5882.55880808941, 6148.200733904564, 6149.723262453201, 5283.735813209324, 5734.455226753452, 5812.593118481665, 5855.765769369177, 6049.637021778707, 5924.377940316291, 5998.310194327708, 6051.576389652682, 6098.5426093042315, 6100.511959043266, 4942.629302802232, 5105.566026887756, 5223.712695801615, 5460.232439616651, 5939.732712027882, 4964.429090654477, 5280.3630874429045, 5611.80358687444, 5790.218320526675, 5790.392008839011, 5066.9239961401345, 5291.3385826771655, 5974.833338330692, 6118.388161183846, 6122.602030867979, 3117.846396833186, 3463.290025544707, 3477.287156133037, 3663.2856592964117, 3920.9805450582485, 5057.115004874058, 5358.6871216550635, 5383.946160538345, 5390.110631745875, 5844.357120716632, 4781.235002399739, 5239.476052394883, 5690.743916523684, 5702.173184888251, 5793.652380857162, 5285.497877701612, 5400.216968539618, 5702.7718891243885, 5723.570732195185, 5741.942580574141, 4622.791974361095, 4979.751012449291, 5562.99330602461, 5599.636023658449, 5609.382967873612, 4655.674102812771, 5633.802816901552, 5638.718064096696, 5687.43125687428, 5772.711364431678, 4263.424437700871, 5168.767405466839, 5418.322709661293, 5463.7814487420055, 5625.043742563856], "value": 4081.5632638828884, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6121713666055, 748.2966011948768, 764.5221736414741, 797.4975765267881, 819.2954059508824, 15940.920295398535, 17081.57296067599, 17094.401695940644, 17112.486625401227, 17182.14089295535, 15139.167345795977, 15203.467878624251, 15211.315490802912, 15244.466443674473, 15262.694746105099, 704.8555046215539, 722.238038868993, 723.3345322303467, 859.6174702257466, 869.9130086991298, 869.7347309070731, 874.8600223964168, 878.8725634782985, 881.6693739847557, 882.2192359761625, 938.249400479617, 939.0187254319219, 940.2571968145157, 940.534435454451, 940.802431489388, 932.7248461703746, 932.827426926014, 933.9866245124049, 934.8223837470858, 935.5415846235296, 692.6225207262054, 693.0574418790492, 693.2582137113291, 693.4521727835004, 695.4957655699628, 16250.0, 16391.180440977903, 16427.01437913729, 16432.424865129662, 16458.83541164585, 13759.312034398341, 13843.515476958359, 13917.930410347984, 14038.0, 14188.787168192486, 13488.0, 13881.583552493441, 14029.859701402956, 14069.437222511087, 14159.079659822182, 4680.0, 4684.484706682262, 4767.570918617341, 4867.36724225852, 4952.579030782352, 126029.0, 131071.0, 133973.0, 140534.5946540532, 141286.0, 11157.94421027906, 11176.608818691308, 11385.715357116138, 11482.59810906631, 12001.459934302977, 22102.22642207515, 22115.557688846133, 22116.0, 22128.0, 22130.336089917007, 8009.839803203903, 8028.11690714021, 8139.430239883151, 8499.150084991452, 8507.574621268912, 4538.160440318552, 4585.95414045862, 4697.671163018625, 4777.116233496745, 4839.080574690797, 3574.160072382988, 3654.0682126057686, 3680.9263814723554, 3681.0981309579324, 3681.834317455721, 641.3137942401679, 673.0409166937095, 694.4513834071028, 713.9678714457862, 742.38011260598, 553.382977979558, 578.5776383240258, 578.9507891829157, 612.7365232949785, 668.3350066683681, 9954.303198776017, 10076.74808129788, 10175.542100605491, 10200.0, 10217.846732299022, 676.8088164829935, 704.7145905908116, 707.3527722134293, 721.9350258476762, 730.4047201530842, 4719.85840424781, 4869.123557759637, 4883.609311255091, 4885.65800393969, 4937.925931111036, 137111.0, 174696.0, 176395.0, 176537.23462765207, 179299.10350448164, 97187.0, 113125.0, 129055.0, 154849.0, 158021.2098939498, 126602.73397266094, 128853.35573322073, 129756.3512182452, 132265.0, 132873.0, 9330.206932410822, 9384.34309598349, 9389.342746007715, 9410.29422793307, 9428.387154834914, 63929.68035159794, 66398.66800665966, 68908.31091689019, 70384.0, 71223.28776712167, 80465.79301310368, 101164.0, 102923.0, 108126.45936770266, 108829.45585272023, 12134.635960921187, 12758.0, 13886.861131388558, 14083.577492675236, 14253.572392828231, 15147.166905820286, 15175.392984280947, 15970.121643309729, 16265.59336016609, 16366.672666546365, 14447.060941038799, 14616.707665846836, 14702.0, 15521.39873185321, 15791.605209869846, 14167.64580885486, 14200.644983875485, 15318.157501337533, 15706.136162510715, 15852.286647101138, 14198.0, 14720.705585888008, 15023.759476394971, 15144.242787860783, 15459.227038647798, 11305.547778088785, 12046.75906481883, 12234.510619575472, 12344.876551234373, 12445.564405245774, 8040.83918321642, 10064.345817521838, 11129.443527823414, 11867.881321186678, 12557.87442125567], "value": 8345.657912460818, "unit": "score"}], "name": "dromaeo_css", "value": 7523.567906095043, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 111.0, 113.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 108.0, 141.0, 108.0, 110.0, 106.0, 110.0, 165.0, 134.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 181.0, 183.0, 183.0, 183.0, 181.0, 183.0, 183.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 91.0, 60.0, 58.0, 60.0, 58.0, 81.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 92.0, 69.0, 69.0, 68.0, 92.0, 69.0, 69.0, 90.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 86.0, 89.0, 85.0, 90.0, 86.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 98.0, 97.0, 96.0, 99.0, 97.0, 97.0, 97.0, 97.0], "value": 97.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 87.0, 85.0, 83.0, 84.0, 84.0, 90.0, 87.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 51.0, 53.0, 52.0, 55.0, 56.0, 56.0, 56.0, 56.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 67.0, 70.0, 69.0, 64.0, 66.0, 67.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 84.0, 82.0, 81.0, 83.0, 82.0, 88.0, 88.0, 98.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 134.0, 134.0, 139.0, 140.0, 145.0, 147.0, 149.0, 147.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 225.0, 158.0, 208.0, 216.0, 194.0, 165.0, 159.0, 201.0, 165.0], "value": 189.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 74.0, 80.0, 85.0, 81.0, 65.0, 65.0, 64.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1439.7, "alertThreshold": 2.0}]} 06:19:03 INFO - Return code: 0 06:19:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:19:04 INFO - # TBPL SUCCESS # 06:19:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:19:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:19:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:19:04 INFO - 2016-12-02 06:19:04.042 screenresolution[1662:10645] starting screenresolution argv=screenresolution get 06:19:04 INFO - 2016-12-02 06:19:04.045 screenresolution[1662:10645] Display 0: 1600x1200x32@60 06:19:04 INFO - 2016-12-02 06:19:04.051 screenresolution[1663:10648] starting screenresolution argv=screenresolution list 06:19:04 INFO - Available Modes on Display 0 06:19:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:19:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:19:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:19:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:19:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:19:04 INFO - Intel Iris: 06:19:04 INFO - Chipset Model: Intel Iris 06:19:04 INFO - Type: GPU 06:19:04 INFO - Bus: Built-In 06:19:04 INFO - VRAM (Dynamic, Max): 1536 MB 06:19:04 INFO - Vendor: Intel (0x8086) 06:19:04 INFO - Device ID: 0x0a2e 06:19:04 INFO - Revision ID: 0x0009 06:19:04 INFO - Displays: 06:19:04 INFO - Display: 06:19:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:19:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:19:04 INFO - Display Serial Number: 1600x1200 60 06:19:04 INFO - Main Display: Yes 06:19:04 INFO - Mirror: Off 06:19:04 INFO - Online: Yes 06:19:04 INFO - Rotation: Supported 06:19:04 INFO - Return code: 0 06:19:04 INFO - Running post-action listener: _resource_record_post_action 06:19:04 INFO - [mozharness: 2016-12-02 14:19:04.282537Z] Finished run-tests step (success) 06:19:04 INFO - Running post-run listener: _resource_record_post_run 06:19:04 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 31980544; Write bytes: 495498240; Read time: 195; Write time: 1556 06:19:04 INFO - TinderboxPrint: CPU usage
53.3% 06:19:04 INFO - TinderboxPrint: I/O read bytes / time
31,980,544 / 195 06:19:04 INFO - TinderboxPrint: I/O write bytes / time
495,498,240 / 1,556 06:19:04 INFO - TinderboxPrint: CPU idle
2,234.7 (46.7%) 06:19:04 INFO - TinderboxPrint: CPU system
961.0 (20.1%) 06:19:04 INFO - TinderboxPrint: CPU user
1,594.0 (33.3%) 06:19:04 INFO - TinderboxPrint: Swap in / out
223,981,568 / 0 06:19:04 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 190319104; Write bytes: 187729920; Read time: 17639; Write time: 423 06:19:04 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 30215168; Write bytes: 296766464; Read time: 180; Write time: 1102 06:19:04 INFO - Running post-run listener: _upload_blobber_files 06:19:04 INFO - Blob upload gear active. 06:19:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:19:04 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:19:04 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:19:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:06 INFO - (blobuploader) - INFO - Done attempting. 06:19:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:19:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:07 INFO - (blobuploader) - INFO - Done attempting. 06:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:10 INFO - (blobuploader) - INFO - Done attempting. 06:19:10 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:10 INFO - Return code: 0 06:19:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb933cce82ab85f9aad9109d69b5436ff9acd259bed98a59606d2bc338b3963f15a9efca399a0e6594991b48d1899fd75be033e7af9fc5307bbca3e8b0e130a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e9eafc41d77b43e315c8484ee8dd316dff57625b18eb535584cdf51b6114dc7da120ea8913cdaaeea33d96949c90f1a0f05e643d30c613b787a01bfeb112baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f215b6b36d0ec30a110da267f38116de0838665b8f31ade4b39cce82682c916684b5c6476e9dbcef9d3211215e056056127571b77a4ee72c76abc37d033316ad"} 06:19:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:10 INFO - Contents: 06:19:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb933cce82ab85f9aad9109d69b5436ff9acd259bed98a59606d2bc338b3963f15a9efca399a0e6594991b48d1899fd75be033e7af9fc5307bbca3e8b0e130a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e9eafc41d77b43e315c8484ee8dd316dff57625b18eb535584cdf51b6114dc7da120ea8913cdaaeea33d96949c90f1a0f05e643d30c613b787a01bfeb112baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f215b6b36d0ec30a110da267f38116de0838665b8f31ade4b39cce82682c916684b5c6476e9dbcef9d3211215e056056127571b77a4ee72c76abc37d033316ad"} 06:19:10 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:10 INFO - Copying logs to upload dir... 06:19:10 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.528543 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-02 06:19:10.508676) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 06:19:10.513297) ========= 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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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-Beta/sha512/cb933cce82ab85f9aad9109d69b5436ff9acd259bed98a59606d2bc338b3963f15a9efca399a0e6594991b48d1899fd75be033e7af9fc5307bbca3e8b0e130a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e9eafc41d77b43e315c8484ee8dd316dff57625b18eb535584cdf51b6114dc7da120ea8913cdaaeea33d96949c90f1a0f05e643d30c613b787a01bfeb112baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f215b6b36d0ec30a110da267f38116de0838665b8f31ade4b39cce82682c916684b5c6476e9dbcef9d3211215e056056127571b77a4ee72c76abc37d033316ad"} build_url:https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010992 build_url: 'https://queue.taskcluster.net/v1/task/TsU_q-0JT6ylcokk1R2Yjg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb933cce82ab85f9aad9109d69b5436ff9acd259bed98a59606d2bc338b3963f15a9efca399a0e6594991b48d1899fd75be033e7af9fc5307bbca3e8b0e130a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e9eafc41d77b43e315c8484ee8dd316dff57625b18eb535584cdf51b6114dc7da120ea8913cdaaeea33d96949c90f1a0f05e643d30c613b787a01bfeb112baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f215b6b36d0ec30a110da267f38116de0838665b8f31ade4b39cce82682c916684b5c6476e9dbcef9d3211215e056056127571b77a4ee72c76abc37d033316ad"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 06:19:10.552983) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 06:19:10.553407) ========= 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.VNJOeZGji3/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.Y08jyGiQ0J/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.005024 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 06:19:10.609022) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 06:19:10.609417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 06:19:10.609854) ========= ========= Total master_lag: 0.23 =========