builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1474462446.68 results: success (0) buildid: 20160921031007 builduid: 5a19ef8c60804b159f62ec6b34fa30d4 revision: 675331e308773c07e5b39cafd92ec1f4f591d152 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:06.679070) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:06.679497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:06.679779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:06.729373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:06.729685) ========= 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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-21 05:54:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.37M=0.002s 2016-09-21 05:54:07 (7.37 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.500288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:07.250232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:07.250555) ========= 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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.020943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:07.298483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 05:54:07.298804) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 675331e308773c07e5b39cafd92ec1f4f591d152 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 675331e308773c07e5b39cafd92ec1f4f591d152 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-21 05:54:07,372 truncating revision to first 12 chars 2016-09-21 05:54:07,372 Setting DEBUG logging. 2016-09-21 05:54:07,372 attempt 1/10 2016-09-21 05:54:07,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/675331e30877?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 05:54:08,572 unpacking tar archive at: fx-team-675331e30877/testing/mozharness/ program finished with exit code 0 elapsedTime=1.480233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 05:54:08.800992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:08.801273) ========= script_repo_revision: 675331e308773c07e5b39cafd92ec1f4f591d152 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:08.801640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:08.801910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 05:54:08.820498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-21 05:54:08.820804) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:09 INFO - MultiFileLogger online at 20160921 05:54:09 in /builds/slave/test 05:54:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:54:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:09 INFO - {'append_to_log': False, 05:54:09 INFO - 'base_work_dir': '/builds/slave/test', 05:54:09 INFO - 'blob_upload_branch': 'Fx-Team', 05:54:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:09 INFO - 'branch': 'Fx-Team', 05:54:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:09 INFO - 'config_files': ('talos/mac_config.py',), 05:54:09 INFO - 'default_actions': ('clobber', 05:54:09 INFO - 'read-buildbot-config', 05:54:09 INFO - 'download-and-extract', 05:54:09 INFO - 'populate-webroot', 05:54:09 INFO - 'create-virtualenv', 05:54:09 INFO - 'install', 05:54:09 INFO - 'run-tests'), 05:54:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:09 INFO - 'download_minidump_stackwalk': True, 05:54:09 INFO - 'download_symbols': 'ondemand', 05:54:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:09 INFO - 'installer_path': 'installer.exe', 05:54:09 INFO - 'log_level': 'info', 05:54:09 INFO - 'log_name': 'talos', 05:54:09 INFO - 'log_to_console': True, 05:54:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:54:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:54:09 INFO - 'opt_config_files': (), 05:54:09 INFO - 'pip_index': False, 05:54:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:09 INFO - 'cmd': ('bash', 05:54:09 INFO - '-c', 05:54:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:09 INFO - 'enabled': True, 05:54:09 INFO - 'halt_on_failure': False, 05:54:09 INFO - 'name': 'check_screen_resolution'},), 05:54:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:09 INFO - 'cmd': ('bash', 05:54:09 INFO - '-c', 05:54:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:09 INFO - 'enabled': True, 05:54:09 INFO - 'halt_on_failure': False, 05:54:09 INFO - 'name': 'check_screen_resolution'},), 05:54:09 INFO - 'run_cmd_checks_enabled': True, 05:54:09 INFO - 'sps_profile': False, 05:54:09 INFO - 'sps_profile_interval': 0, 05:54:09 INFO - 'suite': 'dromaeojs', 05:54:09 INFO - 'system_bits': '32', 05:54:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:09 INFO - 'title': 't-yosemite-r7-0102', 05:54:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:09 INFO - 'use_talos_json': True, 05:54:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:09 INFO - 'work_dir': 'build'} 05:54:09 INFO - [mozharness: 2016-09-21 12:54:09.016712Z] Running clobber step. 05:54:09 INFO - Running pre-action listener: _resource_record_pre_action 05:54:09 INFO - Running main action method: clobber 05:54:09 INFO - rmtree: /builds/slave/test/build 05:54:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:10 INFO - Running post-action listener: _resource_record_post_action 05:54:10 INFO - [mozharness: 2016-09-21 12:54:10.557103Z] Finished clobber step (success) 05:54:10 INFO - [mozharness: 2016-09-21 12:54:10.557364Z] Running read-buildbot-config step. 05:54:10 INFO - Running pre-action listener: _resource_record_pre_action 05:54:10 INFO - Running main action method: read_buildbot_config 05:54:10 INFO - Using buildbot properties: 05:54:10 INFO - { 05:54:10 INFO - "project": "", 05:54:10 INFO - "product": "firefox", 05:54:10 INFO - "script_repo_revision": "production", 05:54:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:54:10 INFO - "repository": "", 05:54:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:54:10 INFO - "buildid": "20160921031007", 05:54:10 INFO - "pgo_build": "False", 05:54:10 INFO - "basedir": "/builds/slave/test", 05:54:10 INFO - "buildnumber": 158, 05:54:10 INFO - "slavename": "t-yosemite-r7-0102", 05:54:10 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:54:10 INFO - "platform": "yosemite_r7", 05:54:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:54:10 INFO - "branch": "fx-team", 05:54:10 INFO - "repo_path": "integration/fx-team", 05:54:10 INFO - "revision": "675331e308773c07e5b39cafd92ec1f4f591d152", 05:54:10 INFO - "stage_platform": "macosx64", 05:54:10 INFO - "builduid": "5a19ef8c60804b159f62ec6b34fa30d4", 05:54:10 INFO - "slavebuilddir": "test" 05:54:10 INFO - } 05:54:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:54:10 INFO - Running post-action listener: _resource_record_post_action 05:54:10 INFO - [mozharness: 2016-09-21 12:54:10.563174Z] Finished read-buildbot-config step (success) 05:54:10 INFO - [mozharness: 2016-09-21 12:54:10.563415Z] Running download-and-extract step. 05:54:10 INFO - Running pre-action listener: _resource_record_pre_action 05:54:10 INFO - Running main action method: download_and_extract 05:54:10 INFO - mkdir: /builds/slave/test/build/tests 05:54:10 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:54:10 INFO - trying https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:54:10 INFO - Downloading https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:54:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:54:11 INFO - Downloaded 1199 bytes. 05:54:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:54:11 INFO - Using the following test package requirements: 05:54:11 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:54:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:54:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:54:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'jsshell-mac.zip'], 05:54:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:54:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:54:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:54:11 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:54:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:54:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:54:11 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:54:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:54:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:54:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:54:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:54:12 INFO - Expected file size: 16432581 05:54:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:54:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:54:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:54:19 INFO - Fetch https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:54:20 INFO - Expected file size: 16432581 05:54:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:54:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:54:26 INFO - Fetch https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:54:28 INFO - Expected file size: 14414059 05:54: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:54:29 INFO - trying https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:54:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:54:31 INFO - Downloaded 111314123 bytes. 05:54:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:54:31 INFO - mkdir: /builds/slave/test/properties 05:54:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:31 INFO - Contents: 05:54:31 INFO - build_url:https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:54:32 INFO - Running post-action listener: _resource_record_post_action 05:54:32 INFO - Running post-action listener: set_extra_try_arguments 05:54:32 INFO - [mozharness: 2016-09-21 12:54:32.554224Z] Finished download-and-extract step (success) 05:54:32 INFO - [mozharness: 2016-09-21 12:54:32.554370Z] Running populate-webroot step. 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: populate_webroot 05:54:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:32 INFO - '--tppagecycles', 05:54:32 INFO - '7'], 05:54:32 INFO - 'tests': ['tsvgm']}}, 05:54:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['damp', 'tps']}, 05:54:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'tests': ['damp', 'tps']}, 05:54:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['dromaeo_dom']}, 05:54:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['basic_compositor_video']}, 05:54:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tsvgx', 05:54:32 INFO - 'tsvgr_opacity', 05:54:32 INFO - 'tart', 05:54:32 INFO - 'tscrollx', 05:54:32 INFO - 'cart']}, 05:54:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:32 INFO - 'tsvgr_opacity', 05:54:32 INFO - 'tart', 05:54:32 INFO - 'tscrollx', 05:54:32 INFO - 'cart']}, 05:54:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tp5o']}, 05:54:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'tests': ['tp5o']}, 05:54:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s', 05:54:32 INFO - '--xperf_path', 05:54:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:32 INFO - 'tests': ['tp5n']}, 05:54:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--xperf_path', 05:54:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:32 INFO - 'tests': ['tp5n']}}, 05:54:32 INFO - 'talos.zip': {'path': '', 05:54:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:32 INFO - Running post-action listener: _resource_record_post_action 05:54:32 INFO - [mozharness: 2016-09-21 12:54:32.573536Z] Finished populate-webroot step (success) 05:54:32 INFO - [mozharness: 2016-09-21 12:54:32.573668Z] Running create-virtualenv step. 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: create_virtualenv 05:54:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:32 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:54:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:32 INFO - Using real prefix '/tools/python27' 05:54:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:36 INFO - Installing pip.................done. 05:54:36 INFO - Return code: 0 05:54:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:36 INFO - 'HOME': '/Users/cltbld', 05:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:36 INFO - 'LOGNAME': 'cltbld', 05:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:36 INFO - 'MOZ_NO_REMOTE': '1', 05:54:36 INFO - 'NO_EM_RESTART': '1', 05:54:36 INFO - 'PAGER': '/bin/cat', 05:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:36 INFO - 'PWD': '/builds/slave/test', 05:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:36 INFO - 'SHELL': '/bin/bash', 05:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:36 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:36 INFO - 'USER': 'cltbld', 05:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:36 INFO - 'XPC_FLAGS': '0x0', 05:54:36 INFO - 'XPC_SERVICE_NAME': '0', 05:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:36 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:54:36 INFO - Cleaning up... 05:54:36 INFO - Return code: 0 05:54:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:36 INFO - 'HOME': '/Users/cltbld', 05:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:36 INFO - 'LOGNAME': 'cltbld', 05:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:36 INFO - 'MOZ_NO_REMOTE': '1', 05:54:36 INFO - 'NO_EM_RESTART': '1', 05:54:36 INFO - 'PAGER': '/bin/cat', 05:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:36 INFO - 'PWD': '/builds/slave/test', 05:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:36 INFO - 'SHELL': '/bin/bash', 05:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:36 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:36 INFO - 'USER': 'cltbld', 05:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:36 INFO - 'XPC_FLAGS': '0x0', 05:54:36 INFO - 'XPC_SERVICE_NAME': '0', 05:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:36 INFO - Downloading/unpacking psutil>=3.1.1 05:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:40 INFO - Installing collected packages: psutil 05:54:40 INFO - Running setup.py install for psutil 05:54:40 INFO - building 'psutil._psutil_osx' extension 05:54:40 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:54:40 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:54:40 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:54:40 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:54:40 INFO - building 'psutil._psutil_posix' extension 05:54:40 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:54:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:54:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:54:40 INFO - ^ 05:54:40 INFO - 1 warning generated. 05:54:40 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:54:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:41 INFO - Successfully installed psutil 05:54:41 INFO - Cleaning up... 05:54:41 INFO - Return code: 0 05:54:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:41 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:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:41 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:54:41 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:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:41 INFO - 'HOME': '/Users/cltbld', 05:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:41 INFO - 'LOGNAME': 'cltbld', 05:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:41 INFO - 'MOZ_NO_REMOTE': '1', 05:54:41 INFO - 'NO_EM_RESTART': '1', 05:54:41 INFO - 'PAGER': '/bin/cat', 05:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:41 INFO - 'PWD': '/builds/slave/test', 05:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:41 INFO - 'SHELL': '/bin/bash', 05:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:41 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:41 INFO - 'USER': 'cltbld', 05:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:41 INFO - 'XPC_FLAGS': '0x0', 05:54:41 INFO - 'XPC_SERVICE_NAME': '0', 05:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:41 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:54:41 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:54:41 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:54:41 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:54:41 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:54:41 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:54:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:43 INFO - Installing collected packages: mozsystemmonitor 05:54:43 INFO - Running setup.py install for mozsystemmonitor 05:54:44 INFO - Successfully installed mozsystemmonitor 05:54:44 INFO - Cleaning up... 05:54:44 INFO - Return code: 0 05:54:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:44 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:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:44 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:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:44 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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:44 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:54:44 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:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:44 INFO - 'HOME': '/Users/cltbld', 05:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:44 INFO - 'LOGNAME': 'cltbld', 05:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:44 INFO - 'MOZ_NO_REMOTE': '1', 05:54:44 INFO - 'NO_EM_RESTART': '1', 05:54:44 INFO - 'PAGER': '/bin/cat', 05:54:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:44 INFO - 'PWD': '/builds/slave/test', 05:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:44 INFO - 'SHELL': '/bin/bash', 05:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:44 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:44 INFO - 'USER': 'cltbld', 05:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:44 INFO - 'XPC_FLAGS': '0x0', 05:54:44 INFO - 'XPC_SERVICE_NAME': '0', 05:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:47 INFO - warning: no files found matching '*.txt' 05:54:47 INFO - no previously-included directories found matching 'build' 05:54:47 INFO - no previously-included directories found matching 'dist' 05:54:47 INFO - no previously-included directories found matching '.git*' 05:54:47 INFO - Installing collected packages: jsonschema, functools32 05:54:47 INFO - Running setup.py install for functools32 05:54:47 INFO - warning: no files found matching '*.txt' 05:54:47 INFO - no previously-included directories found matching 'build' 05:54:47 INFO - no previously-included directories found matching 'dist' 05:54:47 INFO - no previously-included directories found matching '.git*' 05:54:47 INFO - Successfully installed jsonschema functools32 05:54:47 INFO - Cleaning up... 05:54:47 INFO - Return code: 0 05:54:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:47 INFO - 'HOME': '/Users/cltbld', 05:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:47 INFO - 'LOGNAME': 'cltbld', 05:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:47 INFO - 'MOZ_NO_REMOTE': '1', 05:54:47 INFO - 'NO_EM_RESTART': '1', 05:54:47 INFO - 'PAGER': '/bin/cat', 05:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:47 INFO - 'PWD': '/builds/slave/test', 05:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:47 INFO - 'SHELL': '/bin/bash', 05:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:47 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:47 INFO - 'USER': 'cltbld', 05:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:47 INFO - 'XPC_FLAGS': '0x0', 05:54:47 INFO - 'XPC_SERVICE_NAME': '0', 05:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:47 INFO - Cleaning up... 05:54:47 INFO - Return code: 0 05:54:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:47 INFO - 'HOME': '/Users/cltbld', 05:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:47 INFO - 'LOGNAME': 'cltbld', 05:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:47 INFO - 'MOZ_NO_REMOTE': '1', 05:54:47 INFO - 'NO_EM_RESTART': '1', 05:54:47 INFO - 'PAGER': '/bin/cat', 05:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:47 INFO - 'PWD': '/builds/slave/test', 05:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:47 INFO - 'SHELL': '/bin/bash', 05:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:47 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:47 INFO - 'USER': 'cltbld', 05:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:47 INFO - 'XPC_FLAGS': '0x0', 05:54:47 INFO - 'XPC_SERVICE_NAME': '0', 05:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:50 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:54:50 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:54:50 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:54:50 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:54:50 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:54:50 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:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54: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:54: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:54: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:54: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:54: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:54: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:54:51 INFO - Downloading docopt-0.6.1.tar.gz 05:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:51 INFO - Running setup.py install for blobuploader 05:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:52 INFO - Running setup.py install for requests 05:54:52 INFO - Running setup.py install for docopt 05:54:52 INFO - Successfully installed blobuploader requests docopt 05:54:52 INFO - Cleaning up... 05:54:52 INFO - Return code: 0 05:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:52 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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:52 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:54:52 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:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:52 INFO - 'HOME': '/Users/cltbld', 05:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:52 INFO - 'LOGNAME': 'cltbld', 05:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:52 INFO - 'MOZ_NO_REMOTE': '1', 05:54:52 INFO - 'NO_EM_RESTART': '1', 05:54:52 INFO - 'PAGER': '/bin/cat', 05:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:52 INFO - 'PWD': '/builds/slave/test', 05:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:52 INFO - 'SHELL': '/bin/bash', 05:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:52 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:52 INFO - 'USER': 'cltbld', 05:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:52 INFO - 'XPC_FLAGS': '0x0', 05:54:52 INFO - 'XPC_SERVICE_NAME': '0', 05:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GNKKMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Sj6CXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-znI8Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-vZjH8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-erPzKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-R7IR_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-fCq_9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-lB5bxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kGQZVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-pLZPyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:54 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-InhpbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:54 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EwXWF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:54 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-S03PpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:54 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kSpXs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:54 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-MReZZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:54 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-9P889D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:54 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-8g67zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:54 INFO - Running setup.py install for manifestparser 05:54:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:54 INFO - Running setup.py install for mozcrash 05:54:55 INFO - Running setup.py install for mozdebug 05:54:55 INFO - Running setup.py install for mozdevice 05:54:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Running setup.py install for mozfile 05:54:55 INFO - Running setup.py install for mozhttpd 05:54:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Running setup.py install for mozinfo 05:54:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Running setup.py install for mozInstall 05:54:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:55 INFO - Running setup.py install for mozleak 05:54:56 INFO - Running setup.py install for mozlog 05:54:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:56 INFO - Running setup.py install for moznetwork 05:54:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:56 INFO - Running setup.py install for mozprocess 05:54:56 INFO - Running setup.py install for mozprofile 05:54:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:56 INFO - Running setup.py install for mozrunner 05:54:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:56 INFO - Running setup.py install for mozscreenshot 05:54:57 INFO - Running setup.py install for moztest 05:54:57 INFO - Running setup.py install for mozversion 05:54:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:57 INFO - Cleaning up... 05:54:57 INFO - Return code: 0 05:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:57 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:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:54:57 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:54:57 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:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:57 INFO - 'HOME': '/Users/cltbld', 05:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:57 INFO - 'LOGNAME': 'cltbld', 05:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:57 INFO - 'MOZ_NO_REMOTE': '1', 05:54:57 INFO - 'NO_EM_RESTART': '1', 05:54:57 INFO - 'PAGER': '/bin/cat', 05:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:57 INFO - 'PWD': '/builds/slave/test', 05:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:57 INFO - 'SHELL': '/bin/bash', 05:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:54:57 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:57 INFO - 'USER': 'cltbld', 05:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:57 INFO - 'XPC_FLAGS': '0x0', 05:54:57 INFO - 'XPC_SERVICE_NAME': '0', 05:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:57 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-sCEwMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:57 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:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:57 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-FFs7pC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:57 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:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:57 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-QpK6wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:57 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:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:57 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-INjVB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EV_PYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-9rBEP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-jdpcBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-domvvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-l_b3lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-hcn4it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5imCum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-V0e1Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-aQ_bYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-nRJNFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-bPvTK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6usxJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-e30SjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:54:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:54:59 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:55:01 INFO - Downloading blessings-1.6.tar.gz 05:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:02 INFO - Installing collected packages: blessings 05:55:02 INFO - Running setup.py install for blessings 05:55:02 INFO - Successfully installed blessings 05:55:02 INFO - Cleaning up... 05:55:02 INFO - Return code: 0 05:55:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:02 INFO - Reading from file tmpfile_stdout 05:55:02 INFO - Current package versions: 05:55:02 INFO - blessings == 1.6 05:55:02 INFO - blobuploader == 1.2.4 05:55:02 INFO - docopt == 0.6.1 05:55:02 INFO - functools32 == 3.2.3-2 05:55:02 INFO - jsonschema == 2.5.1 05:55:02 INFO - manifestparser == 1.1 05:55:02 INFO - mozInstall == 1.12 05:55:02 INFO - mozcrash == 0.17 05:55:02 INFO - mozdebug == 0.1 05:55:02 INFO - mozdevice == 0.48 05:55:02 INFO - mozfile == 1.2 05:55:02 INFO - mozhttpd == 0.7 05:55:02 INFO - mozinfo == 0.9 05:55:02 INFO - mozleak == 0.1 05:55:02 INFO - mozlog == 3.4 05:55:02 INFO - moznetwork == 0.27 05:55:02 INFO - mozprocess == 0.23 05:55:02 INFO - mozprofile == 0.28 05:55:02 INFO - mozrunner == 6.12 05:55:02 INFO - mozscreenshot == 0.1 05:55:02 INFO - mozsystemmonitor == 0.3 05:55:02 INFO - moztest == 0.7 05:55:02 INFO - mozversion == 1.4 05:55:02 INFO - psutil == 3.1.1 05:55:02 INFO - requests == 1.2.3 05:55:02 INFO - wsgiref == 0.1.2 05:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:02 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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:55:02 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:55:02 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:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:02 INFO - 'HOME': '/Users/cltbld', 05:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:02 INFO - 'LOGNAME': 'cltbld', 05:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:02 INFO - 'MOZ_NO_REMOTE': '1', 05:55:02 INFO - 'NO_EM_RESTART': '1', 05:55:02 INFO - 'PAGER': '/bin/cat', 05:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:02 INFO - 'PWD': '/builds/slave/test', 05:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:02 INFO - 'SHELL': '/bin/bash', 05:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:55:02 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:02 INFO - 'USER': 'cltbld', 05:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:02 INFO - 'XPC_FLAGS': '0x0', 05:55:02 INFO - 'XPC_SERVICE_NAME': '0', 05:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 INFO - Cleaning up... 05:55:02 INFO - Return code: 0 05:55:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:02 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 0x107256490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feeb2d80de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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:55:02 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:55:02 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:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:02 INFO - 'HOME': '/Users/cltbld', 05:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:02 INFO - 'LOGNAME': 'cltbld', 05:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:02 INFO - 'MOZ_NO_REMOTE': '1', 05:55:02 INFO - 'NO_EM_RESTART': '1', 05:55:02 INFO - 'PAGER': '/bin/cat', 05:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:02 INFO - 'PWD': '/builds/slave/test', 05:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:02 INFO - 'SHELL': '/bin/bash', 05:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:55:02 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:02 INFO - 'USER': 'cltbld', 05:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:02 INFO - 'XPC_FLAGS': '0x0', 05:55:02 INFO - 'XPC_SERVICE_NAME': '0', 05:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:03 INFO - Cleaning up... 05:55:03 INFO - Return code: 0 05:55:03 INFO - Running post-action listener: _resource_record_post_action 05:55:03 INFO - Running post-action listener: _start_resource_monitoring 05:55:03 INFO - Starting resource monitoring. 05:55:03 INFO - [mozharness: 2016-09-21 12:55:03.235756Z] Finished create-virtualenv step (success) 05:55:03 INFO - [mozharness: 2016-09-21 12:55:03.236833Z] Running install step. 05:55:03 INFO - Running pre-action listener: _resource_record_pre_action 05:55:03 INFO - Running main action method: install 05:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:03 INFO - Reading from file tmpfile_stdout 05:55:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:03 INFO - Reading from file tmpfile_stdout 05:55:03 INFO - Output received: 05:55:03 INFO - Usage: mozinstall [options] installer 05:55:03 INFO - Options: 05:55:03 INFO - -h, --help show this help message and exit 05:55:03 INFO - -d DEST, --destination=DEST 05:55:03 INFO - Directory to install application into. [default: 05:55:03 INFO - "/builds/slave/test"] 05:55:03 INFO - --app=APP Application being installed. [default: firefox] 05:55:03 INFO - mkdir: /builds/slave/test/build/application 05:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:55:38 INFO - Reading from file tmpfile_stdout 05:55:38 INFO - Output received: 05:55:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:55:38 INFO - Running post-action listener: _resource_record_post_action 05:55:38 INFO - [mozharness: 2016-09-21 12:55:38.020900Z] Finished install step (success) 05:55:38 INFO - [mozharness: 2016-09-21 12:55:38.021059Z] Running run-tests step. 05:55:38 INFO - Running pre-action listener: _resource_record_pre_action 05:55:38 INFO - Running main action method: run_tests 05:55:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:55:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:55:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:55:38 INFO - 2016-09-21 05:55:38.035 screenresolution[1925:22377] starting screenresolution argv=screenresolution get 05:55:38 INFO - 2016-09-21 05:55:38.037 screenresolution[1925:22377] Display 0: 1600x1200x32@60 05:55:38 INFO - 2016-09-21 05:55:38.042 screenresolution[1926:22379] starting screenresolution argv=screenresolution list 05:55:38 INFO - Available Modes on Display 0 05:55:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:55:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:55:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:55:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:55:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:55:38 INFO - Intel Iris: 05:55:38 INFO - Chipset Model: Intel Iris 05:55:38 INFO - Type: GPU 05:55:38 INFO - Bus: Built-In 05:55:38 INFO - VRAM (Dynamic, Max): 1536 MB 05:55:38 INFO - Vendor: Intel (0x8086) 05:55:38 INFO - Device ID: 0x0a2e 05:55:38 INFO - Revision ID: 0x0009 05:55:38 INFO - Displays: 05:55:38 INFO - Display: 05:55:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:55:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:55:38 INFO - Display Serial Number: 1600x1200 60 05:55:38 INFO - Main Display: Yes 05:55:38 INFO - Mirror: Off 05:55:38 INFO - Online: Yes 05:55:38 INFO - Rotation: Supported 05:55:38 INFO - Return code: 0 05:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:38 INFO - Python 2.7.3 05:55:38 INFO - Return code: 0 05:55:38 INFO - grabbing minidump binary from tooltool 05:55: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:55:38 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 0x10706ad30>, '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 0x106e90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:38 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:55:38 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:55:38 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:55:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:38 INFO - Return code: 0 05:55:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:55:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:55:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EiLW1JwXIV/Render', 05:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:38 INFO - 'HOME': '/Users/cltbld', 05:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:38 INFO - 'LOGNAME': 'cltbld', 05:55:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:38 INFO - 'MOZ_NO_REMOTE': '1', 05:55:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:38 INFO - 'NO_EM_RESTART': '1', 05:55:38 INFO - 'PAGER': '/bin/cat', 05:55:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:38 INFO - 'PWD': '/builds/slave/test', 05:55:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:38 INFO - 'SHELL': '/bin/bash', 05:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xx6aUSUvD5/Listeners', 05:55:38 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 05:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:38 INFO - 'USER': 'cltbld', 05:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:38 INFO - 'XPC_FLAGS': '0x0', 05:55:38 INFO - 'XPC_SERVICE_NAME': '0', 05:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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:55:38 INFO - mozversion application_buildid: 20160921031007 05:55:38 INFO - mozversion application_changeset: 675331e308773c07e5b39cafd92ec1f4f591d152 05:55:38 INFO - mozversion application_display_name: Nightly 05:55:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:38 INFO - mozversion application_name: Firefox 05:55:38 INFO - mozversion application_remotingname: firefox 05:55:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:55:38 INFO - mozversion application_vendor: Mozilla 05:55:38 INFO - mozversion application_version: 52.0a1 05:55:38 INFO - mozversion platform_buildid: 20160921031007 05:55:38 INFO - mozversion platform_changeset: 675331e308773c07e5b39cafd92ec1f4f591d152 05:55:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:55:38 INFO - mozversion platform_version: 52.0a1 05:55:38 INFO - using testdate: 1474462538 05:55:38 INFO - actual date: 1474462538 05:55:38 INFO - starting webserver on 'localhost:56581' 05:55:38 INFO - SUITE-START | Running 2 tests 05:55:38 INFO - TEST-START | dromaeo_css 05:55:38 INFO - operating with platform_type : mac_ 05:55:38 INFO - Initialising browser for dromaeo_css test... 05:55:38 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpRWaxEn/profile http://localhost:56581/getInfo.html) 05:55:41 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 05:55:41 INFO - PROCESS | 1936 | colorDepth:24 05:55:41 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 05:55:41 INFO - PROCESS | 1936 | __metrics 05:55:41 INFO - PROCESS | 1936 | 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:55:41 INFO - PROCESS | 1936 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:41 INFO - TEST-INFO | 1936: exit 0 05:55:41 INFO - Browser initialized. 05:55:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:41 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpRWaxEn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:53 INFO - PROCESS | 1938 | RSS: Main: 234995712 05:55:53 INFO - PROCESS | 1938 | 05:56:45 INFO - PROCESS | 1938 | 1474462605789 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:58:56 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56581/tests/dromaeo/cssquery-ext.html) 05:58:58 INFO - PROCESS | 1938 | RSS: Main: 350289920 05:58:58 INFO - PROCESS | 1938 | 06:02:00 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-ext.html (next: http://localhost:56581/tests/dromaeo/cssquery-jquery.html) 06:02:01 INFO - PROCESS | 1938 | RSS: Main: 370118656 06:02:01 INFO - PROCESS | 1938 | 06:05:03 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56581/tests/dromaeo/cssquery-mootools.html) 06:05:04 INFO - PROCESS | 1938 | RSS: Main: 335921152 06:05:04 INFO - PROCESS | 1938 | 06:08:06 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56581/tests/dromaeo/cssquery-prototype.html) 06:08:07 INFO - PROCESS | 1938 | RSS: Main: 345706496 06:08:07 INFO - PROCESS | 1938 | 06:11:10 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56581/tests/dromaeo/cssquery-yui.html) 06:11:11 INFO - PROCESS | 1938 | RSS: Main: 325758976 06:11:11 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-yui.html (next: http://localhost:56581/tests/dromaeo/cssquery-dojo.html) 06:14:14 INFO - PROCESS | 1938 | RSS: Main: 466911232 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | __start_tp_report 06:14:14 INFO - PROCESS | 1938 | _x_x_mozilla_page_load 06:14:14 INFO - PROCESS | 1938 | _x_x_mozilla_page_load_details 06:14:14 INFO - PROCESS | 1938 | |i|pagename|runs| 06:14:14 INFO - PROCESS | 1938 | |0;dojo.html;2828.816126951748;3250.7074363307297;3297.6537463566324;3329.716974057205;3373.1904342957682;5633.6338138021;5693.516051135648;5705.229793977812;5837.445442682949;5849.473547380746;4584.793684284207;5746.281714785652;5760.049591817345;5763.991301522238;5813.098969659699;5152.9484705152845;5172.017316709813;5189.974050129763;5245.868853278679;5298.523132918056;4789.688670236441;5321.787128514855;5372.946270537283;5396.352437707461;5430.239766432703;5202.869928251824;5334.893302133974;5336.813211537577;5346.572274218072;5421.322334708161;5182.170852663556;5204.9479505204845;5238.71187084714;5239.869003274911;5246.396664383607;5136.332276804029;5205.973970130163;5206.531412172884;5217.608679349026;5227.294315267428;4787.40157480315;5737.684427356494;5752.827415177551;5759.539236861041;5824.0390335594575;6096.0603354173045;6108.008189064015;6124;6147.907781383283;6222.408871157233;6218.81343559694;6256.468200202943;6259.499240060784;6266.561340706153;6268;5919.763209471573;5922.526197904157;5936.257967754031;5945.256842894638;5968.910466343008;6165.1985241919165;6235.875282494325;6267.811965641038;6332.176817013758;6335.11308416822;6083.144640884484;6124.686092398479;6131.356207598138;6134.460499230538;6227.719752611143;6234.625922444668;6248.875022499616;6249.9062514062325;6251.74993000284;6256.217972753406;5911.852203694942;6077.3314935357075;6140.600860944024;6204.658743769136;6242.063690446469;6106.582013105394;6145.631262124287;6152.538559608047;6158;6169.5064394849205;4936.185529387611;4962.379702537183;4964.875878103004;4996.225585034325;5014.89970200594;4419.756913369732;4420.557944205618;4428.31361139024;4435.223835828717;4464.995376040365;5268.998890210848;5620;5652.943470565242;5829.562782791223;5868.4424979626865;6185.41238582334;6242.65665388408;6248.4376406123665;6251.3123556408755;6254.124422580842;5776.826695199151;5824.417558244227;5836.358000619928;5856.238688970407;5938.792142275086;5416.620836541483;5421.701806400607;5424.267723857308;5447.210154527571;5468.972655136698;6423.100765892778;6428.292887782433;6431.871362572816;6435.2599451063725;6440.4847612190915;6141.455323060992;6188.628682279078;6219.067139929047;6238.282597501164;6284.214473190851;6369.7452101915405;6377.394147555975;6381.074744162163;6390.648514331757;6435.324290949383;6188.876222475616;6217.191765070512;6254.906176407449;6256.624602523863;6257.374262573706;6099.279518885317;6167.1366008759705;6181.598196117238;6256.280527739186;6260.812175634738;6104.359042300494;6175.96912015455;6219.40915613016;6224.06639004153;6229.408206220402;5556.416576259596;6198.6280823150755;6205.47253483459;6206.06908963659;6211.3167551570195;5457.590680699042;5830.2420685310635;6023.969880150571;6055.9091613626715;6080.939190608215;5004.649674522894;6053.636781793107;6119.969400152971;6132.356102609162;6141.731496609813;5952.732127054206;6075.362086980804;6076.210092687922;6083.361247069171;6096.75612975476 06:14:14 INFO - PROCESS | 1938 | |1;ext.html;478.63623646029015;513.2070950381665;520.5289213261998;524.5986820082635;527.6412039812928;28825.423491530182;40022.799886000605;41203.58796412035;41289;42981.14037719244;42126.36810447846;42389.57610423902;42454;42495.57504424955;42659.573404265946;9868;10061.64784232552;10068.395896246213;10080;10082.49587520621;8862.379633425662;9059.365844390895;9997.750056248578;12218.450169742338;12247.75504489914;12151.088668349865;12250.571230006952;12251.816222756666;12269.631911042683;12272;8907.599158037903;11990.820137697941;11991.760164796655;12259.570915017975;12342.876571234263;8786.297096232285;11763.294202347886;12097.455614497281;12122.515099396014;12319.44562494681;40770;41142.9714257146;41143.588564114274;41182.38226426606;41254.38118428226;3151.4642510772997;3329.433996220648;3332.8166950817695;3344.7324214062814;3344.8160351180677;30663.540046899314;31043.379132417223;31689.683103168903;31830.840845795854;32249;3235.1588586967323;3286.5891763529557;3338.9499157512655;3378.341223461426;3402.4385976314124;487430;491427.2001919698;494199;494716.9999999964;495783;57730.845383092106;57798.4220157793;59666.70166649139;60023.69988150031;60097;63570;63645.363546363944;63691.68154159292;63733;63743.04385434222;16592.83407165913;16829.41097061597;16847;16851;16897.239624216938;11864.584739534248;12079.818802717966;12838.422270997828;12960.80558791619;12993.415296311689;12576.434060467302;15483.380664773284;15576.766348504781;15593.454229101926;17038.847813154607;5198.558122559549;6248.812535623939;6280.780172693934;6282.780102696383;6288.496920246369;884.7743825324501;953.3040880157524;957.593022965251;965.1120968708805;984.1093810101869;25412;26292.342691432485;28097.735601897963;28357.716422835507;30202.54696179559;1002.734275417015;1022.25375475903;1036.6268143468346;1084.8698156221303;1095.7205912492423;14722.484713034992;14918.4778532753;15654.13902235388;15736.68526629461;15821.762673559906;539085;622640;625535;626026;628332.0251373631;57321.71339143361;57407;57450.425495745345;57579;57615.423845761004;1292.8319318488725;1354.3228385807097;1363.3864760857455;1366.863313668645;1374.8212732344732;28932.710672893;29471.85264073666;29492.115236542937;29954.85022574873;30237.244068898453;50142;50621;50671.49328506815;50747.492525074274;50803.23795143002;570159;570390;572265;572342;573512;27479;34903.12742181466;35357.116072098404;37543.061423463536;37714.811425942695;37251.6274837259;39735;46926.82682932817;47123.764381177876;48063;30768;37898.62101378951;38779.80610096931;39458.80270598629;40440.98897527585;38166.64917095219;38629.613703862604;39456.2108757829;39957.40063899102;40289.79855100823;34129.30280626516;35548.93353199408;37246.813765930994;37785.055373615876;38507.42238866475;23675.64486532738;33755.66244337623;33865;34638.82680586682;34669;23821.404464888517;25254.747452525975;25529.617055743805;26206.606900896884;26598.867005664848 06:14:14 INFO - PROCESS | 1938 | |2;jquery.html;345.5145520543637;365.846344535295;365.8719448193132;377.08180580287;394.3434182086826;15167.165805880672;15244.771328430068;16206.118392539556;20743.585128297425;20764.377068687925;16823;19562.510937226576;19926.302579409723;20396.69404958923;20768.68846967297;5718.59969802114;5972.6715030673295;5991.850203744898;5992.310884248302;5996.640201587897;3393.7285017198565;4318.093200427914;4401.449818772653;5807.796727114552;5881.705914704269;4190.2248084104385;6149;6461.224653041641;6465.3857883501;6535.183102112236;6346.52401069917;6446.645434501101;6456.366750308663;6504.772332968323;6514.088027676129;5619.129034999541;5619.241402410663;5626.099824028177;5627.127795191752;5641.548676105943;24929.252122436355;25257.242282731546;25284;25299.98800047996;25591.48817023649;2247.9438014049615;2397.832151749378;2406.2300063979533;2414.7464516225896;2665.2936971702516;12401.75196496074;15093.320800564;15166.620834479116;15454.922725386414;16007.919960400124;1811.7191835265555;1819.672458957387;1843.9858078057016;1881.7835948865918;1909.713542968552;73567.63216183938;117901.82098178995;119906;120667.396663017;124043.37978310141;10807.945960270148;10816.134709223243;11020.944895275472;11045.72114764359;11122.221444498808;14045.508407205698;14066.929665351608;14081.155130692192;14085.43658253679;14089.929550352388;8173.591320433955;8350.290225330915;8395.202455766692;8464.746057618282;8465.238128568459;6649.368310010541;8295.502269863708;8344.165583441607;8467.703630372907;8481.388536178107;3550.5029295898594;4260.910839641236;4399.5160532341415;4438.689291749546;4503.639708823286;1604.5667669729107;1615.781869447633;1682.5541231573643;1727.2227497626118;1885.7737071551228;696.6934548798513;761.7257787196605;925.9675911343071;947.1144479911305;970.6360114956891;20088.79911200869;20278.695819562425;20671.8966405167;20728.896355518125;20844.47888802792;882.9735107946643;884.425123669607;920.4293338130402;927.3276874266103;937.803061357109;10442.63450779219;10878.292910960763;10934.343939363505;10968.341899486057;10969.067629251604;551650.2417487887;560673;563202;575656;576663;95882;118630;121265.39367303283;125088;131324;967.5259123029806;983.9212862971088;1016.1819735113305;1038.901304376083;1042.4006196437078;16603.3358665652;17280.913595431943;17895.642087158445;18037.63924721472;18382;54676;55877;56124.719376402856;56483.71758141183;56491.71754141203;77960.61019694865;83614.3277134466;85905.57047214724;87896.56051719701;88597.68413895187;7488.475806693479;7828.825676148624;7909.367250620052;8125.79685507867;8191.098979112174;11387.715307117389;12180;12805.92657762149;13057;13470.730585388434;7941.642626081955;9071.95464022702;10832.783344333227;10895.400752958663;10988.175886808362;11100.777984440105;11249.718757030812;11416.543338266376;11444.82832757526;11610.303381797119;9659.372140810825;11504.884951150381;11525.654230372767;11560.42197890119;11797.410129493319;7868.763937081897;7875;7944.523328600302;8274.462159959583;8294.336453083859;9974.700758977242;11045.33727976324;11319.830202547133;11382.94308528452;11525.366104864313 06:14:14 INFO - PROCESS | 1938 | |3;mootools.html;1509.630140615549;1538.776877352784;1716.8626509879211;1868.8878667279973;1869.3270422647836;8064.596770161498;8326.708565200219;8503.702370417037;9085.318601104918;9098.226650734696;8102.432829701923;8562.957185214082;8761.780955476117;8772.517511536864;8897.421667591601;2384.546936082143;2421.624648179535;2421.648860915166;2421.7336093029753;2423.309356833303;2105.315772373977;2393.497365553227;2398.7526486227152;2429.9028038878423;2440.804735621146;2173.89130543473;2203.2839327218717;2203.5482726041205;2203.5482726041205;2205.0628482894786;2335.94160145996;2409.168836751318;2411.6141417373137;2421.769931856471;2423.866687332196;2380.916667916632;2389.4026493376655;2396.892139853711;2413.0227257960555;2414.5895197816412;8933.28533717301;9017.819643607158;9036.63853445868;9039.954800226022;9041;5267.999080174793;5386.649867758583;5441.374241962186;5445.346558413015;5459.290292262021;3540.0972751948348;3651.8721844735305;3710.9257814843822;3712.461693054519;3721.497597824286;1058.1957712138753;1103.3269705479652;1114.0641860836854;1126.8985791278742;1128.0975219824109;11933.880661193363;11942.701432464171;11943.581974630846;11948.163628546004;11963.880361196363;4656;4658.161530924466;4806.519348065235;4858;4869.902601947942;10184.287099902936;10188.694339169837;10214.233932455096;10225.795484090426;10234.130098941525;5436.374816896028;5438.456154384609;5440.238366628675;5443.2107344434835;5448.782048718086;4759.595434388047;4897.681650692693;4969.2546118081855;4981.626378021663;5010.599152067826;3712.7029837612927;3777.3578491656485;3808.619138086169;3851.614838516126;3860.1121741999495;1163.116031815826;1163.4589915689246;1175.4416652090188;1178.4284621958343;1178.640514643025;799.1010113622175;884.7168905950034;885.9379843411028;903.9186473217442;922.5756152169943;5788.421157884262;5803.7968671096305;5901.318124334544;6052.273727152682;6151.477124444383;864.5461132905149;878.6046279174398;894.3158483759929;912.8904531456268;951.6003278622995;3233.224026233687;3672.898130560821;3864;3932.508436445444;4014.1770936957855;10715.03564679167;10998.34009959389;11119.388433636228;11136.443177841076;11145.275557088764;11042.392668403154;11055.834162487568;11059.778804423866;11063.557457701763;11066.004059634672;8236.794080148044;8372.790680232922;8391.790205244917;8394.916050839414;8403.285720713686;5609.943900560942;5760.884782304247;5903.970480147572;5954.10688396744;5982.252218472691;10202.33684810485;10256.282060255711;10259.640912568024;10272.897271027194;10279.794404112026;9943.204543636637;10266.486675666336;10311.793764124526;10466.110380617733;10469.31949423285;7499.137599176164;7653.579053151907;7672.73145439907;7674.155842857393;7686.9231307686205;8195;8206.794830129056;8272.255497005057;8341.416100873123;8369.748907532783;7469;7505.4746167767735;7574.602510251659;7587.317141457295;7646.847063058819;7442.218567050381;7460.253974602496;7491;7496.812579685551;7498.700051997859;6934.098567186234;6995.160580730345;7038.859222815413;7095.3968912643;7120.60836653989;4816.759162041954;4911.803527858989;4918.95081049185;4942.28336891156;5067.594592432522;4981.053599816023;5092.796288148433;5101.234814777813;5167.250748641502;5245.816396426107 06:14:14 INFO - PROCESS | 1938 | |4;prototype.html;277.9944401111979;281.53406112883187;296.70033266400935;305.6072946264051;309.7115997450604;4385.3641222022825;5045.243213517974;5076.16749354238;5099.362579677545;5102.948970510294;4094.5086589609214;4276.828926842931;4844;5210.478952104788;5284.833218380465;4031.6371526562602;4052;4055.959440405588;4064.7764372959477;4105.706702388753;3397.3884700753856;3430.365382404263;4091.468109145807;4107.548169701346;4118.588141185887;3191.808491490506;3970.285348637244;4045.9797701011453;4081.3674530188014;4113.786433002257;3560.4659301104784;3697.5932647408763;3984.382420724792;4000.479937608107;4005.5794141615293;3465.7573969822124;3469.5836499619954;3479.530263414432;3484.529588505545;3484.8954531364097;4554.7039442436135;4940.678855874393;4979.526944940225;5174.689518628894;5257.553107985787;3977.5226972763166;4520.796564154588;4530.466236335664;4566.725996440225;4587.42657167854;5457.536109430703;5519.5097323722775;5521.696306703129;5545.639533430314;5553.722973580853;3384.4415671414185;3572.2855428914063;3756.398976163801;3763.8870833875026;3776.3202623527754;4221.64116050133;5302.655327403745;5407.539174928049;5603.579731520112;5613.494785469327;3711.740178187501;3732.570754363283;3736.3087828751222;3741.513603231617;3755.2677227940835;3563.80399078048;3762.9435558466644;3876.030992251937;3885.6502914737807;3904.9651842261824;4507.323901414748;4519.254323036728;4539.682222244412;4557.794899229542;4579.633629309647;5350.662334416396;5501.394846566875;5535.308086489189;5595.482033085046;5631.239782629293;1069.4919913041242;1232.3591732299333;1311;1321.2666969831835;1321.8678132186897;648.6043513456788;803.7709252862905;812.5774597209418;816.6733306677377;818.0979223305837;3699.3711069118312;3755.455458958436;4255.76593287366;4271.594198551133;4307.6769242306955;4129.401236820644;4258.212230737324;4620.8151673933335;4632.30920713937;4651.488336283006;3585.928281434357;3864.381698928158;4150.64719498846;4228.767417792051;4310.698251122454;2129.243374216278;2206.591780520577;2318.5362927414585;2456.5823809952353;2539.961900571493;4098;4647.790849411785;4784.932807113995;4820.469748327681;4821.421429428491;4052.878413647595;4599;4825.5174482551465;4889.462159162489;4934.925976110361;3746.2018231249153;3775.3770627846648;4877.365942427462;4929.457759646436;4936.851894443173;4457.398251236042;4701.506341834195;4764.571188593043;4793.5685788279225;4822.95177048239;4125.855595054159;4606.723596584216;4662.065242924148;4690.530946905282;4774.30772537987;4298.441202643637;4309.870703878889;4344.391785150145;5176.870578235575;5536.501714845684;3197.4404479215577;3222.38774632819;3807.9619203807606;3820.8662696805477;3840.9231815364096;4793.832215872428;5273.868153296198;5693.601447898607;5734.885302293847;5774.740136693943;4564.771761411983;4823.927641085456;4932.186189278729;5473.781048758005;5632.380438151718;5248.475152484873;5269.552088072403;5529.087700529368;5547.448173840079;5559.305086864142;5411.540019098421;5423.674579525241;5448.482394172547;5473.099257393587;5488.588355873246;4807.735574543433;5067.695938243717;5596.888062238814;5636.730696196279;5664.688442135722;5092.618053645917;5476.58925580591;5511.4213007633625;5531.446855314436;5552.861178470571 06:14:14 INFO - PROCESS | 1938 | |5;yui.html;725.4595326481772;733.4242619543659;738.4941315199089;761.9771406857793;799.338203781408;15456;16351.01893886366;16352.91823540882;16359.427420040302;16410.261538230778;14789;14887;14916.105033697986;14926;14936.62658433537;682.556338380052;700.5481464455423;703.3564288675856;843.962021709023;858.356232825381;681.427600815315;842.3008902610818;863.5811631358786;865.273170536749;869.4131461263653;886.8315020146184;887.9156480134377;888.0409158109227;888.1695614600337;888.258304315897;723.6490302203428;884.8539990901494;886.3042511628405;887.2857349833381;890.8485557455216;548.9862753431156;663.2405895249912;679.7620832708562;681.9727210911558;683.729926678959;14934.70130597382;14964.47624333154;14972.625684357869;14980.700385992328;15001.32494037771;13834.515791947335;14045.955341423112;14238.644033899132;14341.856581434156;14460.638484037878;10891.183161262938;11907.642770716893;12886.613401597873;12991.805122923164;13435;4573.611243044345;4594.173048851206;4596.655250856165;4786.329913812069;4806.687565308243;124917.37541312235;128060;128632.35683821615;130541;130889;11108.556807164432;11116.277441966246;11168.497417616227;11221.438928053565;11502.94248528752;22468.662970055462;22496.77503224947;22520.77479225187;22544.66183007256;22566.661500077185;7827.6477558510005;7836.686532538634;7952.403569732178;8074.515529068275;8142.796430089295;4299.247631664446;4307.590778876001;4386.298192289219;4411;4435.068635586563;3495.8776442824887;3610.530631017951;3610.801405922647;3612.512310838056;3613.9277214455565;641.9775307864296;654.456800855289;660.0330515794384;664.2560332427712;664.6444152378551;590.4213870407025;602.2926943389492;618.5330075792748;620.7579044172776;623.8939380305359;8876.20114189713;9099.772505687411;9177.632894684139;9268.351215414856;9312;476.9878219046709;535.8928214357067;558.7988324203284;582.1006544888158;585.5696063393402;4337.631301339358;4462.263726485158;4470.262406702857;4486.371907932892;4600.5629465200755;145382;152735;157670;160685;162470;94221;137989;139500.60499395078;140725;144412;100962.49518752359;109379;117963;119443.2083518748;123667.76332236563;8595.18345757152;8638.956805215934;8660.566971651266;8697.425490430227;8882.289416846508;46046.30930535978;58523.9999999983;61773;62130;62340.02559590625;91979;93118.53440732753;94127;95060;95940.60148496344;9818.361806482555;11599.478023489131;11855.466504007169;11887.405629718307;11920.582779602672;12212.511499540275;12360.938195308965;12467.189632673848;12563;12783.80824287655;11703.180777345504;12021.09841761854;12113.394330283274;12271.447784849524;12384.318862462651;11544.365059921785;11964.461599227881;12034.458449369975;12309.076819238413;12320.568780092653;11623.825642615537;11901.940490297493;11912.52349905994;12011.219270747373;12301.93849030785;8705.956470217609;9651.951740241535;10037.5483103262;10051.748706282402;10437.895621043692;9389.436633801994;9830.557624906753;9900.455474948947;9943;9949.651762188289 06:14:14 INFO - PROCESS | 1938 | __end_tp_report 06:14:14 INFO - PROCESS | 1938 | __start_cc_report 06:14:14 INFO - PROCESS | 1938 | _x_x_mozilla_cycle_collect,1473 06:14:14 INFO - PROCESS | 1938 | __end_cc_report 06:14:14 INFO - PROCESS | 1938 | __startTimestamp1474463654972__endTimestamp 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | ------- Summary: start ------- 06:14:14 INFO - PROCESS | 1938 | Number of tests: 6 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | [#0] dojo.html Cycles:165 Average:5747.96 Median:6053.64 stddev:670.11 (11.1%) stddev-sans-first:631.83 06:14:14 INFO - PROCESS | 1938 | Values: 2828.8 3250.7 3297.7 3329.7 3373.2 5633.6 5693.5 5705.2 5837.4 5849.5 4584.8 5746.3 5760.0 5764.0 5813.1 5152.9 5172.0 5190.0 5245.9 5298.5 4789.7 5321.8 5372.9 5396.4 5430.2 5202.9 5334.9 5336.8 5346.6 5421.3 5182.2 5204.9 5238.7 5239.9 5246.4 5136.3 5206.0 5206.5 5217.6 5227.3 4787.4 5737.7 5752.8 5759.5 5824.0 6096.1 6108.0 6124.0 6147.9 6222.4 6218.8 6256.5 6259.5 6266.6 6268.0 5919.8 5922.5 5936.3 5945.3 5968.9 6165.2 6235.9 6267.8 6332.2 6335.1 6083.1 6124.7 6131.4 6134.5 6227.7 6234.6 6248.9 6249.9 6251.7 6256.2 5911.9 6077.3 6140.6 6204.7 6242.1 6106.6 6145.6 6152.5 6158.0 6169.5 4936.2 4962.4 4964.9 4996.2 5014.9 4419.8 4420.6 4428.3 4435.2 4465.0 5269.0 5620.0 5652.9 5829.6 5868.4 6185.4 6242.7 6248.4 6251.3 6254.1 5776.8 5824.4 5836.4 5856.2 5938.8 5416.6 5421.7 5424.3 5447.2 5469.0 6423.1 6428.3 6431.9 6435.3 6440.5 6141.5 6188.6 6219.1 6238.3 6284.2 6369.7 6377.4 6381.1 6390.6 6435.3 6188.9 6217.2 6254.9 6256.6 6257.4 6099.3 6167.1 6181.6 6256.3 6260.8 6104.4 6176.0 6219.4 6224.1 6229.4 5556.4 6198.6 6205.5 6206.1 6211.3 5457.6 5830.2 6024.0 6055.9 6080.9 5004.6 6053.6 6120.0 6132.4 6141.7 5952.7 6075.4 6076.2 6083.4 6096.8 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | [#1] ext.html Cycles:180 Average:69343.85 Median:36397.87 stddev:149453.08 (410.6%) stddev-sans-first:149782.90 06:14:14 INFO - PROCESS | 1938 | Values: 478.6 513.2 520.5 524.6 527.6 28825.4 40022.8 41203.6 41289.0 42981.1 42126.4 42389.6 42454.0 42495.6 42659.6 9868.0 10061.6 10068.4 10080.0 10082.5 8862.4 9059.4 9997.8 12218.5 12247.8 12151.1 12250.6 12251.8 12269.6 12272.0 8907.6 11990.8 11991.8 12259.6 12342.9 8786.3 11763.3 12097.5 12122.5 12319.4 40770.0 41143.0 41143.6 41182.4 41254.4 3151.5 3329.4 3332.8 3344.7 3344.8 30663.5 31043.4 31689.7 31830.8 32249.0 3235.2 3286.6 3338.9 3378.3 3402.4 487430.0 491427.2 494199.0 494717.0 495783.0 57730.8 57798.4 59666.7 60023.7 60097.0 63570.0 63645.4 63691.7 63733.0 63743.0 16592.8 16829.4 16847.0 16851.0 16897.2 11864.6 12079.8 12838.4 12960.8 12993.4 12576.4 15483.4 15576.8 15593.5 17038.8 5198.6 6248.8 6280.8 6282.8 6288.5 884.8 953.3 957.6 965.1 984.1 25412.0 26292.3 28097.7 28357.7 30202.5 1002.7 1022.3 1036.6 1084.9 1095.7 14722.5 14918.5 15654.1 15736.7 15821.8 539085.0 622640.0 625535.0 626026.0 628332.0 57321.7 57407.0 57450.4 57579.0 57615.4 1292.8 1354.3 1363.4 1366.9 1374.8 28932.7 29471.9 29492.1 29954.9 30237.2 50142.0 50621.0 50671.5 50747.5 50803.2 570159.0 570390.0 572265.0 572342.0 573512.0 27479.0 34903.1 35357.1 37543.1 37714.8 37251.6 39735.0 46926.8 47123.8 48063.0 30768.0 37898.6 38779.8 39458.8 40441.0 38166.6 38629.6 39456.2 39957.4 40289.8 34129.3 35548.9 37246.8 37785.1 38507.4 23675.6 33755.7 33865.0 34638.8 34669.0 23821.4 25254.7 25529.6 26206.6 26598.9 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | [#2] jquery.html Cycles:180 Average:33828.67 Median:14128.39 stddev:94517.82 (669.0%) stddev-sans-first:94749.53 06:14:14 INFO - PROCESS | 1938 | Values: 345.5 365.8 365.9 377.1 394.3 15167.2 15244.8 16206.1 20743.6 20764.4 16823.0 19562.5 19926.3 20396.7 20768.7 5718.6 5972.7 5991.9 5992.3 5996.6 3393.7 4318.1 4401.4 5807.8 5881.7 4190.2 6149.0 6461.2 6465.4 6535.2 6346.5 6446.6 6456.4 6504.8 6514.1 5619.1 5619.2 5626.1 5627.1 5641.5 24929.3 25257.2 25284.0 25300.0 25591.5 2247.9 2397.8 2406.2 2414.7 2665.3 12401.8 15093.3 15166.6 15454.9 16007.9 1811.7 1819.7 1844.0 1881.8 1909.7 73567.6 117901.8 119906.0 120667.4 124043.4 10807.9 10816.1 11020.9 11045.7 11122.2 14045.5 14066.9 14081.2 14085.4 14089.9 8173.6 8350.3 8395.2 8464.7 8465.2 6649.4 8295.5 8344.2 8467.7 8481.4 3550.5 4260.9 4399.5 4438.7 4503.6 1604.6 1615.8 1682.6 1727.2 1885.8 696.7 761.7 926.0 947.1 970.6 20088.8 20278.7 20671.9 20728.9 20844.5 883.0 884.4 920.4 927.3 937.8 10442.6 10878.3 10934.3 10968.3 10969.1 551650.2 560673.0 563202.0 575656.0 576663.0 95882.0 118630.0 121265.4 125088.0 131324.0 967.5 983.9 1016.2 1038.9 1042.4 16603.3 17280.9 17895.6 18037.6 18382.0 54676.0 55877.0 56124.7 56483.7 56491.7 77960.6 83614.3 85905.6 87896.6 88597.7 7488.5 7828.8 7909.4 8125.8 8191.1 11387.7 12180.0 12805.9 13057.0 13470.7 7941.6 9072.0 10832.8 10895.4 10988.2 11100.8 11249.7 11416.5 11444.8 11610.3 9659.4 11504.9 11525.7 11560.4 11797.4 7868.8 7875.0 7944.5 8274.5 8294.3 9974.7 11045.3 11319.8 11382.9 11525.4 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | [#3] mootools.html Cycles:180 Average:5791.07 Median:4883.79 stddev:3285.48 (67.3%) stddev-sans-first:3278.94 06:14:14 INFO - PROCESS | 1938 | Values: 1509.6 1538.8 1716.9 1868.9 1869.3 8064.6 8326.7 8503.7 9085.3 9098.2 8102.4 8563.0 8761.8 8772.5 8897.4 2384.5 2421.6 2421.6 2421.7 2423.3 2105.3 2393.5 2398.8 2429.9 2440.8 2173.9 2203.3 2203.5 2203.5 2205.1 2335.9 2409.2 2411.6 2421.8 2423.9 2380.9 2389.4 2396.9 2413.0 2414.6 8933.3 9017.8 9036.6 9040.0 9041.0 5268.0 5386.6 5441.4 5445.3 5459.3 3540.1 3651.9 3710.9 3712.5 3721.5 1058.2 1103.3 1114.1 1126.9 1128.1 11933.9 11942.7 11943.6 11948.2 11963.9 4656.0 4658.2 4806.5 4858.0 4869.9 10184.3 10188.7 10214.2 10225.8 10234.1 5436.4 5438.5 5440.2 5443.2 5448.8 4759.6 4897.7 4969.3 4981.6 5010.6 3712.7 3777.4 3808.6 3851.6 3860.1 1163.1 1163.5 1175.4 1178.4 1178.6 799.1 884.7 885.9 903.9 922.6 5788.4 5803.8 5901.3 6052.3 6151.5 864.5 878.6 894.3 912.9 951.6 3233.2 3672.9 3864.0 3932.5 4014.2 10715.0 10998.3 11119.4 11136.4 11145.3 11042.4 11055.8 11059.8 11063.6 11066.0 8236.8 8372.8 8391.8 8394.9 8403.3 5609.9 5760.9 5904.0 5954.1 5982.3 10202.3 10256.3 10259.6 10272.9 10279.8 9943.2 10266.5 10311.8 10466.1 10469.3 7499.1 7653.6 7672.7 7674.2 7686.9 8195.0 8206.8 8272.3 8341.4 8369.7 7469.0 7505.5 7574.6 7587.3 7646.8 7442.2 7460.3 7491.0 7496.8 7498.7 6934.1 6995.2 7038.9 7095.4 7120.6 4816.8 4911.8 4919.0 4942.3 5067.6 4981.1 5092.8 5101.2 5167.3 5245.8 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | [#4] prototype.html Cycles:180 Average:4192.90 Median:4547.19 stddev:1289.10 (28.3%) stddev-sans-first:1258.79 06:14:14 INFO - PROCESS | 1938 | Values: 278.0 281.5 296.7 305.6 309.7 4385.4 5045.2 5076.2 5099.4 5102.9 4094.5 4276.8 4844.0 5210.5 5284.8 4031.6 4052.0 4056.0 4064.8 4105.7 3397.4 3430.4 4091.5 4107.5 4118.6 3191.8 3970.3 4046.0 4081.4 4113.8 3560.5 3697.6 3984.4 4000.5 4005.6 3465.8 3469.6 3479.5 3484.5 3484.9 4554.7 4940.7 4979.5 5174.7 5257.6 3977.5 4520.8 4530.5 4566.7 4587.4 5457.5 5519.5 5521.7 5545.6 5553.7 3384.4 3572.3 3756.4 3763.9 3776.3 4221.6 5302.7 5407.5 5603.6 5613.5 3711.7 3732.6 3736.3 3741.5 3755.3 3563.8 3762.9 3876.0 3885.7 3905.0 4507.3 4519.3 4539.7 4557.8 4579.6 5350.7 5501.4 5535.3 5595.5 5631.2 1069.5 1232.4 1311.0 1321.3 1321.9 648.6 803.8 812.6 816.7 818.1 3699.4 3755.5 4255.8 4271.6 4307.7 4129.4 4258.2 4620.8 4632.3 4651.5 3585.9 3864.4 4150.6 4228.8 4310.7 2129.2 2206.6 2318.5 2456.6 2540.0 4098.0 4647.8 4784.9 4820.5 4821.4 4052.9 4599.0 4825.5 4889.5 4934.9 3746.2 3775.4 4877.4 4929.5 4936.9 4457.4 4701.5 4764.6 4793.6 4823.0 4125.9 4606.7 4662.1 4690.5 4774.3 4298.4 4309.9 4344.4 5176.9 5536.5 3197.4 3222.4 3808.0 3820.9 3840.9 4793.8 5273.9 5693.6 5734.9 5774.7 4564.8 4823.9 4932.2 5473.8 5632.4 5248.5 5269.6 5529.1 5547.4 5559.3 5411.5 5423.7 5448.5 5473.1 5488.6 4807.7 5067.7 5596.9 5636.7 5664.7 5092.6 5476.6 5511.4 5531.4 5552.9 06:14:14 INFO - PROCESS | 1938 | 06:14:14 INFO - PROCESS | 1938 | [#5] yui.html Cycles:180 Average:25490.64 Median:4423.03 stddev:42074.25 (951.3%) stddev-sans-first:42151.19 06:14:14 INFO - PROCESS | 1938 | Values: 725.5 733.4 738.5 762.0 799.3 15456.0 16351.0 16352.9 16359.4 16410.3 14789.0 14887.0 14916.1 14926.0 14936.6 682.6 700.5 703.4 844.0 858.4 681.4 842.3 863.6 865.3 869.4 886.8 887.9 888.0 888.2 888.3 723.6 884.9 886.3 887.3 890.8 549.0 663.2 679.8 682.0 683.7 14934.7 14964.5 14972.6 14980.7 15001.3 13834.5 14046.0 14238.6 14341.9 14460.6 10891.2 11907.6 12886.6 12991.8 13435.0 4573.6 4594.2 4596.7 4786.3 4806.7 124917.4 128060.0 128632.4 130541.0 130889.0 11108.6 11116.3 11168.5 11221.4 11502.9 22468.7 22496.8 22520.8 22544.7 22566.7 7827.6 7836.7 7952.4 8074.5 8142.8 4299.2 4307.6 4386.3 4411.0 4435.1 3495.9 3610.5 3610.8 3612.5 3613.9 642.0 654.5 660.0 664.3 664.6 590.4 602.3 618.5 620.8 623.9 8876.2 9099.8 9177.6 9268.4 9312.0 477.0 535.9 558.8 582.1 585.6 4337.6 4462.3 4470.3 4486.4 4600.6 145382.0 152735.0 157670.0 160685.0 162470.0 94221.0 137989.0 139500.6 140725.0 144412.0 100962.5 109379.0 117963.0 119443.2 123667.8 8595.2 8639.0 8660.6 8697.4 8882.3 46046.3 58524.0 61773.0 62130.0 62340.0 91979.0 93118.5 94127.0 95060.0 95940.6 9818.4 11599.5 11855.5 11887.4 11920.6 12212.5 12360.9 12467.2 12563.0 12783.8 11703.2 12021.1 12113.4 12271.4 12384.3 11544.4 11964.5 12034.5 12309.1 12320.6 11623.8 11901.9 11912.5 12011.2 12301.9 8706.0 9652.0 10037.5 10051.7 10437.9 9389.4 9830.6 9900.5 9943.0 9949.7 06:14:14 INFO - PROCESS | 1938 | -------- Summary: end -------- 06:14:14 INFO - PROCESS | 1938 | 06:14:15 INFO - TEST-INFO | 1938: exit 0 06:14:15 INFO - TEST-OK | dromaeo_css | took 1117005ms 06:14:15 INFO - TEST-START | kraken 06:14:15 INFO - operating with platform_type : mac_ 06:14:15 INFO - Initialising browser for kraken test... 06:14:15 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpaPqar0/profile http://localhost:56581/getInfo.html) 06:14:17 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 06:14:17 INFO - PROCESS | 1941 | colorDepth:24 06:14:17 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 06:14:17 INFO - PROCESS | 1941 | __metrics 06:14:17 INFO - PROCESS | 1941 | 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:14:17 INFO - PROCESS | 1941 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:18 INFO - TEST-INFO | 1941: exit 0 06:14:18 INFO - Browser initialized. 06:14:18 INFO - Running cycle 1/1 for kraken test... 06:14:18 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpaPqar0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:30 INFO - PROCESS | 1942 | RSS: Main: 235139072 06:14:30 INFO - PROCESS | 1942 | 06:14:33 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:34 INFO - PROCESS | 1942 | RSS: Main: 293666816 06:14:34 INFO - PROCESS | 1942 | 06:14:37 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-dft) 06:14:37 INFO - PROCESS | 1942 | RSS: Main: 292675584 06:14:37 INFO - PROCESS | 1942 | 06:14:41 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-fft) 06:14:41 INFO - PROCESS | 1942 | RSS: Main: 384516096 06:14:41 INFO - PROCESS | 1942 | 06:14:43 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-oscillator) 06:14:44 INFO - PROCESS | 1942 | RSS: Main: 286203904 06:14:44 INFO - PROCESS | 1942 | 06:14:46 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:47 INFO - PROCESS | 1942 | RSS: Main: 290639872 06:14:47 INFO - PROCESS | 1942 | 06:14:49 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56581/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:50 INFO - PROCESS | 1942 | RSS: Main: 328175616 06:14:50 INFO - PROCESS | 1942 | 06:14:53 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56581/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:54 INFO - PROCESS | 1942 | RSS: Main: 330375168 06:14:54 INFO - PROCESS | 1942 | 06:14:56 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56581/tests/kraken/driver.html?testName=json-parse-financial) 06:14:57 INFO - PROCESS | 1942 | RSS: Main: 326397952 06:14:57 INFO - PROCESS | 1942 | 06:14:59 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:59 INFO - PROCESS | 1942 | RSS: Main: 299683840 06:14:59 INFO - PROCESS | 1942 | 06:15:01 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:02 INFO - PROCESS | 1942 | RSS: Main: 305582080 06:15:02 INFO - PROCESS | 1942 | 06:15:04 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:05 INFO - PROCESS | 1942 | RSS: Main: 302927872 06:15:05 INFO - PROCESS | 1942 | 06:15:08 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:08 INFO - PROCESS | 1942 | RSS: Main: 319713280 06:15:08 INFO - PROCESS | 1942 | 06:15:11 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:12 INFO - PROCESS | 1942 | RSS: Main: 315867136 06:15:12 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56581/tests/kraken/driver.html?testName=ai-astar) 06:15:14 INFO - PROCESS | 1942 | RSS: Main: 360402944 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | __start_tp_report 06:15:14 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 06:15:14 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 06:15:14 INFO - PROCESS | 1942 | |i|pagename|runs| 06:15:14 INFO - PROCESS | 1942 | |0;ai-astar;122;167;141;113;113;111;113;111;113;112 06:15:14 INFO - PROCESS | 1942 | |1;audio-beat-detection;153;108;111;146;109;109;106;138;138;106 06:15:14 INFO - PROCESS | 1942 | |2;audio-dft;182;184;184;185;186;183;180;181;183;185 06:15:14 INFO - PROCESS | 1942 | |3;audio-fft;79;60;59;88;78;83;81;59;83;56 06:15:14 INFO - PROCESS | 1942 | |4;audio-oscillator;90;71;91;69;69;70;92;66;68;91 06:15:14 INFO - PROCESS | 1942 | |5;imaging-gaussian-blur;86;127;100;87;90;86;90;88;90;85 06:15:14 INFO - PROCESS | 1942 | |6;imaging-darkroom;95;95;95;94;96;94;95;95;94;95 06:15:14 INFO - PROCESS | 1942 | |7;imaging-desaturate;83;85;83;84;85;85;101;140;137;85 06:15:14 INFO - PROCESS | 1942 | |8;json-parse-financial;54;56;54;54;55;58;56;55;54;56 06:15:14 INFO - PROCESS | 1942 | |9;json-stringify-tinderbox;66;71;79;77;75;70;72;71;71;72 06:15:14 INFO - PROCESS | 1942 | |10;stanford-crypto-aes;87;82;75;86;94;106;103;104;89;88 06:15:14 INFO - PROCESS | 1942 | |11;stanford-crypto-ccm;142;140;140;137;141;138;141;139;179;139 06:15:14 INFO - PROCESS | 1942 | |12;stanford-crypto-pbkdf2;174;174;170;172;173;177;172;177;206;174 06:15:14 INFO - PROCESS | 1942 | |13;stanford-crypto-sha256-iterative;67;69;69;68;69;71;67;69;68;68 06:15:14 INFO - PROCESS | 1942 | __end_tp_report 06:15:14 INFO - PROCESS | 1942 | __start_cc_report 06:15:14 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,1981 06:15:14 INFO - PROCESS | 1942 | __end_cc_report 06:15:14 INFO - PROCESS | 1942 | __startTimestamp1474463714275__endTimestamp 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | ------- Summary: start ------- 06:15:14 INFO - PROCESS | 1942 | Number of tests: 14 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#0] ai-astar Cycles:10 Average:121.60 Median:113.00 stddev:18.41 (16.3%) stddev-sans-first:19.53 06:15:14 INFO - PROCESS | 1942 | Values: 122.0 167.0 141.0 113.0 113.0 111.0 113.0 111.0 113.0 112.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:124.50 stddev:18.90 (15.2%) stddev-sans-first:16.48 06:15:14 INFO - PROCESS | 1942 | Values: 153.0 108.0 111.0 146.0 109.0 109.0 106.0 138.0 138.0 106.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.89 (1.0%) stddev-sans-first:1.94 06:15:14 INFO - PROCESS | 1942 | Values: 182.0 184.0 184.0 185.0 186.0 183.0 180.0 181.0 183.0 185.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#3] audio-fft Cycles:10 Average:72.60 Median:80.00 stddev:12.47 (15.6%) stddev-sans-first:13.00 06:15:14 INFO - PROCESS | 1942 | Values: 79.0 60.0 59.0 88.0 78.0 83.0 81.0 59.0 83.0 56.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:80.50 stddev:11.53 (14.3%) stddev-sans-first:11.34 06:15:14 INFO - PROCESS | 1942 | Values: 90.0 71.0 91.0 69.0 69.0 70.0 92.0 66.0 68.0 91.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:87.50 stddev:12.71 (14.5%) stddev-sans-first:13.24 06:15:14 INFO - PROCESS | 1942 | Values: 86.0 127.0 100.0 87.0 90.0 86.0 90.0 88.0 90.0 85.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:15:14 INFO - PROCESS | 1942 | Values: 95.0 95.0 95.0 94.0 96.0 94.0 95.0 95.0 94.0 95.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:84.50 stddev:22.61 (26.8%) stddev-sans-first:23.43 06:15:14 INFO - PROCESS | 1942 | Values: 83.0 85.0 83.0 84.0 85.0 85.0 101.0 140.0 137.0 85.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.32 (2.4%) stddev-sans-first:1.32 06:15:14 INFO - PROCESS | 1942 | Values: 54.0 56.0 54.0 54.0 55.0 58.0 56.0 55.0 54.0 56.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.00 stddev:3.72 (5.2%) stddev-sans-first:3.14 06:15:14 INFO - PROCESS | 1942 | Values: 66.0 71.0 79.0 77.0 75.0 70.0 72.0 71.0 71.0 72.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:86.50 stddev:10.20 (11.8%) stddev-sans-first:10.69 06:15:14 INFO - PROCESS | 1942 | Values: 87.0 82.0 75.0 86.0 94.0 106.0 103.0 104.0 89.0 88.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:140.50 stddev:12.53 (8.9%) stddev-sans-first:13.27 06:15:14 INFO - PROCESS | 1942 | Values: 142.0 140.0 140.0 137.0 141.0 138.0 141.0 139.0 179.0 139.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:174.00 stddev:10.45 (6.0%) stddev-sans-first:11.03 06:15:14 INFO - PROCESS | 1942 | Values: 174.0 174.0 170.0 172.0 173.0 177.0 172.0 177.0 206.0 174.0 06:15:14 INFO - PROCESS | 1942 | 06:15:14 INFO - PROCESS | 1942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.18 (1.7%) stddev-sans-first:1.12 06:15:14 INFO - PROCESS | 1942 | Values: 67.0 69.0 69.0 68.0 69.0 71.0 67.0 69.0 68.0 68.0 06:15:14 INFO - PROCESS | 1942 | -------- Summary: end -------- 06:15:14 INFO - PROCESS | 1942 | 06:15:15 INFO - TEST-INFO | 1942: exit 0 06:15:15 INFO - TEST-OK | kraken | took 59568ms 06:15:15 INFO - SUITE-END | took 1176s 06:15:15 INFO - Completed test suite (00:19:36) 06:15:15 INFO - javascript benchmark 06:15:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2828.816126951748, 3250.7074363307297, 3297.6537463566324, 3329.716974057205, 3373.1904342957682, 5633.6338138021, 5693.516051135648, 5705.229793977812, 5837.445442682949, 5849.473547380746, 4584.793684284207, 5746.281714785652, 5760.049591817345, 5763.991301522238, 5813.098969659699, 5152.9484705152845, 5172.017316709813, 5189.974050129763, 5245.868853278679, 5298.523132918056, 4789.688670236441, 5321.787128514855, 5372.946270537283, 5396.352437707461, 5430.239766432703, 5202.869928251824, 5334.893302133974, 5336.813211537577, 5346.572274218072, 5421.322334708161, 5182.170852663556, 5204.9479505204845, 5238.71187084714, 5239.869003274911, 5246.396664383607, 5136.332276804029, 5205.973970130163, 5206.531412172884, 5217.608679349026, 5227.294315267428, 4787.40157480315, 5737.684427356494, 5752.827415177551, 5759.539236861041, 5824.0390335594575, 6096.0603354173045, 6108.008189064015, 6124.0, 6147.907781383283, 6222.408871157233, 6218.81343559694, 6256.468200202943, 6259.499240060784, 6266.561340706153, 6268.0, 5919.763209471573, 5922.526197904157, 5936.257967754031, 5945.256842894638, 5968.910466343008, 6165.1985241919165, 6235.875282494325, 6267.811965641038, 6332.176817013758, 6335.11308416822, 6083.144640884484, 6124.686092398479, 6131.356207598138, 6134.460499230538, 6227.719752611143, 6234.625922444668, 6248.875022499616, 6249.9062514062325, 6251.74993000284, 6256.217972753406, 5911.852203694942, 6077.3314935357075, 6140.600860944024, 6204.658743769136, 6242.063690446469, 6106.582013105394, 6145.631262124287, 6152.538559608047, 6158.0, 6169.5064394849205, 4936.185529387611, 4962.379702537183, 4964.875878103004, 4996.225585034325, 5014.89970200594, 4419.756913369732, 4420.557944205618, 4428.31361139024, 4435.223835828717, 4464.995376040365, 5268.998890210848, 5620.0, 5652.943470565242, 5829.562782791223, 5868.4424979626865, 6185.41238582334, 6242.65665388408, 6248.4376406123665, 6251.3123556408755, 6254.124422580842, 5776.826695199151, 5824.417558244227, 5836.358000619928, 5856.238688970407, 5938.792142275086, 5416.620836541483, 5421.701806400607, 5424.267723857308, 5447.210154527571, 5468.972655136698, 6423.100765892778, 6428.292887782433, 6431.871362572816, 6435.2599451063725, 6440.4847612190915, 6141.455323060992, 6188.628682279078, 6219.067139929047, 6238.282597501164, 6284.214473190851, 6369.7452101915405, 6377.394147555975, 6381.074744162163, 6390.648514331757, 6435.324290949383, 6188.876222475616, 6217.191765070512, 6254.906176407449, 6256.624602523863, 6257.374262573706, 6099.279518885317, 6167.1366008759705, 6181.598196117238, 6256.280527739186, 6260.812175634738, 6104.359042300494, 6175.96912015455, 6219.40915613016, 6224.06639004153, 6229.408206220402, 5556.416576259596, 6198.6280823150755, 6205.47253483459, 6206.06908963659, 6211.3167551570195, 5457.590680699042, 5830.2420685310635, 6023.969880150571, 6055.9091613626715, 6080.939190608215, 5004.649674522894, 6053.636781793107, 6119.969400152971, 6132.356102609162, 6141.731496609813, 5952.732127054206, 6075.362086980804, 6076.210092687922, 6083.361247069171, 6096.75612975476], "value": 5703.454540138216, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.63623646029015, 513.2070950381665, 520.5289213261998, 524.5986820082635, 527.6412039812928, 28825.423491530182, 40022.799886000605, 41203.58796412035, 41289.0, 42981.14037719244, 42126.36810447846, 42389.57610423902, 42454.0, 42495.57504424955, 42659.573404265946, 9868.0, 10061.64784232552, 10068.395896246213, 10080.0, 10082.49587520621, 8862.379633425662, 9059.365844390895, 9997.750056248578, 12218.450169742338, 12247.75504489914, 12151.088668349865, 12250.571230006952, 12251.816222756666, 12269.631911042683, 12272.0, 8907.599158037903, 11990.820137697941, 11991.760164796655, 12259.570915017975, 12342.876571234263, 8786.297096232285, 11763.294202347886, 12097.455614497281, 12122.515099396014, 12319.44562494681, 40770.0, 41142.9714257146, 41143.588564114274, 41182.38226426606, 41254.38118428226, 3151.4642510772997, 3329.433996220648, 3332.8166950817695, 3344.7324214062814, 3344.8160351180677, 30663.540046899314, 31043.379132417223, 31689.683103168903, 31830.840845795854, 32249.0, 3235.1588586967323, 3286.5891763529557, 3338.9499157512655, 3378.341223461426, 3402.4385976314124, 487430.0, 491427.2001919698, 494199.0, 494716.9999999964, 495783.0, 57730.845383092106, 57798.4220157793, 59666.70166649139, 60023.69988150031, 60097.0, 63570.0, 63645.363546363944, 63691.68154159292, 63733.0, 63743.04385434222, 16592.83407165913, 16829.41097061597, 16847.0, 16851.0, 16897.239624216938, 11864.584739534248, 12079.818802717966, 12838.422270997828, 12960.80558791619, 12993.415296311689, 12576.434060467302, 15483.380664773284, 15576.766348504781, 15593.454229101926, 17038.847813154607, 5198.558122559549, 6248.812535623939, 6280.780172693934, 6282.780102696383, 6288.496920246369, 884.7743825324501, 953.3040880157524, 957.593022965251, 965.1120968708805, 984.1093810101869, 25412.0, 26292.342691432485, 28097.735601897963, 28357.716422835507, 30202.54696179559, 1002.734275417015, 1022.25375475903, 1036.6268143468346, 1084.8698156221303, 1095.7205912492423, 14722.484713034992, 14918.4778532753, 15654.13902235388, 15736.68526629461, 15821.762673559906, 539085.0, 622640.0, 625535.0, 626026.0, 628332.0251373631, 57321.71339143361, 57407.0, 57450.425495745345, 57579.0, 57615.423845761004, 1292.8319318488725, 1354.3228385807097, 1363.3864760857455, 1366.863313668645, 1374.8212732344732, 28932.710672893, 29471.85264073666, 29492.115236542937, 29954.85022574873, 30237.244068898453, 50142.0, 50621.0, 50671.49328506815, 50747.492525074274, 50803.23795143002, 570159.0, 570390.0, 572265.0, 572342.0, 573512.0, 27479.0, 34903.12742181466, 35357.116072098404, 37543.061423463536, 37714.811425942695, 37251.6274837259, 39735.0, 46926.82682932817, 47123.764381177876, 48063.0, 30768.0, 37898.62101378951, 38779.80610096931, 39458.80270598629, 40440.98897527585, 38166.64917095219, 38629.613703862604, 39456.2108757829, 39957.40063899102, 40289.79855100823, 34129.30280626516, 35548.93353199408, 37246.813765930994, 37785.055373615876, 38507.42238866475, 23675.64486532738, 33755.66244337623, 33865.0, 34638.82680586682, 34669.0, 23821.404464888517, 25254.747452525975, 25529.617055743805, 26206.606900896884, 26598.867005664848], "value": 20115.164508064885, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.5145520543637, 365.846344535295, 365.8719448193132, 377.08180580287, 394.3434182086826, 15167.165805880672, 15244.771328430068, 16206.118392539556, 20743.585128297425, 20764.377068687925, 16823.0, 19562.510937226576, 19926.302579409723, 20396.69404958923, 20768.68846967297, 5718.59969802114, 5972.6715030673295, 5991.850203744898, 5992.310884248302, 5996.640201587897, 3393.7285017198565, 4318.093200427914, 4401.449818772653, 5807.796727114552, 5881.705914704269, 4190.2248084104385, 6149.0, 6461.224653041641, 6465.3857883501, 6535.183102112236, 6346.52401069917, 6446.645434501101, 6456.366750308663, 6504.772332968323, 6514.088027676129, 5619.129034999541, 5619.241402410663, 5626.099824028177, 5627.127795191752, 5641.548676105943, 24929.252122436355, 25257.242282731546, 25284.0, 25299.98800047996, 25591.48817023649, 2247.9438014049615, 2397.832151749378, 2406.2300063979533, 2414.7464516225896, 2665.2936971702516, 12401.75196496074, 15093.320800564, 15166.620834479116, 15454.922725386414, 16007.919960400124, 1811.7191835265555, 1819.672458957387, 1843.9858078057016, 1881.7835948865918, 1909.713542968552, 73567.63216183938, 117901.82098178995, 119906.0, 120667.396663017, 124043.37978310141, 10807.945960270148, 10816.134709223243, 11020.944895275472, 11045.72114764359, 11122.221444498808, 14045.508407205698, 14066.929665351608, 14081.155130692192, 14085.43658253679, 14089.929550352388, 8173.591320433955, 8350.290225330915, 8395.202455766692, 8464.746057618282, 8465.238128568459, 6649.368310010541, 8295.502269863708, 8344.165583441607, 8467.703630372907, 8481.388536178107, 3550.5029295898594, 4260.910839641236, 4399.5160532341415, 4438.689291749546, 4503.639708823286, 1604.5667669729107, 1615.781869447633, 1682.5541231573643, 1727.2227497626118, 1885.7737071551228, 696.6934548798513, 761.7257787196605, 925.9675911343071, 947.1144479911305, 970.6360114956891, 20088.79911200869, 20278.695819562425, 20671.8966405167, 20728.896355518125, 20844.47888802792, 882.9735107946643, 884.425123669607, 920.4293338130402, 927.3276874266103, 937.803061357109, 10442.63450779219, 10878.292910960763, 10934.343939363505, 10968.341899486057, 10969.067629251604, 551650.2417487887, 560673.0, 563202.0, 575656.0, 576663.0, 95882.0, 118630.0, 121265.39367303283, 125088.0, 131324.0, 967.5259123029806, 983.9212862971088, 1016.1819735113305, 1038.901304376083, 1042.4006196437078, 16603.3358665652, 17280.913595431943, 17895.642087158445, 18037.63924721472, 18382.0, 54676.0, 55877.0, 56124.719376402856, 56483.71758141183, 56491.71754141203, 77960.61019694865, 83614.3277134466, 85905.57047214724, 87896.56051719701, 88597.68413895187, 7488.475806693479, 7828.825676148624, 7909.367250620052, 8125.79685507867, 8191.098979112174, 11387.715307117389, 12180.0, 12805.92657762149, 13057.0, 13470.730585388434, 7941.642626081955, 9071.95464022702, 10832.783344333227, 10895.400752958663, 10988.175886808362, 11100.777984440105, 11249.718757030812, 11416.543338266376, 11444.82832757526, 11610.303381797119, 9659.372140810825, 11504.884951150381, 11525.654230372767, 11560.42197890119, 11797.410129493319, 7868.763937081897, 7875.0, 7944.523328600302, 8274.462159959583, 8294.336453083859, 9974.700758977242, 11045.33727976324, 11319.830202547133, 11382.94308528452, 11525.366104864313], "value": 9430.916415246615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.630140615549, 1538.776877352784, 1716.8626509879211, 1868.8878667279973, 1869.3270422647836, 8064.596770161498, 8326.708565200219, 8503.702370417037, 9085.318601104918, 9098.226650734696, 8102.432829701923, 8562.957185214082, 8761.780955476117, 8772.517511536864, 8897.421667591601, 2384.546936082143, 2421.624648179535, 2421.648860915166, 2421.7336093029753, 2423.309356833303, 2105.315772373977, 2393.497365553227, 2398.7526486227152, 2429.9028038878423, 2440.804735621146, 2173.89130543473, 2203.2839327218717, 2203.5482726041205, 2203.5482726041205, 2205.0628482894786, 2335.94160145996, 2409.168836751318, 2411.6141417373137, 2421.769931856471, 2423.866687332196, 2380.916667916632, 2389.4026493376655, 2396.892139853711, 2413.0227257960555, 2414.5895197816412, 8933.28533717301, 9017.819643607158, 9036.63853445868, 9039.954800226022, 9041.0, 5267.999080174793, 5386.649867758583, 5441.374241962186, 5445.346558413015, 5459.290292262021, 3540.0972751948348, 3651.8721844735305, 3710.9257814843822, 3712.461693054519, 3721.497597824286, 1058.1957712138753, 1103.3269705479652, 1114.0641860836854, 1126.8985791278742, 1128.0975219824109, 11933.880661193363, 11942.701432464171, 11943.581974630846, 11948.163628546004, 11963.880361196363, 4656.0, 4658.161530924466, 4806.519348065235, 4858.0, 4869.902601947942, 10184.287099902936, 10188.694339169837, 10214.233932455096, 10225.795484090426, 10234.130098941525, 5436.374816896028, 5438.456154384609, 5440.238366628675, 5443.2107344434835, 5448.782048718086, 4759.595434388047, 4897.681650692693, 4969.2546118081855, 4981.626378021663, 5010.599152067826, 3712.7029837612927, 3777.3578491656485, 3808.619138086169, 3851.614838516126, 3860.1121741999495, 1163.116031815826, 1163.4589915689246, 1175.4416652090188, 1178.4284621958343, 1178.640514643025, 799.1010113622175, 884.7168905950034, 885.9379843411028, 903.9186473217442, 922.5756152169943, 5788.421157884262, 5803.7968671096305, 5901.318124334544, 6052.273727152682, 6151.477124444383, 864.5461132905149, 878.6046279174398, 894.3158483759929, 912.8904531456268, 951.6003278622995, 3233.224026233687, 3672.898130560821, 3864.0, 3932.508436445444, 4014.1770936957855, 10715.03564679167, 10998.34009959389, 11119.388433636228, 11136.443177841076, 11145.275557088764, 11042.392668403154, 11055.834162487568, 11059.778804423866, 11063.557457701763, 11066.004059634672, 8236.794080148044, 8372.790680232922, 8391.790205244917, 8394.916050839414, 8403.285720713686, 5609.943900560942, 5760.884782304247, 5903.970480147572, 5954.10688396744, 5982.252218472691, 10202.33684810485, 10256.282060255711, 10259.640912568024, 10272.897271027194, 10279.794404112026, 9943.204543636637, 10266.486675666336, 10311.793764124526, 10466.110380617733, 10469.31949423285, 7499.137599176164, 7653.579053151907, 7672.73145439907, 7674.155842857393, 7686.9231307686205, 8195.0, 8206.794830129056, 8272.255497005057, 8341.416100873123, 8369.748907532783, 7469.0, 7505.4746167767735, 7574.602510251659, 7587.317141457295, 7646.847063058819, 7442.218567050381, 7460.253974602496, 7491.0, 7496.812579685551, 7498.700051997859, 6934.098567186234, 6995.160580730345, 7038.859222815413, 7095.3968912643, 7120.60836653989, 4816.759162041954, 4911.803527858989, 4918.95081049185, 4942.28336891156, 5067.594592432522, 4981.053599816023, 5092.796288148433, 5101.234814777813, 5167.250748641502, 5245.816396426107], "value": 4624.598581471628, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.9944401111979, 281.53406112883187, 296.70033266400935, 305.6072946264051, 309.7115997450604, 4385.3641222022825, 5045.243213517974, 5076.16749354238, 5099.362579677545, 5102.948970510294, 4094.5086589609214, 4276.828926842931, 4844.0, 5210.478952104788, 5284.833218380465, 4031.6371526562602, 4052.0, 4055.959440405588, 4064.7764372959477, 4105.706702388753, 3397.3884700753856, 3430.365382404263, 4091.468109145807, 4107.548169701346, 4118.588141185887, 3191.808491490506, 3970.285348637244, 4045.9797701011453, 4081.3674530188014, 4113.786433002257, 3560.4659301104784, 3697.5932647408763, 3984.382420724792, 4000.479937608107, 4005.5794141615293, 3465.7573969822124, 3469.5836499619954, 3479.530263414432, 3484.529588505545, 3484.8954531364097, 4554.7039442436135, 4940.678855874393, 4979.526944940225, 5174.689518628894, 5257.553107985787, 3977.5226972763166, 4520.796564154588, 4530.466236335664, 4566.725996440225, 4587.42657167854, 5457.536109430703, 5519.5097323722775, 5521.696306703129, 5545.639533430314, 5553.722973580853, 3384.4415671414185, 3572.2855428914063, 3756.398976163801, 3763.8870833875026, 3776.3202623527754, 4221.64116050133, 5302.655327403745, 5407.539174928049, 5603.579731520112, 5613.494785469327, 3711.740178187501, 3732.570754363283, 3736.3087828751222, 3741.513603231617, 3755.2677227940835, 3563.80399078048, 3762.9435558466644, 3876.030992251937, 3885.6502914737807, 3904.9651842261824, 4507.323901414748, 4519.254323036728, 4539.682222244412, 4557.794899229542, 4579.633629309647, 5350.662334416396, 5501.394846566875, 5535.308086489189, 5595.482033085046, 5631.239782629293, 1069.4919913041242, 1232.3591732299333, 1311.0, 1321.2666969831835, 1321.8678132186897, 648.6043513456788, 803.7709252862905, 812.5774597209418, 816.6733306677377, 818.0979223305837, 3699.3711069118312, 3755.455458958436, 4255.76593287366, 4271.594198551133, 4307.6769242306955, 4129.401236820644, 4258.212230737324, 4620.8151673933335, 4632.30920713937, 4651.488336283006, 3585.928281434357, 3864.381698928158, 4150.64719498846, 4228.767417792051, 4310.698251122454, 2129.243374216278, 2206.591780520577, 2318.5362927414585, 2456.5823809952353, 2539.961900571493, 4098.0, 4647.790849411785, 4784.932807113995, 4820.469748327681, 4821.421429428491, 4052.878413647595, 4599.0, 4825.5174482551465, 4889.462159162489, 4934.925976110361, 3746.2018231249153, 3775.3770627846648, 4877.365942427462, 4929.457759646436, 4936.851894443173, 4457.398251236042, 4701.506341834195, 4764.571188593043, 4793.5685788279225, 4822.95177048239, 4125.855595054159, 4606.723596584216, 4662.065242924148, 4690.530946905282, 4774.30772537987, 4298.441202643637, 4309.870703878889, 4344.391785150145, 5176.870578235575, 5536.501714845684, 3197.4404479215577, 3222.38774632819, 3807.9619203807606, 3820.8662696805477, 3840.9231815364096, 4793.832215872428, 5273.868153296198, 5693.601447898607, 5734.885302293847, 5774.740136693943, 4564.771761411983, 4823.927641085456, 4932.186189278729, 5473.781048758005, 5632.380438151718, 5248.475152484873, 5269.552088072403, 5529.087700529368, 5547.448173840079, 5559.305086864142, 5411.540019098421, 5423.674579525241, 5448.482394172547, 5473.099257393587, 5488.588355873246, 4807.735574543433, 5067.695938243717, 5596.888062238814, 5636.730696196279, 5664.688442135722, 5092.618053645917, 5476.58925580591, 5511.4213007633625, 5531.446855314436, 5552.861178470571], "value": 3784.468589479094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.4595326481772, 733.4242619543659, 738.4941315199089, 761.9771406857793, 799.338203781408, 15456.0, 16351.01893886366, 16352.91823540882, 16359.427420040302, 16410.261538230778, 14789.0, 14887.0, 14916.105033697986, 14926.0, 14936.62658433537, 682.556338380052, 700.5481464455423, 703.3564288675856, 843.962021709023, 858.356232825381, 681.427600815315, 842.3008902610818, 863.5811631358786, 865.273170536749, 869.4131461263653, 886.8315020146184, 887.9156480134377, 888.0409158109227, 888.1695614600337, 888.258304315897, 723.6490302203428, 884.8539990901494, 886.3042511628405, 887.2857349833381, 890.8485557455216, 548.9862753431156, 663.2405895249912, 679.7620832708562, 681.9727210911558, 683.729926678959, 14934.70130597382, 14964.47624333154, 14972.625684357869, 14980.700385992328, 15001.32494037771, 13834.515791947335, 14045.955341423112, 14238.644033899132, 14341.856581434156, 14460.638484037878, 10891.183161262938, 11907.642770716893, 12886.613401597873, 12991.805122923164, 13435.0, 4573.611243044345, 4594.173048851206, 4596.655250856165, 4786.329913812069, 4806.687565308243, 124917.37541312235, 128060.0, 128632.35683821615, 130541.0, 130889.0, 11108.556807164432, 11116.277441966246, 11168.497417616227, 11221.438928053565, 11502.94248528752, 22468.662970055462, 22496.77503224947, 22520.77479225187, 22544.66183007256, 22566.661500077185, 7827.6477558510005, 7836.686532538634, 7952.403569732178, 8074.515529068275, 8142.796430089295, 4299.247631664446, 4307.590778876001, 4386.298192289219, 4411.0, 4435.068635586563, 3495.8776442824887, 3610.530631017951, 3610.801405922647, 3612.512310838056, 3613.9277214455565, 641.9775307864296, 654.456800855289, 660.0330515794384, 664.2560332427712, 664.6444152378551, 590.4213870407025, 602.2926943389492, 618.5330075792748, 620.7579044172776, 623.8939380305359, 8876.20114189713, 9099.772505687411, 9177.632894684139, 9268.351215414856, 9312.0, 476.9878219046709, 535.8928214357067, 558.7988324203284, 582.1006544888158, 585.5696063393402, 4337.631301339358, 4462.263726485158, 4470.262406702857, 4486.371907932892, 4600.5629465200755, 145382.0, 152735.0, 157670.0, 160685.0, 162470.0, 94221.0, 137989.0, 139500.60499395078, 140725.0, 144412.0, 100962.49518752359, 109379.0, 117963.0, 119443.2083518748, 123667.76332236563, 8595.18345757152, 8638.956805215934, 8660.566971651266, 8697.425490430227, 8882.289416846508, 46046.30930535978, 58523.9999999983, 61773.0, 62130.0, 62340.02559590625, 91979.0, 93118.53440732753, 94127.0, 95060.0, 95940.60148496344, 9818.361806482555, 11599.478023489131, 11855.466504007169, 11887.405629718307, 11920.582779602672, 12212.511499540275, 12360.938195308965, 12467.189632673848, 12563.0, 12783.80824287655, 11703.180777345504, 12021.09841761854, 12113.394330283274, 12271.447784849524, 12384.318862462651, 11544.365059921785, 11964.461599227881, 12034.458449369975, 12309.076819238413, 12320.568780092653, 11623.825642615537, 11901.940490297493, 11912.52349905994, 12011.219270747373, 12301.93849030785, 8705.956470217609, 9651.951740241535, 10037.5483103262, 10051.748706282402, 10437.895621043692, 9389.436633801994, 9830.557624906753, 9900.455474948947, 9943.0, 9949.651762188289], "value": 7657.7757297899325, "unit": "score"}], "name": "dromaeo_css", "value": 7248.382765439832, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 167.0, 141.0, 113.0, 113.0, 111.0, 113.0, 111.0, 113.0, 112.0], "value": 121.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 108.0, 111.0, 146.0, 109.0, 109.0, 106.0, 138.0, 138.0, 106.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 184.0, 185.0, 186.0, 183.0, 180.0, 181.0, 183.0, 185.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 88.0, 78.0, 83.0, 81.0, 59.0, 83.0, 56.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 91.0, 69.0, 69.0, 70.0, 92.0, 66.0, 68.0, 91.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 127.0, 100.0, 87.0, 90.0, 86.0, 90.0, 88.0, 90.0, 85.0], "value": 92.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 84.0, 85.0, 85.0, 101.0, 140.0, 137.0, 85.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 54.0, 55.0, 58.0, 56.0, 55.0, 54.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 79.0, 77.0, 75.0, 70.0, 72.0, 71.0, 71.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 75.0, 86.0, 94.0, 106.0, 103.0, 104.0, 89.0, 88.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 140.0, 137.0, 141.0, 138.0, 141.0, 139.0, 179.0, 139.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 170.0, 172.0, 173.0, 177.0, 172.0, 177.0, 206.0, 174.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 68.0, 69.0, 71.0, 67.0, 69.0, 68.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1470.1, "alertThreshold": 2.0}]} 06:15:15 INFO - Return code: 0 06:15:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:15 INFO - # TBPL SUCCESS # 06:15:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:15 INFO - 2016-09-21 06:15:15.614 screenresolution[1946:24537] starting screenresolution argv=screenresolution get 06:15:15 INFO - 2016-09-21 06:15:15.617 screenresolution[1946:24537] Display 0: 1600x1200x32@60 06:15:15 INFO - 2016-09-21 06:15:15.623 screenresolution[1947:24540] starting screenresolution argv=screenresolution list 06:15:15 INFO - Available Modes on Display 0 06:15:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:15 INFO - Intel Iris: 06:15:15 INFO - Chipset Model: Intel Iris 06:15:15 INFO - Type: GPU 06:15:15 INFO - Bus: Built-In 06:15:15 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:15 INFO - Vendor: Intel (0x8086) 06:15:15 INFO - Device ID: 0x0a2e 06:15:15 INFO - Revision ID: 0x0009 06:15:15 INFO - Displays: 06:15:15 INFO - Display: 06:15:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:15 INFO - Display Serial Number: 1600x1200 60 06:15:15 INFO - Main Display: Yes 06:15:15 INFO - Mirror: Off 06:15:15 INFO - Online: Yes 06:15:15 INFO - Rotation: Supported 06:15:15 INFO - Return code: 0 06:15:15 INFO - Running post-action listener: _resource_record_post_action 06:15:15 INFO - [mozharness: 2016-09-21 13:15:15.862055Z] Finished run-tests step (success) 06:15:15 INFO - Running post-run listener: _resource_record_post_run 06:15:15 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 1593344; Write bytes: 705321472; Read time: 12; Write time: 1923 06:15:15 INFO - TinderboxPrint: CPU usage
53.5% 06:15:15 INFO - TinderboxPrint: I/O read bytes / time
1,593,344 / 12 06:15:15 INFO - TinderboxPrint: I/O write bytes / time
705,321,472 / 1,923 06:15:15 INFO - TinderboxPrint: CPU idle
2,253.6 (46.5%) 06:15:15 INFO - TinderboxPrint: CPU system
970.7 (20.0%) 06:15:15 INFO - TinderboxPrint: CPU user
1,625.4 (33.5%) 06:15:15 INFO - TinderboxPrint: Swap in / out
406,405,120 / 0 06:15:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389106176; Write bytes: 383342080; Read time: 29486; Write time: 681 06:15:15 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1593344; Write bytes: 296592896; Read time: 12; Write time: 1175 06:15:16 INFO - Running post-run listener: _upload_blobber_files 06:15:16 INFO - Blob upload gear active. 06:15:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:16 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:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:16 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:17 INFO - (blobuploader) - INFO - Done attempting. 06:15:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:18 INFO - (blobuploader) - INFO - Done attempting. 06:15:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:24 INFO - (blobuploader) - INFO - Done attempting. 06:15:24 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:24 INFO - Return code: 0 06:15:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/803e30128f40ae1b062770897fad17f6f2dc9f9a657f6ece6d37a57947d638dcda2a65f983c30cbda540c6a602c1f9164675b209e4aa6b117bdc9297062a434b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51226a3b675c5234884270bd55f60abb54d9b298be3fa469889eceb540fedf45797038ebff0cf4b5c751432df029e61983fea70a997028a4df2910ddfda06ce3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d555860d1cda999056b8a53afc53b5a40adc7c66c55f10b1465b91a17755f2940e4ee95b50bd5f92917beded39049418eef0ff26de64891685386c900e566be8"} 06:15:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:24 INFO - Contents: 06:15:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/803e30128f40ae1b062770897fad17f6f2dc9f9a657f6ece6d37a57947d638dcda2a65f983c30cbda540c6a602c1f9164675b209e4aa6b117bdc9297062a434b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51226a3b675c5234884270bd55f60abb54d9b298be3fa469889eceb540fedf45797038ebff0cf4b5c751432df029e61983fea70a997028a4df2910ddfda06ce3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d555860d1cda999056b8a53afc53b5a40adc7c66c55f10b1465b91a17755f2940e4ee95b50bd5f92917beded39049418eef0ff26de64891685386c900e566be8"} 06:15:24 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:24 INFO - Copying logs to upload dir... 06:15:24 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.230924 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-21 06:15:24.088941) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 06:15:24.092416) ========= 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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/Fx-Team/sha512/803e30128f40ae1b062770897fad17f6f2dc9f9a657f6ece6d37a57947d638dcda2a65f983c30cbda540c6a602c1f9164675b209e4aa6b117bdc9297062a434b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51226a3b675c5234884270bd55f60abb54d9b298be3fa469889eceb540fedf45797038ebff0cf4b5c751432df029e61983fea70a997028a4df2910ddfda06ce3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d555860d1cda999056b8a53afc53b5a40adc7c66c55f10b1465b91a17755f2940e4ee95b50bd5f92917beded39049418eef0ff26de64891685386c900e566be8"} build_url:https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011000 build_url: 'https://queue.taskcluster.net/v1/task/YBbyai4LTZui3pW-tVnKxA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/803e30128f40ae1b062770897fad17f6f2dc9f9a657f6ece6d37a57947d638dcda2a65f983c30cbda540c6a602c1f9164675b209e4aa6b117bdc9297062a434b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51226a3b675c5234884270bd55f60abb54d9b298be3fa469889eceb540fedf45797038ebff0cf4b5c751432df029e61983fea70a997028a4df2910ddfda06ce3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d555860d1cda999056b8a53afc53b5a40adc7c66c55f10b1465b91a17755f2940e4ee95b50bd5f92917beded39049418eef0ff26de64891685386c900e566be8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 06:15:24.124792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 06:15:24.125114) ========= 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.EiLW1JwXIV/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.Xx6aUSUvD5/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005260 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 06:15:24.173554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 06:15:24.173848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 06:15:24.174159) ========= ========= Total master_lag: 0.17 =========