builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0338 starttime: 1488977080.76 results: success (0) buildid: 20170308030207 builduid: 863c07f17b854228a4ae277e8f0d2acb revision: 58753259bfeb3b818eac7870871b0aae1f8de64a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:40.762122) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:40.762536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:40.762809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:40.791076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:40.791455) ========= 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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-08 04:44:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-03-08 04:44:40 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139358 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:40.954666) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:40.955274) ========= 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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.038918 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:41.017775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 04:44:41.018136) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 58753259bfeb3b818eac7870871b0aae1f8de64a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 58753259bfeb3b818eac7870871b0aae1f8de64a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6cGWEbcKXc/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.gvXSP0QjZC/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-08 04:44:41,124 truncating revision to first 12 chars 2017-03-08 04:44:41,124 Setting DEBUG logging. 2017-03-08 04:44:41,125 attempt 1/10 2017-03-08 04:44:41,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/58753259bfeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 04:44:42,290 unpacking tar archive at: mozilla-central-58753259bfeb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.441925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 04:44:42.483942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:42.484265) ========= script_repo_revision: 58753259bfeb3b818eac7870871b0aae1f8de64a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:42.484657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:42.484918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 04:44:42.505023) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-08 04:44:42.505418) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6cGWEbcKXc/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.gvXSP0QjZC/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:44:42 INFO - MultiFileLogger online at 20170308 04:44:42 in /builds/slave/test 04:44:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:44:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:42 INFO - {'append_to_log': False, 04:44:42 INFO - 'base_work_dir': '/builds/slave/test', 04:44:42 INFO - 'blob_upload_branch': 'Firefox', 04:44:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:42 INFO - 'branch': 'Firefox', 04:44:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:42 INFO - 'config_files': ('talos/mac_config.py',), 04:44:42 INFO - 'default_actions': ('clobber', 04:44:42 INFO - 'read-buildbot-config', 04:44:42 INFO - 'download-and-extract', 04:44:42 INFO - 'populate-webroot', 04:44:42 INFO - 'create-virtualenv', 04:44:42 INFO - 'install', 04:44:42 INFO - 'run-tests'), 04:44:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:42 INFO - 'download_minidump_stackwalk': True, 04:44:42 INFO - 'download_symbols': 'ondemand', 04:44:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:42 INFO - 'gecko_profile': False, 04:44:42 INFO - 'gecko_profile_interval': 0, 04:44:42 INFO - 'installer_path': 'installer.exe', 04:44:42 INFO - 'log_level': 'info', 04:44:42 INFO - 'log_name': 'talos', 04:44:42 INFO - 'log_to_console': True, 04:44:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:44:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:44:42 INFO - 'opt_config_files': (), 04:44:42 INFO - 'pip_index': False, 04:44:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:42 INFO - 'cmd': ('bash', 04:44:42 INFO - '-c', 04:44:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:42 INFO - 'enabled': True, 04:44:42 INFO - 'halt_on_failure': False, 04:44:42 INFO - 'name': 'check_screen_resolution'},), 04:44:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:42 INFO - 'cmd': ('bash', 04:44:42 INFO - '-c', 04:44:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:42 INFO - 'enabled': True, 04:44:42 INFO - 'halt_on_failure': False, 04:44:42 INFO - 'name': 'check_screen_resolution'},), 04:44:42 INFO - 'run_cmd_checks_enabled': True, 04:44:42 INFO - 'suite': 'dromaeojs', 04:44:42 INFO - 'system_bits': '32', 04:44:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:42 INFO - 'title': 't-yosemite-r7-0338', 04:44:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:42 INFO - 'use_talos_json': True, 04:44:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:42 INFO - 'work_dir': 'build'} 04:44:42 INFO - [mozharness: 2017-03-08 12:44:42.720106Z] Running clobber step. 04:44:42 INFO - Running pre-action listener: _resource_record_pre_action 04:44:42 INFO - Running main action method: clobber 04:44:42 INFO - rmtree: /builds/slave/test/build 04:44:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:45 INFO - Running post-action listener: _resource_record_post_action 04:44:45 INFO - [mozharness: 2017-03-08 12:44:45.200930Z] Finished clobber step (success) 04:44:45 INFO - [mozharness: 2017-03-08 12:44:45.201078Z] Running read-buildbot-config step. 04:44:45 INFO - Running pre-action listener: _resource_record_pre_action 04:44:45 INFO - Running main action method: read_buildbot_config 04:44:45 INFO - Using buildbot properties: 04:44:45 INFO - { 04:44:45 INFO - "project": "", 04:44:45 INFO - "product": "firefox", 04:44:45 INFO - "script_repo_revision": "production", 04:44:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:44:45 INFO - "repository": "", 04:44:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:44:45 INFO - "buildid": "20170308030207", 04:44:45 INFO - "stage_platform": "macosx64", 04:44:45 INFO - "basedir": "/builds/slave/test", 04:44:45 INFO - "nightly_build": "True", 04:44:45 INFO - "buildnumber": 12, 04:44:45 INFO - "slavename": "t-yosemite-r7-0338", 04:44:45 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:44:45 INFO - "platform": "yosemite_r7", 04:44:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:44:45 INFO - "branch": "mozilla-central", 04:44:45 INFO - "repo_path": "mozilla-central", 04:44:45 INFO - "revision": "58753259bfeb3b818eac7870871b0aae1f8de64a", 04:44:45 INFO - "pgo_build": "False", 04:44:45 INFO - "builduid": "863c07f17b854228a4ae277e8f0d2acb", 04:44:45 INFO - "slavebuilddir": "test" 04:44:45 INFO - } 04:44:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:44:45 INFO - Running post-action listener: _resource_record_post_action 04:44:45 INFO - [mozharness: 2017-03-08 12:44:45.204502Z] Finished read-buildbot-config step (success) 04:44:45 INFO - [mozharness: 2017-03-08 12:44:45.204638Z] Running download-and-extract step. 04:44:45 INFO - Running pre-action listener: _resource_record_pre_action 04:44:45 INFO - Running main action method: download_and_extract 04:44:45 INFO - mkdir: /builds/slave/test/build/tests 04:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:45 INFO - trying https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:44:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:44:46 INFO - Downloaded 1199 bytes. 04:44:46 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:44:46 INFO - Using the following test package requirements: 04:44:46 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:44:46 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:44:46 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:44:46 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'jsshell-mac.zip'], 04:44:46 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:44:46 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:44:46 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:44:46 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:44:46 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:44:46 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:44:46 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:44:46 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:44:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:44:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:44:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:44:48 INFO - Expected file size: 51789031 04:44:48 INFO - Obtained file size: 51789031 04:45:03 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:45:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:45:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:45:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:45:05 INFO - Expected file size: 51789031 04:45:05 INFO - Obtained file size: 51789031 04:45:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:45:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:45:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:45:21 INFO - Expected file size: 14404424 04:45:21 INFO - Obtained file size: 14404424 04:45: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')]} 04:45:22 INFO - trying https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:45:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:45:24 INFO - Downloaded 74991506 bytes. 04:45:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:45:24 INFO - mkdir: /builds/slave/test/properties 04:45:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:24 INFO - Contents: 04:45:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:45:25 INFO - Running post-action listener: _resource_record_post_action 04:45:25 INFO - Running post-action listener: set_extra_try_arguments 04:45:25 INFO - [mozharness: 2017-03-08 12:45:25.120170Z] Finished download-and-extract step (success) 04:45:25 INFO - [mozharness: 2017-03-08 12:45:25.120292Z] Running populate-webroot step. 04:45:25 INFO - Running pre-action listener: _resource_record_pre_action 04:45:25 INFO - Running main action method: populate_webroot 04:45:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:25 INFO - '--tppagecycles', 04:45:25 INFO - '7'], 04:45:25 INFO - 'tests': ['tsvgm']}}, 04:45:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:45:25 INFO - 'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:45:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:45:25 INFO - 'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['damp', 'tps']}, 04:45:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:45:25 INFO - 'tests': ['damp', 'tps']}, 04:45:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['dromaeo_dom']}, 04:45:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['basic_compositor_video']}, 04:45:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:45:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['a11yr', 04:45:25 INFO - 'ts_paint', 04:45:25 INFO - 'tpaint', 04:45:25 INFO - 'sessionrestore', 04:45:25 INFO - 'sessionrestore_no_auto_restore', 04:45:25 INFO - 'tabpaint']}, 04:45:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:25 INFO - 'ts_paint', 04:45:25 INFO - 'tpaint', 04:45:25 INFO - 'sessionrestore', 04:45:25 INFO - 'sessionrestore_no_auto_restore', 04:45:25 INFO - 'tabpaint']}, 04:45:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:25 INFO - 'ts_paint', 04:45:25 INFO - 'tpaint', 04:45:25 INFO - 'sessionrestore', 04:45:25 INFO - 'sessionrestore_no_auto_restore', 04:45:25 INFO - 'tabpaint']}, 04:45:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:25 INFO - 'ts_paint', 04:45:25 INFO - 'tpaint', 04:45:25 INFO - 'sessionrestore', 04:45:25 INFO - 'sessionrestore_no_auto_restore', 04:45:25 INFO - 'tabpaint']}, 04:45:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['a11yr', 04:45:25 INFO - 'ts_paint', 04:45:25 INFO - 'tpaint', 04:45:25 INFO - 'sessionrestore', 04:45:25 INFO - 'sessionrestore_no_auto_restore', 04:45:25 INFO - 'tabpaint']}, 04:45:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['a11yr', 04:45:25 INFO - 'ts_paint', 04:45:25 INFO - 'tpaint', 04:45:25 INFO - 'sessionrestore', 04:45:25 INFO - 'sessionrestore_no_auto_restore', 04:45:25 INFO - 'tabpaint']}, 04:45:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['tsvgx', 04:45:25 INFO - 'tsvgr_opacity', 04:45:25 INFO - 'tart', 04:45:25 INFO - 'tscrollx', 04:45:25 INFO - 'cart', 04:45:25 INFO - 'tsvg_static']}, 04:45:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:25 INFO - 'tsvgr_opacity', 04:45:25 INFO - 'tart', 04:45:25 INFO - 'tscrollx', 04:45:25 INFO - 'cart', 04:45:25 INFO - 'tsvg_static']}, 04:45:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:45:25 INFO - 'talos_options': ['--disable-e10s'], 04:45:25 INFO - 'tests': ['tp5o']}, 04:45:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:45:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:45:25 INFO - 'talos_options': ['--disable-e10s', 04:45:25 INFO - '--xperf_path', 04:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:25 INFO - 'tests': ['tp5n']}, 04:45:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:45:25 INFO - 'talos_options': ['--xperf_path', 04:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:25 INFO - 'tests': ['tp5n']}}, 04:45:25 INFO - 'talos.zip': {'path': '', 04:45:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:25 INFO - Running post-action listener: _resource_record_post_action 04:45:25 INFO - [mozharness: 2017-03-08 12:45:25.138647Z] Finished populate-webroot step (success) 04:45:25 INFO - [mozharness: 2017-03-08 12:45:25.138751Z] Running create-virtualenv step. 04:45:25 INFO - Running pre-action listener: _resource_record_pre_action 04:45:25 INFO - Running main action method: create_virtualenv 04:45:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45: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 04:45:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:25 INFO - Using real prefix '/tools/python27' 04:45:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:28 INFO - Installing pip.................done. 04:45:28 INFO - Return code: 0 04:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:45:29 INFO - Reading from file tmpfile_stdout 04:45:29 INFO - Output received: 04:45: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) 04:45:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:29 INFO - 'HOME': '/Users/cltbld', 04:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:29 INFO - 'LOGNAME': 'cltbld', 04:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:29 INFO - 'MOZ_NO_REMOTE': '1', 04:45:29 INFO - 'NO_EM_RESTART': '1', 04:45:29 INFO - 'PAGER': '/bin/cat', 04:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:29 INFO - 'PWD': '/builds/slave/test', 04:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:29 INFO - 'SHELL': '/bin/bash', 04:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:29 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:29 INFO - 'USER': 'cltbld', 04:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:29 INFO - 'XPC_FLAGS': '0x0', 04:45:29 INFO - 'XPC_SERVICE_NAME': '0', 04:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45: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 04:45:29 INFO - Cleaning up... 04:45:29 INFO - Return code: 0 04:45:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:29 INFO - 'HOME': '/Users/cltbld', 04:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:29 INFO - 'LOGNAME': 'cltbld', 04:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:29 INFO - 'MOZ_NO_REMOTE': '1', 04:45:29 INFO - 'NO_EM_RESTART': '1', 04:45:29 INFO - 'PAGER': '/bin/cat', 04:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:29 INFO - 'PWD': '/builds/slave/test', 04:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:29 INFO - 'SHELL': '/bin/bash', 04:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:29 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:29 INFO - 'USER': 'cltbld', 04:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:29 INFO - 'XPC_FLAGS': '0x0', 04:45:29 INFO - 'XPC_SERVICE_NAME': '0', 04:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:29 INFO - Downloading/unpacking psutil>=3.1.1 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:33 INFO - Installing collected packages: psutil 04:45:33 INFO - Running setup.py install for psutil 04:45:33 INFO - building 'psutil._psutil_osx' extension 04:45: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 04:45: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 04:45: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 04:45: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 04:45:34 INFO - building 'psutil._psutil_posix' extension 04:45:34 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 04:45:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:45:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:45:34 INFO - ^ 04:45:34 INFO - 1 warning generated. 04:45: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 04:45:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:34 INFO - Successfully installed psutil 04:45:34 INFO - Cleaning up... 04:45:34 INFO - Return code: 0 04:45:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:34 INFO - 'HOME': '/Users/cltbld', 04:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:34 INFO - 'LOGNAME': 'cltbld', 04:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:34 INFO - 'MOZ_NO_REMOTE': '1', 04:45:34 INFO - 'NO_EM_RESTART': '1', 04:45:34 INFO - 'PAGER': '/bin/cat', 04:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:34 INFO - 'PWD': '/builds/slave/test', 04:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:34 INFO - 'SHELL': '/bin/bash', 04:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:34 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:34 INFO - 'USER': 'cltbld', 04:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:34 INFO - 'XPC_FLAGS': '0x0', 04:45:34 INFO - 'XPC_SERVICE_NAME': '0', 04:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:37 INFO - Installing collected packages: mozsystemmonitor 04:45:37 INFO - Running setup.py install for mozsystemmonitor 04:45:37 INFO - Successfully installed mozsystemmonitor 04:45:37 INFO - Cleaning up... 04:45:37 INFO - Return code: 0 04:45:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:38 INFO - 'HOME': '/Users/cltbld', 04:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:38 INFO - 'LOGNAME': 'cltbld', 04:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:38 INFO - 'MOZ_NO_REMOTE': '1', 04:45:38 INFO - 'NO_EM_RESTART': '1', 04:45:38 INFO - 'PAGER': '/bin/cat', 04:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:38 INFO - 'PWD': '/builds/slave/test', 04:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:38 INFO - 'SHELL': '/bin/bash', 04:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:38 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:38 INFO - 'USER': 'cltbld', 04:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:38 INFO - 'XPC_FLAGS': '0x0', 04:45:38 INFO - 'XPC_SERVICE_NAME': '0', 04:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:41 INFO - warning: no files found matching '*.txt' 04:45:41 INFO - no previously-included directories found matching 'build' 04:45:41 INFO - no previously-included directories found matching 'dist' 04:45:41 INFO - no previously-included directories found matching '.git*' 04:45:41 INFO - Installing collected packages: jsonschema, functools32 04:45:41 INFO - Running setup.py install for functools32 04:45:41 INFO - warning: no files found matching '*.txt' 04:45:41 INFO - no previously-included directories found matching 'build' 04:45:41 INFO - no previously-included directories found matching 'dist' 04:45:41 INFO - no previously-included directories found matching '.git*' 04:45:41 INFO - Successfully installed jsonschema functools32 04:45:41 INFO - Cleaning up... 04:45:42 INFO - Return code: 0 04:45:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:42 INFO - 'HOME': '/Users/cltbld', 04:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:42 INFO - 'LOGNAME': 'cltbld', 04:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:42 INFO - 'MOZ_NO_REMOTE': '1', 04:45:42 INFO - 'NO_EM_RESTART': '1', 04:45:42 INFO - 'PAGER': '/bin/cat', 04:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:42 INFO - 'PWD': '/builds/slave/test', 04:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:42 INFO - 'SHELL': '/bin/bash', 04:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:42 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:42 INFO - 'USER': 'cltbld', 04:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:42 INFO - 'XPC_FLAGS': '0x0', 04:45:42 INFO - 'XPC_SERVICE_NAME': '0', 04:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:45:42 INFO - Cleaning up... 04:45:42 INFO - Return code: 0 04:45:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:42 INFO - 'HOME': '/Users/cltbld', 04:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:42 INFO - 'LOGNAME': 'cltbld', 04:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:42 INFO - 'MOZ_NO_REMOTE': '1', 04:45:42 INFO - 'NO_EM_RESTART': '1', 04:45:42 INFO - 'PAGER': '/bin/cat', 04:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:42 INFO - 'PWD': '/builds/slave/test', 04:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:42 INFO - 'SHELL': '/bin/bash', 04:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:42 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:42 INFO - 'USER': 'cltbld', 04:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:42 INFO - 'XPC_FLAGS': '0x0', 04:45:42 INFO - 'XPC_SERVICE_NAME': '0', 04:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:46 INFO - Downloading docopt-0.6.1.tar.gz 04:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:46 INFO - Running setup.py install for blobuploader 04:45:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:46 INFO - Running setup.py install for requests 04:45:47 INFO - Running setup.py install for docopt 04:45:47 INFO - Successfully installed blobuploader requests docopt 04:45:47 INFO - Cleaning up... 04:45:47 INFO - Return code: 0 04:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:47 INFO - 'HOME': '/Users/cltbld', 04:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:47 INFO - 'LOGNAME': 'cltbld', 04:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:47 INFO - 'MOZ_NO_REMOTE': '1', 04:45:47 INFO - 'NO_EM_RESTART': '1', 04:45:47 INFO - 'PAGER': '/bin/cat', 04:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:47 INFO - 'PWD': '/builds/slave/test', 04:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:47 INFO - 'SHELL': '/bin/bash', 04:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:47 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:47 INFO - 'USER': 'cltbld', 04:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:47 INFO - 'XPC_FLAGS': '0x0', 04:45:47 INFO - 'XPC_SERVICE_NAME': '0', 04:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:47 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-uibePF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:47 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-y3BkLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:47 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-s8wImb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-nELUs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-1MlaFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-rwYlKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-pAWYDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-7BN3nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-x1esgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-yrr43F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ayQeIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:48 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-2x73eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:49 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-v78e24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:49 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-W_udUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:49 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-7DNt24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:49 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-nX0PoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:49 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-O54KmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:49 INFO - Running setup.py install for manifestparser 04:45:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for mozcrash 04:45:49 INFO - Running setup.py install for mozdebug 04:45:49 INFO - Running setup.py install for mozdevice 04:45:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Running setup.py install for mozfile 04:45:50 INFO - Running setup.py install for mozhttpd 04:45:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Running setup.py install for mozinfo 04:45:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Running setup.py install for mozInstall 04:45:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Running setup.py install for mozleak 04:45:50 INFO - Running setup.py install for mozlog 04:45:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:51 INFO - Running setup.py install for moznetwork 04:45:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:51 INFO - Running setup.py install for mozprocess 04:45:51 INFO - Running setup.py install for mozprofile 04:45:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:51 INFO - Running setup.py install for mozrunner 04:45:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:51 INFO - Running setup.py install for mozscreenshot 04:45:51 INFO - Running setup.py install for moztest 04:45:51 INFO - Running setup.py install for mozversion 04:45:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:52 INFO - Cleaning up... 04:45:52 INFO - Return code: 0 04:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:52 INFO - 'HOME': '/Users/cltbld', 04:45:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:52 INFO - 'LOGNAME': 'cltbld', 04:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:52 INFO - 'MOZ_NO_REMOTE': '1', 04:45:52 INFO - 'NO_EM_RESTART': '1', 04:45:52 INFO - 'PAGER': '/bin/cat', 04:45:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:52 INFO - 'PWD': '/builds/slave/test', 04:45:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:52 INFO - 'SHELL': '/bin/bash', 04:45:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:52 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:52 INFO - 'USER': 'cltbld', 04:45:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:52 INFO - 'XPC_FLAGS': '0x0', 04:45:52 INFO - 'XPC_SERVICE_NAME': '0', 04:45:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-vKMb5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45: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)) 04:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Fh4g3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45: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)) 04:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-CJYC9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45: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)) 04:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-K9zCPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:52 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)) 04:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-WEHxDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:52 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)) 04:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:52 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-eRKusr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45: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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-xCIU3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45: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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-8UMo9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45: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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-sG1wlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45: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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-GmNTSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45: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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-QW6ZcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45: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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-VZ9jhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45: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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-gSqkT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:53 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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-8bCqVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:53 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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-m1PFOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:53 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)) 04:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:53 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-10ca5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45: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)) 04:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:54 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Bo1opa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45: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)) 04:45: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)) 04:45: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)) 04:45: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)) 04:45: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)) 04:45: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)) 04:45:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:56 INFO - Downloading blessings-1.6.tar.gz 04:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:57 INFO - Installing collected packages: blessings 04:45:57 INFO - Running setup.py install for blessings 04:45:57 INFO - Successfully installed blessings 04:45:57 INFO - Cleaning up... 04:45:57 INFO - Return code: 0 04:45:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:57 INFO - Reading from file tmpfile_stdout 04:45:57 INFO - Current package versions: 04:45:57 INFO - blessings == 1.6 04:45:57 INFO - blobuploader == 1.2.4 04:45:57 INFO - docopt == 0.6.1 04:45:57 INFO - functools32 == 3.2.3-2 04:45:57 INFO - jsonschema == 2.5.1 04:45:57 INFO - manifestparser == 1.1 04:45:57 INFO - mozInstall == 1.12 04:45:57 INFO - mozcrash == 1.0 04:45:57 INFO - mozdebug == 0.1 04:45:57 INFO - mozdevice == 0.49 04:45:57 INFO - mozfile == 1.2 04:45:57 INFO - mozhttpd == 0.7 04:45:57 INFO - mozinfo == 0.9 04:45:57 INFO - mozleak == 0.1 04:45:57 INFO - mozlog == 3.4 04:45:57 INFO - moznetwork == 0.27 04:45:57 INFO - mozprocess == 0.25 04:45:57 INFO - mozprofile == 0.28 04:45:57 INFO - mozrunner == 6.13 04:45:57 INFO - mozscreenshot == 0.1 04:45:57 INFO - mozsystemmonitor == 0.3 04:45:57 INFO - moztest == 0.8 04:45:57 INFO - mozversion == 1.4 04:45:57 INFO - psutil == 3.1.1 04:45:57 INFO - requests == 1.2.3 04:45:57 INFO - wsgiref == 0.1.2 04:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45: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 04:45: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 04:45:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:57 INFO - 'HOME': '/Users/cltbld', 04:45:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:57 INFO - 'LOGNAME': 'cltbld', 04:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:57 INFO - 'MOZ_NO_REMOTE': '1', 04:45:57 INFO - 'NO_EM_RESTART': '1', 04:45:57 INFO - 'PAGER': '/bin/cat', 04:45:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:57 INFO - 'PWD': '/builds/slave/test', 04:45:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:57 INFO - 'SHELL': '/bin/bash', 04:45:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:57 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:57 INFO - 'USER': 'cltbld', 04:45:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:57 INFO - 'XPC_FLAGS': '0x0', 04:45:57 INFO - 'XPC_SERVICE_NAME': '0', 04:45:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 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)) 04:45:57 INFO - Cleaning up... 04:45:57 INFO - Return code: 0 04:45:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:57 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 0x105cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88e2d962c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, '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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 04:45:57 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 04:45:57 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 04:45:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:45:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:57 INFO - 'HOME': '/Users/cltbld', 04:45:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:57 INFO - 'LOGNAME': 'cltbld', 04:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:57 INFO - 'MOZ_NO_REMOTE': '1', 04:45:57 INFO - 'NO_EM_RESTART': '1', 04:45:57 INFO - 'PAGER': '/bin/cat', 04:45:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:57 INFO - 'PWD': '/builds/slave/test', 04:45:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:57 INFO - 'SHELL': '/bin/bash', 04:45:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:45:57 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:45:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:57 INFO - 'USER': 'cltbld', 04:45:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:57 INFO - 'XPC_FLAGS': '0x0', 04:45:57 INFO - 'XPC_SERVICE_NAME': '0', 04:45:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:58 INFO - Cleaning up... 04:45:58 INFO - Return code: 0 04:45:58 INFO - Running post-action listener: _resource_record_post_action 04:45:58 INFO - Running post-action listener: _start_resource_monitoring 04:45:58 INFO - Starting resource monitoring. 04:45:58 INFO - [mozharness: 2017-03-08 12:45:58.169032Z] Finished create-virtualenv step (success) 04:45:58 INFO - [mozharness: 2017-03-08 12:45:58.170021Z] Running install step. 04:45:58 INFO - Running pre-action listener: _resource_record_pre_action 04:45:58 INFO - Running main action method: install 04:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:58 INFO - Reading from file tmpfile_stdout 04:45:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:58 INFO - Reading from file tmpfile_stdout 04:45:58 INFO - Output received: 04:45:58 INFO - Usage: mozinstall [options] installer 04:45:58 INFO - Options: 04:45:58 INFO - -h, --help show this help message and exit 04:45:58 INFO - -d DEST, --destination=DEST 04:45:58 INFO - Directory to install application into. [default: 04:45:58 INFO - "/builds/slave/test"] 04:45:58 INFO - --app=APP Application being installed. [default: firefox] 04:45:58 INFO - mkdir: /builds/slave/test/build/application 04:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:46:18 INFO - Reading from file tmpfile_stdout 04:46:18 INFO - Output received: 04:46:18 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:46:18 INFO - Running post-action listener: _resource_record_post_action 04:46:18 INFO - [mozharness: 2017-03-08 12:46:18.609995Z] Finished install step (success) 04:46:18 INFO - [mozharness: 2017-03-08 12:46:18.610118Z] Running run-tests step. 04:46:18 INFO - Running pre-action listener: _resource_record_pre_action 04:46:18 INFO - Running main action method: run_tests 04:46:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:18 INFO - 2017-03-08 04:46:18.624 screenresolution[1626:7314] starting screenresolution argv=screenresolution get 04:46:18 INFO - 2017-03-08 04:46:18.627 screenresolution[1626:7314] Display 0: 1600x1200x32@60 04:46:18 INFO - 2017-03-08 04:46:18.633 screenresolution[1627:7316] starting screenresolution argv=screenresolution list 04:46:18 INFO - Available Modes on Display 0 04:46:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:18 INFO - Intel Iris: 04:46:18 INFO - Chipset Model: Intel Iris 04:46:18 INFO - Type: GPU 04:46:18 INFO - Bus: Built-In 04:46:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:18 INFO - Vendor: Intel (0x8086) 04:46:18 INFO - Device ID: 0x0a2e 04:46:18 INFO - Revision ID: 0x0009 04:46:18 INFO - Displays: 04:46:18 INFO - Display: 04:46:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:18 INFO - Display Serial Number: 1600x1200 60 04:46:18 INFO - Main Display: Yes 04:46:18 INFO - Mirror: Off 04:46:18 INFO - Online: Yes 04:46:18 INFO - Rotation: Supported 04:46:18 INFO - Return code: 0 04:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:18 INFO - Python 2.7.3 04:46:18 INFO - Return code: 0 04:46:18 INFO - grabbing minidump binary from tooltool 04:46:18 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')]} 04:46:18 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 0x105ad9d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105acebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:18 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 04:46:18 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 04:46:18 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 04:46:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:18 INFO - Return code: 0 04:46:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:46:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:18 INFO - ENV: RUST_BACKTRACE is now 1 04:46:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:46:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 04:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --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 04:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6cGWEbcKXc/Render', 04:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:18 INFO - 'HOME': '/Users/cltbld', 04:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:18 INFO - 'LOGNAME': 'cltbld', 04:46:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:18 INFO - 'MOZ_NO_REMOTE': '1', 04:46:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:18 INFO - 'NO_EM_RESTART': '1', 04:46:18 INFO - 'PAGER': '/bin/cat', 04:46:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:18 INFO - 'PWD': '/builds/slave/test', 04:46:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:18 INFO - 'RUST_BACKTRACE': '1', 04:46:18 INFO - 'SHELL': '/bin/bash', 04:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gvXSP0QjZC/Listeners', 04:46:18 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 04:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:18 INFO - 'USER': 'cltbld', 04:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:18 INFO - 'XPC_FLAGS': '0x0', 04:46:18 INFO - 'XPC_SERVICE_NAME': '0', 04:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 04:46:19 INFO - mozversion application_buildid: 20170308030207 04:46:19 INFO - mozversion application_changeset: 58753259bfeb3b818eac7870871b0aae1f8de64a 04:46:19 INFO - mozversion application_display_name: Nightly 04:46:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:19 INFO - mozversion application_name: Firefox 04:46:19 INFO - mozversion application_remotingname: firefox 04:46:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:46:19 INFO - mozversion application_vendor: Mozilla 04:46:19 INFO - mozversion application_version: 55.0a1 04:46:19 INFO - mozversion platform_buildid: 20170308030207 04:46:19 INFO - mozversion platform_changeset: 58753259bfeb3b818eac7870871b0aae1f8de64a 04:46:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:46:19 INFO - mozversion platform_version: 55.0a1 04:46:19 INFO - using testdate: 1488977179 04:46:19 INFO - actual date: 1488977179 04:46:19 INFO - starting webserver on 'localhost:49242' 04:46:19 INFO - SUITE-START | Running 2 tests 04:46:19 INFO - TEST-START | dromaeo_css 04:46:19 INFO - operating with platform_type : mac_ 04:46:19 INFO - Initialising browser for dromaeo_css test... 04:46:19 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpaM08LZ/profile http://localhost:49242/getInfo.html) 04:46:22 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 04:46:22 INFO - PROCESS | 1637 | colorDepth:24 04:46:22 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 04:46:22 INFO - PROCESS | 1637 | __metrics 04:46:22 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:46:22 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:22 INFO - TEST-INFO | 1637: exit 0 04:46:22 INFO - Browser initialized. 04:46:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:22 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpaM08LZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:35 INFO - PROCESS | 1640 | RSS: Main: 232603648 04:46:35 INFO - PROCESS | 1640 | 04:49:39 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 04:49:41 INFO - PROCESS | 1640 | RSS: Main: 418893824 04:49:41 INFO - PROCESS | 1640 | 04:51:24 INFO - PROCESS | 1640 | ************************* 04:51:24 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 04:51:24 INFO - PROCESS | 1640 | 04:51:24 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:51:24 INFO - PROCESS | 1640 | Full stack: 04:51:24 INFO - PROCESS | 1640 | ************************* 04:52:44 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 04:52:45 INFO - PROCESS | 1640 | RSS: Main: 425299968 04:52:45 INFO - PROCESS | 1640 | 04:55:48 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 04:55:48 INFO - PROCESS | 1640 | RSS: Main: 350208000 04:55:48 INFO - PROCESS | 1640 | 04:58:51 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 04:58:51 INFO - PROCESS | 1640 | RSS: Main: 338792448 04:58:51 INFO - PROCESS | 1640 | 05:01:55 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 05:01:56 INFO - PROCESS | 1640 | RSS: Main: 341524480 05:01:56 INFO - PROCESS | 1640 | 05:04:59 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 05:05:00 INFO - PROCESS | 1640 | RSS: Main: 532705280 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | __start_tp_report 05:05:00 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 05:05:00 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 05:05:00 INFO - PROCESS | 1640 | |i|pagename|runs| 05:05:00 INFO - PROCESS | 1640 | |0;dojo.html;2793.9522678995377;2856.942861142777;3365.478350855615;3382.6448222936606;3427.982860085699;5604.635698679583;5716.114002329646;5732.713364331782;5848.152017957388;5861.941380586193;4978.2532620107;5766.625169363989;5809.564282678805;5912.320083190434;5963.850903727409;5177.559907407875;5210.5310522053005;5221.425643179256;5232.136697444917;5255.527002569768;5349.946500535003;5353.1167357386175;5383.542398896098;5407.270018547485;5411.134218525037;5170.689758614495;5197.584193264567;5238.79044838206;5270.9736451317885;5291.3650361956425;5208.973955130238;5209.010288045297;5209.869753256161;5213.687178769286;5218.739063046833;5163.096458119851;5201.453847346012;5225.608079394061;5233.502817232356;5236.7905283788605;5691.971540142315;5727.3699893011735;5730.255066841326;5733.369329373765;5739.3399759027825;6248.4376406123665;6252.187215661935;6252.906206406908;6260.624362538262;6269.749210031593;5823;6292.993121100602;6301.7164227609865;6315.021171718345;6329.019002054642;5851.502622277111;5863.149843272744;5865.970670146665;5869.735861886225;5971.940280597139;6323.43089121972;6355.396237357444;6362.84092897672;6365.904511432333;6376.171097757262;6046.455818976313;6112.083187521907;6125.234345706786;6253.968730156411;6264.342244064308;6225.470834978987;6299.960506516373;6302.149209856702;6315.210598675166;6329.810105696836;6310.400511951358;6317.4946004319545;6318.526110541728;6328.810135695937;6331.398517140864;5829.795957141479;6052.364501727343;6326.398992095744;6344.333844946306;6346.079818426302;4865.878353041131;4894.3147959285725;4961.206207006861;4964.851054468371;4966.081274964144;3726.385146450805;4327.935080973788;4453.19842428366;4474.463064432289;4491.393661855608;5664.178694089416;5688.288963879515;5693.202951586781;5693.886122277614;5694.857628559236;6175.62946223228;6229.065640154013;6322.114903913456;6326.082718005863;6338.492920566344;5913;5916.408359164136;5939.970300148471;5943;5948.345681974979;5556.638818476867;5568.749406276727;5570.637908535932;5576.749046292926;5585.944140558542;6257.937420625826;6312.053192021233;6324.620522768465;6329.367063293634;6334.113224148531;6246.781362652286;6292.244930608356;6294.087357333069;6302.716377763103;6304.5586808922935;6421.775237866652;6426.132472116205;6441.452476539546;6462.224533056064;6463.385978332051;5183.922241166461;6213.381519147527;6267.843303917439;6273.654948977667;6292;6144.863200307957;6290.24517057956;6298.937010629835;6299.96850015747;6329.145565348803;6103.267607887082;6120.326764056039;6151.323354431099;6219.0982307566055;6242;6237;6246.031865060922;6257.374262573889;6262.655553944577;6263.843403914939;6125.111858780541;6125.816225513242;6131.693415329305;6137.662428566293;6143.662098584621;6006.789762358297;6050.848728781815;6126.908096378647;6140.293866205444;6163.291221509405;6054.39456054391;6106.157323464254;6131.315499378873;6131.560175786138;6135.416406698409 05:05:00 INFO - PROCESS | 1640 | |1;ext.html;703.8521910398816;766.7431410477491;783.0368646564727;855.7218903856244;869.9347548933831;27520.58719119215;38600.42099368508;39257.803710981476;39332;39459.013524661896;38578.26397812098;38717.806410967976;38733.612663873355;38744.03139921503;38781.612183878155;7265.946437766547;8877.156670116345;9018.143276388733;9035.909640903605;9050.547472626375;7245.4928155029165;7328;7339.486235963458;7353.779386618383;10709.410982396004;10952.34285942846;10963.83554246687;10964.725881852977;10967.177461690366;10968.451577421138;10916.781664366668;10917.39954302513;10941.96051375122;10951.288166269247;10976.670699879016;7107.395871350941;7283.854322913565;10687.572497100107;10766.78466430667;10767.03096721291;27330.04344847921;27407.45185096287;27462;37484.625153748384;38165;3753.774773513598;3762.1094756027464;3825.196708691178;3833.252515759428;3918.902027449308;26936.86531567349;27931.720682793115;27949.860250698617;27979.440411191867;27988;2602.2323414592743;2970.4207679502506;3043.1997298465017;3067.4785286501346;3142.010266765961;324221;325438.9999999976;325840;325903;326328;49276;49370.753146234754;49452.76368090827;49454;49537;51276.48723512792;51323.48676513187;51355;51359.97280054378;51501.7424912873;13359.799603005962;13480.93259533696;13484.595462136152;13487.25820079905;13537;11637.47631356591;11641.6507504775;11647.708807279885;11651.650450486499;11705.590304339306;9248.537573121452;9922.355046921926;10113.949430252802;10116.797664046679;11593.594224202112;5816.88366232673;5919.822405327761;5925.200097986803;5935.228420305332;5964.522838172936;1133.4106264742288;1137.2323681514945;1139.202558209257;1148.9372330594167;1197.0363857094949;26390.6041409379;26547.130739516484;26948.46103077967;26995.73004269932;27095.593566096526;1146.4611632532697;1225.7916154253799;1227.1410012990941;1284.184542815319;1286.6847622332589;10890.782184356427;13081;13529.255890926093;13764.793528097087;13803.792943105862;382848.0857595694;447096;450769.7461512737;452375;453845.73077134404;54356.18465723017;54757.45242547523;54970.900581988135;54994.525246364006;55070.44929550734;1387.965300867466;1435.9210243436712;1440.942362305517;1445.6674964757954;1448.9637759056109;25251.74748252494;25727;25730.356741080876;25826.450412975282;26019.349516262246;39814.80092599519;44491;44498;44597.66207013795;44652.55347446614;417490;417621;419228;420468;420973;33362.833185833915;33736;33879;34081.97754067382;34186.29068546613;40336;42961.78519107385;43156.70529884109;43276.56723432725;43319.783401082794;28289.57565636476;34353.31293374168;34488.96533104011;34600;36131.458028130124;29556.556651650673;34575.82712086423;35495.935121946386;35514.467282991296;35613.64386356103;32687;33331.166720832174;35404;35568.644313556535;35636.287274254886;27119.72880271172;27924.162275131777;29051;29142.708572913998;29270.41459170847;18584.25662973466;22676.546469070858;22909.312720618407;22930.312090637308;23349.88325058364 05:05:00 INFO - PROCESS | 1640 | |2;jquery.html;362.9927401451973;391.3562190197124;410.84798624508926;419.0278553755288;440.9911801763965;12474.690827518907;19771.406857794253;21262.36212913613;21552.784472155272;21558.676619850674;21041.842698651606;21522.031508582113;21537.892310538424;21587.568248635016;21963.670544941837;6574.375434333754;6628.502862285324;6647.700853461582;6776.8305792355095;6826;6562.081308616797;6630.270670226271;6697.5646582972195;6700.463962882957;6714.362135597111;6492.123563318939;6623.205215374138;6678.265390807007;6707.195136583592;6707.664616769166;6470.611763294218;6560.442362399202;6636.966815165917;6637.103990961206;6648.368405001565;6372.681365931685;6429.549931504796;6467.93532064678;6468.708908099147;6471.385218404244;26189.73810261911;26620.73379266202;26873.865630671917;26917;27255.727442725518;3293.176705823544;3310.6854848789326;3313.9171520711934;3329.667033296675;3447.6035255945385;15610.141442220673;16453.83546164535;16466.83533164677;16494.83505164945;16651.000939943642;1867.934622288227;1894.825208370819;2039.2862498125685;2046.8669536480081;2111.4088055344528;118862.40568797101;121239.78760212462;123629.38185309106;124364.37817810943;124732.75267247303;15073.393487015157;15979;18004.729929051075;18772.906135469235;20752.377428677162;31246.21884452907;31694;31694.36611267808;31743.841280793447;31807.84096079505;9894.455804930654;9946;10171.186305095574;10348.068673819393;10505.842412363821;8323.417360784808;8351.248387645019;8406.915930840736;8551.401401901932;8552.95723521391;10013.79972400548;10099.242556808269;10161.593536258615;10280.897191028143;10284.897151028394;3455.222574920673;3649.908752281161;4156.702595567717;4217;4227.260229459832;1017.9389236645825;1091.7270682329417;1095.8301463273206;1102.5204036244259;1146.873843877173;19066.428007159808;20296.62139533025;21861.234856779938;22157.77842221557;22203.444913877283;889.1419779912416;961.3270710502676;1105.9225854190129;1139.3107170162098;1150.2753265442884;8044.597770111471;10600.151987840954;10629;10712.196585256137;10735.78528429427;605337;640872;680747;684159;697545;151098;156011;161742.9128543568;168899;169111;1082.868402519369;1252.4990003998291;1278.386374540226;1278.6355888571713;1280.3918138883955;15073.930038889219;17736.467905962843;17998.37005704794;18394.905474223542;18585.81414185841;46482.767586161855;59995;61681;63008;63042.68478657577;80349.58077305804;81704.59147704224;81832;82126.3574728514;82291.58854205691;10652.733681658021;10800.675979720621;10915.945420273165;11270.154738394489;11651.951324380847;10830;12845.743085138432;13127;13253.933730331286;13301;11094.334339939629;11116.555337786398;11315.547378105113;11457.828132577852;11508.96419322265;10695.251332406657;10916.781664366827;11331.773364532828;11348.205625606128;11353.03499202577;10351.359974475336;11307.812679668516;11900.226485278428;11926.045916326846;11951.043916486486;10088.394696318244;11380.772384552429;11776.352300623204;11846.466908989289;11861.169718119994;9511.524423778921;10947.616833410792;10957.958993895567;11131.554737810397;11465.656030319104 05:05:00 INFO - PROCESS | 1640 | |3;mootools.html;1386.5285802827036;1517.6661134550409;1549.3957356630915;1588.0947859719956;1592.1243316176103;10307.63923262686;10833.945830270848;10837.295575787568;10839.67480975572;10857.619983300576;9808.362456440327;10381.013803688638;10770.784584308329;10904.509297081631;10942.890571094287;2324.233003108978;2362.3031205794246;2365.8935347909387;2369.3484291819714;2371.4308565944134;2284.132029828663;2319.884005799703;2326.906923723049;2331.5686597979343;2332.54515369503;2299.4021554395895;2319.2926157521947;2322.8490148140318;2324.372419446757;2329.219711396684;2198.692183094352;2214.1918199857096;2220.4781876259067;2220.5669894370603;2227.209340684058;2256.954860902773;2307.4231442139467;2310.4570425949887;2310.4685922237813;2311.6416955371774;10645.467726613715;10756.946215268874;10760;10765.892341076567;10766.730831729192;5514.228008078872;5701.4013528579735;5701.515371193454;5703.144528320744;5706.201131841545;3198.504231844068;3266.3957167923772;3424.880129195466;3560.590532088791;3568.37553428149;963.7446076789656;1160.1762748448612;1165.592042785027;1217.0385395537514;1235.215638069832;14964.401423943029;14987.550373488813;15094.622634434118;15099;15181.089134651957;3615.385384484644;4515.254982927846;4569.405977223007;4637.443506779208;4648.256278995412;11139.164562657834;11145.554177832795;11147;11149.944250278697;11154.274972126786;5486.31421072366;5495.285612870382;5499.890002199933;5503.752331145108;5509.669419834822;5015.724135172601;5022.42242142151;5071.087204303187;5107.795688172506;5154.9484505155215;3649.3431182387426;3723.1436769542615;3729;3768.1144930941205;3803.125281185343;1006.7382480555109;1010.7473131717071;1014.2342531388754;1024.3239461955075;1028.7788125552893;793.4168386236112;874.4141425245101;901.8917729872326;932.7407999201024;951.9571619277149;6375.895954335058;6419.871602568016;6600.80197594073;6660.600363978177;6698.593295407922;778.5601135358504;874.0865795243985;915.8168366326761;988.6885631026204;1034.0900007993068;3273.6726327367073;3591.4792355108884;3663.175785448253;3870.43878637596;4039.9192016159514;12133.575324863587;12777.93611031939;12808.871911280768;12811.295378754072;12855.100142990088;11622.128340374336;12643.494260229489;12685.619431417072;12791.808122878165;12978.831905128583;8633.266172375294;8893.377463577617;9363.29775266844;9550.140487356033;9807.999999999858;6384.712687929147;6445.484361250995;6606;6608.504362172953;6621.668916554249;11520;12001;12020.879791201976;12052.51789928393;12066.698332541757;11887.16789824704;12038.638840834788;12066.948618734661;12156.635300940987;12287.385630718607;8644.394892357475;8865.24645405122;9063.229625481645;9070.138336857988;9079.364444488823;8400.705975290835;8508.74473765788;9708.708738737849;9914.603415863574;10005.149562287286;8797.692080777142;8838.204561589488;8872.423292485968;8893.955530222307;8945.955270223607;7746.457747957589;8064.395170362363;8703.738887833375;8809.251213646912;9048;7382.372498337487;7627.580483073484;7681.42389320792;7681.69273229087;7790.182030886675;5783.884322313615;5800.854978625399;5839.35767065614;5849.268841394825;5992.250968628921;5701.914471283017;5867.178594996789;5889.057750759858;5895.351511333835;5915.497182739343 05:05:00 INFO - PROCESS | 1640 | |4;prototype.html;359.8326778048207;361.86915887850466;374.57859907603944;376.0298430050469;386.48018415231513;4242.91805589575;4964.808445972968;4965.453800081988;4974.577160941324;5000.449950505446;4434.645228381722;4772.68977516462;4909.901801963959;4943.8134847636575;4951.3563236779255;3405.6594340565994;3540.380433424153;3672.816359182037;3896.9283447052003;3918.6473217410426;3344.933101337972;3621.6559426854406;4071.1043570414463;4089.386592011207;4154.543000269968;3566.147082334135;3814.6539877975124;3841.4621952926614;4153.979230103845;4184.686148538856;3862.3627101528355;4096.934796952784;4114.626006674528;4182.268103081979;4230;3489.476578513218;3843.673287770543;3846.4999550058315;3865.729398942075;3880.767153970771;4122.660135455959;4369.213541562517;4801.663883528155;4899.28960300758;4913.213885778258;4361.542038085987;4361.563843615645;4545.568146034022;4845.588125009378;4846.273059041172;5017.799288028475;5040.697558146523;5045.924311135336;5264.763085661154;5310.8141215057285;4006.9198616027807;4276.294411422112;4289.399484072233;4303.203907277164;4312.439382880237;4136.710430269913;4722.716637001791;5203.557697595709;5677.460641239076;5705.4294570543025;3558.0290457467786;3727.434477519448;4180.623743863067;4352.627817839222;4361.956380436219;3802.657760801541;4286.571342865688;4460.353248778909;4468.888277793081;4478.664100192498;3971.4241434991764;4388.780560972003;4509.503954564995;4783.689060211075;4868.659193856467;4769.855234743636;4916.778744956486;4925.704457732548;5373.382061063028;5381.3811411687375;1371.9176849389069;1474.6387135151956;1505.3827930548641;1515.545336399076;1516.3707061569326;930.7295541585822;982.6462473509531;1007.5969612155196;1122.5341483284346;1126.451129696667;4633.968447450739;4891.5353041461;4926.359573255526;4999.500149954999;5024.864432616124;5131.307273518102;5467.617266791366;5536.557075433956;5537.366476889328;5549.334079910436;4402.911941761146;4554.339620755039;4974.363587298738;4978.352814134139;4987.925181122286;2755.704818735191;2867.813592116506;2877.2087675889297;2881.222070041077;2908.185708001763;5040.925035728203;5156.381234251839;5350.5987050971335;5534.335879694382;5752.539796816244;4780.593649539758;4886.291487734258;4906.55840974314;5707.1191589718555;5719.2279042328755;4693.436787585511;4706.929396059062;5678.602497825113;5683.61288258924;5703.429657034347;5050.671706339076;5293.708846013352;5365.543928766098;5528.44715528444;5578.191162281528;5111.667741596784;5126.051680439131;5306.681599104066;5442.6462279951675;5486;5686.862627474439;5720.623722852105;5742.875136199633;5750.424957504216;5778.706137501584;3817.828197731053;3821.9044523886014;3902.9609703902597;3930.194310166466;4303.246931786987;4201.621854033029;4916.541729135432;5087.515052189262;5314.468553144809;5508.862278443071;4438.511763705925;4542.772861356985;4984.215153452726;4997.550710294119;5020.769911371592;4404.73571585693;4582.6104781092645;4804.567588917014;5131.640785145004;5280.973595132154;4297.948456595727;4493.091010820607;4770.761461926821;4886.755662216946;5274.287971124003;4736.336912832275;5338.706371149624;5346.385165705994;5348.331458567679;5363.973180134074;5228.63399562027;5238.345206849144;5253.868653283698;5261.789528418821;5266.947330526646 05:05:00 INFO - PROCESS | 1640 | |5;yui.html;648.6594537867619;702.6346299924039;747.237817426225;781.0861292288023;833.7123692326145;14791.334389952452;15133.470328538504;15616.06303621782;15833.524994250161;15855.682886342267;14459.710805783905;14562.927185364086;14575.489857854976;14586.854131458682;14622.48821291255;813.2030610002201;937.0769791755133;949.4208532794989;950.0357137505438;950.538988590533;923.1737594852636;923.5197697197453;923.7598224461655;924.3160061554435;925.3846192282124;938.7887725261829;966.1497881863985;986.2997271936933;986.378581493658;986.990130098697;970.684527528549;971.9708408747714;972.4019727867311;973.0172525748974;973.8247115519204;731.8097294703363;732.952358096722;733.4609062339176;734.5519233267703;735.2427000189813;15508.61228469286;15519.5344139676;15537.689246215012;15695.686086278325;16173.595660108474;13732.313384330744;13979.580612581638;14209.50266740659;14224.217668028254;14247.28763561828;11417;11438.599649012327;11582.594609188638;11600.12999025068;12047.759044819142;3670.4861319415304;3689.8339574719203;3763.9623603763885;3814.0274230071154;3836.136869204435;107230;108111;108850.91149088487;109874.45062774635;110878.89121108767;10745.409002504937;10856.837147442795;10927.726806829893;11018.889811101946;11311.038561722346;22556.436089097904;22638.207662731726;22671.319860404215;22679;22820.543589128123;7135;7342.853142937111;7518.812029699301;7626;7680.923190768132;4120.423140760296;4156.916861662749;4199.76901270427;4202.180574787948;4289.378040184156;3327.1349449143395;3395.762296639261;3424.33225521021;3429.6570342966;3432.5709286339206;513.6609837507302;517.3963345299928;589.761853764963;618.5639124417276;625.1185827982523;646.3859333633068;657.2901266632026;663.6515829189617;671.4695390641436;677.7221339250883;9949.850752238723;9953.054459826304;10051.296409251283;10173.54219060144;10262.692119236435;650.1498818811717;679.4530403025611;693.9070963232828;699.7935608995358;719.6905330707741;4486.60658561555;4832.685875418157;4942.45294329218;5133.329669286478;5228.751651749029;74361;82484.17515824764;93883;96979.51510242403;97816;55520.16719749207;56932.715336423884;75116.62441687867;82797.17202828015;84781.15218847856;68271;69103;69998.60002799916;70833.2916670837;71255.6437217821;10610.494624934028;10622.20333474977;10755.623553175601;10780.245382823126;10811.135109191404;44613.33080003737;44705.77647111744;46979.53020469751;47469.10123595018;47975.28037079377;60696.39303606907;62878.99617566999;65978.01032984412;66267.33732662804;67192.66403668145;12605.621831345074;12671.17637353569;12688.555900543437;13226.272555009567;13419;13212.669683257995;13556.389962451516;14200;14411.495597654031;14707.779383309473;13248.536301229411;13287.40206690682;13300.477897252167;13455.259960702255;13857.168569885838;12884.355782210665;13161.210327380004;13178.670533236746;13182.73634527285;13593.932030339785;12876.935615322238;13001.609951701465;13041.934790325988;13047.347632618521;13396.995225358332;10811.891881081088;11020.228583999044;11045.05244815811;11214.83177752318;11331.773364532828;9369.953150234205;9735.805283894424;11002.449877506253;11105;11125.109991200847 05:05:00 INFO - PROCESS | 1640 | __end_tp_report 05:05:00 INFO - PROCESS | 1640 | __start_cc_report 05:05:00 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2055 05:05:00 INFO - PROCESS | 1640 | __end_cc_report 05:05:00 INFO - PROCESS | 1640 | __startTimestamp1488978300109__endTimestamp 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | ------- Summary: start ------- 05:05:00 INFO - PROCESS | 1640 | Number of tests: 6 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5790.06 Median:6054.39 stddev:692.75 (11.4%) stddev-sans-first:653.78 05:05:00 INFO - PROCESS | 1640 | Values: 2794.0 2856.9 3365.5 3382.6 3428.0 5604.6 5716.1 5732.7 5848.2 5861.9 4978.3 5766.6 5809.6 5912.3 5963.9 5177.6 5210.5 5221.4 5232.1 5255.5 5349.9 5353.1 5383.5 5407.3 5411.1 5170.7 5197.6 5238.8 5271.0 5291.4 5209.0 5209.0 5209.9 5213.7 5218.7 5163.1 5201.5 5225.6 5233.5 5236.8 5692.0 5727.4 5730.3 5733.4 5739.3 6248.4 6252.2 6252.9 6260.6 6269.7 5823.0 6293.0 6301.7 6315.0 6329.0 5851.5 5863.1 5866.0 5869.7 5971.9 6323.4 6355.4 6362.8 6365.9 6376.2 6046.5 6112.1 6125.2 6254.0 6264.3 6225.5 6300.0 6302.1 6315.2 6329.8 6310.4 6317.5 6318.5 6328.8 6331.4 5829.8 6052.4 6326.4 6344.3 6346.1 4865.9 4894.3 4961.2 4964.9 4966.1 3726.4 4327.9 4453.2 4474.5 4491.4 5664.2 5688.3 5693.2 5693.9 5694.9 6175.6 6229.1 6322.1 6326.1 6338.5 5913.0 5916.4 5940.0 5943.0 5948.3 5556.6 5568.7 5570.6 5576.7 5585.9 6257.9 6312.1 6324.6 6329.4 6334.1 6246.8 6292.2 6294.1 6302.7 6304.6 6421.8 6426.1 6441.5 6462.2 6463.4 5183.9 6213.4 6267.8 6273.7 6292.0 6144.9 6290.2 6298.9 6300.0 6329.1 6103.3 6120.3 6151.3 6219.1 6242.0 6237.0 6246.0 6257.4 6262.7 6263.8 6125.1 6125.8 6131.7 6137.7 6143.7 6006.8 6050.8 6126.9 6140.3 6163.3 6054.4 6106.2 6131.3 6131.6 6135.4 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:53097.51 Median:33549.42 stddev:105328.72 (314.0%) stddev-sans-first:105550.73 05:05:00 INFO - PROCESS | 1640 | Values: 703.9 766.7 783.0 855.7 869.9 27520.6 38600.4 39257.8 39332.0 39459.0 38578.3 38717.8 38733.6 38744.0 38781.6 7265.9 8877.2 9018.1 9035.9 9050.5 7245.5 7328.0 7339.5 7353.8 10709.4 10952.3 10963.8 10964.7 10967.2 10968.5 10916.8 10917.4 10942.0 10951.3 10976.7 7107.4 7283.9 10687.6 10766.8 10767.0 27330.0 27407.5 27462.0 37484.6 38165.0 3753.8 3762.1 3825.2 3833.3 3918.9 26936.9 27931.7 27949.9 27979.4 27988.0 2602.2 2970.4 3043.2 3067.5 3142.0 324221.0 325439.0 325840.0 325903.0 326328.0 49276.0 49370.8 49452.8 49454.0 49537.0 51276.5 51323.5 51355.0 51360.0 51501.7 13359.8 13480.9 13484.6 13487.3 13537.0 11637.5 11641.7 11647.7 11651.7 11705.6 9248.5 9922.4 10113.9 10116.8 11593.6 5816.9 5919.8 5925.2 5935.2 5964.5 1133.4 1137.2 1139.2 1148.9 1197.0 26390.6 26547.1 26948.5 26995.7 27095.6 1146.5 1225.8 1227.1 1284.2 1286.7 10890.8 13081.0 13529.3 13764.8 13803.8 382848.1 447096.0 450769.7 452375.0 453845.7 54356.2 54757.5 54970.9 54994.5 55070.4 1388.0 1435.9 1440.9 1445.7 1449.0 25251.7 25727.0 25730.4 25826.5 26019.3 39814.8 44491.0 44498.0 44597.7 44652.6 417490.0 417621.0 419228.0 420468.0 420973.0 33362.8 33736.0 33879.0 34082.0 34186.3 40336.0 42961.8 43156.7 43276.6 43319.8 28289.6 34353.3 34489.0 34600.0 36131.5 29556.6 34575.8 35495.9 35514.5 35613.6 32687.0 33331.2 35404.0 35568.6 35636.3 27119.7 27924.2 29051.0 29142.7 29270.4 18584.3 22676.5 22909.3 22930.3 23349.9 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:39527.83 Median:11399.62 stddev:110804.89 (972.0%) stddev-sans-first:111076.70 05:05:00 INFO - PROCESS | 1640 | Values: 363.0 391.4 410.8 419.0 441.0 12474.7 19771.4 21262.4 21552.8 21558.7 21041.8 21522.0 21537.9 21587.6 21963.7 6574.4 6628.5 6647.7 6776.8 6826.0 6562.1 6630.3 6697.6 6700.5 6714.4 6492.1 6623.2 6678.3 6707.2 6707.7 6470.6 6560.4 6637.0 6637.1 6648.4 6372.7 6429.5 6467.9 6468.7 6471.4 26189.7 26620.7 26873.9 26917.0 27255.7 3293.2 3310.7 3313.9 3329.7 3447.6 15610.1 16453.8 16466.8 16494.8 16651.0 1867.9 1894.8 2039.3 2046.9 2111.4 118862.4 121239.8 123629.4 124364.4 124732.8 15073.4 15979.0 18004.7 18772.9 20752.4 31246.2 31694.0 31694.4 31743.8 31807.8 9894.5 9946.0 10171.2 10348.1 10505.8 8323.4 8351.2 8406.9 8551.4 8553.0 10013.8 10099.2 10161.6 10280.9 10284.9 3455.2 3649.9 4156.7 4217.0 4227.3 1017.9 1091.7 1095.8 1102.5 1146.9 19066.4 20296.6 21861.2 22157.8 22203.4 889.1 961.3 1105.9 1139.3 1150.3 8044.6 10600.2 10629.0 10712.2 10735.8 605337.0 640872.0 680747.0 684159.0 697545.0 151098.0 156011.0 161742.9 168899.0 169111.0 1082.9 1252.5 1278.4 1278.6 1280.4 15073.9 17736.5 17998.4 18394.9 18585.8 46482.8 59995.0 61681.0 63008.0 63042.7 80349.6 81704.6 81832.0 82126.4 82291.6 10652.7 10800.7 10915.9 11270.2 11652.0 10830.0 12845.7 13127.0 13253.9 13301.0 11094.3 11116.6 11315.5 11457.8 11509.0 10695.3 10916.8 11331.8 11348.2 11353.0 10351.4 11307.8 11900.2 11926.0 11951.0 10088.4 11380.8 11776.4 11846.5 11861.2 9511.5 10947.6 10958.0 11131.6 11465.7 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6478.74 Median:3579.93 stddev:4042.96 (112.9%) stddev-sans-first:4036.19 05:05:00 INFO - PROCESS | 1640 | Values: 1386.5 1517.7 1549.4 1588.1 1592.1 10307.6 10833.9 10837.3 10839.7 10857.6 9808.4 10381.0 10770.8 10904.5 10942.9 2324.2 2362.3 2365.9 2369.3 2371.4 2284.1 2319.9 2326.9 2331.6 2332.5 2299.4 2319.3 2322.8 2324.4 2329.2 2198.7 2214.2 2220.5 2220.6 2227.2 2257.0 2307.4 2310.5 2310.5 2311.6 10645.5 10756.9 10760.0 10765.9 10766.7 5514.2 5701.4 5701.5 5703.1 5706.2 3198.5 3266.4 3424.9 3560.6 3568.4 963.7 1160.2 1165.6 1217.0 1235.2 14964.4 14987.6 15094.6 15099.0 15181.1 3615.4 4515.3 4569.4 4637.4 4648.3 11139.2 11145.6 11147.0 11149.9 11154.3 5486.3 5495.3 5499.9 5503.8 5509.7 5015.7 5022.4 5071.1 5107.8 5154.9 3649.3 3723.1 3729.0 3768.1 3803.1 1006.7 1010.7 1014.2 1024.3 1028.8 793.4 874.4 901.9 932.7 952.0 6375.9 6419.9 6600.8 6660.6 6698.6 778.6 874.1 915.8 988.7 1034.1 3273.7 3591.5 3663.2 3870.4 4039.9 12133.6 12777.9 12808.9 12811.3 12855.1 11622.1 12643.5 12685.6 12791.8 12978.8 8633.3 8893.4 9363.3 9550.1 9808.0 6384.7 6445.5 6606.0 6608.5 6621.7 11520.0 12001.0 12020.9 12052.5 12066.7 11887.2 12038.6 12066.9 12156.6 12287.4 8644.4 8865.2 9063.2 9070.1 9079.4 8400.7 8508.7 9708.7 9914.6 10005.1 8797.7 8838.2 8872.4 8894.0 8946.0 7746.5 8064.4 8703.7 8809.3 9048.0 7382.4 7627.6 7681.4 7681.7 7790.2 5783.9 5800.9 5839.4 5849.3 5992.3 5701.9 5867.2 5889.1 5895.4 5915.5 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4374.81 Median:4776.64 stddev:1231.88 (25.8%) stddev-sans-first:1197.91 05:05:00 INFO - PROCESS | 1640 | Values: 359.8 361.9 374.6 376.0 386.5 4242.9 4964.8 4965.5 4974.6 5000.4 4434.6 4772.7 4909.9 4943.8 4951.4 3405.7 3540.4 3672.8 3896.9 3918.6 3344.9 3621.7 4071.1 4089.4 4154.5 3566.1 3814.7 3841.5 4154.0 4184.7 3862.4 4096.9 4114.6 4182.3 4230.0 3489.5 3843.7 3846.5 3865.7 3880.8 4122.7 4369.2 4801.7 4899.3 4913.2 4361.5 4361.6 4545.6 4845.6 4846.3 5017.8 5040.7 5045.9 5264.8 5310.8 4006.9 4276.3 4289.4 4303.2 4312.4 4136.7 4722.7 5203.6 5677.5 5705.4 3558.0 3727.4 4180.6 4352.6 4362.0 3802.7 4286.6 4460.4 4468.9 4478.7 3971.4 4388.8 4509.5 4783.7 4868.7 4769.9 4916.8 4925.7 5373.4 5381.4 1371.9 1474.6 1505.4 1515.5 1516.4 930.7 982.6 1007.6 1122.5 1126.5 4634.0 4891.5 4926.4 4999.5 5024.9 5131.3 5467.6 5536.6 5537.4 5549.3 4402.9 4554.3 4974.4 4978.4 4987.9 2755.7 2867.8 2877.2 2881.2 2908.2 5040.9 5156.4 5350.6 5534.3 5752.5 4780.6 4886.3 4906.6 5707.1 5719.2 4693.4 4706.9 5678.6 5683.6 5703.4 5050.7 5293.7 5365.5 5528.4 5578.2 5111.7 5126.1 5306.7 5442.6 5486.0 5686.9 5720.6 5742.9 5750.4 5778.7 3817.8 3821.9 3903.0 3930.2 4303.2 4201.6 4916.5 5087.5 5314.5 5508.9 4438.5 4542.8 4984.2 4997.6 5020.8 4404.7 4582.6 4804.6 5131.6 5281.0 4297.9 4493.1 4770.8 4886.8 5274.3 4736.3 5338.7 5346.4 5348.3 5364.0 5228.6 5238.3 5253.9 5261.8 5266.9 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19303.28 Median:3978.28 stddev:26970.24 (677.9%) stddev-sans-first:27009.52 05:05:00 INFO - PROCESS | 1640 | Values: 648.7 702.6 747.2 781.1 833.7 14791.3 15133.5 15616.1 15833.5 15855.7 14459.7 14562.9 14575.5 14586.9 14622.5 813.2 937.1 949.4 950.0 950.5 923.2 923.5 923.8 924.3 925.4 938.8 966.1 986.3 986.4 987.0 970.7 972.0 972.4 973.0 973.8 731.8 733.0 733.5 734.6 735.2 15508.6 15519.5 15537.7 15695.7 16173.6 13732.3 13979.6 14209.5 14224.2 14247.3 11417.0 11438.6 11582.6 11600.1 12047.8 3670.5 3689.8 3764.0 3814.0 3836.1 107230.0 108111.0 108850.9 109874.5 110878.9 10745.4 10856.8 10927.7 11018.9 11311.0 22556.4 22638.2 22671.3 22679.0 22820.5 7135.0 7342.9 7518.8 7626.0 7680.9 4120.4 4156.9 4199.8 4202.2 4289.4 3327.1 3395.8 3424.3 3429.7 3432.6 513.7 517.4 589.8 618.6 625.1 646.4 657.3 663.7 671.5 677.7 9949.9 9953.1 10051.3 10173.5 10262.7 650.1 679.5 693.9 699.8 719.7 4486.6 4832.7 4942.5 5133.3 5228.8 74361.0 82484.2 93883.0 96979.5 97816.0 55520.2 56932.7 75116.6 82797.2 84781.2 68271.0 69103.0 69998.6 70833.3 71255.6 10610.5 10622.2 10755.6 10780.2 10811.1 44613.3 44705.8 46979.5 47469.1 47975.3 60696.4 62879.0 65978.0 66267.3 67192.7 12605.6 12671.2 12688.6 13226.3 13419.0 13212.7 13556.4 14200.0 14411.5 14707.8 13248.5 13287.4 13300.5 13455.3 13857.2 12884.4 13161.2 13178.7 13182.7 13593.9 12876.9 13001.6 13041.9 13047.3 13397.0 10811.9 11020.2 11045.1 11214.8 11331.8 9370.0 9735.8 11002.4 11105.0 11125.1 05:05:00 INFO - PROCESS | 1640 | -------- Summary: end -------- 05:05:00 INFO - PROCESS | 1640 | 05:05:00 INFO - TEST-INFO | 1640: exit 0 05:05:00 INFO - TEST-OK | dromaeo_css | took 1121560ms 05:05:00 INFO - TEST-START | kraken 05:05:00 INFO - operating with platform_type : mac_ 05:05:00 INFO - Initialising browser for kraken test... 05:05:00 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpGJJmS_/profile http://localhost:49242/getInfo.html) 05:05:03 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 05:05:03 INFO - PROCESS | 1650 | colorDepth:24 05:05:03 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 05:05:03 INFO - PROCESS | 1650 | __metrics 05:05:03 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:03 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:04 INFO - TEST-INFO | 1650: exit 0 05:05:04 INFO - Browser initialized. 05:05:04 INFO - Running cycle 1/1 for kraken test... 05:05:04 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpGJJmS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:16 INFO - PROCESS | 1652 | RSS: Main: 232218624 05:05:16 INFO - PROCESS | 1652 | 05:05:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:20 INFO - PROCESS | 1652 | RSS: Main: 283725824 05:05:20 INFO - PROCESS | 1652 | 05:05:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 05:05:23 INFO - PROCESS | 1652 | RSS: Main: 286273536 05:05:23 INFO - PROCESS | 1652 | 05:05:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 05:05:27 INFO - PROCESS | 1652 | RSS: Main: 377913344 05:05:27 INFO - PROCESS | 1652 | 05:05:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 05:05:30 INFO - PROCESS | 1652 | RSS: Main: 282415104 05:05:30 INFO - PROCESS | 1652 | 05:05:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:32 INFO - PROCESS | 1652 | RSS: Main: 284585984 05:05:32 INFO - PROCESS | 1652 | 05:05:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:36 INFO - PROCESS | 1652 | RSS: Main: 326561792 05:05:36 INFO - PROCESS | 1652 | 05:05:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:40 INFO - PROCESS | 1652 | RSS: Main: 328450048 05:05:40 INFO - PROCESS | 1652 | 05:05:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 05:05:44 INFO - PROCESS | 1652 | RSS: Main: 325287936 05:05:44 INFO - PROCESS | 1652 | 05:05:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:46 INFO - PROCESS | 1652 | RSS: Main: 302436352 05:05:46 INFO - PROCESS | 1652 | 05:05:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:49 INFO - PROCESS | 1652 | RSS: Main: 307605504 05:05:49 INFO - PROCESS | 1652 | 05:05:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:51 INFO - PROCESS | 1652 | RSS: Main: 310956032 05:05:51 INFO - PROCESS | 1652 | 05:05:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:55 INFO - PROCESS | 1652 | RSS: Main: 325197824 05:05:55 INFO - PROCESS | 1652 | 05:05:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:59 INFO - PROCESS | 1652 | RSS: Main: 319987712 05:05:59 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 05:06:01 INFO - PROCESS | 1652 | RSS: Main: 364904448 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | __start_tp_report 05:06:01 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:06:01 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:06:01 INFO - PROCESS | 1652 | |i|pagename|runs| 05:06:01 INFO - PROCESS | 1652 | |0;ai-astar;114;116;117;116;115;115;114;116;115;116 05:06:01 INFO - PROCESS | 1652 | |1;audio-beat-detection;134;111;111;159;142;140;120;109;130;110 05:06:01 INFO - PROCESS | 1652 | |2;audio-dft;183;185;184;183;187;183;180;231;221;187 05:06:01 INFO - PROCESS | 1652 | |3;audio-fft;82;62;60;91;66;60;60;63;92;86 05:06:01 INFO - PROCESS | 1652 | |4;audio-oscillator;88;72;92;102;100;100;116;69;67;84 05:06:01 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;88;90;112;88;88;88;89;87;88 05:06:01 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;119;96;94;95;95;95;95;95;94 05:06:01 INFO - PROCESS | 1652 | |7;imaging-desaturate;130;131;83;85;84;84;83;83;84;101 05:06:01 INFO - PROCESS | 1652 | |8;json-parse-financial;62;60;61;61;62;62;62;61;61;63 05:06:01 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;57;59;55;65;60;56;58;57;56;56 05:06:01 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;95;85;90;87;88;86;85;87;86;91 05:06:01 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;144;152;144;146;151;146;159;150;200;156 05:06:01 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;171;170;220;187;179;169;171;170;171;171 05:06:01 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;64;66;66;66;67;67;64;65;65 05:06:01 INFO - PROCESS | 1652 | __end_tp_report 05:06:01 INFO - PROCESS | 1652 | __start_cc_report 05:06:01 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2171 05:06:01 INFO - PROCESS | 1652 | __end_cc_report 05:06:01 INFO - PROCESS | 1652 | __startTimestamp1488978361338__endTimestamp 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:06:01 INFO - PROCESS | 1652 | Number of tests: 14 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:0.97 (0.8%) stddev-sans-first:0.88 05:06:01 INFO - PROCESS | 1652 | Values: 114.0 116.0 117.0 116.0 115.0 115.0 114.0 116.0 115.0 116.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:132.00 stddev:17.15 (13.0%) stddev-sans-first:17.98 05:06:01 INFO - PROCESS | 1652 | Values: 134.0 111.0 111.0 159.0 142.0 140.0 120.0 109.0 130.0 110.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:192.40 Median:186.00 stddev:17.98 (9.7%) stddev-sans-first:18.75 05:06:01 INFO - PROCESS | 1652 | Values: 183.0 185.0 184.0 183.0 187.0 183.0 180.0 231.0 221.0 187.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:72.20 Median:74.00 stddev:13.77 (18.6%) stddev-sans-first:14.14 05:06:01 INFO - PROCESS | 1652 | Values: 82.0 62.0 60.0 91.0 66.0 60.0 60.0 63.0 92.0 86.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:70.50 stddev:16.15 (22.9%) stddev-sans-first:17.13 05:06:01 INFO - PROCESS | 1652 | Values: 88.0 72.0 92.0 102.0 100.0 100.0 116.0 69.0 67.0 84.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:88.00 stddev:7.56 (8.6%) stddev-sans-first:7.96 05:06:01 INFO - PROCESS | 1652 | Values: 88.0 88.0 90.0 112.0 88.0 88.0 88.0 89.0 87.0 88.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:95.00 stddev:7.65 (8.0%) stddev-sans-first:8.06 05:06:01 INFO - PROCESS | 1652 | Values: 95.0 119.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:83.50 stddev:19.58 (23.5%) stddev-sans-first:16.10 05:06:01 INFO - PROCESS | 1652 | Values: 130.0 131.0 83.0 85.0 84.0 84.0 83.0 83.0 84.0 101.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 05:06:01 INFO - PROCESS | 1652 | Values: 62.0 60.0 61.0 61.0 62.0 62.0 62.0 61.0 61.0 63.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:57.50 stddev:2.92 (5.1%) stddev-sans-first:3.08 05:06:01 INFO - PROCESS | 1652 | Values: 57.0 59.0 55.0 65.0 60.0 56.0 58.0 57.0 56.0 56.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.50 stddev:3.16 (3.6%) stddev-sans-first:2.11 05:06:01 INFO - PROCESS | 1652 | Values: 95.0 85.0 90.0 87.0 88.0 86.0 85.0 87.0 86.0 91.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:151.50 stddev:16.65 (11.0%) stddev-sans-first:17.20 05:06:01 INFO - PROCESS | 1652 | Values: 144.0 152.0 144.0 146.0 151.0 146.0 159.0 150.0 200.0 156.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:171.00 stddev:15.81 (9.2%) stddev-sans-first:16.58 05:06:01 INFO - PROCESS | 1652 | Values: 171.0 170.0 220.0 187.0 179.0 169.0 171.0 170.0 171.0 171.0 05:06:01 INFO - PROCESS | 1652 | 05:06:01 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.13 05:06:01 INFO - PROCESS | 1652 | Values: 68.0 64.0 66.0 66.0 66.0 67.0 67.0 64.0 65.0 65.0 05:06:01 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:06:01 INFO - PROCESS | 1652 | 05:06:02 INFO - TEST-INFO | 1652: exit 0 05:06:02 INFO - TEST-OK | kraken | took 61525ms 05:06:02 INFO - SUITE-END | took 1183s 05:06:02 INFO - Completed test suite (00:19:43) 05:06:02 INFO - javascript benchmark 05:06:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7477.23873019563, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2793.9522678995377, 2856.942861142777, 3365.478350855615, 3382.6448222936606, 3427.982860085699, 5604.635698679583, 5716.114002329646, 5732.713364331782, 5848.152017957388, 5861.941380586193, 4978.2532620107, 5766.625169363989, 5809.564282678805, 5912.320083190434, 5963.850903727409, 5177.559907407875, 5210.5310522053005, 5221.425643179256, 5232.136697444917, 5255.527002569768, 5349.946500535003, 5353.1167357386175, 5383.542398896098, 5407.270018547485, 5411.134218525037, 5170.689758614495, 5197.584193264567, 5238.79044838206, 5270.9736451317885, 5291.3650361956425, 5208.973955130238, 5209.010288045297, 5209.869753256161, 5213.687178769286, 5218.739063046833, 5163.096458119851, 5201.453847346012, 5225.608079394061, 5233.502817232356, 5236.7905283788605, 5691.971540142315, 5727.3699893011735, 5730.255066841326, 5733.369329373765, 5739.3399759027825, 6248.4376406123665, 6252.187215661935, 6252.906206406908, 6260.624362538262, 6269.749210031593, 5823.0, 6292.993121100602, 6301.7164227609865, 6315.021171718345, 6329.019002054642, 5851.502622277111, 5863.149843272744, 5865.970670146665, 5869.735861886225, 5971.940280597139, 6323.43089121972, 6355.396237357444, 6362.84092897672, 6365.904511432333, 6376.171097757262, 6046.455818976313, 6112.083187521907, 6125.234345706786, 6253.968730156411, 6264.342244064308, 6225.470834978987, 6299.960506516373, 6302.149209856702, 6315.210598675166, 6329.810105696836, 6310.400511951358, 6317.4946004319545, 6318.526110541728, 6328.810135695937, 6331.398517140864, 5829.795957141479, 6052.364501727343, 6326.398992095744, 6344.333844946306, 6346.079818426302, 4865.878353041131, 4894.3147959285725, 4961.206207006861, 4964.851054468371, 4966.081274964144, 3726.385146450805, 4327.935080973788, 4453.19842428366, 4474.463064432289, 4491.393661855608, 5664.178694089416, 5688.288963879515, 5693.202951586781, 5693.886122277614, 5694.857628559236, 6175.62946223228, 6229.065640154013, 6322.114903913456, 6326.082718005863, 6338.492920566344, 5913.0, 5916.408359164136, 5939.970300148471, 5943.0, 5948.345681974979, 5556.638818476867, 5568.749406276727, 5570.637908535932, 5576.749046292926, 5585.944140558542, 6257.937420625826, 6312.053192021233, 6324.620522768465, 6329.367063293634, 6334.113224148531, 6246.781362652286, 6292.244930608356, 6294.087357333069, 6302.716377763103, 6304.5586808922935, 6421.775237866652, 6426.132472116205, 6441.452476539546, 6462.224533056064, 6463.385978332051, 5183.922241166461, 6213.381519147527, 6267.843303917439, 6273.654948977667, 6292.0, 6144.863200307957, 6290.24517057956, 6298.937010629835, 6299.96850015747, 6329.145565348803, 6103.267607887082, 6120.326764056039, 6151.323354431099, 6219.0982307566055, 6242.0, 6237.0, 6246.031865060922, 6257.374262573889, 6262.655553944577, 6263.843403914939, 6125.111858780541, 6125.816225513242, 6131.693415329305, 6137.662428566293, 6143.662098584621, 6006.789762358297, 6050.848728781815, 6126.908096378647, 6140.293866205444, 6163.291221509405, 6054.39456054391, 6106.157323464254, 6131.315499378873, 6131.560175786138, 6135.416406698409], "value": 5741.050471791148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.8521910398816, 766.7431410477491, 783.0368646564727, 855.7218903856244, 869.9347548933831, 27520.58719119215, 38600.42099368508, 39257.803710981476, 39332.0, 39459.013524661896, 38578.26397812098, 38717.806410967976, 38733.612663873355, 38744.03139921503, 38781.612183878155, 7265.946437766547, 8877.156670116345, 9018.143276388733, 9035.909640903605, 9050.547472626375, 7245.4928155029165, 7328.0, 7339.486235963458, 7353.779386618383, 10709.410982396004, 10952.34285942846, 10963.83554246687, 10964.725881852977, 10967.177461690366, 10968.451577421138, 10916.781664366668, 10917.39954302513, 10941.96051375122, 10951.288166269247, 10976.670699879016, 7107.395871350941, 7283.854322913565, 10687.572497100107, 10766.78466430667, 10767.03096721291, 27330.04344847921, 27407.45185096287, 27462.0, 37484.625153748384, 38165.0, 3753.774773513598, 3762.1094756027464, 3825.196708691178, 3833.252515759428, 3918.902027449308, 26936.86531567349, 27931.720682793115, 27949.860250698617, 27979.440411191867, 27988.0, 2602.2323414592743, 2970.4207679502506, 3043.1997298465017, 3067.4785286501346, 3142.010266765961, 324221.0, 325438.9999999976, 325840.0, 325903.0, 326328.0, 49276.0, 49370.753146234754, 49452.76368090827, 49454.0, 49537.0, 51276.48723512792, 51323.48676513187, 51355.0, 51359.97280054378, 51501.7424912873, 13359.799603005962, 13480.93259533696, 13484.595462136152, 13487.25820079905, 13537.0, 11637.47631356591, 11641.6507504775, 11647.708807279885, 11651.650450486499, 11705.590304339306, 9248.537573121452, 9922.355046921926, 10113.949430252802, 10116.797664046679, 11593.594224202112, 5816.88366232673, 5919.822405327761, 5925.200097986803, 5935.228420305332, 5964.522838172936, 1133.4106264742288, 1137.2323681514945, 1139.202558209257, 1148.9372330594167, 1197.0363857094949, 26390.6041409379, 26547.130739516484, 26948.46103077967, 26995.73004269932, 27095.593566096526, 1146.4611632532697, 1225.7916154253799, 1227.1410012990941, 1284.184542815319, 1286.6847622332589, 10890.782184356427, 13081.0, 13529.255890926093, 13764.793528097087, 13803.792943105862, 382848.0857595694, 447096.0, 450769.7461512737, 452375.0, 453845.73077134404, 54356.18465723017, 54757.45242547523, 54970.900581988135, 54994.525246364006, 55070.44929550734, 1387.965300867466, 1435.9210243436712, 1440.942362305517, 1445.6674964757954, 1448.9637759056109, 25251.74748252494, 25727.0, 25730.356741080876, 25826.450412975282, 26019.349516262246, 39814.80092599519, 44491.0, 44498.0, 44597.66207013795, 44652.55347446614, 417490.0, 417621.0, 419228.0, 420468.0, 420973.0, 33362.833185833915, 33736.0, 33879.0, 34081.97754067382, 34186.29068546613, 40336.0, 42961.78519107385, 43156.70529884109, 43276.56723432725, 43319.783401082794, 28289.57565636476, 34353.31293374168, 34488.96533104011, 34600.0, 36131.458028130124, 29556.556651650673, 34575.82712086423, 35495.935121946386, 35514.467282991296, 35613.64386356103, 32687.0, 33331.166720832174, 35404.0, 35568.644313556535, 35636.287274254886, 27119.72880271172, 27924.162275131777, 29051.0, 29142.708572913998, 29270.41459170847, 18584.25662973466, 22676.546469070858, 22909.312720618407, 22930.312090637308, 23349.88325058364], "value": 18119.660904711705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.9927401451973, 391.3562190197124, 410.84798624508926, 419.0278553755288, 440.9911801763965, 12474.690827518907, 19771.406857794253, 21262.36212913613, 21552.784472155272, 21558.676619850674, 21041.842698651606, 21522.031508582113, 21537.892310538424, 21587.568248635016, 21963.670544941837, 6574.375434333754, 6628.502862285324, 6647.700853461582, 6776.8305792355095, 6826.0, 6562.081308616797, 6630.270670226271, 6697.5646582972195, 6700.463962882957, 6714.362135597111, 6492.123563318939, 6623.205215374138, 6678.265390807007, 6707.195136583592, 6707.664616769166, 6470.611763294218, 6560.442362399202, 6636.966815165917, 6637.103990961206, 6648.368405001565, 6372.681365931685, 6429.549931504796, 6467.93532064678, 6468.708908099147, 6471.385218404244, 26189.73810261911, 26620.73379266202, 26873.865630671917, 26917.0, 27255.727442725518, 3293.176705823544, 3310.6854848789326, 3313.9171520711934, 3329.667033296675, 3447.6035255945385, 15610.141442220673, 16453.83546164535, 16466.83533164677, 16494.83505164945, 16651.000939943642, 1867.934622288227, 1894.825208370819, 2039.2862498125685, 2046.8669536480081, 2111.4088055344528, 118862.40568797101, 121239.78760212462, 123629.38185309106, 124364.37817810943, 124732.75267247303, 15073.393487015157, 15979.0, 18004.729929051075, 18772.906135469235, 20752.377428677162, 31246.21884452907, 31694.0, 31694.36611267808, 31743.841280793447, 31807.84096079505, 9894.455804930654, 9946.0, 10171.186305095574, 10348.068673819393, 10505.842412363821, 8323.417360784808, 8351.248387645019, 8406.915930840736, 8551.401401901932, 8552.95723521391, 10013.79972400548, 10099.242556808269, 10161.593536258615, 10280.897191028143, 10284.897151028394, 3455.222574920673, 3649.908752281161, 4156.702595567717, 4217.0, 4227.260229459832, 1017.9389236645825, 1091.7270682329417, 1095.8301463273206, 1102.5204036244259, 1146.873843877173, 19066.428007159808, 20296.62139533025, 21861.234856779938, 22157.77842221557, 22203.444913877283, 889.1419779912416, 961.3270710502676, 1105.9225854190129, 1139.3107170162098, 1150.2753265442884, 8044.597770111471, 10600.151987840954, 10629.0, 10712.196585256137, 10735.78528429427, 605337.0, 640872.0, 680747.0, 684159.0, 697545.0, 151098.0, 156011.0, 161742.9128543568, 168899.0, 169111.0, 1082.868402519369, 1252.4990003998291, 1278.386374540226, 1278.6355888571713, 1280.3918138883955, 15073.930038889219, 17736.467905962843, 17998.37005704794, 18394.905474223542, 18585.81414185841, 46482.767586161855, 59995.0, 61681.0, 63008.0, 63042.68478657577, 80349.58077305804, 81704.59147704224, 81832.0, 82126.3574728514, 82291.58854205691, 10652.733681658021, 10800.675979720621, 10915.945420273165, 11270.154738394489, 11651.951324380847, 10830.0, 12845.743085138432, 13127.0, 13253.933730331286, 13301.0, 11094.334339939629, 11116.555337786398, 11315.547378105113, 11457.828132577852, 11508.96419322265, 10695.251332406657, 10916.781664366827, 11331.773364532828, 11348.205625606128, 11353.03499202577, 10351.359974475336, 11307.812679668516, 11900.226485278428, 11926.045916326846, 11951.043916486486, 10088.394696318244, 11380.772384552429, 11776.352300623204, 11846.466908989289, 11861.169718119994, 9511.524423778921, 10947.616833410792, 10957.958993895567, 11131.554737810397, 11465.656030319104], "value": 11362.741927831668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.5285802827036, 1517.6661134550409, 1549.3957356630915, 1588.0947859719956, 1592.1243316176103, 10307.63923262686, 10833.945830270848, 10837.295575787568, 10839.67480975572, 10857.619983300576, 9808.362456440327, 10381.013803688638, 10770.784584308329, 10904.509297081631, 10942.890571094287, 2324.233003108978, 2362.3031205794246, 2365.8935347909387, 2369.3484291819714, 2371.4308565944134, 2284.132029828663, 2319.884005799703, 2326.906923723049, 2331.5686597979343, 2332.54515369503, 2299.4021554395895, 2319.2926157521947, 2322.8490148140318, 2324.372419446757, 2329.219711396684, 2198.692183094352, 2214.1918199857096, 2220.4781876259067, 2220.5669894370603, 2227.209340684058, 2256.954860902773, 2307.4231442139467, 2310.4570425949887, 2310.4685922237813, 2311.6416955371774, 10645.467726613715, 10756.946215268874, 10760.0, 10765.892341076567, 10766.730831729192, 5514.228008078872, 5701.4013528579735, 5701.515371193454, 5703.144528320744, 5706.201131841545, 3198.504231844068, 3266.3957167923772, 3424.880129195466, 3560.590532088791, 3568.37553428149, 963.7446076789656, 1160.1762748448612, 1165.592042785027, 1217.0385395537514, 1235.215638069832, 14964.401423943029, 14987.550373488813, 15094.622634434118, 15099.0, 15181.089134651957, 3615.385384484644, 4515.254982927846, 4569.405977223007, 4637.443506779208, 4648.256278995412, 11139.164562657834, 11145.554177832795, 11147.0, 11149.944250278697, 11154.274972126786, 5486.31421072366, 5495.285612870382, 5499.890002199933, 5503.752331145108, 5509.669419834822, 5015.724135172601, 5022.42242142151, 5071.087204303187, 5107.795688172506, 5154.9484505155215, 3649.3431182387426, 3723.1436769542615, 3729.0, 3768.1144930941205, 3803.125281185343, 1006.7382480555109, 1010.7473131717071, 1014.2342531388754, 1024.3239461955075, 1028.7788125552893, 793.4168386236112, 874.4141425245101, 901.8917729872326, 932.7407999201024, 951.9571619277149, 6375.895954335058, 6419.871602568016, 6600.80197594073, 6660.600363978177, 6698.593295407922, 778.5601135358504, 874.0865795243985, 915.8168366326761, 988.6885631026204, 1034.0900007993068, 3273.6726327367073, 3591.4792355108884, 3663.175785448253, 3870.43878637596, 4039.9192016159514, 12133.575324863587, 12777.93611031939, 12808.871911280768, 12811.295378754072, 12855.100142990088, 11622.128340374336, 12643.494260229489, 12685.619431417072, 12791.808122878165, 12978.831905128583, 8633.266172375294, 8893.377463577617, 9363.29775266844, 9550.140487356033, 9807.999999999858, 6384.712687929147, 6445.484361250995, 6606.0, 6608.504362172953, 6621.668916554249, 11520.0, 12001.0, 12020.879791201976, 12052.51789928393, 12066.698332541757, 11887.16789824704, 12038.638840834788, 12066.948618734661, 12156.635300940987, 12287.385630718607, 8644.394892357475, 8865.24645405122, 9063.229625481645, 9070.138336857988, 9079.364444488823, 8400.705975290835, 8508.74473765788, 9708.708738737849, 9914.603415863574, 10005.149562287286, 8797.692080777142, 8838.204561589488, 8872.423292485968, 8893.955530222307, 8945.955270223607, 7746.457747957589, 8064.395170362363, 8703.738887833375, 8809.251213646912, 9048.0, 7382.372498337487, 7627.580483073484, 7681.42389320792, 7681.69273229087, 7790.182030886675, 5783.884322313615, 5800.854978625399, 5839.35767065614, 5849.268841394825, 5992.250968628921, 5701.914471283017, 5867.178594996789, 5889.057750759858, 5895.351511333835, 5915.497182739343], "value": 4939.169585479514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.8326778048207, 361.86915887850466, 374.57859907603944, 376.0298430050469, 386.48018415231513, 4242.91805589575, 4964.808445972968, 4965.453800081988, 4974.577160941324, 5000.449950505446, 4434.645228381722, 4772.68977516462, 4909.901801963959, 4943.8134847636575, 4951.3563236779255, 3405.6594340565994, 3540.380433424153, 3672.816359182037, 3896.9283447052003, 3918.6473217410426, 3344.933101337972, 3621.6559426854406, 4071.1043570414463, 4089.386592011207, 4154.543000269968, 3566.147082334135, 3814.6539877975124, 3841.4621952926614, 4153.979230103845, 4184.686148538856, 3862.3627101528355, 4096.934796952784, 4114.626006674528, 4182.268103081979, 4230.0, 3489.476578513218, 3843.673287770543, 3846.4999550058315, 3865.729398942075, 3880.767153970771, 4122.660135455959, 4369.213541562517, 4801.663883528155, 4899.28960300758, 4913.213885778258, 4361.542038085987, 4361.563843615645, 4545.568146034022, 4845.588125009378, 4846.273059041172, 5017.799288028475, 5040.697558146523, 5045.924311135336, 5264.763085661154, 5310.8141215057285, 4006.9198616027807, 4276.294411422112, 4289.399484072233, 4303.203907277164, 4312.439382880237, 4136.710430269913, 4722.716637001791, 5203.557697595709, 5677.460641239076, 5705.4294570543025, 3558.0290457467786, 3727.434477519448, 4180.623743863067, 4352.627817839222, 4361.956380436219, 3802.657760801541, 4286.571342865688, 4460.353248778909, 4468.888277793081, 4478.664100192498, 3971.4241434991764, 4388.780560972003, 4509.503954564995, 4783.689060211075, 4868.659193856467, 4769.855234743636, 4916.778744956486, 4925.704457732548, 5373.382061063028, 5381.3811411687375, 1371.9176849389069, 1474.6387135151956, 1505.3827930548641, 1515.545336399076, 1516.3707061569326, 930.7295541585822, 982.6462473509531, 1007.5969612155196, 1122.5341483284346, 1126.451129696667, 4633.968447450739, 4891.5353041461, 4926.359573255526, 4999.500149954999, 5024.864432616124, 5131.307273518102, 5467.617266791366, 5536.557075433956, 5537.366476889328, 5549.334079910436, 4402.911941761146, 4554.339620755039, 4974.363587298738, 4978.352814134139, 4987.925181122286, 2755.704818735191, 2867.813592116506, 2877.2087675889297, 2881.222070041077, 2908.185708001763, 5040.925035728203, 5156.381234251839, 5350.5987050971335, 5534.335879694382, 5752.539796816244, 4780.593649539758, 4886.291487734258, 4906.55840974314, 5707.1191589718555, 5719.2279042328755, 4693.436787585511, 4706.929396059062, 5678.602497825113, 5683.61288258924, 5703.429657034347, 5050.671706339076, 5293.708846013352, 5365.543928766098, 5528.44715528444, 5578.191162281528, 5111.667741596784, 5126.051680439131, 5306.681599104066, 5442.6462279951675, 5486.0, 5686.862627474439, 5720.623722852105, 5742.875136199633, 5750.424957504216, 5778.706137501584, 3817.828197731053, 3821.9044523886014, 3902.9609703902597, 3930.194310166466, 4303.246931786987, 4201.621854033029, 4916.541729135432, 5087.515052189262, 5314.468553144809, 5508.862278443071, 4438.511763705925, 4542.772861356985, 4984.215153452726, 4997.550710294119, 5020.769911371592, 4404.73571585693, 4582.6104781092645, 4804.567588917014, 5131.640785145004, 5280.973595132154, 4297.948456595727, 4493.091010820607, 4770.761461926821, 4886.755662216946, 5274.287971124003, 4736.336912832275, 5338.706371149624, 5346.385165705994, 5348.331458567679, 5363.973180134074, 5228.63399562027, 5238.345206849144, 5253.868653283698, 5261.789528418821, 5266.947330526646], "value": 4018.2938677514885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.6594537867619, 702.6346299924039, 747.237817426225, 781.0861292288023, 833.7123692326145, 14791.334389952452, 15133.470328538504, 15616.06303621782, 15833.524994250161, 15855.682886342267, 14459.710805783905, 14562.927185364086, 14575.489857854976, 14586.854131458682, 14622.48821291255, 813.2030610002201, 937.0769791755133, 949.4208532794989, 950.0357137505438, 950.538988590533, 923.1737594852636, 923.5197697197453, 923.7598224461655, 924.3160061554435, 925.3846192282124, 938.7887725261829, 966.1497881863985, 986.2997271936933, 986.378581493658, 986.990130098697, 970.684527528549, 971.9708408747714, 972.4019727867311, 973.0172525748974, 973.8247115519204, 731.8097294703363, 732.952358096722, 733.4609062339176, 734.5519233267703, 735.2427000189813, 15508.61228469286, 15519.5344139676, 15537.689246215012, 15695.686086278325, 16173.595660108474, 13732.313384330744, 13979.580612581638, 14209.50266740659, 14224.217668028254, 14247.28763561828, 11417.0, 11438.599649012327, 11582.594609188638, 11600.12999025068, 12047.759044819142, 3670.4861319415304, 3689.8339574719203, 3763.9623603763885, 3814.0274230071154, 3836.136869204435, 107230.0, 108111.0, 108850.91149088487, 109874.45062774635, 110878.89121108767, 10745.409002504937, 10856.837147442795, 10927.726806829893, 11018.889811101946, 11311.038561722346, 22556.436089097904, 22638.207662731726, 22671.319860404215, 22679.0, 22820.543589128123, 7135.0, 7342.853142937111, 7518.812029699301, 7626.0, 7680.923190768132, 4120.423140760296, 4156.916861662749, 4199.76901270427, 4202.180574787948, 4289.378040184156, 3327.1349449143395, 3395.762296639261, 3424.33225521021, 3429.6570342966, 3432.5709286339206, 513.6609837507302, 517.3963345299928, 589.761853764963, 618.5639124417276, 625.1185827982523, 646.3859333633068, 657.2901266632026, 663.6515829189617, 671.4695390641436, 677.7221339250883, 9949.850752238723, 9953.054459826304, 10051.296409251283, 10173.54219060144, 10262.692119236435, 650.1498818811717, 679.4530403025611, 693.9070963232828, 699.7935608995358, 719.6905330707741, 4486.60658561555, 4832.685875418157, 4942.45294329218, 5133.329669286478, 5228.751651749029, 74361.0, 82484.17515824764, 93883.0, 96979.51510242403, 97816.0, 55520.16719749207, 56932.715336423884, 75116.62441687867, 82797.17202828015, 84781.15218847856, 68271.0, 69103.0, 69998.60002799916, 70833.2916670837, 71255.6437217821, 10610.494624934028, 10622.20333474977, 10755.623553175601, 10780.245382823126, 10811.135109191404, 44613.33080003737, 44705.77647111744, 46979.53020469751, 47469.10123595018, 47975.28037079377, 60696.39303606907, 62878.99617566999, 65978.01032984412, 66267.33732662804, 67192.66403668145, 12605.621831345074, 12671.17637353569, 12688.555900543437, 13226.272555009567, 13419.0, 13212.669683257995, 13556.389962451516, 14200.0, 14411.495597654031, 14707.779383309473, 13248.536301229411, 13287.40206690682, 13300.477897252167, 13455.259960702255, 13857.168569885838, 12884.355782210665, 13161.210327380004, 13178.670533236746, 13182.73634527285, 13593.932030339785, 12876.935615322238, 13001.609951701465, 13041.934790325988, 13047.347632618521, 13396.995225358332, 10811.891881081088, 11020.228583999044, 11045.05244815811, 11214.83177752318, 11331.773364532828, 9369.953150234205, 9735.805283894424, 11002.449877506253, 11105.0, 11125.109991200847], "value": 7448.7539932511745, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 117.0, 116.0, 115.0, 115.0, 114.0, 116.0, 115.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 111.0, 111.0, 159.0, 142.0, 140.0, 120.0, 109.0, 130.0, 110.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 184.0, 183.0, 187.0, 183.0, 180.0, 231.0, 221.0, 187.0], "value": 192.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 60.0, 91.0, 66.0, 60.0, 60.0, 63.0, 92.0, 86.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 92.0, 102.0, 100.0, 100.0, 116.0, 69.0, 67.0, 84.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 90.0, 112.0, 88.0, 88.0, 88.0, 89.0, 87.0, 88.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 119.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 83.0, 85.0, 84.0, 84.0, 83.0, 83.0, 84.0, 101.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 63.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 55.0, 65.0, 60.0, 56.0, 58.0, 57.0, 56.0, 56.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 85.0, 90.0, 87.0, 88.0, 86.0, 85.0, 87.0, 86.0, 91.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 152.0, 144.0, 146.0, 151.0, 146.0, 159.0, 150.0, 200.0, 156.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 220.0, 187.0, 179.0, 169.0, 171.0, 170.0, 171.0, 171.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 66.0, 66.0, 67.0, 67.0, 64.0, 65.0, 65.0], "value": 65.8, "unit": "score"}]}]} 05:06:02 INFO - Return code: 0 05:06:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:06:02 ERROR - # TBPL SUCCESS # 05:06:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:02 INFO - 2017-03-08 05:06:02.692 screenresolution[1656:10072] starting screenresolution argv=screenresolution get 05:06:02 INFO - 2017-03-08 05:06:02.695 screenresolution[1656:10072] Display 0: 1600x1200x32@60 05:06:02 INFO - 2017-03-08 05:06:02.701 screenresolution[1657:10075] starting screenresolution argv=screenresolution list 05:06:02 INFO - Available Modes on Display 0 05:06:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:02 INFO - Intel Iris: 05:06:02 INFO - Chipset Model: Intel Iris 05:06:02 INFO - Type: GPU 05:06:02 INFO - Bus: Built-In 05:06:02 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:02 INFO - Vendor: Intel (0x8086) 05:06:02 INFO - Device ID: 0x0a2e 05:06:02 INFO - Revision ID: 0x0009 05:06:02 INFO - Displays: 05:06:02 INFO - Display: 05:06:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:02 INFO - Display Serial Number: 1600x1200 60 05:06:02 INFO - Main Display: Yes 05:06:02 INFO - Mirror: Off 05:06:02 INFO - Online: Yes 05:06:02 INFO - Rotation: Supported 05:06:02 INFO - Return code: 0 05:06:02 INFO - Running post-action listener: _resource_record_post_action 05:06:02 INFO - [mozharness: 2017-03-08 13:06:02.938687Z] Finished run-tests step (success) 05:06:02 INFO - Running post-run listener: _resource_record_post_run 05:06:03 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 37987328; Write bytes: 513623040; Read time: 243; Write time: 1583 05:06:03 INFO - TinderboxPrint: CPU usage
53.9% 05:06:03 INFO - TinderboxPrint: I/O read bytes / time
37,987,328 / 243 05:06:03 INFO - TinderboxPrint: I/O write bytes / time
513,623,040 / 1,583 05:06:03 INFO - TinderboxPrint: CPU idle
2,219.5 (46.1%) 05:06:03 INFO - TinderboxPrint: CPU system
956.1 (19.8%) 05:06:03 INFO - TinderboxPrint: CPU user
1,642.1 (34.1%) 05:06:03 INFO - TinderboxPrint: Swap in / out
248,090,624 / 0 05:06:03 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205769216; Write bytes: 204314624; Read time: 15610; Write time: 431 05:06:03 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 35980288; Write bytes: 298466304; Read time: 223; Write time: 1116 05:06:03 INFO - Running post-run listener: _upload_blobber_files 05:06:03 INFO - Blob upload gear active. 05:06:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:03 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 05:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:06:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:04 INFO - (blobuploader) - INFO - Done attempting. 05:06:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:06:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:05 INFO - (blobuploader) - INFO - Done attempting. 05:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:06 INFO - (blobuploader) - INFO - Done attempting. 05:06:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:06:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:09 INFO - (blobuploader) - INFO - Done attempting. 05:06:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:09 INFO - Return code: 0 05:06:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb9ccef6f89117d7fa8a15e256bf56f5200cae24a67b58376aac21076cd96fc8fde91fe216d24fa5ee610eff436dcbb8a010b851ad232d1033d1929d3251f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66a27ee6b3f87f14bd8fec281346e750ad61aca83443243db2d4133c836243082a25eafa49ddb023003d2ea49dd29cfaf68d76a68149704e61fb89f298f2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb36fb227f28e1ec41cffa9771e018136c2da4522af0cc772568a0ac93d1f0e6ef76d78cc869380879d06381144a13166e5daa7ff275664debf44b0153164c3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c01a2988537f25c980c6749e9509ba4611a1df09f4af1ea43bd04c3dcf68e5111660ef9397afe340475c40ac9874ba39bcaee96701652454e95b9c41b6162c68"} 05:06:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:09 INFO - Contents: 05:06:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb9ccef6f89117d7fa8a15e256bf56f5200cae24a67b58376aac21076cd96fc8fde91fe216d24fa5ee610eff436dcbb8a010b851ad232d1033d1929d3251f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66a27ee6b3f87f14bd8fec281346e750ad61aca83443243db2d4133c836243082a25eafa49ddb023003d2ea49dd29cfaf68d76a68149704e61fb89f298f2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb36fb227f28e1ec41cffa9771e018136c2da4522af0cc772568a0ac93d1f0e6ef76d78cc869380879d06381144a13166e5daa7ff275664debf44b0153164c3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c01a2988537f25c980c6749e9509ba4611a1df09f4af1ea43bd04c3dcf68e5111660ef9397afe340475c40ac9874ba39bcaee96701652454e95b9c41b6162c68"} 05:06:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:09 INFO - Copying logs to upload dir... 05:06:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.552466 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-08 05:06:09.096661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 05:06:09.100448) ========= 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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb9ccef6f89117d7fa8a15e256bf56f5200cae24a67b58376aac21076cd96fc8fde91fe216d24fa5ee610eff436dcbb8a010b851ad232d1033d1929d3251f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66a27ee6b3f87f14bd8fec281346e750ad61aca83443243db2d4133c836243082a25eafa49ddb023003d2ea49dd29cfaf68d76a68149704e61fb89f298f2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb36fb227f28e1ec41cffa9771e018136c2da4522af0cc772568a0ac93d1f0e6ef76d78cc869380879d06381144a13166e5daa7ff275664debf44b0153164c3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c01a2988537f25c980c6749e9509ba4611a1df09f4af1ea43bd04c3dcf68e5111660ef9397afe340475c40ac9874ba39bcaee96701652454e95b9c41b6162c68"} build_url:https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb9ccef6f89117d7fa8a15e256bf56f5200cae24a67b58376aac21076cd96fc8fde91fe216d24fa5ee610eff436dcbb8a010b851ad232d1033d1929d3251f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d66a27ee6b3f87f14bd8fec281346e750ad61aca83443243db2d4133c836243082a25eafa49ddb023003d2ea49dd29cfaf68d76a68149704e61fb89f298f2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb36fb227f28e1ec41cffa9771e018136c2da4522af0cc772568a0ac93d1f0e6ef76d78cc869380879d06381144a13166e5daa7ff275664debf44b0153164c3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c01a2988537f25c980c6749e9509ba4611a1df09f4af1ea43bd04c3dcf68e5111660ef9397afe340475c40ac9874ba39bcaee96701652454e95b9c41b6162c68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 05:06:09.136226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 05:06:09.136587) ========= 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.6cGWEbcKXc/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.gvXSP0QjZC/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005359 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 05:06:09.185112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 05:06:09.185443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 05:06:09.185804) ========= ========= Total master_lag: 0.18 =========