builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0175 starttime: 1490813920.4 results: success (0) buildid: 20170329103122 builduid: 418ae77880bc4c23b7a7647fe41d4e06 revision: 27057064e224a8e69de0de4cedca78d25b5ec9a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.397174) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.397571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.397856) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.423432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.423750) ========= 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.8adPaKISJv/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.BUt3uRTAmJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 --2017-03-29 11:58:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.07M=0.001s 2017-03-29 11:58:40 (8.07 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.620159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.620483) ========= 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.8adPaKISJv/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.BUt3uRTAmJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.021165 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:40.669454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 11:58:40.669817) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 27057064e224a8e69de0de4cedca78d25b5ec9a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 27057064e224a8e69de0de4cedca78d25b5ec9a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8adPaKISJv/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.BUt3uRTAmJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 2017-03-29 11:58:40,756 truncating revision to first 12 chars 2017-03-29 11:58:40,756 Setting DEBUG logging. 2017-03-29 11:58:40,756 attempt 1/10 2017-03-29 11:58:40,756 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/27057064e224?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 11:58:41,753 unpacking tar archive at: mozilla-aurora-27057064e224/testing/mozharness/ program finished with exit code 0 elapsedTime=1.261096 ========= master_lag: 0.33 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 11:58:42.261183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:42.261547) ========= script_repo_revision: 27057064e224a8e69de0de4cedca78d25b5ec9a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:42.261938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:42.262214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 11:58:42.282738) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-29 11:58:42.283131) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8adPaKISJv/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.BUt3uRTAmJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:58:42 INFO - MultiFileLogger online at 20170329 11:58:42 in /builds/slave/test 11:58:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:58:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:42 INFO - {'append_to_log': False, 11:58:42 INFO - 'base_work_dir': '/builds/slave/test', 11:58:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:58:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:42 INFO - 'branch': 'Mozilla-Aurora', 11:58:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:42 INFO - 'config_files': ('talos/mac_config.py',), 11:58:42 INFO - 'default_actions': ('clobber', 11:58:42 INFO - 'read-buildbot-config', 11:58:42 INFO - 'download-and-extract', 11:58:42 INFO - 'populate-webroot', 11:58:42 INFO - 'create-virtualenv', 11:58:42 INFO - 'install', 11:58:42 INFO - 'run-tests'), 11:58:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:42 INFO - 'download_minidump_stackwalk': True, 11:58:42 INFO - 'download_symbols': 'ondemand', 11:58:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:58:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:58:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:58:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:58:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:42 INFO - 'gecko_profile': False, 11:58:42 INFO - 'gecko_profile_interval': 0, 11:58:42 INFO - 'installer_path': 'installer.exe', 11:58:42 INFO - 'log_level': 'info', 11:58:42 INFO - 'log_name': 'talos', 11:58:42 INFO - 'log_to_console': True, 11:58:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:58:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:58:42 INFO - 'opt_config_files': (), 11:58:42 INFO - 'pip_index': False, 11:58:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:42 INFO - 'cmd': ('bash', 11:58:42 INFO - '-c', 11:58:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:42 INFO - 'enabled': True, 11:58:42 INFO - 'halt_on_failure': False, 11:58:42 INFO - 'name': 'check_screen_resolution'},), 11:58:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:42 INFO - 'cmd': ('bash', 11:58:42 INFO - '-c', 11:58:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:42 INFO - 'enabled': True, 11:58:42 INFO - 'halt_on_failure': False, 11:58:42 INFO - 'name': 'check_screen_resolution'},), 11:58:42 INFO - 'run_cmd_checks_enabled': True, 11:58:42 INFO - 'suite': 'dromaeojs', 11:58:42 INFO - 'system_bits': '32', 11:58:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:42 INFO - 'title': 't-yosemite-r7-0175', 11:58:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:42 INFO - 'use_talos_json': True, 11:58:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:42 INFO - 'work_dir': 'build'} 11:58:42 INFO - [mozharness: 2017-03-29 18:58:42.498308Z] Running clobber step. 11:58:42 INFO - Running pre-action listener: _resource_record_pre_action 11:58:42 INFO - Running main action method: clobber 11:58:42 INFO - rmtree: /builds/slave/test/build 11:58:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:44 INFO - Running post-action listener: _resource_record_post_action 11:58:44 INFO - [mozharness: 2017-03-29 18:58:44.610078Z] Finished clobber step (success) 11:58:44 INFO - [mozharness: 2017-03-29 18:58:44.610256Z] Running read-buildbot-config step. 11:58:44 INFO - Running pre-action listener: _resource_record_pre_action 11:58:44 INFO - Running main action method: read_buildbot_config 11:58:44 INFO - Using buildbot properties: 11:58:44 INFO - { 11:58:44 INFO - "project": "", 11:58:44 INFO - "product": "firefox", 11:58:44 INFO - "script_repo_revision": "production", 11:58:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:58:44 INFO - "repository": "", 11:58:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:58:44 INFO - "buildid": "20170329103122", 11:58:44 INFO - "pgo_build": "False", 11:58:44 INFO - "basedir": "/builds/slave/test", 11:58:44 INFO - "buildnumber": 70, 11:58:44 INFO - "slavename": "t-yosemite-r7-0175", 11:58:44 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:58:44 INFO - "platform": "yosemite_r7", 11:58:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:58:44 INFO - "branch": "mozilla-aurora", 11:58:44 INFO - "repo_path": "releases/mozilla-aurora", 11:58:44 INFO - "revision": "27057064e224a8e69de0de4cedca78d25b5ec9a1", 11:58:44 INFO - "stage_platform": "macosx64", 11:58:44 INFO - "builduid": "418ae77880bc4c23b7a7647fe41d4e06", 11:58:44 INFO - "slavebuilddir": "test" 11:58:44 INFO - } 11:58:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 11:58:44 INFO - Running post-action listener: _resource_record_post_action 11:58:44 INFO - [mozharness: 2017-03-29 18:58:44.616193Z] Finished read-buildbot-config step (success) 11:58:44 INFO - [mozharness: 2017-03-29 18:58:44.616425Z] Running download-and-extract step. 11:58:44 INFO - Running pre-action listener: _resource_record_pre_action 11:58:44 INFO - Running main action method: download_and_extract 11:58:44 INFO - mkdir: /builds/slave/test/build/tests 11:58: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')]} 11:58:44 INFO - trying https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 11:58:44 INFO - Downloading https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 11:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 11:58:45 INFO - Downloaded 1199 bytes. 11:58:45 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 11:58:45 INFO - Using the following test package requirements: 11:58:45 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 11:58:45 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 11:58:45 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 11:58:45 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'jsshell-mac.zip'], 11:58:45 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 11:58:45 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 11:58:45 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 11:58:45 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 11:58:45 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 11:58:45 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:58:45 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 11:58:45 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:58:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 11:58:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:58:45 INFO - Fetch https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 11:58:47 INFO - Expected file size: 51791838 11:58:47 INFO - Obtained file size: 51791838 11:59:03 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:59:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 11:59:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:59:03 INFO - Fetch https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 11:59:05 INFO - Expected file size: 51791838 11:59:05 INFO - Obtained file size: 51791838 11:59:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 11:59:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:59:21 INFO - Fetch https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 11:59:22 INFO - Expected file size: 14404438 11:59:22 INFO - Obtained file size: 14404438 11:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:22 INFO - trying https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 11:59:22 INFO - Downloading https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 11:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 11:59:24 INFO - Downloaded 74686351 bytes. 11:59:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 11:59:24 INFO - mkdir: /builds/slave/test/properties 11:59:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:59:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:59:24 INFO - Contents: 11:59:24 INFO - build_url:https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 11:59:25 INFO - Running post-action listener: _resource_record_post_action 11:59:25 INFO - Running post-action listener: set_extra_try_arguments 11:59:25 INFO - [mozharness: 2017-03-29 18:59:25.181796Z] Finished download-and-extract step (success) 11:59:25 INFO - [mozharness: 2017-03-29 18:59:25.181941Z] Running populate-webroot step. 11:59:25 INFO - Running pre-action listener: _resource_record_pre_action 11:59:25 INFO - Running main action method: populate_webroot 11:59:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:59:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:59:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:59:25 INFO - '--tppagecycles', 11:59:25 INFO - '7'], 11:59:25 INFO - 'tests': ['tsvgm']}}, 11:59:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:59:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:59:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:59:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:59:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:59:25 INFO - 'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:59:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:59:25 INFO - 'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['damp', 'tps']}, 11:59:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:59:25 INFO - 'tests': ['damp', 'tps']}, 11:59:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['dromaeo_dom']}, 11:59:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:59:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['basic_compositor_video']}, 11:59:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:59:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['a11yr', 11:59:25 INFO - 'ts_paint', 11:59:25 INFO - 'tpaint', 11:59:25 INFO - 'sessionrestore', 11:59:25 INFO - 'sessionrestore_no_auto_restore', 11:59:25 INFO - 'tabpaint']}, 11:59:25 INFO - 'other-e10s': {'tests': ['a11yr', 11:59:25 INFO - 'ts_paint', 11:59:25 INFO - 'tpaint', 11:59:25 INFO - 'sessionrestore', 11:59:25 INFO - 'sessionrestore_no_auto_restore', 11:59:25 INFO - 'tabpaint']}, 11:59:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:59:25 INFO - 'ts_paint', 11:59:25 INFO - 'tpaint', 11:59:25 INFO - 'sessionrestore', 11:59:25 INFO - 'sessionrestore_no_auto_restore', 11:59:25 INFO - 'tabpaint']}, 11:59:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:59:25 INFO - 'ts_paint', 11:59:25 INFO - 'tpaint', 11:59:25 INFO - 'sessionrestore', 11:59:25 INFO - 'sessionrestore_no_auto_restore', 11:59:25 INFO - 'tabpaint']}, 11:59:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['a11yr', 11:59:25 INFO - 'ts_paint', 11:59:25 INFO - 'tpaint', 11:59:25 INFO - 'sessionrestore', 11:59:25 INFO - 'sessionrestore_no_auto_restore', 11:59:25 INFO - 'tabpaint']}, 11:59:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['a11yr', 11:59:25 INFO - 'ts_paint', 11:59:25 INFO - 'tpaint', 11:59:25 INFO - 'sessionrestore', 11:59:25 INFO - 'sessionrestore_no_auto_restore', 11:59:25 INFO - 'tabpaint']}, 11:59:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['tsvgx', 11:59:25 INFO - 'tsvgr_opacity', 11:59:25 INFO - 'tart', 11:59:25 INFO - 'tscrollx', 11:59:25 INFO - 'cart', 11:59:25 INFO - 'tsvg_static']}, 11:59:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:59:25 INFO - 'tsvgr_opacity', 11:59:25 INFO - 'tart', 11:59:25 INFO - 'tscrollx', 11:59:25 INFO - 'cart', 11:59:25 INFO - 'tsvg_static']}, 11:59:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:59:25 INFO - 'talos_options': ['--disable-e10s'], 11:59:25 INFO - 'tests': ['tp5o']}, 11:59:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:59:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:59:25 INFO - 'talos_options': ['--disable-e10s', 11:59:25 INFO - '--xperf_path', 11:59:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:25 INFO - 'tests': ['tp5n']}, 11:59:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:59:25 INFO - 'talos_options': ['--xperf_path', 11:59:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:25 INFO - 'tests': ['tp5n']}}, 11:59:25 INFO - 'talos.zip': {'path': '', 11:59:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:59:25 INFO - Running post-action listener: _resource_record_post_action 11:59:25 INFO - [mozharness: 2017-03-29 18:59:25.200569Z] Finished populate-webroot step (success) 11:59:25 INFO - [mozharness: 2017-03-29 18:59:25.200701Z] Running create-virtualenv step. 11:59:25 INFO - Running pre-action listener: _resource_record_pre_action 11:59:25 INFO - Running main action method: create_virtualenv 11:59:25 INFO - Creating virtualenv /builds/slave/test/build/venv 11:59:25 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 11:59:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:59:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:59:25 INFO - Using real prefix '/tools/python27' 11:59:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:59:26 INFO - Installing distribute.............................................................................................................................................................................................done. 11:59:28 INFO - Installing pip.................done. 11:59:28 INFO - Return code: 0 11:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:59:29 INFO - Reading from file tmpfile_stdout 11:59:29 INFO - Output received: 11:59:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:59:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:29 INFO - 'HOME': '/Users/cltbld', 11:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:29 INFO - 'LOGNAME': 'cltbld', 11:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:29 INFO - 'MOZ_NO_REMOTE': '1', 11:59:29 INFO - 'NO_EM_RESTART': '1', 11:59:29 INFO - 'PAGER': '/bin/cat', 11:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:29 INFO - 'PWD': '/builds/slave/test', 11:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:29 INFO - 'SHELL': '/bin/bash', 11:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:29 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:29 INFO - 'USER': 'cltbld', 11:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:29 INFO - 'XPC_FLAGS': '0x0', 11:59:29 INFO - 'XPC_SERVICE_NAME': '0', 11:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:29 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 11:59:29 INFO - Cleaning up... 11:59:29 INFO - Return code: 0 11:59:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:29 INFO - 'HOME': '/Users/cltbld', 11:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:29 INFO - 'LOGNAME': 'cltbld', 11:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:29 INFO - 'MOZ_NO_REMOTE': '1', 11:59:29 INFO - 'NO_EM_RESTART': '1', 11:59:29 INFO - 'PAGER': '/bin/cat', 11:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:29 INFO - 'PWD': '/builds/slave/test', 11:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:29 INFO - 'SHELL': '/bin/bash', 11:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:29 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:29 INFO - 'USER': 'cltbld', 11:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:29 INFO - 'XPC_FLAGS': '0x0', 11:59:29 INFO - 'XPC_SERVICE_NAME': '0', 11:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:29 INFO - Downloading/unpacking psutil>=3.1.1 11:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:59:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:33 INFO - Installing collected packages: psutil 11:59:33 INFO - Running setup.py install for psutil 11:59:33 INFO - building 'psutil._psutil_osx' extension 11:59:33 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 11:59:33 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 11:59:33 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 11:59:33 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 11:59:33 INFO - building 'psutil._psutil_posix' extension 11:59:33 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 11:59:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:59:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:59:34 INFO - ^ 11:59:34 INFO - 1 warning generated. 11:59:34 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 11:59:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:34 INFO - Successfully installed psutil 11:59:34 INFO - Cleaning up... 11:59:34 INFO - Return code: 0 11:59:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:59:34 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')]} 11:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:34 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')]} 11:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:34 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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:34 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 11:59:34 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 11:59:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:34 INFO - 'HOME': '/Users/cltbld', 11:59:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:34 INFO - 'LOGNAME': 'cltbld', 11:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:34 INFO - 'MOZ_NO_REMOTE': '1', 11:59:34 INFO - 'NO_EM_RESTART': '1', 11:59:34 INFO - 'PAGER': '/bin/cat', 11:59:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:34 INFO - 'PWD': '/builds/slave/test', 11:59:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:34 INFO - 'SHELL': '/bin/bash', 11:59:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:34 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:34 INFO - 'USER': 'cltbld', 11:59:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:34 INFO - 'XPC_FLAGS': '0x0', 11:59:34 INFO - 'XPC_SERVICE_NAME': '0', 11:59:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:59:37 INFO - Installing collected packages: mozsystemmonitor 11:59:37 INFO - Running setup.py install for mozsystemmonitor 11:59:37 INFO - Successfully installed mozsystemmonitor 11:59:37 INFO - Cleaning up... 11:59:37 INFO - Return code: 0 11:59:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:38 INFO - 'HOME': '/Users/cltbld', 11:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:38 INFO - 'LOGNAME': 'cltbld', 11:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:38 INFO - 'MOZ_NO_REMOTE': '1', 11:59:38 INFO - 'NO_EM_RESTART': '1', 11:59:38 INFO - 'PAGER': '/bin/cat', 11:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:38 INFO - 'PWD': '/builds/slave/test', 11:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:38 INFO - 'SHELL': '/bin/bash', 11:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:38 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:38 INFO - 'USER': 'cltbld', 11:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:38 INFO - 'XPC_FLAGS': '0x0', 11:59:38 INFO - 'XPC_SERVICE_NAME': '0', 11:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:38 INFO - Downloading/unpacking jsonschema==2.5.1 11:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:59:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:59: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 11:59: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 11:59: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 11:59: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 11:59: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 11:59: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 11:59:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:59:42 INFO - warning: no files found matching '*.txt' 11:59:42 INFO - no previously-included directories found matching 'build' 11:59:42 INFO - no previously-included directories found matching 'dist' 11:59:42 INFO - no previously-included directories found matching '.git*' 11:59:42 INFO - Installing collected packages: jsonschema, functools32 11:59:42 INFO - Running setup.py install for functools32 11:59:42 INFO - warning: no files found matching '*.txt' 11:59:42 INFO - no previously-included directories found matching 'build' 11:59:42 INFO - no previously-included directories found matching 'dist' 11:59:42 INFO - no previously-included directories found matching '.git*' 11:59:42 INFO - Successfully installed jsonschema functools32 11:59:42 INFO - Cleaning up... 11:59:42 INFO - Return code: 0 11:59:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:42 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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:42 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 11:59:42 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 11:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:42 INFO - 'HOME': '/Users/cltbld', 11:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:42 INFO - 'LOGNAME': 'cltbld', 11:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:42 INFO - 'MOZ_NO_REMOTE': '1', 11:59:42 INFO - 'NO_EM_RESTART': '1', 11:59:42 INFO - 'PAGER': '/bin/cat', 11:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:42 INFO - 'PWD': '/builds/slave/test', 11:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:42 INFO - 'SHELL': '/bin/bash', 11:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:42 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:42 INFO - 'USER': 'cltbld', 11:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:42 INFO - 'XPC_FLAGS': '0x0', 11:59:42 INFO - 'XPC_SERVICE_NAME': '0', 11:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:59:42 INFO - Cleaning up... 11:59:42 INFO - Return code: 0 11:59:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:42 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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:42 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 11:59:42 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 11:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:42 INFO - 'HOME': '/Users/cltbld', 11:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:42 INFO - 'LOGNAME': 'cltbld', 11:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:42 INFO - 'MOZ_NO_REMOTE': '1', 11:59:42 INFO - 'NO_EM_RESTART': '1', 11:59:42 INFO - 'PAGER': '/bin/cat', 11:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:42 INFO - 'PWD': '/builds/slave/test', 11:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:42 INFO - 'SHELL': '/bin/bash', 11:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:42 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:42 INFO - 'USER': 'cltbld', 11:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:42 INFO - 'XPC_FLAGS': '0x0', 11:59:42 INFO - 'XPC_SERVICE_NAME': '0', 11:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:45 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 11:59:45 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 11:59:45 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 11:59:45 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 11:59:45 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 11:59:45 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 11:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59: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 11:59: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 11:59: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 11:59: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 11:59: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 11:59: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 11:59:46 INFO - Downloading docopt-0.6.1.tar.gz 11:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:46 INFO - Running setup.py install for blobuploader 11:59:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:46 INFO - Running setup.py install for requests 11:59:47 INFO - Running setup.py install for docopt 11:59:47 INFO - Successfully installed blobuploader requests docopt 11:59:47 INFO - Cleaning up... 11:59:47 INFO - Return code: 0 11:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:47 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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:47 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 11:59:47 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 11:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:47 INFO - 'HOME': '/Users/cltbld', 11:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:47 INFO - 'LOGNAME': 'cltbld', 11:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:47 INFO - 'MOZ_NO_REMOTE': '1', 11:59:47 INFO - 'NO_EM_RESTART': '1', 11:59:47 INFO - 'PAGER': '/bin/cat', 11:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:47 INFO - 'PWD': '/builds/slave/test', 11:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:47 INFO - 'SHELL': '/bin/bash', 11:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:47 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:47 INFO - 'USER': 'cltbld', 11:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:47 INFO - 'XPC_FLAGS': '0x0', 11:59:47 INFO - 'XPC_SERVICE_NAME': '0', 11:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:47 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Rr9yjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-UTlkbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Vfcil6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-1tfxHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-UBwfZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-YBzMlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-pCncLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-e7PVv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-YFcP7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:48 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-lG6R8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:49 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Uz_Wo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:49 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-XbFeX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:49 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-mT9Mip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:49 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-UCYmMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:49 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-mKtyAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:49 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-7fVRUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:49 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-UiXf6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:49 INFO - Running setup.py install for manifestparser 11:59:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:49 INFO - Running setup.py install for mozcrash 11:59:50 INFO - Running setup.py install for mozdebug 11:59:50 INFO - Running setup.py install for mozdevice 11:59:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Running setup.py install for mozfile 11:59:50 INFO - Running setup.py install for mozhttpd 11:59:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Running setup.py install for mozinfo 11:59:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Running setup.py install for mozInstall 11:59:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:50 INFO - Running setup.py install for mozleak 11:59:51 INFO - Running setup.py install for mozlog 11:59:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:51 INFO - Running setup.py install for moznetwork 11:59:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:51 INFO - Running setup.py install for mozprocess 11:59:51 INFO - Running setup.py install for mozprofile 11:59:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:51 INFO - Running setup.py install for mozrunner 11:59:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:51 INFO - Running setup.py install for mozscreenshot 11:59:52 INFO - Running setup.py install for moztest 11:59:52 INFO - Running setup.py install for mozversion 11:59:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:52 INFO - Cleaning up... 11:59:52 INFO - Return code: 0 11:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:52 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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:52 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 11:59:52 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 11:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:52 INFO - 'HOME': '/Users/cltbld', 11:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:52 INFO - 'LOGNAME': 'cltbld', 11:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:52 INFO - 'MOZ_NO_REMOTE': '1', 11:59:52 INFO - 'NO_EM_RESTART': '1', 11:59:52 INFO - 'PAGER': '/bin/cat', 11:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:52 INFO - 'PWD': '/builds/slave/test', 11:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:52 INFO - 'SHELL': '/bin/bash', 11:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:52 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:52 INFO - 'USER': 'cltbld', 11:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:52 INFO - 'XPC_FLAGS': '0x0', 11:59:52 INFO - 'XPC_SERVICE_NAME': '0', 11:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:52 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-MeWQDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:52 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)) 11:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:52 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-JH_9fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 11:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:52 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-MIQFvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:52 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)) 11:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:52 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-LGGHHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Jccj7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:53 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-n5Djv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:53 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-TjUwEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:53 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-_xrWLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:53 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-40WlsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:53 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-waUo8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:53 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-vU1tld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:53 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-WNoZL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 11:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:53 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-RAnlFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:54 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)) 11:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:54 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-fbwRWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 11:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:54 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-fPKttN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:54 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)) 11:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:54 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ZOWLIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:54 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-q4PY3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:54 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)) 11:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:54 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)) 11:59:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:59:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:59:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:57 INFO - Downloading blessings-1.6.tar.gz 11:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:57 INFO - Installing collected packages: blessings 11:59:57 INFO - Running setup.py install for blessings 11:59:57 INFO - Successfully installed blessings 11:59:57 INFO - Cleaning up... 11:59:57 INFO - Return code: 0 11:59:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:57 INFO - Reading from file tmpfile_stdout 11:59:57 INFO - Current package versions: 11:59:57 INFO - blessings == 1.6 11:59:57 INFO - blobuploader == 1.2.4 11:59:57 INFO - docopt == 0.6.1 11:59:57 INFO - functools32 == 3.2.3-2 11:59:57 INFO - jsonschema == 2.5.1 11:59:57 INFO - manifestparser == 1.1 11:59:57 INFO - mozInstall == 1.12 11:59:57 INFO - mozcrash == 1.0 11:59:57 INFO - mozdebug == 0.1 11:59:57 INFO - mozdevice == 0.49 11:59:57 INFO - mozfile == 1.2 11:59:57 INFO - mozhttpd == 0.7 11:59:57 INFO - mozinfo == 0.9 11:59:57 INFO - mozleak == 0.1 11:59:57 INFO - mozlog == 3.4 11:59:57 INFO - moznetwork == 0.27 11:59:57 INFO - mozprocess == 0.25 11:59:57 INFO - mozprofile == 0.28 11:59:57 INFO - mozrunner == 6.13 11:59:57 INFO - mozscreenshot == 0.1 11:59:57 INFO - mozsystemmonitor == 0.3 11:59:57 INFO - moztest == 0.8 11:59:57 INFO - mozversion == 1.4 11:59:57 INFO - psutil == 3.1.1 11:59:57 INFO - requests == 1.2.3 11:59:57 INFO - wsgiref == 0.1.2 11:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:57 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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:57 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 11:59:57 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 11:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:57 INFO - 'HOME': '/Users/cltbld', 11:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:57 INFO - 'LOGNAME': 'cltbld', 11:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:57 INFO - 'MOZ_NO_REMOTE': '1', 11:59:57 INFO - 'NO_EM_RESTART': '1', 11:59:57 INFO - 'PAGER': '/bin/cat', 11:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:57 INFO - 'PWD': '/builds/slave/test', 11:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:57 INFO - 'SHELL': '/bin/bash', 11:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:57 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:57 INFO - 'USER': 'cltbld', 11:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:57 INFO - 'XPC_FLAGS': '0x0', 11:59:57 INFO - 'XPC_SERVICE_NAME': '0', 11:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 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)) 11:59:58 INFO - Cleaning up... 11:59:58 INFO - Return code: 0 11:59:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:58 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')]} 11:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:58 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')]} 11:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:58 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 0x103b1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0d676f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, '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.8adPaKISJv/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.BUt3uRTAmJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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 11:59:58 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 11:59:58 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 11:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 11:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:58 INFO - 'HOME': '/Users/cltbld', 11:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:58 INFO - 'LOGNAME': 'cltbld', 11:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:58 INFO - 'MOZ_NO_REMOTE': '1', 11:59:58 INFO - 'NO_EM_RESTART': '1', 11:59:58 INFO - 'PAGER': '/bin/cat', 11:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:58 INFO - 'PWD': '/builds/slave/test', 11:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:58 INFO - 'SHELL': '/bin/bash', 11:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 11:59:58 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 11:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:58 INFO - 'USER': 'cltbld', 11:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:58 INFO - 'XPC_FLAGS': '0x0', 11:59:58 INFO - 'XPC_SERVICE_NAME': '0', 11:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:59:58 INFO - Cleaning up... 11:59:58 INFO - Return code: 0 11:59:58 INFO - Running post-action listener: _resource_record_post_action 11:59:58 INFO - Running post-action listener: _start_resource_monitoring 11:59:58 INFO - Starting resource monitoring. 11:59:58 INFO - [mozharness: 2017-03-29 18:59:58.327859Z] Finished create-virtualenv step (success) 11:59:58 INFO - [mozharness: 2017-03-29 18:59:58.328905Z] Running install step. 11:59:58 INFO - Running pre-action listener: _resource_record_pre_action 11:59:58 INFO - Running main action method: install 11:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:58 INFO - Reading from file tmpfile_stdout 11:59:58 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:58 INFO - Reading from file tmpfile_stdout 11:59:58 INFO - Output received: 11:59:58 INFO - Usage: mozinstall [options] installer 11:59:58 INFO - Options: 11:59:58 INFO - -h, --help show this help message and exit 11:59:58 INFO - -d DEST, --destination=DEST 11:59:58 INFO - Directory to install application into. [default: 11:59:58 INFO - "/builds/slave/test"] 11:59:58 INFO - --app=APP Application being installed. [default: firefox] 11:59:58 INFO - mkdir: /builds/slave/test/build/application 11:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:00:18 INFO - Reading from file tmpfile_stdout 12:00:18 INFO - Output received: 12:00:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:00:18 INFO - Running post-action listener: _resource_record_post_action 12:00:18 INFO - [mozharness: 2017-03-29 19:00:18.805129Z] Finished install step (success) 12:00:18 INFO - [mozharness: 2017-03-29 19:00:18.805307Z] Running run-tests step. 12:00:18 INFO - Running pre-action listener: _resource_record_pre_action 12:00:18 INFO - Running main action method: run_tests 12:00:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:00:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:00:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:00:18 INFO - 2017-03-29 12:00:18.820 screenresolution[1895:13881] starting screenresolution argv=screenresolution get 12:00:18 INFO - 2017-03-29 12:00:18.823 screenresolution[1895:13881] Display 0: 1600x1200x32@60 12:00:18 INFO - 2017-03-29 12:00:18.829 screenresolution[1896:13884] starting screenresolution argv=screenresolution list 12:00:18 INFO - Available Modes on Display 0 12:00:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:00:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:00:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:00:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:00:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:00:19 INFO - Intel Iris: 12:00:19 INFO - Chipset Model: Intel Iris 12:00:19 INFO - Type: GPU 12:00:19 INFO - Bus: Built-In 12:00:19 INFO - VRAM (Dynamic, Max): 1536 MB 12:00:19 INFO - Vendor: Intel (0x8086) 12:00:19 INFO - Device ID: 0x0a2e 12:00:19 INFO - Revision ID: 0x0009 12:00:19 INFO - Displays: 12:00:19 INFO - Display: 12:00:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:00:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:00:19 INFO - Display Serial Number: 1600x1200 60 12:00:19 INFO - Main Display: Yes 12:00:19 INFO - Mirror: Off 12:00:19 INFO - Online: Yes 12:00:19 INFO - Rotation: Supported 12:00:19 INFO - Return code: 0 12:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:00:19 INFO - Python 2.7.3 12:00:19 INFO - Return code: 0 12:00:19 INFO - grabbing minidump binary from tooltool 12:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:00:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038fdd30>, '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 0x103824db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038f2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:00:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:00:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:00:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:00:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:00:19 INFO - Return code: 0 12:00:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:00:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:00:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:00:19 INFO - ENV: RUST_BACKTRACE is now 1 12:00:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:00:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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 12:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0175 --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 12:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8adPaKISJv/Render', 12:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:19 INFO - 'HOME': '/Users/cltbld', 12:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:19 INFO - 'LOGNAME': 'cltbld', 12:00:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:19 INFO - 'MOZ_NO_REMOTE': '1', 12:00:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:19 INFO - 'NO_EM_RESTART': '1', 12:00:19 INFO - 'PAGER': '/bin/cat', 12:00:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:19 INFO - 'PWD': '/builds/slave/test', 12:00:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:19 INFO - 'RUST_BACKTRACE': '1', 12:00:19 INFO - 'SHELL': '/bin/bash', 12:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BUt3uRTAmJ/Listeners', 12:00:19 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 12:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:19 INFO - 'USER': 'cltbld', 12:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:19 INFO - 'XPC_FLAGS': '0x0', 12:00:19 INFO - 'XPC_SERVICE_NAME': '0', 12:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:00:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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 12:00:19 INFO - mozversion application_buildid: 20170329103122 12:00:19 INFO - mozversion application_changeset: 27057064e224a8e69de0de4cedca78d25b5ec9a1 12:00:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:00:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:00:19 INFO - mozversion application_name: Firefox 12:00:19 INFO - mozversion application_remotingname: firefox-dev 12:00:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:00:19 INFO - mozversion application_vendor: Mozilla 12:00:19 INFO - mozversion application_version: 54.0a2 12:00:19 INFO - mozversion platform_buildid: 20170329103122 12:00:19 INFO - mozversion platform_changeset: 27057064e224a8e69de0de4cedca78d25b5ec9a1 12:00:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:00:19 INFO - mozversion platform_version: 54.0a2 12:00:19 INFO - using testdate: 1490814019 12:00:19 INFO - actual date: 1490814019 12:00:19 INFO - starting webserver on 'localhost:49367' 12:00:19 INFO - SUITE-START | Running 2 tests 12:00:19 INFO - TEST-START | dromaeo_css 12:00:19 INFO - operating with platform_type : mac_ 12:00:19 INFO - Initialising browser for dromaeo_css test... 12:00:19 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpuEXdZd/profile http://localhost:49367/getInfo.html) 12:00:21 INFO - PROCESS | 1906 | __metrics Screen width/height:1600/1200 12:00:21 INFO - PROCESS | 1906 | colorDepth:24 12:00:21 INFO - PROCESS | 1906 | Browser inner width/height: 1024/689 12:00:21 INFO - PROCESS | 1906 | __metrics 12:00:21 INFO - PROCESS | 1906 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:00:21 INFO - PROCESS | 1906 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:22 INFO - TEST-INFO | 1906: exit 0 12:00:22 INFO - Browser initialized. 12:00:22 INFO - Running cycle 1/1 for dromaeo_css test... 12:00:22 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpuEXdZd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:34 INFO - PROCESS | 1908 | RSS: Main: 214810624 12:00:34 INFO - PROCESS | 1908 | 12:03:38 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49367/tests/dromaeo/cssquery-ext.html) 12:03:41 INFO - PROCESS | 1908 | RSS: Main: 440623104 12:03:41 INFO - PROCESS | 1908 | 12:05:24 INFO - PROCESS | 1908 | ************************* 12:05:24 INFO - PROCESS | 1908 | A coding exception was thrown and uncaught in a Task. 12:05:24 INFO - PROCESS | 1908 | 12:05:24 ERROR - PROCESS | 1908 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:05:24 INFO - PROCESS | 1908 | Full stack: 12:05:24 INFO - PROCESS | 1908 | ************************* 12:06:44 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-ext.html (next: http://localhost:49367/tests/dromaeo/cssquery-jquery.html) 12:06:45 INFO - PROCESS | 1908 | RSS: Main: 354615296 12:06:45 INFO - PROCESS | 1908 | 12:09:47 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49367/tests/dromaeo/cssquery-mootools.html) 12:09:48 INFO - PROCESS | 1908 | RSS: Main: 345640960 12:09:48 INFO - PROCESS | 1908 | 12:12:50 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49367/tests/dromaeo/cssquery-prototype.html) 12:12:51 INFO - PROCESS | 1908 | RSS: Main: 319295488 12:12:51 INFO - PROCESS | 1908 | 12:15:55 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49367/tests/dromaeo/cssquery-yui.html) 12:15:56 INFO - PROCESS | 1908 | RSS: Main: 323198976 12:15:56 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-yui.html (next: http://localhost:49367/tests/dromaeo/cssquery-dojo.html) 12:18:59 INFO - PROCESS | 1908 | RSS: Main: 556552192 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | __start_tp_report 12:18:59 INFO - PROCESS | 1908 | _x_x_mozilla_page_load 12:18:59 INFO - PROCESS | 1908 | _x_x_mozilla_page_load_details 12:18:59 INFO - PROCESS | 1908 | |i|pagename|runs| 12:18:59 INFO - PROCESS | 1908 | |0;dojo.html;3109.238236632024;3295;3343.1642089477623;3359.7480188985824;3400.5409269748593;5856.765729370825;5882.970585147079;5885.588008839383;5908.261467316585;5922.407759224076;5900.262467191601;5926.970365148179;5944.791932282371;5985.311689155748;6009.849753756158;4641.744704041276;5358.33020872391;5369.704666243355;5385.299911011563;5415.079436495806;5298.549623282026;5315.282436871031;5327.520523152915;5503.532199763025;5505;5353.411124776291;5380.24676545284;5385.892282154355;5387.0841956867425;5395.271638328834;5373.973130134344;5398.865028374283;5401.945980540184;5402;5412.161115027177;5236.162214045772;5346.91979620306;5349.598780091509;5351.2240725095035;5385.434529374437;5946.137810017566;5963.344032156459;5974.014287642533;5978.491828194608;5985.16207730918;5268.262443257909;6331.620102793801;6342.429181373698;6343.365663433666;6347.8413039673915;6299.992001279819;6304.653244071575;6307.369263073701;6353.872922541524;6393.93606063938;6036.396360363972;6084.574079814415;6085.117657939574;6089.391060893875;6095.725692343855;6278.497720182374;6574.967125164344;6589.769358072444;6591.209054913441;6606.570572912745;5324.973375133177;6252.343503932022;6259.2488901332135;6302.873942521124;6367.363263673596;6408.391202835724;6418.326075762071;6421.325760795143;6430.260520040161;6433.195850518685;6241.157443745127;6307.274663413675;6318.842028949313;6319.557630965788;6325.588836725598;6111.873644844951;6213.1922850029205;6259.812205633838;6318.557700960981;6345.17512723343;5112.335396398445;5146.099432599281;5168.01807656544;5198.402183748842;5203.739813009334;4558;4561.589456948825;4567.040921406476;4574.313852922089;4599.448066232074;5801.361850196475;5931.673757943268;5967.403259674084;6128.050152226412;6133.570650054453;6311.211098612674;6339.4611458025665;6385.233771947396;6390.808275751735;6403.359664033653;6086.817395478142;6128.1726966858905;6141.416565426277;6142.692865356804;6152.938470615326;5491.945080549143;5539.612227144142;5685.829425117253;5689.601727879091;5715.657060576379;6307.4954003679595;6539.542232043711;6556.082148499309;6650.73397064112;6658.400743933069;6409;6418.807435776934;6424.261209960728;6427.871442571029;6429.132067170872;6518.934810651833;6574.309697481695;6603.636799976048;6603.9009414859775;6609.20689517261;6233.844153896189;6293.96853015732;6333.081703153109;6338.58799178052;6354.364563543609;6323.114763932961;6336.58812177207;6339.841503962438;6342.460890824332;6345.587536810092;6250.718717657625;6290.433860952537;6294.402031806971;6325.177726895658;6345.17512723343;6306.968465157828;6331.493480521455;6339.461145802474;6343.714532846126;6352.301246862934;6255.311915689362;6262.34245404226;6265.467435268053;6280.811575652738;6282.528810339334;5156.226566015128;5367.5169234769055;6202.968985155046;6226.221722284715;6282.968585157045;6224.875502489835;6246.375362463899;6249.125122482947;6252.374762523711;6253.843653908507 12:18:59 INFO - PROCESS | 1908 | |1;ext.html;787.2285160542668;805.9637316320765;874.5933141089396;886.6940905387639;888.3159966825541;38763.83708488746;39124.60875391245;39505.60494395055;39725.40411893817;39781;40854.59145408545;41101.79449102758;41125;41217;41307.967300817494;7229.530080544774;8912.331575131859;9063.637454501812;9067.141236046595;9075.682351117712;7360.889586656204;10708.25042247043;10901.073408760265;10970.945145274263;10981.560737570488;9315.347925645208;10865.239433239676;10877.945610271938;10879.83680244797;10886.183536234774;9202.861957070583;10785.892141078568;10838.945805271002;10847.728806779814;10865.83701244482;7170.28297170284;7337.559746415232;10451.947740261327;10703.250772445854;10755.085817705505;38480.23039539193;38701.80649096765;38765.03087422837;38771.03072423184;38796.806015970025;3776.339140650375;3778.3199024175638;3814.4850445189822;3835.0795809005917;3865.9226815463535;26383.868080659668;26497.602535961974;27411.725882741317;27672.03147889814;28558.428831423254;3086.1667349815425;3087.367089746597;3093.443180227558;3102.10039088664;3127.6090488688915;355749;356083;356634;356669;356736;41806.79096604497;42695.35956960648;52498.73750631222;52568;52811.20783188255;52266;53199.468005320225;55591;55702.72148639231;55927.72036139793;14523.273836308143;14591.635209119644;14618.780718289234;14627.122372657675;14643.828493720477;12600.054995875345;12603.243805371707;12606;12615.49538018469;12645.873541264653;11734.413279335999;11939.701507462209;11982.221155624857;11988.700282493008;12160.209586376857;5501.229827824108;5516.779328826802;5519.668819870821;5521.779128834802;5580.074874168406;882.3779235638859;925.3476299209042;954.2652157838426;961.9086186812242;988.6786794291884;26966.73033269642;28310;28320.858395707888;28630.856845716055;28944.565831512544;1046.4349251404308;1053.7997780421695;1057.6245432871374;1074.0977578833817;1078.3691540448926;14250.786238206436;14383.208923509308;14521.983461157617;14638.560843174722;14818.777718334233;444166;445236;445362;445362;445799;55533.44466555364;55610.887782244936;55744.72127639336;55753;55961.720191399596;1431.0912570517587;1463.1586837568227;1468.067776961637;1475.42458441208;1479.5413421839264;25993.6100958482;27278.318042049108;27476;27832.86083569569;27934;45301.09397811959;45391.773041134584;45507;45507.77246113748;45552.544474556154;393370;396028.0397195991;427537;428240;428323;23998.640020400057;27076.593851092643;27908.720912790614;33644.158896027795;33797.493037604945;40634.593654064265;42742.57257427386;42910.71267861969;43454;43933;29342.266443339086;29830.70169298279;30747;30965.380692386476;31057.689423106385;29538.409231814814;29649.407011860072;29898.252543686584;30474.84762576173;30659.54010689886;35806.46290305595;36093;36363.81818090893;36511.817440913685;36568.817155914054;20722.585548288647;25782.871085644452;27971.601419929328;28190.295242619097;29929;19139.712904306725;23717.525649486568;24003.27990160298;24100.87949560241;25059.99760009652 12:18:59 INFO - PROCESS | 1908 | |2;jquery.html;387.1965671232194;402.117352411457;425.82966813274686;426.4243271583362;449.4180036852276;12537.435815388306;14354.210518421483;20556;21092.472688182803;21283.467913302175;21643.891780541115;21669.45826354342;22188.334349969486;22403.32790016298;22665.98003089861;6267.529935254863;6271.843203919916;6493.70778314977;6554.41010309072;6582.8683426331445;3961.77185072627;4098.385242213662;6421.903671444932;6486.513511486633;6487.481001519891;4138.234426631083;7442.925570744304;7461.515001524884;7461.515001524911;7466.813329666747;7347.8163045924275;7372.889406658905;7452.956586077953;7456.217097204824;7468.178500364956;6945.236024037352;6994.440444764457;7172.46206534512;7202.783916482514;7214.134303883515;22003.449913752123;27222.863885680643;27373.04194353208;27732.8906843726;27733.445331093466;2912.053582585647;2914.402547477762;2920.4597149527403;2932.912012639624;2944.6319210098736;14004.789928151085;15731.921340393224;16325.346986120541;16918.407855725112;17045.31818727262;1970.5265668319503;2048.8565800393976;2056.074766355131;2081.3131666550003;2088.0186312433134;143142;143380;144082.99999999895;144229.27885360506;146377.26811365876;16947.745783813254;21646.86120512517;22009.33971980843;22078.896055197496;22231.77768222297;35017.824910875795;35299.29401411957;35588.82205589007;35706;35786.46320305197;10395.896041039645;10421.270511064304;10431.321964072311;10766.838497422545;10846.566137354575;7206.603636799921;8500.914990850137;8568.614412351459;8612.09572994839;8695.956520217485;10114.735658042744;10221.080102790784;10252.333598316234;10411.323263987817;10417.47912604382;3574.7140228781636;3722.1253005543676;4072.9796351018053;4162.7502349859105;4174.457320548309;991.1921783746224;1037.7405648587853;1038.2350004991545;1059.782744537368;1103.9282446640943;20856.478588035116;22105.036913372238;22415.663765043537;22442;22482.100715971505;987.6888780034266;1051.9684409467727;1063.9787204255872;1076.4779082145153;1094.731790711265;9189.77025574366;11678.824817627743;11688.47401866918;11788;11809.645710628694;745536;747665;755316;759501;777109;135258;137762.31118844342;141781;144441;150929;1187.2045729361348;1211.7455334379704;1301.069735139361;1301.8828305452555;1305.6083175047447;19144.521386965436;19385;19754;19759.209631614576;19843.702344464557;46715;51855.18506852242;63305.68347158235;63726;64229;94933;95423;95475.52262238644;98523.01476985139;98537;11261.324320540794;11418.486168122621;11477.713057173303;11517.366544840113;11859.229150105215;12553.309567973849;12690.969444889142;12943.676408089874;13054.673633159247;13265.86734132685;10898.618548350769;11125.666230013112;11197.888021119685;11212.439378030902;11295.435228238392;9923.900760992587;10138.746531336481;10240.334378265388;10253.58985640566;10445.634402795866;11220.438978051228;11307.547698092314;11319.717007074889;11371.374574398156;11563.42182890869;10835.349879007284;11197.384143872165;11378.203525753117;11544.769104618028;11778.115501519716;9960.55177516999;11193;11231.831522527005;11290.774184516427;11501.252418592765 12:18:59 INFO - PROCESS | 1908 | |3;mootools.html;1423.5160045584498;1512.8033355663765;1525.5804653720234;1567.6942996115754;1590.6500569874627;10562.366258024524;11111.333320000806;11129.83305250421;11154.163437742161;11156.776864462707;10568.471576421187;10941.56233750651;11137.443127843617;11151.330920144797;11178;2311.560803447348;2350.894209760565;2351.459164392191;2353;2358.481134150484;2274.9658755118685;2319.211468100845;2413.78275955164;2416.4200591857916;2416.66166736657;2325.546518428907;2383.880805959695;2386.7732565406345;2409.8072154227707;2418.056957786465;2337.976620233793;2384.332386931662;2385.666006759055;2391.366287933699;2398.2445529658103;2338.3101984914492;2362.5511152881068;2366.857988520677;2369;2371.8102551795987;10598.364098154136;10806.51370688321;10812.29720068201;10824.945875270652;10825.24223304369;5763.538916886681;5944.643321400687;5959.761609535613;5961.940380596182;5971.910421343683;3474.9131271718156;3614.981925090358;3653.963460365389;3689.9262014759825;3705.7961812100325;1078.8941335131474;1185.869554349021;1229.0536287059003;1231.7043909461665;1239.9318037507933;13612;14037.298135093306;14263.358148883326;15246.618834529114;15451.381944722198;3306.7685262031428;4224.66202703783;4327.675424343187;4340.131973605228;4355.8457008892665;9627.614895404105;10394.064534191959;11437.942810285895;11510.136739744552;11514.827277590843;5571.164325351148;5572.972135139379;5573.777048918079;5574.136008918624;5579.972100139555;5239.790408383622;5249.658772179796;5275.235090911873;5309.628326017141;5321.2018197269945;3201.3437245364644;3814.2562200371217;3867.651911327994;3913.412988051815;3920.2355540669296;1028.0901402259055;1028.8919663435381;1032.6437379104198;1047.1256500821746;1048.2295512798087;751.2037240525061;768.8539177556246;785.8546168958646;787.3111027850631;796.1839114907151;5502.504774570228;6383.904241436382;6417.06952491886;6427.164468619049;6490.902636460457;888.2228050455851;1020.3673722292078;1022.0903395977438;1039.101177481473;1065.3714308557987;4241.660667146621;4421.513633500313;4561.133384656904;4680.95319046812;4717.551832575899;12926.095173337777;13247.470101196037;13448.731025379439;13913.652158696113;13993.650158746113;11543.018843398237;12347.13570050088;12845.614631561068;13304.600861974157;13324.40040198174;8027.638756255866;10241.74395640115;10244.231682623833;10251.538680759384;10254.846177307347;5487.396386397413;6570.244421891352;6719.798406047827;6736.157980252468;6950.235474097744;11743.941280293544;11794.46924888365;11899.702507437383;12034.157608967289;12056.819147712968;12081.973032292002;12110.878891211327;12148.635540933787;12242.571509997108;12338.81491777606;9942.105210531086;10280.845787313046;10312.639057632947;10330.173586113244;10337.534810933677;9311.534423278674;9385.812283754423;9431.764205894908;9477.478738669439;10272.383656980604;7891.802704932193;8046.718364857202;8139.593020348841;8164.1019487857475;8274.462159959583;7454.850902982019;7810.492317999312;7898.052233731989;7945.1657575953695;8130.186981301823;7210.819729506804;7361.668724907499;7384.52000619958;7389.261073892568;7390.556566606021;5293.550048245942;5510.421405752499;5571.804986825442;5655.830325090254;5697.857553561194;5501.669899806025;5527.50252477279;5601.24383208278;5659.236003139524;5708.80019199326 12:18:59 INFO - PROCESS | 1908 | |4;prototype.html;366.9431238158085;377.24174409437023;379.49527128918544;384.12611309271404;386.08690447092624;4495.910081798362;4582.74794886282;4765.499622539635;5104.234364845275;5127.7436128193585;4522.525134860842;4790.520947905216;4933.679310844793;4999.8000079996755;5024.623153263502;3593.4070878305047;3617.8371973261264;3628.8367023483875;3935.9803200983956;4247.596478334569;3719.628037196272;3931.6461518463334;4095.4061661059127;4225.112726327475;4247.235497610429;4058.5592114799265;4062.7092055435046;4212.4945006599255;4275.315949448089;4276.786160691969;3378.2736711606876;4041.8278699177204;4282.850100246507;4283.250431174548;4307.353896915472;3308.3217940322174;3444.9655503444897;3826;3886.844526218948;3897.4215442745735;4480.417545719069;4730.550597693214;4770.1175282572485;4943.851684449436;4985.800567977277;4017.979910100431;4654.860649896481;4763.7141771493825;4808.519148085164;4898.926516102261;4497.168023915586;4970.353853998993;5216.739163041871;5311.123664595337;5401.432849550819;3383.6954674079207;4140.4617399737845;4287.678424118172;4296.613304802583;4375.496817865955;5281.920771188396;5486.478784515464;5606.7388784524055;5632.52123569493;5811.941880581182;3509.5613048368955;3896.201278737852;3923.431102490123;4163.854265100767;4287.627959053136;4436.556344365537;4452.395348721035;4467.508574056851;4482.282834746425;4492.9550704493195;4195.538490766014;4814.855554333376;4844.231855372764;4856.9314750754775;4900.460949295574;4934.827281045146;5398.406175320712;5413.783448662089;5465.863353416196;5487.07952216721;1330.9020058451815;1482.3249727807508;1484.5768955847532;1493.1414436698942;1493.5587158392204;1081.6538707613645;1139.9886001139882;1141.3380239461092;1142.7771584540935;1157.5948418053613;4391.8682439526865;5007.649464537448;5059.016868384638;5066.974665126724;5068.341115655015;4691.319758634979;5051.797928082909;5592.356878958891;5593.636413633101;5628.437156284421;4183.2430379240795;4192.748435093904;4736.360591320196;4826.831060912851;5037.79848806051;2458.868920296648;2656.4023094803515;2879.3665393613373;2917.8395188264426;2939.76481881449;5486.259354987105;5842.883142337215;5872.29532456108;5913.615614985012;5913.852153696106;5194.376674798973;5319.601029922771;5364.30264065669;5370.516653501204;5385.919211211835;4773.498782627774;5140.820071297487;5627.902559000955;5634.549236061023;5700.515456186271;4691.481388958281;4800.879978000578;4968.304437378698;5315.747402078399;5425.294711687456;4986.775595098156;5389.622726409114;5443.475826768511;5494.2857428535635;5534.501894829485;4877.975610122068;5369.322014420135;5375.623706340519;5736.5410767139365;5749.9712501437225;3828.679105708526;4078.857239996586;4211.852585159505;4344.3700663403;4364.581511008998;4844.346013288161;4866.491387669692;5034.798608055637;5038.748062596929;5579.414161512983;4912.533309335608;5346.652467589594;5378.892422151614;5413.431589683027;5438.18427235902;4467.2182368086105;5072.391313042459;5153.819616313411;5275.024120537712;5425.972870135624;4755.785989630405;4778.713277203379;4825.541573550507;4973.875653108701;5280.207968804556;4716.7500612338445;5131.25596788471;5210.921836172536;5432.538234250133;5483.369412517452;4688.812447502198;4850.5149485052625;4892.3884514435695;5230.712310822942;5232.947670523398 12:18:59 INFO - PROCESS | 1908 | |5;yui.html;712.6009434716556;730.0254160695471;770.7379490973068;831.5343407691691;836.3100442135238;15451.150186739726;16152.83847161528;16158.353665853367;16168.949018313817;16277.918610406932;14666.926665366658;14687.92656036721;14723.779143312859;14799.704005919903;14878.404863805461;909.122696597783;923.7321176858703;924.2190349154953;942.4109931292942;945.3146468810127;883.4478450968145;943.7640589852537;944.84882418813;946.3943076431055;947.3984020147187;989.3915242126112;989.4459102902398;990.2968892086627;992.6525715999378;993.1260490768113;981.8232718110737;982.9410235385828;983.3608154699431;985.4186030242156;987.2299606307092;729.7810656802938;730.1311439387113;730.4229658569724;730.8611363840853;731.4477569435043;15747.448839290684;15868.761968570481;15897;16433.83566164335;16711.749323760152;11484.964174477996;12574.497020119185;13937.721245575032;13986.16083035021;14284.714305713931;11531.48108335127;11536.365499897502;11581.710457238552;11899.048076153887;12023.93988030063;3568.80371579563;3579.826239438864;3626.256617393428;3700.5189325387796;3738.738288319819;116388;117687;117695;119917;124204;10638.414887181125;10730.19523535738;10964.451777411097;11119.332840029625;11400.258983166068;22439.43901402478;22621.660675089886;22677.659835102488;23118.075276989068;23118.76881231166;7660.693572257047;7720.613969301512;7732.57470839098;7739;7980.441369104107;4278.7860606969525;4315.8489452869;4320.308750599952;4401.6698747594055;4511.187986162457;3362.81504517249;3423.7089847362754;3437.6906078452557;3468.3063387322636;3524.5241892344206;632.5256057956533;634.4226753654244;637.6652257564723;646.5668002438377;649.1107183159008;631.233051842005;650.8015055408146;660.5838321857199;660.9622892059516;694.5346617766108;9316.534173291308;10154.796904062025;10231.795364092824;10509.527071281811;10524.684259472227;627.5638431290209;676.9169329073443;700.5411455496658;703.3353480960545;718.7017387784011;4690.273007683814;4955.8017679292425;4989.426215985136;4995.325631039763;5017.7491125443585;73070;95110.52444737732;95383;96295.51852240694;96784.51607742057;55490.72254638701;58740.70629646824;61646.691766540884;65904.67047664731;75284;53481.465185348425;75013;77574.612126939;78424.60787696025;79978;10618.885017073097;10681.465926703479;10790.860984623834;11045.723856903642;11184.273022253528;44546.77726611346;46695;47167.52832471632;47523.28715069208;49513.75243123761;62292.68853655703;62909;63252.939764819625;63298;63643.68178159265;12071.275723456622;12341.876581234073;12577.245365278113;12628.810567841674;13142.60572182836;14149.746192893614;14156.716865662424;14265.358058887168;14585.562433127023;14599.416023359372;11488.138389620979;13304.825840148778;13607.591772246848;13670.17978921268;13676;12886.613401597968;13049.151805133015;13537.323133843465;13542.729145417234;13927.303634818016;12247.510099595916;13307.933460332637;13352.265625390697;13802.585922422344;13934.233617151154;9590.328676992543;9610.807783844424;9914.314616101747;10006.599736010769;10631.096356809758;9014.90985090167;9406.200472959876;10016.949915250378;10281.845772313272;11358.034567061562 12:18:59 INFO - PROCESS | 1908 | __end_tp_report 12:18:59 INFO - PROCESS | 1908 | __start_cc_report 12:18:59 INFO - PROCESS | 1908 | _x_x_mozilla_cycle_collect,2690 12:18:59 INFO - PROCESS | 1908 | __end_cc_report 12:18:59 INFO - PROCESS | 1908 | __startTimestamp1490815139343__endTimestamp 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | ------- Summary: start ------- 12:18:59 INFO - PROCESS | 1908 | Number of tests: 6 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | [#0] dojo.html Cycles:165 Average:5910.18 Median:6224.88 stddev:678.43 (10.9%) stddev-sans-first:643.94 12:18:59 INFO - PROCESS | 1908 | Values: 3109.2 3295.0 3343.2 3359.7 3400.5 5856.8 5883.0 5885.6 5908.3 5922.4 5900.3 5927.0 5944.8 5985.3 6009.8 4641.7 5358.3 5369.7 5385.3 5415.1 5298.5 5315.3 5327.5 5503.5 5505.0 5353.4 5380.2 5385.9 5387.1 5395.3 5374.0 5398.9 5401.9 5402.0 5412.2 5236.2 5346.9 5349.6 5351.2 5385.4 5946.1 5963.3 5974.0 5978.5 5985.2 5268.3 6331.6 6342.4 6343.4 6347.8 6300.0 6304.7 6307.4 6353.9 6393.9 6036.4 6084.6 6085.1 6089.4 6095.7 6278.5 6575.0 6589.8 6591.2 6606.6 5325.0 6252.3 6259.2 6302.9 6367.4 6408.4 6418.3 6421.3 6430.3 6433.2 6241.2 6307.3 6318.8 6319.6 6325.6 6111.9 6213.2 6259.8 6318.6 6345.2 5112.3 5146.1 5168.0 5198.4 5203.7 4558.0 4561.6 4567.0 4574.3 4599.4 5801.4 5931.7 5967.4 6128.1 6133.6 6311.2 6339.5 6385.2 6390.8 6403.4 6086.8 6128.2 6141.4 6142.7 6152.9 5491.9 5539.6 5685.8 5689.6 5715.7 6307.5 6539.5 6556.1 6650.7 6658.4 6409.0 6418.8 6424.3 6427.9 6429.1 6518.9 6574.3 6603.6 6603.9 6609.2 6233.8 6294.0 6333.1 6338.6 6354.4 6323.1 6336.6 6339.8 6342.5 6345.6 6250.7 6290.4 6294.4 6325.2 6345.2 6307.0 6331.5 6339.5 6343.7 6352.3 6255.3 6262.3 6265.5 6280.8 6282.5 5156.2 5367.5 6203.0 6226.2 6283.0 6224.9 6246.4 6249.1 6252.4 6253.8 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | [#1] ext.html Cycles:180 Average:54461.23 Median:355916.00 stddev:107872.96 (30.3%) stddev-sans-first:108100.30 12:18:59 INFO - PROCESS | 1908 | Values: 787.2 806.0 874.6 886.7 888.3 38763.8 39124.6 39505.6 39725.4 39781.0 40854.6 41101.8 41125.0 41217.0 41308.0 7229.5 8912.3 9063.6 9067.1 9075.7 7360.9 10708.3 10901.1 10970.9 10981.6 9315.3 10865.2 10877.9 10879.8 10886.2 9202.9 10785.9 10838.9 10847.7 10865.8 7170.3 7337.6 10451.9 10703.3 10755.1 38480.2 38701.8 38765.0 38771.0 38796.8 3776.3 3778.3 3814.5 3835.1 3865.9 26383.9 26497.6 27411.7 27672.0 28558.4 3086.2 3087.4 3093.4 3102.1 3127.6 355749.0 356083.0 356634.0 356669.0 356736.0 41806.8 42695.4 52498.7 52568.0 52811.2 52266.0 53199.5 55591.0 55702.7 55927.7 14523.3 14591.6 14618.8 14627.1 14643.8 12600.1 12603.2 12606.0 12615.5 12645.9 11734.4 11939.7 11982.2 11988.7 12160.2 5501.2 5516.8 5519.7 5521.8 5580.1 882.4 925.3 954.3 961.9 988.7 26966.7 28310.0 28320.9 28630.9 28944.6 1046.4 1053.8 1057.6 1074.1 1078.4 14250.8 14383.2 14522.0 14638.6 14818.8 444166.0 445236.0 445362.0 445362.0 445799.0 55533.4 55610.9 55744.7 55753.0 55961.7 1431.1 1463.2 1468.1 1475.4 1479.5 25993.6 27278.3 27476.0 27832.9 27934.0 45301.1 45391.8 45507.0 45507.8 45552.5 393370.0 396028.0 427537.0 428240.0 428323.0 23998.6 27076.6 27908.7 33644.2 33797.5 40634.6 42742.6 42910.7 43454.0 43933.0 29342.3 29830.7 30747.0 30965.4 31057.7 29538.4 29649.4 29898.3 30474.8 30659.5 35806.5 36093.0 36363.8 36511.8 36568.8 20722.6 25782.9 27971.6 28190.3 29929.0 19139.7 23717.5 24003.3 24100.9 25060.0 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | [#2] jquery.html Cycles:180 Average:42896.72 Median:21187.97 stddev:125811.63 (593.8%) stddev-sans-first:126124.08 12:18:59 INFO - PROCESS | 1908 | Values: 387.2 402.1 425.8 426.4 449.4 12537.4 14354.2 20556.0 21092.5 21283.5 21643.9 21669.5 22188.3 22403.3 22666.0 6267.5 6271.8 6493.7 6554.4 6582.9 3961.8 4098.4 6421.9 6486.5 6487.5 4138.2 7442.9 7461.5 7461.5 7466.8 7347.8 7372.9 7453.0 7456.2 7468.2 6945.2 6994.4 7172.5 7202.8 7214.1 22003.4 27222.9 27373.0 27732.9 27733.4 2912.1 2914.4 2920.5 2932.9 2944.6 14004.8 15731.9 16325.3 16918.4 17045.3 1970.5 2048.9 2056.1 2081.3 2088.0 143142.0 143380.0 144083.0 144229.3 146377.3 16947.7 21646.9 22009.3 22078.9 22231.8 35017.8 35299.3 35588.8 35706.0 35786.5 10395.9 10421.3 10431.3 10766.8 10846.6 7206.6 8500.9 8568.6 8612.1 8696.0 10114.7 10221.1 10252.3 10411.3 10417.5 3574.7 3722.1 4073.0 4162.8 4174.5 991.2 1037.7 1038.2 1059.8 1103.9 20856.5 22105.0 22415.7 22442.0 22482.1 987.7 1052.0 1064.0 1076.5 1094.7 9189.8 11678.8 11688.5 11788.0 11809.6 745536.0 747665.0 755316.0 759501.0 777109.0 135258.0 137762.3 141781.0 144441.0 150929.0 1187.2 1211.7 1301.1 1301.9 1305.6 19144.5 19385.0 19754.0 19759.2 19843.7 46715.0 51855.2 63305.7 63726.0 64229.0 94933.0 95423.0 95475.5 98523.0 98537.0 11261.3 11418.5 11477.7 11517.4 11859.2 12553.3 12691.0 12943.7 13054.7 13265.9 10898.6 11125.7 11197.9 11212.4 11295.4 9923.9 10138.7 10240.3 10253.6 10445.6 11220.4 11307.5 11319.7 11371.4 11563.4 10835.3 11197.4 11378.2 11544.8 11778.1 9960.6 11193.0 11231.8 11290.8 11501.3 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | [#3] mootools.html Cycles:180 Average:6540.02 Median:2394.81 stddev:4077.85 (170.3%) stddev-sans-first:4071.17 12:18:59 INFO - PROCESS | 1908 | Values: 1423.5 1512.8 1525.6 1567.7 1590.7 10562.4 11111.3 11129.8 11154.2 11156.8 10568.5 10941.6 11137.4 11151.3 11178.0 2311.6 2350.9 2351.5 2353.0 2358.5 2275.0 2319.2 2413.8 2416.4 2416.7 2325.5 2383.9 2386.8 2409.8 2418.1 2338.0 2384.3 2385.7 2391.4 2398.2 2338.3 2362.6 2366.9 2369.0 2371.8 10598.4 10806.5 10812.3 10824.9 10825.2 5763.5 5944.6 5959.8 5961.9 5971.9 3474.9 3615.0 3654.0 3689.9 3705.8 1078.9 1185.9 1229.1 1231.7 1239.9 13612.0 14037.3 14263.4 15246.6 15451.4 3306.8 4224.7 4327.7 4340.1 4355.8 9627.6 10394.1 11437.9 11510.1 11514.8 5571.2 5573.0 5573.8 5574.1 5580.0 5239.8 5249.7 5275.2 5309.6 5321.2 3201.3 3814.3 3867.7 3913.4 3920.2 1028.1 1028.9 1032.6 1047.1 1048.2 751.2 768.9 785.9 787.3 796.2 5502.5 6383.9 6417.1 6427.2 6490.9 888.2 1020.4 1022.1 1039.1 1065.4 4241.7 4421.5 4561.1 4681.0 4717.6 12926.1 13247.5 13448.7 13913.7 13993.7 11543.0 12347.1 12845.6 13304.6 13324.4 8027.6 10241.7 10244.2 10251.5 10254.8 5487.4 6570.2 6719.8 6736.2 6950.2 11743.9 11794.5 11899.7 12034.2 12056.8 12082.0 12110.9 12148.6 12242.6 12338.8 9942.1 10280.8 10312.6 10330.2 10337.5 9311.5 9385.8 9431.8 9477.5 10272.4 7891.8 8046.7 8139.6 8164.1 8274.5 7454.9 7810.5 7898.1 7945.2 8130.2 7210.8 7361.7 7384.5 7389.3 7390.6 5293.6 5510.4 5571.8 5655.8 5697.9 5501.7 5527.5 5601.2 5659.2 5708.8 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | [#4] prototype.html Cycles:180 Average:4435.53 Median:4804.70 stddev:1244.65 (25.9%) stddev-sans-first:1210.10 12:18:59 INFO - PROCESS | 1908 | Values: 366.9 377.2 379.5 384.1 386.1 4495.9 4582.7 4765.5 5104.2 5127.7 4522.5 4790.5 4933.7 4999.8 5024.6 3593.4 3617.8 3628.8 3936.0 4247.6 3719.6 3931.6 4095.4 4225.1 4247.2 4058.6 4062.7 4212.5 4275.3 4276.8 3378.3 4041.8 4282.9 4283.3 4307.4 3308.3 3445.0 3826.0 3886.8 3897.4 4480.4 4730.6 4770.1 4943.9 4985.8 4018.0 4654.9 4763.7 4808.5 4898.9 4497.2 4970.4 5216.7 5311.1 5401.4 3383.7 4140.5 4287.7 4296.6 4375.5 5281.9 5486.5 5606.7 5632.5 5811.9 3509.6 3896.2 3923.4 4163.9 4287.6 4436.6 4452.4 4467.5 4482.3 4493.0 4195.5 4814.9 4844.2 4856.9 4900.5 4934.8 5398.4 5413.8 5465.9 5487.1 1330.9 1482.3 1484.6 1493.1 1493.6 1081.7 1140.0 1141.3 1142.8 1157.6 4391.9 5007.6 5059.0 5067.0 5068.3 4691.3 5051.8 5592.4 5593.6 5628.4 4183.2 4192.7 4736.4 4826.8 5037.8 2458.9 2656.4 2879.4 2917.8 2939.8 5486.3 5842.9 5872.3 5913.6 5913.9 5194.4 5319.6 5364.3 5370.5 5385.9 4773.5 5140.8 5627.9 5634.5 5700.5 4691.5 4800.9 4968.3 5315.7 5425.3 4986.8 5389.6 5443.5 5494.3 5534.5 4878.0 5369.3 5375.6 5736.5 5750.0 3828.7 4078.9 4211.9 4344.4 4364.6 4844.3 4866.5 5034.8 5038.7 5579.4 4912.5 5346.7 5378.9 5413.4 5438.2 4467.2 5072.4 5153.8 5275.0 5426.0 4755.8 4778.7 4825.5 4973.9 5280.2 4716.8 5131.3 5210.9 5432.5 5483.4 4688.8 4850.5 4892.4 5230.7 5232.9 12:18:59 INFO - PROCESS | 1908 | 12:18:59 INFO - PROCESS | 1908 | [#5] yui.html Cycles:180 Average:19496.32 Median:4318.08 stddev:27851.49 (645.0%) stddev-sans-first:27893.91 12:18:59 INFO - PROCESS | 1908 | Values: 712.6 730.0 770.7 831.5 836.3 15451.2 16152.8 16158.4 16168.9 16277.9 14666.9 14687.9 14723.8 14799.7 14878.4 909.1 923.7 924.2 942.4 945.3 883.4 943.8 944.8 946.4 947.4 989.4 989.4 990.3 992.7 993.1 981.8 982.9 983.4 985.4 987.2 729.8 730.1 730.4 730.9 731.4 15747.4 15868.8 15897.0 16433.8 16711.7 11485.0 12574.5 13937.7 13986.2 14284.7 11531.5 11536.4 11581.7 11899.0 12023.9 3568.8 3579.8 3626.3 3700.5 3738.7 116388.0 117687.0 117695.0 119917.0 124204.0 10638.4 10730.2 10964.5 11119.3 11400.3 22439.4 22621.7 22677.7 23118.1 23118.8 7660.7 7720.6 7732.6 7739.0 7980.4 4278.8 4315.8 4320.3 4401.7 4511.2 3362.8 3423.7 3437.7 3468.3 3524.5 632.5 634.4 637.7 646.6 649.1 631.2 650.8 660.6 661.0 694.5 9316.5 10154.8 10231.8 10509.5 10524.7 627.6 676.9 700.5 703.3 718.7 4690.3 4955.8 4989.4 4995.3 5017.7 73070.0 95110.5 95383.0 96295.5 96784.5 55490.7 58740.7 61646.7 65904.7 75284.0 53481.5 75013.0 77574.6 78424.6 79978.0 10618.9 10681.5 10790.9 11045.7 11184.3 44546.8 46695.0 47167.5 47523.3 49513.8 62292.7 62909.0 63252.9 63298.0 63643.7 12071.3 12341.9 12577.2 12628.8 13142.6 14149.7 14156.7 14265.4 14585.6 14599.4 11488.1 13304.8 13607.6 13670.2 13676.0 12886.6 13049.2 13537.3 13542.7 13927.3 12247.5 13307.9 13352.3 13802.6 13934.2 9590.3 9610.8 9914.3 10006.6 10631.1 9014.9 9406.2 10016.9 10281.8 11358.0 12:18:59 INFO - PROCESS | 1908 | -------- Summary: end -------- 12:18:59 INFO - PROCESS | 1908 | 12:19:00 INFO - TEST-INFO | 1908: exit 0 12:19:00 INFO - TEST-OK | dromaeo_css | took 1120632ms 12:19:00 INFO - TEST-START | kraken 12:19:00 INFO - operating with platform_type : mac_ 12:19:00 INFO - Initialising browser for kraken test... 12:19:00 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpAn1rMG/profile http://localhost:49367/getInfo.html) 12:19:02 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 12:19:02 INFO - PROCESS | 1911 | colorDepth:24 12:19:02 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 12:19:02 INFO - PROCESS | 1911 | __metrics 12:19:02 INFO - PROCESS | 1911 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:19:02 INFO - PROCESS | 1911 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:19:03 INFO - TEST-INFO | 1911: exit 0 12:19:03 INFO - Browser initialized. 12:19:03 INFO - Running cycle 1/1 for kraken test... 12:19:03 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpAn1rMG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:15 INFO - PROCESS | 1912 | RSS: Main: 215175168 12:19:15 INFO - PROCESS | 1912 | 12:19:17 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-beat-detection) 12:19:18 INFO - PROCESS | 1912 | RSS: Main: 268582912 12:19:18 INFO - PROCESS | 1912 | 12:19:21 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-dft) 12:19:22 INFO - PROCESS | 1912 | RSS: Main: 280764416 12:19:22 INFO - PROCESS | 1912 | 12:19:25 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-fft) 12:19:25 INFO - PROCESS | 1912 | RSS: Main: 375263232 12:19:25 INFO - PROCESS | 1912 | 12:19:27 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-oscillator) 12:19:28 INFO - PROCESS | 1912 | RSS: Main: 278020096 12:19:28 INFO - PROCESS | 1912 | 12:19:30 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:19:31 INFO - PROCESS | 1912 | RSS: Main: 279240704 12:19:31 INFO - PROCESS | 1912 | 12:19:34 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-darkroom) 12:19:34 INFO - PROCESS | 1912 | RSS: Main: 318521344 12:19:34 INFO - PROCESS | 1912 | 12:19:37 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-desaturate) 12:19:38 INFO - PROCESS | 1912 | RSS: Main: 321294336 12:19:38 INFO - PROCESS | 1912 | 12:19:41 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49367/tests/kraken/driver.html?testName=json-parse-financial) 12:19:41 INFO - PROCESS | 1912 | RSS: Main: 319541248 12:19:41 INFO - PROCESS | 1912 | 12:19:43 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49367/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:44 INFO - PROCESS | 1912 | RSS: Main: 295088128 12:19:44 INFO - PROCESS | 1912 | 12:19:45 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:46 INFO - PROCESS | 1912 | RSS: Main: 297578496 12:19:46 INFO - PROCESS | 1912 | 12:19:48 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:49 INFO - PROCESS | 1912 | RSS: Main: 302977024 12:19:49 INFO - PROCESS | 1912 | 12:19:52 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:53 INFO - PROCESS | 1912 | RSS: Main: 317304832 12:19:53 INFO - PROCESS | 1912 | 12:19:55 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:56 INFO - PROCESS | 1912 | RSS: Main: 310595584 12:19:56 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49367/tests/kraken/driver.html?testName=ai-astar) 12:19:58 INFO - PROCESS | 1912 | RSS: Main: 355463168 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | __start_tp_report 12:19:58 INFO - PROCESS | 1912 | _x_x_mozilla_page_load 12:19:58 INFO - PROCESS | 1912 | _x_x_mozilla_page_load_details 12:19:58 INFO - PROCESS | 1912 | |i|pagename|runs| 12:19:58 INFO - PROCESS | 1912 | |0;ai-astar;116;116;117;116;116;116;116;115;117;116 12:19:58 INFO - PROCESS | 1912 | |1;audio-beat-detection;149;110;109;145;111;109;109;108;131;109 12:19:58 INFO - PROCESS | 1912 | |2;audio-dft;188;183;186;187;185;183;185;183;187;186 12:19:58 INFO - PROCESS | 1912 | |3;audio-fft;83;62;74;116;82;73;60;61;77;59 12:19:58 INFO - PROCESS | 1912 | |4;audio-oscillator;90;70;87;69;73;93;92;67;68;83 12:19:58 INFO - PROCESS | 1912 | |5;imaging-gaussian-blur;90;89;90;90;90;88;89;89;90;105 12:19:58 INFO - PROCESS | 1912 | |6;imaging-darkroom;96;96;96;98;96;96;96;99;95;96 12:19:58 INFO - PROCESS | 1912 | |7;imaging-desaturate;88;87;84;87;86;86;87;87;84;88 12:19:58 INFO - PROCESS | 1912 | |8;json-parse-financial;61;61;60;60;62;64;64;66;63;63 12:19:58 INFO - PROCESS | 1912 | |9;json-stringify-tinderbox;59;60;54;64;59;57;58;57;58;57 12:19:58 INFO - PROCESS | 1912 | |10;stanford-crypto-aes;91;83;83;86;83;85;82;82;82;89 12:19:58 INFO - PROCESS | 1912 | |11;stanford-crypto-ccm;139;139;127;137;141;146;135;156;176;153 12:19:58 INFO - PROCESS | 1912 | |12;stanford-crypto-pbkdf2;165;165;165;164;157;153;166;163;166;165 12:19:58 INFO - PROCESS | 1912 | |13;stanford-crypto-sha256-iterative;66;66;65;65;66;67;65;67;63;63 12:19:58 INFO - PROCESS | 1912 | __end_tp_report 12:19:58 INFO - PROCESS | 1912 | __start_cc_report 12:19:58 INFO - PROCESS | 1912 | _x_x_mozilla_cycle_collect,2162 12:19:58 INFO - PROCESS | 1912 | __end_cc_report 12:19:58 INFO - PROCESS | 1912 | __startTimestamp1490815198507__endTimestamp 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | ------- Summary: start ------- 12:19:58 INFO - PROCESS | 1912 | Number of tests: 14 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#0] ai-astar Cycles:10 Average:116.10 Median:116.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:19:58 INFO - PROCESS | 1912 | Values: 116.0 116.0 117.0 116.0 116.0 116.0 116.0 115.0 117.0 116.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:110.50 stddev:16.28 (14.7%) stddev-sans-first:13.16 12:19:58 INFO - PROCESS | 1912 | Values: 149.0 110.0 109.0 145.0 111.0 109.0 109.0 108.0 131.0 109.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#2] audio-dft Cycles:10 Average:185.30 Median:186.00 stddev:1.83 (1.0%) stddev-sans-first:1.66 12:19:58 INFO - PROCESS | 1912 | Values: 188.0 183.0 186.0 187.0 185.0 183.0 185.0 183.0 187.0 186.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#3] audio-fft Cycles:10 Average:74.70 Median:73.50 stddev:17.15 (23.3%) stddev-sans-first:17.93 12:19:58 INFO - PROCESS | 1912 | Values: 83.0 62.0 74.0 116.0 82.0 73.0 60.0 61.0 77.0 59.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:85.00 stddev:10.79 (12.7%) stddev-sans-first:10.71 12:19:58 INFO - PROCESS | 1912 | Values: 90.0 70.0 87.0 69.0 73.0 93.0 92.0 67.0 68.0 83.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:90.00 stddev:4.97 (5.5%) stddev-sans-first:5.25 12:19:58 INFO - PROCESS | 1912 | Values: 90.0 89.0 90.0 90.0 90.0 88.0 89.0 89.0 90.0 105.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:1.17 (1.2%) stddev-sans-first:1.24 12:19:58 INFO - PROCESS | 1912 | Values: 96.0 96.0 96.0 98.0 96.0 96.0 96.0 99.0 95.0 96.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.39 12:19:58 INFO - PROCESS | 1912 | Values: 88.0 87.0 84.0 87.0 86.0 86.0 87.0 87.0 84.0 88.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.96 (3.1%) stddev-sans-first:2.01 12:19:58 INFO - PROCESS | 1912 | Values: 61.0 61.0 60.0 60.0 62.0 64.0 64.0 66.0 63.0 63.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.50 stddev:2.58 (4.4%) stddev-sans-first:2.73 12:19:58 INFO - PROCESS | 1912 | Values: 59.0 60.0 54.0 64.0 59.0 57.0 58.0 57.0 58.0 57.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.17 (3.8%) stddev-sans-first:2.37 12:19:58 INFO - PROCESS | 1912 | Values: 91.0 83.0 83.0 86.0 83.0 85.0 82.0 82.0 82.0 89.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:143.50 stddev:13.84 (9.6%) stddev-sans-first:14.51 12:19:58 INFO - PROCESS | 1912 | Values: 139.0 139.0 127.0 137.0 141.0 146.0 135.0 156.0 176.0 153.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:165.00 stddev:4.36 (2.6%) stddev-sans-first:4.56 12:19:58 INFO - PROCESS | 1912 | Values: 165.0 165.0 165.0 164.0 157.0 153.0 166.0 163.0 166.0 165.0 12:19:58 INFO - PROCESS | 1912 | 12:19:58 INFO - PROCESS | 1912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 12:19:58 INFO - PROCESS | 1912 | Values: 66.0 66.0 65.0 65.0 66.0 67.0 65.0 67.0 63.0 63.0 12:19:58 INFO - PROCESS | 1912 | -------- Summary: end -------- 12:19:58 INFO - PROCESS | 1912 | 12:19:59 INFO - TEST-INFO | 1912: exit 0 12:19:59 INFO - TEST-OK | kraken | took 59395ms 12:19:59 INFO - SUITE-END | took 1180s 12:19:59 INFO - Completed test suite (00:19:40) 12:19:59 INFO - javascript benchmark 12:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7588.131190574961, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.238236632024, 3295.0, 3343.1642089477623, 3359.7480188985824, 3400.5409269748593, 5856.765729370825, 5882.970585147079, 5885.588008839383, 5908.261467316585, 5922.407759224076, 5900.262467191601, 5926.970365148179, 5944.791932282371, 5985.311689155748, 6009.849753756158, 4641.744704041276, 5358.33020872391, 5369.704666243355, 5385.299911011563, 5415.079436495806, 5298.549623282026, 5315.282436871031, 5327.520523152915, 5503.532199763025, 5505.0, 5353.411124776291, 5380.24676545284, 5385.892282154355, 5387.0841956867425, 5395.271638328834, 5373.973130134344, 5398.865028374283, 5401.945980540184, 5402.0, 5412.161115027177, 5236.162214045772, 5346.91979620306, 5349.598780091509, 5351.2240725095035, 5385.434529374437, 5946.137810017566, 5963.344032156459, 5974.014287642533, 5978.491828194608, 5985.16207730918, 5268.262443257909, 6331.620102793801, 6342.429181373698, 6343.365663433666, 6347.8413039673915, 6299.992001279819, 6304.653244071575, 6307.369263073701, 6353.872922541524, 6393.93606063938, 6036.396360363972, 6084.574079814415, 6085.117657939574, 6089.391060893875, 6095.725692343855, 6278.497720182374, 6574.967125164344, 6589.769358072444, 6591.209054913441, 6606.570572912745, 5324.973375133177, 6252.343503932022, 6259.2488901332135, 6302.873942521124, 6367.363263673596, 6408.391202835724, 6418.326075762071, 6421.325760795143, 6430.260520040161, 6433.195850518685, 6241.157443745127, 6307.274663413675, 6318.842028949313, 6319.557630965788, 6325.588836725598, 6111.873644844951, 6213.1922850029205, 6259.812205633838, 6318.557700960981, 6345.17512723343, 5112.335396398445, 5146.099432599281, 5168.01807656544, 5198.402183748842, 5203.739813009334, 4558.0, 4561.589456948825, 4567.040921406476, 4574.313852922089, 4599.448066232074, 5801.361850196475, 5931.673757943268, 5967.403259674084, 6128.050152226412, 6133.570650054453, 6311.211098612674, 6339.4611458025665, 6385.233771947396, 6390.808275751735, 6403.359664033653, 6086.817395478142, 6128.1726966858905, 6141.416565426277, 6142.692865356804, 6152.938470615326, 5491.945080549143, 5539.612227144142, 5685.829425117253, 5689.601727879091, 5715.657060576379, 6307.4954003679595, 6539.542232043711, 6556.082148499309, 6650.73397064112, 6658.400743933069, 6409.0, 6418.807435776934, 6424.261209960728, 6427.871442571029, 6429.132067170872, 6518.934810651833, 6574.309697481695, 6603.636799976048, 6603.9009414859775, 6609.20689517261, 6233.844153896189, 6293.96853015732, 6333.081703153109, 6338.58799178052, 6354.364563543609, 6323.114763932961, 6336.58812177207, 6339.841503962438, 6342.460890824332, 6345.587536810092, 6250.718717657625, 6290.433860952537, 6294.402031806971, 6325.177726895658, 6345.17512723343, 6306.968465157828, 6331.493480521455, 6339.461145802474, 6343.714532846126, 6352.301246862934, 6255.311915689362, 6262.34245404226, 6265.467435268053, 6280.811575652738, 6282.528810339334, 5156.226566015128, 5367.5169234769055, 6202.968985155046, 6226.221722284715, 6282.968585157045, 6224.875502489835, 6246.375362463899, 6249.125122482947, 6252.374762523711, 6253.843653908507], "value": 5865.017030406655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.2285160542668, 805.9637316320765, 874.5933141089396, 886.6940905387639, 888.3159966825541, 38763.83708488746, 39124.60875391245, 39505.60494395055, 39725.40411893817, 39781.0, 40854.59145408545, 41101.79449102758, 41125.0, 41217.0, 41307.967300817494, 7229.530080544774, 8912.331575131859, 9063.637454501812, 9067.141236046595, 9075.682351117712, 7360.889586656204, 10708.25042247043, 10901.073408760265, 10970.945145274263, 10981.560737570488, 9315.347925645208, 10865.239433239676, 10877.945610271938, 10879.83680244797, 10886.183536234774, 9202.861957070583, 10785.892141078568, 10838.945805271002, 10847.728806779814, 10865.83701244482, 7170.28297170284, 7337.559746415232, 10451.947740261327, 10703.250772445854, 10755.085817705505, 38480.23039539193, 38701.80649096765, 38765.03087422837, 38771.03072423184, 38796.806015970025, 3776.339140650375, 3778.3199024175638, 3814.4850445189822, 3835.0795809005917, 3865.9226815463535, 26383.868080659668, 26497.602535961974, 27411.725882741317, 27672.03147889814, 28558.428831423254, 3086.1667349815425, 3087.367089746597, 3093.443180227558, 3102.10039088664, 3127.6090488688915, 355749.0, 356083.0, 356634.0, 356669.0, 356736.0, 41806.79096604497, 42695.35956960648, 52498.73750631222, 52568.0, 52811.20783188255, 52266.0, 53199.468005320225, 55591.0, 55702.72148639231, 55927.72036139793, 14523.273836308143, 14591.635209119644, 14618.780718289234, 14627.122372657675, 14643.828493720477, 12600.054995875345, 12603.243805371707, 12606.0, 12615.49538018469, 12645.873541264653, 11734.413279335999, 11939.701507462209, 11982.221155624857, 11988.700282493008, 12160.209586376857, 5501.229827824108, 5516.779328826802, 5519.668819870821, 5521.779128834802, 5580.074874168406, 882.3779235638859, 925.3476299209042, 954.2652157838426, 961.9086186812242, 988.6786794291884, 26966.73033269642, 28310.0, 28320.858395707888, 28630.856845716055, 28944.565831512544, 1046.4349251404308, 1053.7997780421695, 1057.6245432871374, 1074.0977578833817, 1078.3691540448926, 14250.786238206436, 14383.208923509308, 14521.983461157617, 14638.560843174722, 14818.777718334233, 444166.0, 445236.0, 445362.0, 445362.0, 445799.0, 55533.44466555364, 55610.887782244936, 55744.72127639336, 55753.0, 55961.720191399596, 1431.0912570517587, 1463.1586837568227, 1468.067776961637, 1475.42458441208, 1479.5413421839264, 25993.6100958482, 27278.318042049108, 27476.0, 27832.86083569569, 27934.0, 45301.09397811959, 45391.773041134584, 45507.0, 45507.77246113748, 45552.544474556154, 393370.0, 396028.0397195991, 427537.0, 428240.0, 428323.0, 23998.640020400057, 27076.593851092643, 27908.720912790614, 33644.158896027795, 33797.493037604945, 40634.593654064265, 42742.57257427386, 42910.71267861969, 43454.0, 43933.0, 29342.266443339086, 29830.70169298279, 30747.0, 30965.380692386476, 31057.689423106385, 29538.409231814814, 29649.407011860072, 29898.252543686584, 30474.84762576173, 30659.54010689886, 35806.46290305595, 36093.0, 36363.81818090893, 36511.817440913685, 36568.817155914054, 20722.585548288647, 25782.871085644452, 27971.601419929328, 28190.295242619097, 29929.0, 19139.712904306725, 23717.525649486568, 24003.27990160298, 24100.87949560241, 25059.99760009652], "value": 18415.268599856772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.1965671232194, 402.117352411457, 425.82966813274686, 426.4243271583362, 449.4180036852276, 12537.435815388306, 14354.210518421483, 20556.0, 21092.472688182803, 21283.467913302175, 21643.891780541115, 21669.45826354342, 22188.334349969486, 22403.32790016298, 22665.98003089861, 6267.529935254863, 6271.843203919916, 6493.70778314977, 6554.41010309072, 6582.8683426331445, 3961.77185072627, 4098.385242213662, 6421.903671444932, 6486.513511486633, 6487.481001519891, 4138.234426631083, 7442.925570744304, 7461.515001524884, 7461.515001524911, 7466.813329666747, 7347.8163045924275, 7372.889406658905, 7452.956586077953, 7456.217097204824, 7468.178500364956, 6945.236024037352, 6994.440444764457, 7172.46206534512, 7202.783916482514, 7214.134303883515, 22003.449913752123, 27222.863885680643, 27373.04194353208, 27732.8906843726, 27733.445331093466, 2912.053582585647, 2914.402547477762, 2920.4597149527403, 2932.912012639624, 2944.6319210098736, 14004.789928151085, 15731.921340393224, 16325.346986120541, 16918.407855725112, 17045.31818727262, 1970.5265668319503, 2048.8565800393976, 2056.074766355131, 2081.3131666550003, 2088.0186312433134, 143142.0, 143380.0, 144082.99999999895, 144229.27885360506, 146377.26811365876, 16947.745783813254, 21646.86120512517, 22009.33971980843, 22078.896055197496, 22231.77768222297, 35017.824910875795, 35299.29401411957, 35588.82205589007, 35706.0, 35786.46320305197, 10395.896041039645, 10421.270511064304, 10431.321964072311, 10766.838497422545, 10846.566137354575, 7206.603636799921, 8500.914990850137, 8568.614412351459, 8612.09572994839, 8695.956520217485, 10114.735658042744, 10221.080102790784, 10252.333598316234, 10411.323263987817, 10417.47912604382, 3574.7140228781636, 3722.1253005543676, 4072.9796351018053, 4162.7502349859105, 4174.457320548309, 991.1921783746224, 1037.7405648587853, 1038.2350004991545, 1059.782744537368, 1103.9282446640943, 20856.478588035116, 22105.036913372238, 22415.663765043537, 22442.0, 22482.100715971505, 987.6888780034266, 1051.9684409467727, 1063.9787204255872, 1076.4779082145153, 1094.731790711265, 9189.77025574366, 11678.824817627743, 11688.47401866918, 11788.0, 11809.645710628694, 745536.0, 747665.0, 755316.0, 759501.0, 777109.0, 135258.0, 137762.31118844342, 141781.0, 144441.0, 150929.0, 1187.2045729361348, 1211.7455334379704, 1301.069735139361, 1301.8828305452555, 1305.6083175047447, 19144.521386965436, 19385.0, 19754.0, 19759.209631614576, 19843.702344464557, 46715.0, 51855.18506852242, 63305.68347158235, 63726.0, 64229.0, 94933.0, 95423.0, 95475.52262238644, 98523.01476985139, 98537.0, 11261.324320540794, 11418.486168122621, 11477.713057173303, 11517.366544840113, 11859.229150105215, 12553.309567973849, 12690.969444889142, 12943.676408089874, 13054.673633159247, 13265.86734132685, 10898.618548350769, 11125.666230013112, 11197.888021119685, 11212.439378030902, 11295.435228238392, 9923.900760992587, 10138.746531336481, 10240.334378265388, 10253.58985640566, 10445.634402795866, 11220.438978051228, 11307.547698092314, 11319.717007074889, 11371.374574398156, 11563.42182890869, 10835.349879007284, 11197.384143872165, 11378.203525753117, 11544.769104618028, 11778.115501519716, 9960.55177516999, 11193.0, 11231.831522527005, 11290.774184516427, 11501.252418592765], "value": 11585.506109836797, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.5160045584498, 1512.8033355663765, 1525.5804653720234, 1567.6942996115754, 1590.6500569874627, 10562.366258024524, 11111.333320000806, 11129.83305250421, 11154.163437742161, 11156.776864462707, 10568.471576421187, 10941.56233750651, 11137.443127843617, 11151.330920144797, 11178.0, 2311.560803447348, 2350.894209760565, 2351.459164392191, 2353.0, 2358.481134150484, 2274.9658755118685, 2319.211468100845, 2413.78275955164, 2416.4200591857916, 2416.66166736657, 2325.546518428907, 2383.880805959695, 2386.7732565406345, 2409.8072154227707, 2418.056957786465, 2337.976620233793, 2384.332386931662, 2385.666006759055, 2391.366287933699, 2398.2445529658103, 2338.3101984914492, 2362.5511152881068, 2366.857988520677, 2369.0, 2371.8102551795987, 10598.364098154136, 10806.51370688321, 10812.29720068201, 10824.945875270652, 10825.24223304369, 5763.538916886681, 5944.643321400687, 5959.761609535613, 5961.940380596182, 5971.910421343683, 3474.9131271718156, 3614.981925090358, 3653.963460365389, 3689.9262014759825, 3705.7961812100325, 1078.8941335131474, 1185.869554349021, 1229.0536287059003, 1231.7043909461665, 1239.9318037507933, 13612.0, 14037.298135093306, 14263.358148883326, 15246.618834529114, 15451.381944722198, 3306.7685262031428, 4224.66202703783, 4327.675424343187, 4340.131973605228, 4355.8457008892665, 9627.614895404105, 10394.064534191959, 11437.942810285895, 11510.136739744552, 11514.827277590843, 5571.164325351148, 5572.972135139379, 5573.777048918079, 5574.136008918624, 5579.972100139555, 5239.790408383622, 5249.658772179796, 5275.235090911873, 5309.628326017141, 5321.2018197269945, 3201.3437245364644, 3814.2562200371217, 3867.651911327994, 3913.412988051815, 3920.2355540669296, 1028.0901402259055, 1028.8919663435381, 1032.6437379104198, 1047.1256500821746, 1048.2295512798087, 751.2037240525061, 768.8539177556246, 785.8546168958646, 787.3111027850631, 796.1839114907151, 5502.504774570228, 6383.904241436382, 6417.06952491886, 6427.164468619049, 6490.902636460457, 888.2228050455851, 1020.3673722292078, 1022.0903395977438, 1039.101177481473, 1065.3714308557987, 4241.660667146621, 4421.513633500313, 4561.133384656904, 4680.95319046812, 4717.551832575899, 12926.095173337777, 13247.470101196037, 13448.731025379439, 13913.652158696113, 13993.650158746113, 11543.018843398237, 12347.13570050088, 12845.614631561068, 13304.600861974157, 13324.40040198174, 8027.638756255866, 10241.74395640115, 10244.231682623833, 10251.538680759384, 10254.846177307347, 5487.396386397413, 6570.244421891352, 6719.798406047827, 6736.157980252468, 6950.235474097744, 11743.941280293544, 11794.46924888365, 11899.702507437383, 12034.157608967289, 12056.819147712968, 12081.973032292002, 12110.878891211327, 12148.635540933787, 12242.571509997108, 12338.81491777606, 9942.105210531086, 10280.845787313046, 10312.639057632947, 10330.173586113244, 10337.534810933677, 9311.534423278674, 9385.812283754423, 9431.764205894908, 9477.478738669439, 10272.383656980604, 7891.802704932193, 8046.718364857202, 8139.593020348841, 8164.1019487857475, 8274.462159959583, 7454.850902982019, 7810.492317999312, 7898.052233731989, 7945.1657575953695, 8130.186981301823, 7210.819729506804, 7361.668724907499, 7384.52000619958, 7389.261073892568, 7390.556566606021, 5293.550048245942, 5510.421405752499, 5571.804986825442, 5655.830325090254, 5697.857553561194, 5501.669899806025, 5527.50252477279, 5601.24383208278, 5659.236003139524, 5708.80019199326], "value": 4995.487307879132, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.9431238158085, 377.24174409437023, 379.49527128918544, 384.12611309271404, 386.08690447092624, 4495.910081798362, 4582.74794886282, 4765.499622539635, 5104.234364845275, 5127.7436128193585, 4522.525134860842, 4790.520947905216, 4933.679310844793, 4999.8000079996755, 5024.623153263502, 3593.4070878305047, 3617.8371973261264, 3628.8367023483875, 3935.9803200983956, 4247.596478334569, 3719.628037196272, 3931.6461518463334, 4095.4061661059127, 4225.112726327475, 4247.235497610429, 4058.5592114799265, 4062.7092055435046, 4212.4945006599255, 4275.315949448089, 4276.786160691969, 3378.2736711606876, 4041.8278699177204, 4282.850100246507, 4283.250431174548, 4307.353896915472, 3308.3217940322174, 3444.9655503444897, 3826.0, 3886.844526218948, 3897.4215442745735, 4480.417545719069, 4730.550597693214, 4770.1175282572485, 4943.851684449436, 4985.800567977277, 4017.979910100431, 4654.860649896481, 4763.7141771493825, 4808.519148085164, 4898.926516102261, 4497.168023915586, 4970.353853998993, 5216.739163041871, 5311.123664595337, 5401.432849550819, 3383.6954674079207, 4140.4617399737845, 4287.678424118172, 4296.613304802583, 4375.496817865955, 5281.920771188396, 5486.478784515464, 5606.7388784524055, 5632.52123569493, 5811.941880581182, 3509.5613048368955, 3896.201278737852, 3923.431102490123, 4163.854265100767, 4287.627959053136, 4436.556344365537, 4452.395348721035, 4467.508574056851, 4482.282834746425, 4492.9550704493195, 4195.538490766014, 4814.855554333376, 4844.231855372764, 4856.9314750754775, 4900.460949295574, 4934.827281045146, 5398.406175320712, 5413.783448662089, 5465.863353416196, 5487.07952216721, 1330.9020058451815, 1482.3249727807508, 1484.5768955847532, 1493.1414436698942, 1493.5587158392204, 1081.6538707613645, 1139.9886001139882, 1141.3380239461092, 1142.7771584540935, 1157.5948418053613, 4391.8682439526865, 5007.649464537448, 5059.016868384638, 5066.974665126724, 5068.341115655015, 4691.319758634979, 5051.797928082909, 5592.356878958891, 5593.636413633101, 5628.437156284421, 4183.2430379240795, 4192.748435093904, 4736.360591320196, 4826.831060912851, 5037.79848806051, 2458.868920296648, 2656.4023094803515, 2879.3665393613373, 2917.8395188264426, 2939.76481881449, 5486.259354987105, 5842.883142337215, 5872.29532456108, 5913.615614985012, 5913.852153696106, 5194.376674798973, 5319.601029922771, 5364.30264065669, 5370.516653501204, 5385.919211211835, 4773.498782627774, 5140.820071297487, 5627.902559000955, 5634.549236061023, 5700.515456186271, 4691.481388958281, 4800.879978000578, 4968.304437378698, 5315.747402078399, 5425.294711687456, 4986.775595098156, 5389.622726409114, 5443.475826768511, 5494.2857428535635, 5534.501894829485, 4877.975610122068, 5369.322014420135, 5375.623706340519, 5736.5410767139365, 5749.9712501437225, 3828.679105708526, 4078.857239996586, 4211.852585159505, 4344.3700663403, 4364.581511008998, 4844.346013288161, 4866.491387669692, 5034.798608055637, 5038.748062596929, 5579.414161512983, 4912.533309335608, 5346.652467589594, 5378.892422151614, 5413.431589683027, 5438.18427235902, 4467.2182368086105, 5072.391313042459, 5153.819616313411, 5275.024120537712, 5425.972870135624, 4755.785989630405, 4778.713277203379, 4825.541573550507, 4973.875653108701, 5280.207968804556, 4716.7500612338445, 5131.25596788471, 5210.921836172536, 5432.538234250133, 5483.369412517452, 4688.812447502198, 4850.5149485052625, 4892.3884514435695, 5230.712310822942, 5232.947670523398], "value": 4077.3931861971605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.6009434716556, 730.0254160695471, 770.7379490973068, 831.5343407691691, 836.3100442135238, 15451.150186739726, 16152.83847161528, 16158.353665853367, 16168.949018313817, 16277.918610406932, 14666.926665366658, 14687.92656036721, 14723.779143312859, 14799.704005919903, 14878.404863805461, 909.122696597783, 923.7321176858703, 924.2190349154953, 942.4109931292942, 945.3146468810127, 883.4478450968145, 943.7640589852537, 944.84882418813, 946.3943076431055, 947.3984020147187, 989.3915242126112, 989.4459102902398, 990.2968892086627, 992.6525715999378, 993.1260490768113, 981.8232718110737, 982.9410235385828, 983.3608154699431, 985.4186030242156, 987.2299606307092, 729.7810656802938, 730.1311439387113, 730.4229658569724, 730.8611363840853, 731.4477569435043, 15747.448839290684, 15868.761968570481, 15897.0, 16433.83566164335, 16711.749323760152, 11484.964174477996, 12574.497020119185, 13937.721245575032, 13986.16083035021, 14284.714305713931, 11531.48108335127, 11536.365499897502, 11581.710457238552, 11899.048076153887, 12023.93988030063, 3568.80371579563, 3579.826239438864, 3626.256617393428, 3700.5189325387796, 3738.738288319819, 116388.0, 117687.0, 117695.0, 119917.0, 124204.0, 10638.414887181125, 10730.19523535738, 10964.451777411097, 11119.332840029625, 11400.258983166068, 22439.43901402478, 22621.660675089886, 22677.659835102488, 23118.075276989068, 23118.76881231166, 7660.693572257047, 7720.613969301512, 7732.57470839098, 7739.0, 7980.441369104107, 4278.7860606969525, 4315.8489452869, 4320.308750599952, 4401.6698747594055, 4511.187986162457, 3362.81504517249, 3423.7089847362754, 3437.6906078452557, 3468.3063387322636, 3524.5241892344206, 632.5256057956533, 634.4226753654244, 637.6652257564723, 646.5668002438377, 649.1107183159008, 631.233051842005, 650.8015055408146, 660.5838321857199, 660.9622892059516, 694.5346617766108, 9316.534173291308, 10154.796904062025, 10231.795364092824, 10509.527071281811, 10524.684259472227, 627.5638431290209, 676.9169329073443, 700.5411455496658, 703.3353480960545, 718.7017387784011, 4690.273007683814, 4955.8017679292425, 4989.426215985136, 4995.325631039763, 5017.7491125443585, 73070.0, 95110.52444737732, 95383.0, 96295.51852240694, 96784.51607742057, 55490.72254638701, 58740.70629646824, 61646.691766540884, 65904.67047664731, 75284.0, 53481.465185348425, 75013.0, 77574.612126939, 78424.60787696025, 79978.0, 10618.885017073097, 10681.465926703479, 10790.860984623834, 11045.723856903642, 11184.273022253528, 44546.77726611346, 46695.0, 47167.52832471632, 47523.28715069208, 49513.75243123761, 62292.68853655703, 62909.0, 63252.939764819625, 63298.0, 63643.68178159265, 12071.275723456622, 12341.876581234073, 12577.245365278113, 12628.810567841674, 13142.60572182836, 14149.746192893614, 14156.716865662424, 14265.358058887168, 14585.562433127023, 14599.416023359372, 11488.138389620979, 13304.825840148778, 13607.591772246848, 13670.17978921268, 13676.0, 12886.613401597968, 13049.151805133015, 13537.323133843465, 13542.729145417234, 13927.303634818016, 12247.510099595916, 13307.933460332637, 13352.265625390697, 13802.585922422344, 13934.233617151154, 9590.328676992543, 9610.807783844424, 9914.314616101747, 10006.599736010769, 10631.096356809758, 9014.90985090167, 9406.200472959876, 10016.949915250378, 10281.845772313272, 11358.034567061562], "value": 7489.331284693649, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 115.0, 117.0, 116.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 109.0, 145.0, 111.0, 109.0, 109.0, 108.0, 131.0, 109.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 186.0, 187.0, 185.0, 183.0, 185.0, 183.0, 187.0, 186.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 74.0, 116.0, 82.0, 73.0, 60.0, 61.0, 77.0, 59.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 87.0, 69.0, 73.0, 93.0, 92.0, 67.0, 68.0, 83.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 90.0, 90.0, 88.0, 89.0, 89.0, 90.0, 105.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 99.0, 95.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 84.0, 87.0, 86.0, 86.0, 87.0, 87.0, 84.0, 88.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 62.0, 64.0, 64.0, 66.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 54.0, 64.0, 59.0, 57.0, 58.0, 57.0, 58.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 83.0, 83.0, 86.0, 83.0, 85.0, 82.0, 82.0, 82.0, 89.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 127.0, 137.0, 141.0, 146.0, 135.0, 156.0, 176.0, 153.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 164.0, 157.0, 153.0, 166.0, 163.0, 166.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 67.0, 65.0, 67.0, 63.0, 63.0], "value": 65.3, "unit": "score"}]}]} 12:19:59 INFO - Return code: 0 12:19:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:59 ERROR - # TBPL SUCCESS # 12:19:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:59 INFO - 2017-03-29 12:19:59.833 screenresolution[1916:15950] starting screenresolution argv=screenresolution get 12:19:59 INFO - 2017-03-29 12:19:59.835 screenresolution[1916:15950] Display 0: 1600x1200x32@60 12:19:59 INFO - 2017-03-29 12:19:59.842 screenresolution[1917:15953] starting screenresolution argv=screenresolution list 12:19:59 INFO - Available Modes on Display 0 12:19:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:20:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:20:00 INFO - Intel Iris: 12:20:00 INFO - Chipset Model: Intel Iris 12:20:00 INFO - Type: GPU 12:20:00 INFO - Bus: Built-In 12:20:00 INFO - VRAM (Dynamic, Max): 1536 MB 12:20:00 INFO - Vendor: Intel (0x8086) 12:20:00 INFO - Device ID: 0x0a2e 12:20:00 INFO - Revision ID: 0x0009 12:20:00 INFO - Displays: 12:20:00 INFO - Display: 12:20:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:20:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:20:00 INFO - Display Serial Number: 1600x1200 60 12:20:00 INFO - Main Display: Yes 12:20:00 INFO - Mirror: Off 12:20:00 INFO - Online: Yes 12:20:00 INFO - Rotation: Supported 12:20:00 INFO - Return code: 0 12:20:00 INFO - Running post-action listener: _resource_record_post_action 12:20:00 INFO - [mozharness: 2017-03-29 19:20:00.083093Z] Finished run-tests step (success) 12:20:00 INFO - Running post-run listener: _resource_record_post_run 12:20:00 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 1232896; Write bytes: 509350912; Read time: 16; Write time: 1568 12:20:00 INFO - TinderboxPrint: CPU usage
54.0% 12:20:00 INFO - TinderboxPrint: I/O read bytes / time
1,232,896 / 16 12:20:00 INFO - TinderboxPrint: I/O write bytes / time
509,350,912 / 1,568 12:20:00 INFO - TinderboxPrint: CPU idle
2,212.3 (46.0%) 12:20:00 INFO - TinderboxPrint: CPU system
960.6 (20.0%) 12:20:00 INFO - TinderboxPrint: CPU user
1,632.8 (34.0%) 12:20:00 INFO - TinderboxPrint: Swap in / out
209,956,864 / 0 12:20:00 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203491840; Write bytes: 199204864; Read time: 15687; Write time: 360 12:20:00 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1232896; Write bytes: 296348672; Read time: 16; Write time: 1109 12:20:00 INFO - Running post-run listener: _upload_blobber_files 12:20:00 INFO - Blob upload gear active. 12:20:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:20:00 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 12:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:20:00 INFO - (blobuploader) - INFO - Open directory for files ... 12:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:02 INFO - (blobuploader) - INFO - Done attempting. 12:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:03 INFO - (blobuploader) - INFO - Done attempting. 12:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:04 INFO - (blobuploader) - INFO - Done attempting. 12:20:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:20:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:20:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:20:06 INFO - (blobuploader) - INFO - Done attempting. 12:20:06 INFO - (blobuploader) - INFO - Iteration through files over. 12:20:06 INFO - Return code: 0 12:20:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:20:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:20:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c972ae5dd0a610ba20786ac16bc244cd7c5b4c238c593fdb330bdb1727f86791c4f715872843f6b1146b2ba798db5f147fda91e88276734e65de77ed10030952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d040f0538e71903c1043f0ea8072f2b4feb769d96f0fd0a62f8d0d3b02313b129d74801544a4ae7d47c7a568e1ca2aa9a0400de71669bfa0711a94e9ddbe7dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b14dbb91853edc04c6a9952635965061afb153dff20a5a372860bd8e823493ee6c3f2f9d08130cebf2d4357c7ec2e77f0409a073ba3b8aaf852071e0efe7fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46500eede9c47e552dc4001b14e089d6d723019c27689224adaa7c45b9bcc0f870d1029b8a642a3e6d32107e1f278dd90fe1d6e3d52076deef0e15ae4c18e327"} 12:20:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:20:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:20:06 INFO - Contents: 12:20:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c972ae5dd0a610ba20786ac16bc244cd7c5b4c238c593fdb330bdb1727f86791c4f715872843f6b1146b2ba798db5f147fda91e88276734e65de77ed10030952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d040f0538e71903c1043f0ea8072f2b4feb769d96f0fd0a62f8d0d3b02313b129d74801544a4ae7d47c7a568e1ca2aa9a0400de71669bfa0711a94e9ddbe7dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b14dbb91853edc04c6a9952635965061afb153dff20a5a372860bd8e823493ee6c3f2f9d08130cebf2d4357c7ec2e77f0409a073ba3b8aaf852071e0efe7fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46500eede9c47e552dc4001b14e089d6d723019c27689224adaa7c45b9bcc0f870d1029b8a642a3e6d32107e1f278dd90fe1d6e3d52076deef0e15ae4c18e327"} 12:20:06 INFO - Running post-run listener: copy_logs_to_upload_dir 12:20:06 INFO - Copying logs to upload dir... 12:20:06 INFO - mkdir: /builds/slave/test/build/upload/logs 12:20:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.274960 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-29 12:20:06.607531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:20:06.611286) ========= 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.8adPaKISJv/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.BUt3uRTAmJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c972ae5dd0a610ba20786ac16bc244cd7c5b4c238c593fdb330bdb1727f86791c4f715872843f6b1146b2ba798db5f147fda91e88276734e65de77ed10030952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d040f0538e71903c1043f0ea8072f2b4feb769d96f0fd0a62f8d0d3b02313b129d74801544a4ae7d47c7a568e1ca2aa9a0400de71669bfa0711a94e9ddbe7dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b14dbb91853edc04c6a9952635965061afb153dff20a5a372860bd8e823493ee6c3f2f9d08130cebf2d4357c7ec2e77f0409a073ba3b8aaf852071e0efe7fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46500eede9c47e552dc4001b14e089d6d723019c27689224adaa7c45b9bcc0f870d1029b8a642a3e6d32107e1f278dd90fe1d6e3d52076deef0e15ae4c18e327"} build_url:https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/YiBKTuY2RiiNrkrikExa1g/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c972ae5dd0a610ba20786ac16bc244cd7c5b4c238c593fdb330bdb1727f86791c4f715872843f6b1146b2ba798db5f147fda91e88276734e65de77ed10030952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d040f0538e71903c1043f0ea8072f2b4feb769d96f0fd0a62f8d0d3b02313b129d74801544a4ae7d47c7a568e1ca2aa9a0400de71669bfa0711a94e9ddbe7dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b14dbb91853edc04c6a9952635965061afb153dff20a5a372860bd8e823493ee6c3f2f9d08130cebf2d4357c7ec2e77f0409a073ba3b8aaf852071e0efe7fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46500eede9c47e552dc4001b14e089d6d723019c27689224adaa7c45b9bcc0f870d1029b8a642a3e6d32107e1f278dd90fe1d6e3d52076deef0e15ae4c18e327"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:20:06.647550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:20:06.648025) ========= 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.8adPaKISJv/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.BUt3uRTAmJ/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.005104 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:20:06.697739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:20:06.698081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:20:06.698474) ========= ========= Total master_lag: 0.50 =========