builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0353 starttime: 1493305617.33 results: success (0) buildid: 20170427060725 builduid: 5db244d2a9ec4495bb9f8ac5b9289363 revision: 1475c20357cf9d509a7cc7ef80fad4deeaac3ba6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.333475) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.334175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.334668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.364442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.364837) ========= 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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-04-27 08:06:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2017-04-27 08:06:57 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.200098 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.590051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.590382) ========= 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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.026718 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:57.639312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-27 08:06:57.639681) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1475c20357cf9d509a7cc7ef80fad4deeaac3ba6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1475c20357cf9d509a7cc7ef80fad4deeaac3ba6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-04-27 08:06:57,741 truncating revision to first 12 chars 2017-04-27 08:06:57,742 Setting DEBUG logging. 2017-04-27 08:06:57,742 attempt 1/10 2017-04-27 08:06:57,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1475c20357cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 08:06:59,674 unpacking tar archive at: mozilla-beta-1475c20357cf/testing/mozharness/ program finished with exit code 0 elapsedTime=2.199406 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-27 08:06:59.865285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:59.865949) ========= script_repo_revision: 1475c20357cf9d509a7cc7ef80fad4deeaac3ba6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:59.866675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:59.867510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 08:06:59.888077) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-27 08:06:59.888567) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:07:00 INFO - MultiFileLogger online at 20170427 08:07:00 in /builds/slave/test 08:07:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:07:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:00 INFO - {'append_to_log': False, 08:07:00 INFO - 'base_work_dir': '/builds/slave/test', 08:07:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:07:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:00 INFO - 'branch': 'Mozilla-Beta', 08:07:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:00 INFO - 'config_files': ('talos/mac_config.py',), 08:07:00 INFO - 'default_actions': ('clobber', 08:07:00 INFO - 'read-buildbot-config', 08:07:00 INFO - 'download-and-extract', 08:07:00 INFO - 'populate-webroot', 08:07:00 INFO - 'create-virtualenv', 08:07:00 INFO - 'install', 08:07:00 INFO - 'run-tests'), 08:07:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:00 INFO - 'download_minidump_stackwalk': True, 08:07:00 INFO - 'download_symbols': 'ondemand', 08:07:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:00 INFO - 'gecko_profile': False, 08:07:00 INFO - 'gecko_profile_interval': 0, 08:07:00 INFO - 'installer_path': 'installer.exe', 08:07:00 INFO - 'log_level': 'info', 08:07:00 INFO - 'log_name': 'talos', 08:07:00 INFO - 'log_to_console': True, 08:07:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:07:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:07:00 INFO - 'opt_config_files': (), 08:07:00 INFO - 'pip_index': False, 08:07:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:07:00 INFO - 'cmd': ('bash', 08:07:00 INFO - '-c', 08:07:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:07:00 INFO - 'enabled': True, 08:07:00 INFO - 'halt_on_failure': False, 08:07:00 INFO - 'name': 'check_screen_resolution'},), 08:07:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:07:00 INFO - 'cmd': ('bash', 08:07:00 INFO - '-c', 08:07:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:07:00 INFO - 'enabled': True, 08:07:00 INFO - 'halt_on_failure': False, 08:07:00 INFO - 'name': 'check_screen_resolution'},), 08:07:00 INFO - 'run_cmd_checks_enabled': True, 08:07:00 INFO - 'suite': 'dromaeojs', 08:07:00 INFO - 'system_bits': '32', 08:07:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:00 INFO - 'title': 't-yosemite-r7-0353', 08:07:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:00 INFO - 'use_talos_json': True, 08:07:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:00 INFO - 'work_dir': 'build'} 08:07:00 INFO - [mozharness: 2017-04-27 15:07:00.100153Z] Running clobber step. 08:07:00 INFO - Running pre-action listener: _resource_record_pre_action 08:07:00 INFO - Running main action method: clobber 08:07:00 INFO - rmtree: /builds/slave/test/build 08:07:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:02 INFO - Running post-action listener: _resource_record_post_action 08:07:02 INFO - [mozharness: 2017-04-27 15:07:02.601246Z] Finished clobber step (success) 08:07:02 INFO - [mozharness: 2017-04-27 15:07:02.601507Z] Running read-buildbot-config step. 08:07:02 INFO - Running pre-action listener: _resource_record_pre_action 08:07:02 INFO - Running main action method: read_buildbot_config 08:07:02 INFO - Using buildbot properties: 08:07:02 INFO - { 08:07:02 INFO - "project": "", 08:07:02 INFO - "product": "firefox", 08:07:02 INFO - "script_repo_revision": "production", 08:07:02 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:07:02 INFO - "repository": "", 08:07:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:07:02 INFO - "buildid": "20170427060725", 08:07:02 INFO - "pgo_build": "False", 08:07:02 INFO - "basedir": "/builds/slave/test", 08:07:02 INFO - "buildnumber": 16, 08:07:02 INFO - "slavename": "t-yosemite-r7-0353", 08:07:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:07:02 INFO - "platform": "yosemite_r7", 08:07:02 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:07:02 INFO - "branch": "mozilla-beta", 08:07:02 INFO - "repo_path": "releases/mozilla-beta", 08:07:02 INFO - "revision": "1475c20357cf9d509a7cc7ef80fad4deeaac3ba6", 08:07:02 INFO - "stage_platform": "macosx64", 08:07:02 INFO - "builduid": "5db244d2a9ec4495bb9f8ac5b9289363", 08:07:02 INFO - "slavebuilddir": "test" 08:07:02 INFO - } 08:07:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 08:07:02 INFO - Running post-action listener: _resource_record_post_action 08:07:02 INFO - [mozharness: 2017-04-27 15:07:02.607492Z] Finished read-buildbot-config step (success) 08:07:02 INFO - [mozharness: 2017-04-27 15:07:02.607697Z] Running download-and-extract step. 08:07:02 INFO - Running pre-action listener: _resource_record_pre_action 08:07:02 INFO - Running main action method: download_and_extract 08:07:02 INFO - mkdir: /builds/slave/test/build/tests 08:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:02 INFO - trying https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 08:07:02 INFO - Downloading https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 08:07:03 INFO - Downloaded 1165 bytes. 08:07:03 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:07:03 INFO - Using the following test package requirements: 08:07:03 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:07:03 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:07:03 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 08:07:03 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:07:03 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 08:07:03 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:07:03 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:07:03 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 08:07:03 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:07:03 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:07:03 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 08:07:03 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:07:03 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 08:07:03 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:07:03 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 08:07:03 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:07:03 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 08:07:03 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 08:07:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:07:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:07:03 INFO - Fetch https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:07:05 INFO - Expected file size: 51225147 08:07:05 INFO - Obtained file size: 51225147 08:07:21 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:07:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:07:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:07:21 INFO - Fetch https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:07:23 INFO - Expected file size: 51225147 08:07:23 INFO - Obtained file size: 51225147 08:07:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 08:07:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 08:07:38 INFO - Fetch https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 08:07:40 INFO - Expected file size: 14404449 08:07:40 INFO - Obtained file size: 14404449 08:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:40 INFO - trying https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:07:40 INFO - Downloading https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 08:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 08:07:43 INFO - Downloaded 59541770 bytes. 08:07:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:07:43 INFO - mkdir: /builds/slave/test/properties 08:07:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:43 INFO - Contents: 08:07:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:07:44 INFO - Running post-action listener: _resource_record_post_action 08:07:44 INFO - Running post-action listener: set_extra_try_arguments 08:07:44 INFO - [mozharness: 2017-04-27 15:07:44.043661Z] Finished download-and-extract step (success) 08:07:44 INFO - [mozharness: 2017-04-27 15:07:44.043782Z] Running populate-webroot step. 08:07:44 INFO - Running pre-action listener: _resource_record_pre_action 08:07:44 INFO - Running main action method: populate_webroot 08:07:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:44 INFO - '--tppagecycles', 08:07:44 INFO - '7'], 08:07:44 INFO - 'tests': ['tsvgm']}}, 08:07:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:07:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:07:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:07:44 INFO - 'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:07:44 INFO - 'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['damp', 'tps']}, 08:07:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:07:44 INFO - 'tests': ['damp', 'tps']}, 08:07:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['dromaeo_dom']}, 08:07:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['basic_compositor_video']}, 08:07:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:07:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['a11yr', 08:07:44 INFO - 'ts_paint', 08:07:44 INFO - 'tpaint', 08:07:44 INFO - 'sessionrestore', 08:07:44 INFO - 'sessionrestore_no_auto_restore', 08:07:44 INFO - 'tabpaint']}, 08:07:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:07:44 INFO - 'ts_paint', 08:07:44 INFO - 'tpaint', 08:07:44 INFO - 'sessionrestore', 08:07:44 INFO - 'sessionrestore_no_auto_restore', 08:07:44 INFO - 'tabpaint']}, 08:07:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:07:44 INFO - 'ts_paint', 08:07:44 INFO - 'tpaint', 08:07:44 INFO - 'sessionrestore', 08:07:44 INFO - 'sessionrestore_no_auto_restore', 08:07:44 INFO - 'tabpaint']}, 08:07:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:07:44 INFO - 'ts_paint', 08:07:44 INFO - 'tpaint', 08:07:44 INFO - 'sessionrestore', 08:07:44 INFO - 'sessionrestore_no_auto_restore', 08:07:44 INFO - 'tabpaint']}, 08:07:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['a11yr', 08:07:44 INFO - 'ts_paint', 08:07:44 INFO - 'tpaint', 08:07:44 INFO - 'sessionrestore', 08:07:44 INFO - 'sessionrestore_no_auto_restore', 08:07:44 INFO - 'tabpaint']}, 08:07:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['a11yr', 08:07:44 INFO - 'ts_paint', 08:07:44 INFO - 'tpaint', 08:07:44 INFO - 'sessionrestore', 08:07:44 INFO - 'sessionrestore_no_auto_restore', 08:07:44 INFO - 'tabpaint']}, 08:07:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['tsvgx', 08:07:44 INFO - 'tsvgr_opacity', 08:07:44 INFO - 'tart', 08:07:44 INFO - 'tscrollx', 08:07:44 INFO - 'cart', 08:07:44 INFO - 'tsvg_static']}, 08:07:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:07:44 INFO - 'tsvgr_opacity', 08:07:44 INFO - 'tart', 08:07:44 INFO - 'tscrollx', 08:07:44 INFO - 'cart', 08:07:44 INFO - 'tsvg_static']}, 08:07:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:07:44 INFO - 'talos_options': ['--disable-e10s'], 08:07:44 INFO - 'tests': ['tp5o']}, 08:07:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:07:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:07:44 INFO - 'talos_options': ['--disable-e10s', 08:07:44 INFO - '--xperf_path', 08:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:44 INFO - 'tests': ['tp5n']}, 08:07:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:07:44 INFO - 'talos_options': ['--xperf_path', 08:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:44 INFO - 'tests': ['tp5n']}}, 08:07:44 INFO - 'talos.zip': {'path': '', 08:07:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:44 INFO - Running post-action listener: _resource_record_post_action 08:07:44 INFO - [mozharness: 2017-04-27 15:07:44.062660Z] Finished populate-webroot step (success) 08:07:44 INFO - [mozharness: 2017-04-27 15:07:44.062792Z] Running create-virtualenv step. 08:07:44 INFO - Running pre-action listener: _resource_record_pre_action 08:07:44 INFO - Running main action method: create_virtualenv 08:07:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:44 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 08:07:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:44 INFO - Using real prefix '/tools/python27' 08:07:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:47 INFO - Installing pip.................done. 08:07:47 INFO - Return code: 0 08:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:07:48 INFO - Reading from file tmpfile_stdout 08:07:48 INFO - Output received: 08:07:48 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) 08:07:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:48 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')]} 08:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:48 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')]} 08:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:48 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:07:48 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 08:07:48 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 08:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:48 INFO - 'HOME': '/Users/cltbld', 08:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:48 INFO - 'LOGNAME': 'cltbld', 08:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:48 INFO - 'MOZ_NO_REMOTE': '1', 08:07:48 INFO - 'NO_EM_RESTART': '1', 08:07:48 INFO - 'PAGER': '/bin/cat', 08:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:48 INFO - 'PWD': '/builds/slave/test', 08:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:48 INFO - 'SHELL': '/bin/bash', 08:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:07:48 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:48 INFO - 'USER': 'cltbld', 08:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:48 INFO - 'XPC_FLAGS': '0x0', 08:07:48 INFO - 'XPC_SERVICE_NAME': '0', 08:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:48 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 08:07:48 INFO - Cleaning up... 08:07:48 INFO - Return code: 0 08:07:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:07:48 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')]} 08:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:48 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')]} 08:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:48 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:07:48 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 08:07:48 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 08:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:48 INFO - 'HOME': '/Users/cltbld', 08:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:48 INFO - 'LOGNAME': 'cltbld', 08:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:48 INFO - 'MOZ_NO_REMOTE': '1', 08:07:48 INFO - 'NO_EM_RESTART': '1', 08:07:48 INFO - 'PAGER': '/bin/cat', 08:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:48 INFO - 'PWD': '/builds/slave/test', 08:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:48 INFO - 'SHELL': '/bin/bash', 08:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:07:48 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:48 INFO - 'USER': 'cltbld', 08:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:48 INFO - 'XPC_FLAGS': '0x0', 08:07:48 INFO - 'XPC_SERVICE_NAME': '0', 08:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:48 INFO - Downloading/unpacking psutil>=3.1.1 08:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:52 INFO - Installing collected packages: psutil 08:07:52 INFO - Running setup.py install for psutil 08:07:52 INFO - building 'psutil._psutil_osx' extension 08:07:52 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 08:07:53 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 08:07:53 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 08:07:53 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 08:07:53 INFO - building 'psutil._psutil_posix' extension 08:07:53 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 08:07:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:07:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:07:53 INFO - ^ 08:07:53 INFO - 1 warning generated. 08:07:53 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 08:07:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:53 INFO - Successfully installed psutil 08:07:53 INFO - Cleaning up... 08:07:53 INFO - Return code: 0 08:07:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:07:53 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')]} 08:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:53 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')]} 08:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:53 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:07:53 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 08:07:53 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 08:07:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:07:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:53 INFO - 'HOME': '/Users/cltbld', 08:07:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:53 INFO - 'LOGNAME': 'cltbld', 08:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:53 INFO - 'MOZ_NO_REMOTE': '1', 08:07:53 INFO - 'NO_EM_RESTART': '1', 08:07:53 INFO - 'PAGER': '/bin/cat', 08:07:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:53 INFO - 'PWD': '/builds/slave/test', 08:07:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:53 INFO - 'SHELL': '/bin/bash', 08:07:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:07:53 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:07:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:53 INFO - 'USER': 'cltbld', 08:07:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:53 INFO - 'XPC_FLAGS': '0x0', 08:07:53 INFO - 'XPC_SERVICE_NAME': '0', 08:07:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:07:56 INFO - Installing collected packages: mozsystemmonitor 08:07:56 INFO - Running setup.py install for mozsystemmonitor 08:07:56 INFO - Successfully installed mozsystemmonitor 08:07:56 INFO - Cleaning up... 08:07:56 INFO - Return code: 0 08:07:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:07:56 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')]} 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:56 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')]} 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:56 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:07:56 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 08:07:56 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 08:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:56 INFO - 'HOME': '/Users/cltbld', 08:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:56 INFO - 'LOGNAME': 'cltbld', 08:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:56 INFO - 'MOZ_NO_REMOTE': '1', 08:07:56 INFO - 'NO_EM_RESTART': '1', 08:07:56 INFO - 'PAGER': '/bin/cat', 08:07:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:56 INFO - 'PWD': '/builds/slave/test', 08:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:56 INFO - 'SHELL': '/bin/bash', 08:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:07:56 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:56 INFO - 'USER': 'cltbld', 08:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:56 INFO - 'XPC_FLAGS': '0x0', 08:07:56 INFO - 'XPC_SERVICE_NAME': '0', 08:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:07:57 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 08:07:57 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 08:07:57 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 08:07:57 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 08:07:57 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 08:07:57 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 08:07:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:07:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:00 INFO - warning: no files found matching '*.txt' 08:08:00 INFO - no previously-included directories found matching 'build' 08:08:00 INFO - no previously-included directories found matching 'dist' 08:08:00 INFO - no previously-included directories found matching '.git*' 08:08:00 INFO - Installing collected packages: jsonschema, functools32 08:08:00 INFO - Running setup.py install for functools32 08:08:00 INFO - warning: no files found matching '*.txt' 08:08:00 INFO - no previously-included directories found matching 'build' 08:08:00 INFO - no previously-included directories found matching 'dist' 08:08:00 INFO - no previously-included directories found matching '.git*' 08:08:00 INFO - Successfully installed jsonschema functools32 08:08:00 INFO - Cleaning up... 08:08:00 INFO - Return code: 0 08:08:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:00 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:08:00 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 08:08:00 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 08:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:00 INFO - 'HOME': '/Users/cltbld', 08:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:00 INFO - 'LOGNAME': 'cltbld', 08:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:00 INFO - 'MOZ_NO_REMOTE': '1', 08:08:00 INFO - 'NO_EM_RESTART': '1', 08:08:00 INFO - 'PAGER': '/bin/cat', 08:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:00 INFO - 'PWD': '/builds/slave/test', 08:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:00 INFO - 'SHELL': '/bin/bash', 08:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:08:00 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:00 INFO - 'USER': 'cltbld', 08:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:00 INFO - 'XPC_FLAGS': '0x0', 08:08:00 INFO - 'XPC_SERVICE_NAME': '0', 08:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:08:00 INFO - Cleaning up... 08:08:00 INFO - Return code: 0 08:08:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:00 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:08:00 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 08:08:00 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 08:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:00 INFO - 'HOME': '/Users/cltbld', 08:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:00 INFO - 'LOGNAME': 'cltbld', 08:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:00 INFO - 'MOZ_NO_REMOTE': '1', 08:08:00 INFO - 'NO_EM_RESTART': '1', 08:08:00 INFO - 'PAGER': '/bin/cat', 08:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:00 INFO - 'PWD': '/builds/slave/test', 08:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:00 INFO - 'SHELL': '/bin/bash', 08:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:08:00 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:00 INFO - 'USER': 'cltbld', 08:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:00 INFO - 'XPC_FLAGS': '0x0', 08:08:00 INFO - 'XPC_SERVICE_NAME': '0', 08:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:01 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 08:08:01 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 08:08:01 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 08:08:01 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 08:08:01 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 08:08:01 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 08:08:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:04 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 08:08:04 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 08:08:04 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 08:08:04 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 08:08:04 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 08:08:04 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 08:08:04 INFO - Downloading docopt-0.6.1.tar.gz 08:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:05 INFO - Running setup.py install for blobuploader 08:08:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:05 INFO - Running setup.py install for requests 08:08:05 INFO - Running setup.py install for docopt 08:08:05 INFO - Successfully installed blobuploader requests docopt 08:08:05 INFO - Cleaning up... 08:08:05 INFO - Return code: 0 08:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:05 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:08:05 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 08:08:05 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 08:08:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:08:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:05 INFO - 'HOME': '/Users/cltbld', 08:08:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:05 INFO - 'LOGNAME': 'cltbld', 08:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:05 INFO - 'MOZ_NO_REMOTE': '1', 08:08:05 INFO - 'NO_EM_RESTART': '1', 08:08:05 INFO - 'PAGER': '/bin/cat', 08:08:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:05 INFO - 'PWD': '/builds/slave/test', 08:08:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:05 INFO - 'SHELL': '/bin/bash', 08:08:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:08:05 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:08:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:05 INFO - 'USER': 'cltbld', 08:08:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:05 INFO - 'XPC_FLAGS': '0x0', 08:08:05 INFO - 'XPC_SERVICE_NAME': '0', 08:08:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-rY0QUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-WlqnfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-o4Cq75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-v3_rxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-pTu8sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-sVzZRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-BvGXhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Ix2uPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-qLDjQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-9Shqn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-itDvo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-HGgJD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-uulIB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-hlk11r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-EKuNqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-CwZHMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-J2dJgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:08 INFO - Running setup.py install for manifestparser 08:08:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:08 INFO - Running setup.py install for mozcrash 08:08:08 INFO - Running setup.py install for mozdebug 08:08:08 INFO - Running setup.py install for mozdevice 08:08:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:08 INFO - Running setup.py install for mozfile 08:08:08 INFO - Running setup.py install for mozhttpd 08:08:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:08 INFO - Running setup.py install for mozinfo 08:08:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Running setup.py install for mozInstall 08:08:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Running setup.py install for mozleak 08:08:09 INFO - Running setup.py install for mozlog 08:08:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Running setup.py install for moznetwork 08:08:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Running setup.py install for mozprocess 08:08:09 INFO - Running setup.py install for mozprofile 08:08:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:09 INFO - Running setup.py install for mozrunner 08:08:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Running setup.py install for mozscreenshot 08:08:10 INFO - Running setup.py install for moztest 08:08:10 INFO - Running setup.py install for mozversion 08:08:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:10 INFO - Cleaning up... 08:08:10 INFO - Return code: 0 08:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:10 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:08:10 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 08:08:10 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 08:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:10 INFO - 'HOME': '/Users/cltbld', 08:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:10 INFO - 'LOGNAME': 'cltbld', 08:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:10 INFO - 'MOZ_NO_REMOTE': '1', 08:08:10 INFO - 'NO_EM_RESTART': '1', 08:08:10 INFO - 'PAGER': '/bin/cat', 08:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:10 INFO - 'PWD': '/builds/slave/test', 08:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:10 INFO - 'SHELL': '/bin/bash', 08:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:08:10 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:10 INFO - 'USER': 'cltbld', 08:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:10 INFO - 'XPC_FLAGS': '0x0', 08:08:10 INFO - 'XPC_SERVICE_NAME': '0', 08:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:10 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8hCGb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-9Nzipj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-rmJtf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-7PKdWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-qaIFg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-PhWBl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-w2Yh75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-UMonC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-JOSKj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-quVshx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:11 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)) 08:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:11 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-KwrSHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Bcij_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-lDwz5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-k8msrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-jJwOct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-sM4czq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:12 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)) 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-u3_wBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 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)) 08:08:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:12 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 08:08:12 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 08:08:12 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 08:08:12 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 08:08:12 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 08:08:12 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 08:08:15 INFO - Downloading blessings-1.6.tar.gz 08:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:15 INFO - Installing collected packages: blessings 08:08:15 INFO - Running setup.py install for blessings 08:08:15 INFO - Successfully installed blessings 08:08:15 INFO - Cleaning up... 08:08:15 INFO - Return code: 0 08:08:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:15 INFO - Reading from file tmpfile_stdout 08:08:15 INFO - Current package versions: 08:08:15 INFO - blessings == 1.6 08:08:15 INFO - blobuploader == 1.2.4 08:08:15 INFO - docopt == 0.6.1 08:08:15 INFO - functools32 == 3.2.3-2 08:08:15 INFO - jsonschema == 2.5.1 08:08:15 INFO - manifestparser == 1.1 08:08:15 INFO - mozInstall == 1.12 08:08:15 INFO - mozcrash == 1.0 08:08:15 INFO - mozdebug == 0.1 08:08:15 INFO - mozdevice == 0.49 08:08:15 INFO - mozfile == 1.2 08:08:15 INFO - mozhttpd == 0.7 08:08:15 INFO - mozinfo == 0.9 08:08:15 INFO - mozleak == 0.1 08:08:15 INFO - mozlog == 3.4 08:08:15 INFO - moznetwork == 0.27 08:08:15 INFO - mozprocess == 0.25 08:08:15 INFO - mozprofile == 0.28 08:08:15 INFO - mozrunner == 6.13 08:08:15 INFO - mozscreenshot == 0.1 08:08:15 INFO - mozsystemmonitor == 0.3 08:08:15 INFO - moztest == 0.8 08:08:15 INFO - mozversion == 1.4 08:08:15 INFO - psutil == 3.1.1 08:08:15 INFO - requests == 1.2.3 08:08:15 INFO - wsgiref == 0.1.2 08:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:15 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')]} 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 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')]} 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:08:15 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 08:08:15 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 08:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:15 INFO - 'HOME': '/Users/cltbld', 08:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:15 INFO - 'LOGNAME': 'cltbld', 08:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:15 INFO - 'MOZ_NO_REMOTE': '1', 08:08:15 INFO - 'NO_EM_RESTART': '1', 08:08:15 INFO - 'PAGER': '/bin/cat', 08:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:15 INFO - 'PWD': '/builds/slave/test', 08:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:15 INFO - 'SHELL': '/bin/bash', 08:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:08:15 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:15 INFO - 'USER': 'cltbld', 08:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:15 INFO - 'XPC_FLAGS': '0x0', 08:08:15 INFO - 'XPC_SERVICE_NAME': '0', 08:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 INFO - Cleaning up... 08:08:16 INFO - Return code: 0 08:08:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:16 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')]} 08:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:16 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')]} 08:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:16 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 0x103472b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd653db8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, '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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 08:08:16 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 08:08:16 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 08:08:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:08:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:16 INFO - 'HOME': '/Users/cltbld', 08:08:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:16 INFO - 'LOGNAME': 'cltbld', 08:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:16 INFO - 'MOZ_NO_REMOTE': '1', 08:08:16 INFO - 'NO_EM_RESTART': '1', 08:08:16 INFO - 'PAGER': '/bin/cat', 08:08:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:16 INFO - 'PWD': '/builds/slave/test', 08:08:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:16 INFO - 'SHELL': '/bin/bash', 08:08:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:08:16 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:08:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:16 INFO - 'USER': 'cltbld', 08:08:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:16 INFO - 'XPC_FLAGS': '0x0', 08:08:16 INFO - 'XPC_SERVICE_NAME': '0', 08:08:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:08:16 INFO - Cleaning up... 08:08:16 INFO - Return code: 0 08:08:16 INFO - Running post-action listener: _resource_record_post_action 08:08:16 INFO - Running post-action listener: _start_resource_monitoring 08:08:16 INFO - Starting resource monitoring. 08:08:16 INFO - [mozharness: 2017-04-27 15:08:16.531906Z] Finished create-virtualenv step (success) 08:08:16 INFO - [mozharness: 2017-04-27 15:08:16.532902Z] Running install step. 08:08:16 INFO - Running pre-action listener: _resource_record_pre_action 08:08:16 INFO - Running main action method: install 08:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:16 INFO - Reading from file tmpfile_stdout 08:08:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:16 INFO - Reading from file tmpfile_stdout 08:08:16 INFO - Output received: 08:08:16 INFO - Usage: mozinstall [options] installer 08:08:16 INFO - Options: 08:08:16 INFO - -h, --help show this help message and exit 08:08:16 INFO - -d DEST, --destination=DEST 08:08:16 INFO - Directory to install application into. [default: 08:08:16 INFO - "/builds/slave/test"] 08:08:16 INFO - --app=APP Application being installed. [default: firefox] 08:08:16 INFO - mkdir: /builds/slave/test/build/application 08:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:08:32 INFO - Reading from file tmpfile_stdout 08:08:32 INFO - Output received: 08:08:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:08:32 INFO - Running post-action listener: _resource_record_post_action 08:08:32 INFO - [mozharness: 2017-04-27 15:08:32.032764Z] Finished install step (success) 08:08:32 INFO - [mozharness: 2017-04-27 15:08:32.032876Z] Running run-tests step. 08:08:32 INFO - Running pre-action listener: _resource_record_pre_action 08:08:32 INFO - Running main action method: run_tests 08:08:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:08:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:08:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:08:32 INFO - 2017-04-27 08:08:32.047 screenresolution[1629:7406] starting screenresolution argv=screenresolution get 08:08:32 INFO - 2017-04-27 08:08:32.050 screenresolution[1629:7406] Display 0: 1600x1200x32@60 08:08:32 INFO - 2017-04-27 08:08:32.055 screenresolution[1630:7408] starting screenresolution argv=screenresolution list 08:08:32 INFO - Available Modes on Display 0 08:08:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:08:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:08:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:08:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:08:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:08:32 INFO - Intel Iris: 08:08:32 INFO - Chipset Model: Intel Iris 08:08:32 INFO - Type: GPU 08:08:32 INFO - Bus: Built-In 08:08:32 INFO - VRAM (Dynamic, Max): 1536 MB 08:08:32 INFO - Vendor: Intel (0x8086) 08:08:32 INFO - Device ID: 0x0a2e 08:08:32 INFO - Revision ID: 0x0009 08:08:32 INFO - Displays: 08:08:32 INFO - Display: 08:08:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:08:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:08:32 INFO - Display Serial Number: 1600x1200 60 08:08:32 INFO - Main Display: Yes 08:08:32 INFO - Mirror: Off 08:08:32 INFO - Online: Yes 08:08:32 INFO - Rotation: Supported 08:08:32 INFO - Return code: 0 08:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:32 INFO - Python 2.7.3 08:08:32 INFO - Return code: 0 08:08:32 INFO - grabbing minidump binary from tooltool 08:08:32 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')]} 08:08:32 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 0x103250d30>, '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 0x103177db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103245be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:32 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 08:08:32 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 08:08:32 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 08:08:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:32 INFO - Return code: 0 08:08:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:08:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:32 INFO - ENV: RUST_BACKTRACE is now 1 08:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 08:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 08:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZeNh7cdhav/Render', 08:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:32 INFO - 'HOME': '/Users/cltbld', 08:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:32 INFO - 'LOGNAME': 'cltbld', 08:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:32 INFO - 'MOZ_NO_REMOTE': '1', 08:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:32 INFO - 'NO_EM_RESTART': '1', 08:08:32 INFO - 'PAGER': '/bin/cat', 08:08:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:32 INFO - 'PWD': '/builds/slave/test', 08:08:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:32 INFO - 'RUST_BACKTRACE': '1', 08:08:32 INFO - 'SHELL': '/bin/bash', 08:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1x6QYXmwZ/Listeners', 08:08:32 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 08:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:32 INFO - 'USER': 'cltbld', 08:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:32 INFO - 'XPC_FLAGS': '0x0', 08:08:32 INFO - 'XPC_SERVICE_NAME': '0', 08:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 08:08:32 INFO - mozversion application_buildid: 20170427060725 08:08:32 INFO - mozversion application_changeset: 1475c20357cf9d509a7cc7ef80fad4deeaac3ba6 08:08:32 INFO - mozversion application_display_name: Firefox 08:08:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:32 INFO - mozversion application_name: Firefox 08:08:32 INFO - mozversion application_remotingname: firefox 08:08:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:08:32 INFO - mozversion application_vendor: Mozilla 08:08:32 INFO - mozversion application_version: 54.0 08:08:32 INFO - mozversion platform_buildid: 20170427060725 08:08:32 INFO - mozversion platform_changeset: 1475c20357cf9d509a7cc7ef80fad4deeaac3ba6 08:08:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:08:32 INFO - mozversion platform_version: 54.0 08:08:32 INFO - using testdate: 1493305712 08:08:32 INFO - actual date: 1493305712 08:08:32 INFO - starting webserver on 'localhost:49236' 08:08:32 INFO - SUITE-START | Running 2 tests 08:08:32 INFO - TEST-START | dromaeo_css 08:08:32 INFO - operating with platform_type : mac_ 08:08:32 INFO - Initialising browser for dromaeo_css test... 08:08:32 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpvldsvV/profile http://localhost:49236/getInfo.html) 08:08:35 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 08:08:35 INFO - PROCESS | 1640 | colorDepth:24 08:08:35 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 08:08:35 INFO - PROCESS | 1640 | __metrics 08:08:35 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:08:35 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:36 INFO - TEST-INFO | 1640: exit 0 08:08:36 INFO - Browser initialized. 08:08:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:36 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpvldsvV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:48 INFO - PROCESS | 1643 | RSS: Main: 165228544 08:08:48 INFO - PROCESS | 1643 | 08:11:51 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:11:53 INFO - PROCESS | 1643 | RSS: Main: 321847296 08:11:53 INFO - PROCESS | 1643 | 08:14:56 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:14:57 INFO - PROCESS | 1643 | RSS: Main: 304791552 08:14:57 INFO - PROCESS | 1643 | 08:17:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 08:18:00 INFO - PROCESS | 1643 | RSS: Main: 287862784 08:18:00 INFO - PROCESS | 1643 | 08:21:02 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 08:21:03 INFO - PROCESS | 1643 | RSS: Main: 273952768 08:21:03 INFO - PROCESS | 1643 | 08:24:06 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:24:07 INFO - PROCESS | 1643 | RSS: Main: 270147584 08:24:07 INFO - PROCESS | 1643 | 08:27:10 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:27:11 INFO - PROCESS | 1643 | RSS: Main: 334770176 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | __start_tp_report 08:27:11 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 08:27:11 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 08:27:11 INFO - PROCESS | 1643 | |i|pagename|runs| 08:27:11 INFO - PROCESS | 1643 | |0;dojo.html;3527.805970671613;3567.3222087803333;3573.624769399213;3598.5142005829207;3618.0231337538867;6167.7841275555365;6177.814665560035;6207.224096987877;6211.975024121015;6220.7822726204595;6149.046897730847;6188.164597779299;6202.596831205969;6205.627662340252;6229.065640153979;5566.3598686151;5581.665100093987;5595.4124816894255;5664.54683625309;5756.165356023374;5487.42382049885;5505.697186654733;5709.229254050712;5721.199032135504;5729.627574207684;5527.336719593654;5566.805161819337;5587.38538760736;5589.776408943638;5592.496675299222;5300.284461597674;5313.3092697949405;5332.600054995891;5353.518183363516;5363.517283444469;5231.398389185254;5310.309659744247;5313.628046036779;5316.9734151329385;5343.171808369709;5780.046292361755;5827;5914.467697907209;6015.819525414201;6041.939580604182;6307.716152773136;6321.336259692712;6325.430711235965;6438.6136831790245;6492.545521813475;6631.635260060695;6669.799906002828;6684.966575167093;6686.966565167192;6693.531452798306;6264.21697287839;6265.749370025239;6313.55805093639;6318.620882746958;6328.968355158195;6415.871682566322;6473.708683109271;6565.441937435371;6742.561733487308;6782.084418603524;6278.152449419361;6332.4934005279465;6342;6377.872442551123;6474.805755827333;6600.471962243009;6612.603243805291;6650.833729156713;6654.866902662016;6670.666466676646;6539.346065393423;6539.640319782363;6541.542092053605;6546.836329091716;6558.049082882955;6272.2159730033745;6299;6301.054841773771;6537.477001839841;6560.179977502812;5178.585713143015;5256.08018596744;5325.920111198335;5343.812966546152;5355.758990845344;4733.384659994247;4738.123447162286;4745.976270118627;4756.334113224151;4795.688280261772;6125.418085281891;6272.749090036347;6284.151639528605;6284.37156284377;6291.716872740738;6393.041043843461;6441.774537891151;6564.901526477107;6585.5719378240265;6585.80242592723;6241.282252540925;6247.406496382836;6267.373262673696;6284.937150628435;6289.433950944345;5810.157527158538;5825.7087145642545;5853.619514731528;5855.912161317584;5889.8233053007625;6566.24488183865;6621.139251897415;6764.93235067643;6805.353491418307;6829;6678;6689.264180939996;6706.094677218513;6719.966400167968;6720.361565651256;6879.724811007503;6884.793456196122;6887.931120688729;6899.344562266577;6904.482163837632;6245.3754624539;6317.30509643948;6473.093766872736;6473.417392434515;6530.444912182517;6424.839379015375;6439.066335381437;6443.677816109082;6444.7744328948265;6446.9032964506505;6296.748130074746;6343.873122537431;6359.650219237987;6407.679616019087;6418.454431373386;6216.2540495140875;6245.68771561411;6292.4966002720585;6314;6378.90431643535;6321.5574909757715;6326.778562750282;6332.620042797447;6332.841678958063;6334.588251763621;5554.916676249779;6443.0335449682925;6449.7097630605795;6451.0968464415955;6451.903221451588;6196.938030619636;6228.377162283736;6231.003039513656;6247.5001999839;6261.906071409024 08:27:11 INFO - PROCESS | 1643 | |1;ext.html;687.7249100359857;769.8344855855989;802.7671975127212;898.74385800047;900.464223786847;29269.853650731744;29584;30494.84752576237;41195.382069268984;41272;42041;42173.57826421735;42290.57709422905;42387.940301492476;42417.57582424175;9420.010898855608;9572.377795443308;9578.616855325814;9584.04159584043;9597.520123993807;7737.226277372274;7864.528128312291;9562.665306714267;9684.273679474032;11704.06367490603;10750.462476876164;11007.569016027905;11802.46888890002;11843.170978031541;11904.821427678591;11753.588624398148;11770.823437648442;11797.646070617895;11798.46906889192;11831.053515718722;11511.30932144074;11565.94217028918;11575.958163765217;11589.188756787029;11613;39908.60091399107;40161;40176.19647607061;40222.396664050066;40425.595744042774;3935.232629637222;4016.136530645925;4017.7388469749667;4033.173199494126;4080.2655522006025;24827.13105041333;28170.577441338395;28679.56980645292;29959;30733.538996914842;3189.9154287542115;3243.8215898125595;3288.2765791525826;3341.3150304187584;3415.4364529852546;351891.24054379563;352149;355869;355872;356352.2182389097;52500.474995249555;52542.73728631409;52567.21149182766;52576.47423525792;52673.2099018515;54745.72627136839;54750.45249547533;54753;54800;54853.72573137109;15561.766573501407;15670.529884103495;15679;15699;15722.05667659944;13170.07809453329;13198.47206111764;13198.736025279633;13199.47202111924;13218.669533261553;10983.39591322469;11169.664910052712;11361.943190283995;11406.771864562663;12657.493700252071;4363.439437857557;4913.115639184981;5538.113901775697;5733.741981610838;5757.165211044459;764.7094104240354;911.4759013567093;925.2274350916925;932.3753085432776;954.2070270674016;28532;28656.856715716287;28918.987835425658;29078.836846526327;29161.125166245045;870.7910101575703;1056.3872953686844;1298.688314804459;1305.11252348404;1317.8616245294106;14355;14376.496822611367;14579;14666.43337415948;14692.559223223321;434892;435451;436098;436299;437905;58246.12630810541;58298.4170158293;58302.7084864573;58319.70840145772;58363.708181458824;1464.985350146485;1471.3967273418275;1515.5226103777495;1519.840416756247;1526.8549487798864;25760.742392576583;26802.329941751614;27072.32319192036;27133.592996105468;27145.86427067931;47483.52516474791;47594;47645.76177119092;47693.761531192125;47734.80662983453;355621;404871.902561953;409577;409647;410609;35290.82354588211;35926.461103082955;35963.64036359603;36000.27999440049;36123;35560.82219588885;43488.78255608702;44410;45054;51301.48698513117;33983.980480585626;34536.48195277123;34567.481487778205;34623.480647790806;35848.64151358453;34222.48666269958;35073.29853402969;35363.823180883934;35487.467687984186;35650.8217458911;41309.38035929403;42144.78927605342;42491.36262955996;42705.57294427016;42979.71060868179;30994.380112398077;34809.955701329;34842.65157348394;35370;35996;21425.785742143;23869.64195537103;26869.462610748065;27559.448811024067;27807.582886257125 08:27:11 INFO - PROCESS | 1643 | |2;jquery.html;380.3818794459004;400.90177906412936;413.64013308421676;421.47526329719494;456.92460743977244;13861.445542178313;15736.842631573694;21732.565348693017;22108.115675372985;22602.095916163333;22935.885320573416;23143;23490.64764028541;23638.645420318666;23787.405314867137;6521.771737989171;7054.329838665319;7132.251113633071;7139.9286007140045;7142.642867856586;6722.462203023746;6937.167539895195;6947.4789390795895;7037.049998250248;7075.398591119761;6995.5802651840795;7008.194057683355;7011.859762804766;7014.263502332258;7018.263082376354;6759.290274521179;7005.29947005298;7060.364567188926;7069.717211311593;7077.07997960267;6878.621675807829;6886.139232595926;7024.367806897352;7296.890546641805;7438.73964411243;23747.525049498912;23983.28050158498;25606.87196564024;25659.1019314325;25848.8707556461;2908.7672986161056;3145.072203699914;3433.5105061845065;3562.1806984393734;3582.731295152874;13171.802422963663;15749.68500629981;17688;18577.349792757323;18585.977771222577;2112.197365001305;2167.1439781286463;2172.728408948881;2188.081005977493;2247.0899285789283;131494;134476.98284525838;155798;158475;163234.18382908127;17560.38538651141;19135.712964305545;20720.58558828815;23187;24806.131785387424;41982.950426239586;42773.57226427758;43119.353209701876;43147.56852431435;43195.78402107969;9427.010163932688;10286.845697314546;10411;10584.841227381596;10783.13734901206;8963.596638151299;8966.820663586692;8982;9165.450072995642;9167.404118732395;7452.751931399159;9246.4914429707;9276.11876871696;9704.9029509704;9705.417674939385;3376.4766461198556;3949.7827619481204;3979.602039796055;4003.6997225208224;4019.376996565537;897.546738896853;918.6187732091241;924.6070420071577;948.3029972969862;975.5756246032998;20344.287949921683;22193.889030554743;22229.221977230718;22244.666330005064;22274.777252227595;938.2165891480554;938.4885237545554;964.7395203295071;969.5152423788106;972.557486343712;11167.106631469464;11374.578177727784;11395.715107122389;11583.594574190032;11596.710082247842;359625;553036.8785248545;777151;782111;806153;155543.4445655529;159197;159971;160948;166281;1219.6950762309423;1248.375812093953;1277.2528071078523;1283.076185146693;1283.159530507519;18977.33579324717;19057.71413428772;19291.035448227813;19351.322703705864;19367.90316048467;63993.68003159954;64491;64832;65487;65985.67007164934;89985;91254.54372728094;92026.07973920443;92802.07197927934;92943.14113717552;11191.2725672831;11650.6504804856;11686.24039437434;11757.88242117602;11762.176647634584;12758.48966041348;12837.871621283668;12889.226646401246;13197;13285.933570332087;11084.168687348643;11112.111031117653;11442.084633229488;11508.94245528767;11552.595659152226;10281.84577231357;10433.791324173322;10443.530041148319;10656.413897235416;10682;11612.88387116118;11645.534178632759;11649.301041937511;11858.347790871585;11899.881001189877;11490.834584895674;11493.367864767519;11791.410429478663;11829.408529573659;11850;11342.886571134182;11403.372814495282;11405.54377824911;11431.485583148611;11691.298522088362 08:27:11 INFO - PROCESS | 1643 | |3;mootools.html;1605.1492708864298;1613.1530946253222;1613.7418013117904;1619.8218195998445;1641.2204203003573;10965;11620.070394368451;11625.244359116652;11638.010769084616;11638.301701897892;10542.683719488408;10833.29583577067;11004.504797284122;11015.173861960346;11276.097912167006;2412.071352529276;2448.7796098351146;2455.9631605525933;2457.987710061447;2461.5815311397105;2349.4126468382906;2445.254197469771;2447.290285817111;2451.2278632230878;2460.520198561281;2369.834111612188;2436.1229957215387;2449.5670033030697;2474.7772700456953;2487.2911220302217;2352.5530149271585;2448.779609835123;2457.33651913984;2458.201084647497;2458.21337172105;2424.9757502424927;2447.36368544178;2451.718052423976;2452.3869032741813;2463.802895768334;11182.16133789969;11473.08215342779;11482.88517114835;11492.712682182928;11506.654800356002;5921.970390148064;6082.5742198046155;6087.421694938974;6092.847678808021;6093.512518998469;3167.303193297471;3259.728705804738;3586.659267369596;3694.9261014779822;3749.625037496256;1252.536561472252;1258.9802260169292;1281.852896398538;1301.4512729851542;1310.8230388897473;13893.16641001533;14139.363728632236;14528.709425811425;16104.355825766956;16282.348706051744;4651.930221046687;4833.830815921426;4834.009028149221;4868;4880.219164933665;12161.209521381259;12173.391330433444;12186.903178713957;12197.878021219853;12204;5032;5190.948090519122;5779.306483221956;5929.436703513159;5980.192673988956;5207.4011488678525;5395.487428694268;5443.972780136153;5458.317710286215;5458.672479651154;3969.8809035728973;4005.539362973237;4031.7984100794843;4111.8560850370095;4138.565450627701;1041.0214398465419;1044.1907521670767;1044.6761503933806;1060.5598676549146;1062.293574772783;961.1781926452783;983.8819341678901;989.6486747204783;990.1979396688705;1000.6347683095618;6686.7993960181275;6770.458363330922;6810.31896810315;6844.28135045823;6922.7923162305215;1004.3070281505737;1006.6728313298207;1013.2901102288656;1044.070777008463;1054.404261592198;3326.9852694927795;3808.3716186828865;4296.871093867189;4350.347447882779;4350.694791562519;13431.529896453578;13618.523351682643;13757.587272381845;14039.368228429541;14105.36525856339;13599.660008499866;13889.652758681113;13992.370343334574;13993.3702983366;14102.929485352714;10001.399916005063;10189.949050254701;10391.649085618821;10484.790304193873;10487.737806554896;7184.209736929038;7218.711251549879;7235.855282894207;7326.267373262631;7434.73978410753;11407.25852819564;12582.559610413591;12778.744425111632;13013.349332533146;13205.207687538394;12110.576129835414;12615.621531354074;13096.869031309565;13208.27354495512;13328.666783330107;9282.675106371245;9590.952045239728;9602.66390676323;9615.990321016192;9616.95191524038;10287.022732840369;10369.429681367295;10459.895401046197;10483.108935740242;10484.737881552717;8845.55772211374;8985.775355616162;9034.683786067457;9048.819023619622;9188.310876684409;8705.651773928972;8723.432976856484;8758.562071896507;8811;8816.338774591803;8097.676092956216;8111.66157583992;8201.507909525448;8206.179382061984;8220.794480138044;5886.764529418947;5912.142739302863;5962.731677074456;6079.544034197541;6139.693015349126;5971.611845230046;6137.048757442603;6148.200733904564;6162.691865406801;6292.307846137013 08:27:11 INFO - PROCESS | 1643 | |4;prototype.html;384.3466107617051;386.62883631713555;387.3763241181697;391.92161567686463;393.66735108833046;4487.775611219438;4573.565511276432;5011.548960593545;5208.166693329068;5306.416294207639;4476.776161191944;5139.486051394868;5223.171889838554;5284.497972692588;5309.389420216677;3435.587729472467;3769.9057523561924;4311.504177019651;4402;4438.9556104439025;3951.6443520083185;4267.893302667442;4325.502567204764;4406.867793966187;4517.638588912879;3967.1750994542545;3968.8214030368704;4036.313826649462;4446.377507149002;4484.66365022623;3818.0982453335387;4257.87226383209;4283.485981682187;4436.55634436557;4437.267850804614;3385.610654774683;3593.4969104325414;3869.941950870739;3984.800759962019;4004.83980640774;4373.91425890057;4640.83757068501;4692.507286734912;5107.591392688576;5173.120569503193;4317.158154159909;4691.3432119503295;4907.288443175756;4921.586255119376;4989.775460104268;4635.629149668019;5148.304978827848;5171.793128274864;5606.467385598362;5620.246079421095;4392.3191905254735;4440.866773996785;4447.888802779924;4515.4129963104915;4580.381648477446;5322.840314790563;5393.393093460519;5555.944440555583;5639.533721232468;5967.49276311514;3842.8078596070086;3930.606939306104;4138.048248902769;4244.575542445731;4613.76931153441;4659.301104834302;4669.182892993713;4708.552687494683;4709.529047095331;4775.880602984884;4499.572540608637;4500.3249512573375;4810.302506136591;5008.574271186917;5042.377963458981;5265.289185959923;5562.415946325658;5645.350784659817;5692.430756924357;5693.0111691361535;1439.5537383411177;1465.3479201755117;1614.1283706798433;1614.4510866305513;1621.5297563706392;1040.1003132290514;1044.9373037617768;1123.5786580032488;1187.98636311453;1217.7442737025324;4726.092384519351;4763.76181190939;5039.521245481674;5223.876866473726;5232.502912223333;5239.904038384677;5400.594955378362;5569.443055694398;5782.855428614318;5825.563082768809;4515;4945.480724523945;5105.2086926526445;5327.680339179662;5412.296401467784;2636.866147556531;2827.886884524637;2888.870000849967;2951.6605590356953;2984.373281610886;5679.346875109332;5696.088625819932;5851.707414629337;5923.348431672513;6119.326874043852;5487.396386397493;5550.501364631607;5765.971170144123;5978.671173085435;6022.969885150634;4888.633352498577;5150.845474635767;5175.948240517622;5479.808206712746;5914.319853216849;5545.7522057538345;5746.856328591819;5765.481106700249;5907.4683278505145;5930.940690593039;5015.614460239251;5302.7083510405755;5679.949209396275;5684.459976302244;5735.397783232867;5211.290129132905;5651.665517344786;5981.312149102909;6129.754809807558;6139.877202455837;4285.992791694011;4923.138450771029;5015.297858299914;5134.5378915897745;5156.484351564814;5070.599811201059;5483.314585676791;5517.841253336845;5599.468050535193;5732.541396688338;4991.900161996812;5253.395859476209;5498.752556135064;5542.944570554404;5771.480566749013;5052.9388828346455;5072;5291;5364.8122315718765;5383.892322153613;4581.839635612738;4867.367242258625;4976.527229913152;5444.8094316698725;5463.994802858332;5574.386817450159;5653.8267485250535;5664.224529980363;5669.262995810518;5723.627964182315;4563.840265590688;5078.695278283315;5479.808206712905;5511.208857121372;5574.108142697149 08:27:11 INFO - PROCESS | 1643 | |5;yui.html;791.4380789639356;805.4563169860343;832.5629044751508;883.2139395937617;884.7257350221431;15616.76574851378;16987.74518382225;17382.478525644252;17732.73400898986;17783.55541111473;15603.84396156038;15954.84045159548;16255;16263.430779922704;16357.345706171738;845.9280961118297;963.8506031565119;964.4358050540442;965.3194497878978;965.7102869139266;973.7127547373507;976.838821594436;995.4723996281946;1022.2333250062453;1026.1431704526728;1058.253930978662;1059.332620449116;1059.8781140168903;1059.9576016959313;1060.3266925502323;1054.6045233037612;1055.7360659835003;1055.9788804223872;1056.1392465140887;1056.487603512296;784.6116172494594;785.6189747972229;786.1784435265162;786.2609147401424;786.8465649198408;17377.47867563975;17514.036727979958;17571.648567028587;18203.180856861472;18485.2605895764;12975;14538.854611453857;14809;15123.395064197419;15659.765103523456;11361.886381136166;11878.40607969598;12295.385230738428;12490.25058496484;12694.238345699288;3972.165845172517;4075.1849630073807;4098.979505102485;4194.328907374806;4208.26355387809;104330;104776.95223047749;106307;106761;107340;11617.302961822317;11877.821832672516;11977.580784672495;11985;12104.757904841854;26385.868070659522;26411.603825942628;26667.599986000227;26806.463870722477;27152.592711109348;8415.11641277657;8468.170721357148;8475.237228649452;8703.825923481494;8868;4510.797014134372;4620.514845941195;4680.578747912704;4685.297205419146;4691.62467002639;3790.886273411802;3827.78947157909;3838.673712734449;3879.0690234343556;3889.4749208857006;604.145134634496;667.5966520526164;676.479111084472;680.8263892707328;689.4105539763531;647.8088963755704;700.4221517248291;702.3959394920364;707.5601151656457;735.1297653048554;10628.840567391495;10675.412852293199;10778.838317425245;11149.721256968478;11291.661250162508;647.8736646353916;704.1409480433863;713.5290708132608;715.3025799845109;720.2509390234097;4543.432070991126;5125.384953805567;5336.332958380202;5340.839774806762;5358.5981051421295;93920;97076.51461742647;107517.46241268744;108584.37123443154;115963.42018290023;54681.45318546764;75774;92547.44715317103;92743.14513709822;95825;74534.62732686302;74905.62547187229;76833.6158319216;79737;80914.59542702249;8730.34522410809;11032.724181895517;11084.778304434027;11435.313881167156;11441.713957151138;46566.30150547677;46933.06133877235;47068.529314706415;51422.22866656928;53589;69364.30635693579;70213.94679079921;70501;72526;73708;13107.475700971854;13440.596782096552;13457.327133643474;13780.242086684928;13974.371153297923;14973.475928342456;14978.251087445366;15592;15909.443169489012;16631.91684041572;12828.55100071493;14122.223277719413;14665.48670796517;14849;15332.15673137988;14129.293535323399;14282.285885705465;14828;15053.77419338689;15213.163276019483;13271.270080145685;13361.53234636783;13780.862191377957;14057.086289391156;14215.786763198766;8824.64701411962;10556.89443105559;10845.634659285084;10961.671149865517;11300.547978080785;11619.967858176728;11630.94184529072;11746.236494627821;11773.705657358634;11835.940820295844 08:27:11 INFO - PROCESS | 1643 | __end_tp_report 08:27:11 INFO - PROCESS | 1643 | __start_cc_report 08:27:11 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1496 08:27:11 INFO - PROCESS | 1643 | __end_cc_report 08:27:11 INFO - PROCESS | 1643 | __startTimestamp1493306831221__endTimestamp 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | ------- Summary: start ------- 08:27:11 INFO - PROCESS | 1643 | Number of tests: 6 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:6085.19 Median:6291.72 stddev:664.31 (10.6%) stddev-sans-first:635.34 08:27:11 INFO - PROCESS | 1643 | Values: 3527.8 3567.3 3573.6 3598.5 3618.0 6167.8 6177.8 6207.2 6212.0 6220.8 6149.0 6188.2 6202.6 6205.6 6229.1 5566.4 5581.7 5595.4 5664.5 5756.2 5487.4 5505.7 5709.2 5721.2 5729.6 5527.3 5566.8 5587.4 5589.8 5592.5 5300.3 5313.3 5332.6 5353.5 5363.5 5231.4 5310.3 5313.6 5317.0 5343.2 5780.0 5827.0 5914.5 6015.8 6041.9 6307.7 6321.3 6325.4 6438.6 6492.5 6631.6 6669.8 6685.0 6687.0 6693.5 6264.2 6265.7 6313.6 6318.6 6329.0 6415.9 6473.7 6565.4 6742.6 6782.1 6278.2 6332.5 6342.0 6377.9 6474.8 6600.5 6612.6 6650.8 6654.9 6670.7 6539.3 6539.6 6541.5 6546.8 6558.0 6272.2 6299.0 6301.1 6537.5 6560.2 5178.6 5256.1 5325.9 5343.8 5355.8 4733.4 4738.1 4746.0 4756.3 4795.7 6125.4 6272.7 6284.2 6284.4 6291.7 6393.0 6441.8 6564.9 6585.6 6585.8 6241.3 6247.4 6267.4 6284.9 6289.4 5810.2 5825.7 5853.6 5855.9 5889.8 6566.2 6621.1 6764.9 6805.4 6829.0 6678.0 6689.3 6706.1 6720.0 6720.4 6879.7 6884.8 6887.9 6899.3 6904.5 6245.4 6317.3 6473.1 6473.4 6530.4 6424.8 6439.1 6443.7 6444.8 6446.9 6296.7 6343.9 6359.7 6407.7 6418.5 6216.3 6245.7 6292.5 6314.0 6378.9 6321.6 6326.8 6332.6 6332.8 6334.6 5554.9 6443.0 6449.7 6451.1 6451.9 6196.9 6228.4 6231.0 6247.5 6261.9 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:55008.92 Median:355870.50 stddev:105033.65 (29.5%) stddev-sans-first:105249.11 08:27:11 INFO - PROCESS | 1643 | Values: 687.7 769.8 802.8 898.7 900.5 29269.9 29584.0 30494.8 41195.4 41272.0 42041.0 42173.6 42290.6 42387.9 42417.6 9420.0 9572.4 9578.6 9584.0 9597.5 7737.2 7864.5 9562.7 9684.3 11704.1 10750.5 11007.6 11802.5 11843.2 11904.8 11753.6 11770.8 11797.6 11798.5 11831.1 11511.3 11565.9 11576.0 11589.2 11613.0 39908.6 40161.0 40176.2 40222.4 40425.6 3935.2 4016.1 4017.7 4033.2 4080.3 24827.1 28170.6 28679.6 29959.0 30733.5 3189.9 3243.8 3288.3 3341.3 3415.4 351891.2 352149.0 355869.0 355872.0 356352.2 52500.5 52542.7 52567.2 52576.5 52673.2 54745.7 54750.5 54753.0 54800.0 54853.7 15561.8 15670.5 15679.0 15699.0 15722.1 13170.1 13198.5 13198.7 13199.5 13218.7 10983.4 11169.7 11361.9 11406.8 12657.5 4363.4 4913.1 5538.1 5733.7 5757.2 764.7 911.5 925.2 932.4 954.2 28532.0 28656.9 28919.0 29078.8 29161.1 870.8 1056.4 1298.7 1305.1 1317.9 14355.0 14376.5 14579.0 14666.4 14692.6 434892.0 435451.0 436098.0 436299.0 437905.0 58246.1 58298.4 58302.7 58319.7 58363.7 1465.0 1471.4 1515.5 1519.8 1526.9 25760.7 26802.3 27072.3 27133.6 27145.9 47483.5 47594.0 47645.8 47693.8 47734.8 355621.0 404871.9 409577.0 409647.0 410609.0 35290.8 35926.5 35963.6 36000.3 36123.0 35560.8 43488.8 44410.0 45054.0 51301.5 33984.0 34536.5 34567.5 34623.5 35848.6 34222.5 35073.3 35363.8 35487.5 35650.8 41309.4 42144.8 42491.4 42705.6 42979.7 30994.4 34810.0 34842.7 35370.0 35996.0 21425.8 23869.6 26869.5 27559.4 27807.6 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:41109.44 Median:23564.65 stddev:114161.51 (484.5%) stddev-sans-first:114440.80 08:27:11 INFO - PROCESS | 1643 | Values: 380.4 400.9 413.6 421.5 456.9 13861.4 15736.8 21732.6 22108.1 22602.1 22935.9 23143.0 23490.6 23638.6 23787.4 6521.8 7054.3 7132.3 7139.9 7142.6 6722.5 6937.2 6947.5 7037.0 7075.4 6995.6 7008.2 7011.9 7014.3 7018.3 6759.3 7005.3 7060.4 7069.7 7077.1 6878.6 6886.1 7024.4 7296.9 7438.7 23747.5 23983.3 25606.9 25659.1 25848.9 2908.8 3145.1 3433.5 3562.2 3582.7 13171.8 15749.7 17688.0 18577.3 18586.0 2112.2 2167.1 2172.7 2188.1 2247.1 131494.0 134477.0 155798.0 158475.0 163234.2 17560.4 19135.7 20720.6 23187.0 24806.1 41983.0 42773.6 43119.4 43147.6 43195.8 9427.0 10286.8 10411.0 10584.8 10783.1 8963.6 8966.8 8982.0 9165.5 9167.4 7452.8 9246.5 9276.1 9704.9 9705.4 3376.5 3949.8 3979.6 4003.7 4019.4 897.5 918.6 924.6 948.3 975.6 20344.3 22193.9 22229.2 22244.7 22274.8 938.2 938.5 964.7 969.5 972.6 11167.1 11374.6 11395.7 11583.6 11596.7 359625.0 553036.9 777151.0 782111.0 806153.0 155543.4 159197.0 159971.0 160948.0 166281.0 1219.7 1248.4 1277.3 1283.1 1283.2 18977.3 19057.7 19291.0 19351.3 19367.9 63993.7 64491.0 64832.0 65487.0 65985.7 89985.0 91254.5 92026.1 92802.1 92943.1 11191.3 11650.7 11686.2 11757.9 11762.2 12758.5 12837.9 12889.2 13197.0 13285.9 11084.2 11112.1 11442.1 11508.9 11552.6 10281.8 10433.8 10443.5 10656.4 10682.0 11612.9 11645.5 11649.3 11858.3 11899.9 11490.8 11493.4 11791.4 11829.4 11850.0 11342.9 11403.4 11405.5 11431.5 11691.3 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6895.39 Median:2454.18 stddev:4294.45 (175.0%) stddev-sans-first:4288.10 08:27:11 INFO - PROCESS | 1643 | Values: 1605.1 1613.2 1613.7 1619.8 1641.2 10965.0 11620.1 11625.2 11638.0 11638.3 10542.7 10833.3 11004.5 11015.2 11276.1 2412.1 2448.8 2456.0 2458.0 2461.6 2349.4 2445.3 2447.3 2451.2 2460.5 2369.8 2436.1 2449.6 2474.8 2487.3 2352.6 2448.8 2457.3 2458.2 2458.2 2425.0 2447.4 2451.7 2452.4 2463.8 11182.2 11473.1 11482.9 11492.7 11506.7 5922.0 6082.6 6087.4 6092.8 6093.5 3167.3 3259.7 3586.7 3694.9 3749.6 1252.5 1259.0 1281.9 1301.5 1310.8 13893.2 14139.4 14528.7 16104.4 16282.3 4651.9 4833.8 4834.0 4868.0 4880.2 12161.2 12173.4 12186.9 12197.9 12204.0 5032.0 5190.9 5779.3 5929.4 5980.2 5207.4 5395.5 5444.0 5458.3 5458.7 3969.9 4005.5 4031.8 4111.9 4138.6 1041.0 1044.2 1044.7 1060.6 1062.3 961.2 983.9 989.6 990.2 1000.6 6686.8 6770.5 6810.3 6844.3 6922.8 1004.3 1006.7 1013.3 1044.1 1054.4 3327.0 3808.4 4296.9 4350.3 4350.7 13431.5 13618.5 13757.6 14039.4 14105.4 13599.7 13889.7 13992.4 13993.4 14102.9 10001.4 10189.9 10391.6 10484.8 10487.7 7184.2 7218.7 7235.9 7326.3 7434.7 11407.3 12582.6 12778.7 13013.3 13205.2 12110.6 12615.6 13096.9 13208.3 13328.7 9282.7 9591.0 9602.7 9616.0 9617.0 10287.0 10369.4 10459.9 10483.1 10484.7 8845.6 8985.8 9034.7 9048.8 9188.3 8705.7 8723.4 8758.6 8811.0 8816.3 8097.7 8111.7 8201.5 8206.2 8220.8 5886.8 5912.1 5962.7 6079.5 6139.7 5971.6 6137.0 6148.2 6162.7 6292.3 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4643.81 Median:5027.57 stddev:1302.20 (25.9%) stddev-sans-first:1266.00 08:27:11 INFO - PROCESS | 1643 | Values: 384.3 386.6 387.4 391.9 393.7 4487.8 4573.6 5011.5 5208.2 5306.4 4476.8 5139.5 5223.2 5284.5 5309.4 3435.6 3769.9 4311.5 4402.0 4439.0 3951.6 4267.9 4325.5 4406.9 4517.6 3967.2 3968.8 4036.3 4446.4 4484.7 3818.1 4257.9 4283.5 4436.6 4437.3 3385.6 3593.5 3869.9 3984.8 4004.8 4373.9 4640.8 4692.5 5107.6 5173.1 4317.2 4691.3 4907.3 4921.6 4989.8 4635.6 5148.3 5171.8 5606.5 5620.2 4392.3 4440.9 4447.9 4515.4 4580.4 5322.8 5393.4 5555.9 5639.5 5967.5 3842.8 3930.6 4138.0 4244.6 4613.8 4659.3 4669.2 4708.6 4709.5 4775.9 4499.6 4500.3 4810.3 5008.6 5042.4 5265.3 5562.4 5645.4 5692.4 5693.0 1439.6 1465.3 1614.1 1614.5 1621.5 1040.1 1044.9 1123.6 1188.0 1217.7 4726.1 4763.8 5039.5 5223.9 5232.5 5239.9 5400.6 5569.4 5782.9 5825.6 4515.0 4945.5 5105.2 5327.7 5412.3 2636.9 2827.9 2888.9 2951.7 2984.4 5679.3 5696.1 5851.7 5923.3 6119.3 5487.4 5550.5 5766.0 5978.7 6023.0 4888.6 5150.8 5175.9 5479.8 5914.3 5545.8 5746.9 5765.5 5907.5 5930.9 5015.6 5302.7 5679.9 5684.5 5735.4 5211.3 5651.7 5981.3 6129.8 6139.9 4286.0 4923.1 5015.3 5134.5 5156.5 5070.6 5483.3 5517.8 5599.5 5732.5 4991.9 5253.4 5498.8 5542.9 5771.5 5052.9 5072.0 5291.0 5364.8 5383.9 4581.8 4867.4 4976.5 5444.8 5464.0 5574.4 5653.8 5664.2 5669.3 5723.6 4563.8 5078.7 5479.8 5511.2 5574.1 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:21024.24 Median:17993.37 stddev:29234.15 (162.5%) stddev-sans-first:29276.68 08:27:11 INFO - PROCESS | 1643 | Values: 791.4 805.5 832.6 883.2 884.7 15616.8 16987.7 17382.5 17732.7 17783.6 15603.8 15954.8 16255.0 16263.4 16357.3 845.9 963.9 964.4 965.3 965.7 973.7 976.8 995.5 1022.2 1026.1 1058.3 1059.3 1059.9 1060.0 1060.3 1054.6 1055.7 1056.0 1056.1 1056.5 784.6 785.6 786.2 786.3 786.8 17377.5 17514.0 17571.6 18203.2 18485.3 12975.0 14538.9 14809.0 15123.4 15659.8 11361.9 11878.4 12295.4 12490.3 12694.2 3972.2 4075.2 4099.0 4194.3 4208.3 104330.0 104777.0 106307.0 106761.0 107340.0 11617.3 11877.8 11977.6 11985.0 12104.8 26385.9 26411.6 26667.6 26806.5 27152.6 8415.1 8468.2 8475.2 8703.8 8868.0 4510.8 4620.5 4680.6 4685.3 4691.6 3790.9 3827.8 3838.7 3879.1 3889.5 604.1 667.6 676.5 680.8 689.4 647.8 700.4 702.4 707.6 735.1 10628.8 10675.4 10778.8 11149.7 11291.7 647.9 704.1 713.5 715.3 720.3 4543.4 5125.4 5336.3 5340.8 5358.6 93920.0 97076.5 107517.5 108584.4 115963.4 54681.5 75774.0 92547.4 92743.1 95825.0 74534.6 74905.6 76833.6 79737.0 80914.6 8730.3 11032.7 11084.8 11435.3 11441.7 46566.3 46933.1 47068.5 51422.2 53589.0 69364.3 70213.9 70501.0 72526.0 73708.0 13107.5 13440.6 13457.3 13780.2 13974.4 14973.5 14978.3 15592.0 15909.4 16631.9 12828.6 14122.2 14665.5 14849.0 15332.2 14129.3 14282.3 14828.0 15053.8 15213.2 13271.3 13361.5 13780.9 14057.1 14215.8 8824.6 10556.9 10845.6 10961.7 11300.5 11620.0 11630.9 11746.2 11773.7 11835.9 08:27:11 INFO - PROCESS | 1643 | -------- Summary: end -------- 08:27:11 INFO - PROCESS | 1643 | 08:27:11 INFO - TEST-INFO | 1643: exit 0 08:27:11 INFO - TEST-OK | dromaeo_css | took 1119166ms 08:27:11 INFO - TEST-START | kraken 08:27:11 INFO - operating with platform_type : mac_ 08:27:11 INFO - Initialising browser for kraken test... 08:27:11 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpbrdZlO/profile http://localhost:49236/getInfo.html) 08:27:13 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 08:27:13 INFO - PROCESS | 1650 | colorDepth:24 08:27:13 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 08:27:13 INFO - PROCESS | 1650 | __metrics 08:27:13 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:27:13 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] 08:27:14 INFO - TEST-INFO | 1650: exit 0 08:27:14 INFO - Browser initialized. 08:27:14 INFO - Running cycle 1/1 for kraken test... 08:27:14 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpbrdZlO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:26 INFO - PROCESS | 1652 | RSS: Main: 165109760 08:27:26 INFO - PROCESS | 1652 | 08:27:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:30 INFO - PROCESS | 1652 | RSS: Main: 216068096 08:27:30 INFO - PROCESS | 1652 | 08:27:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:27:33 INFO - PROCESS | 1652 | RSS: Main: 231301120 08:27:33 INFO - PROCESS | 1652 | 08:27:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:27:37 INFO - PROCESS | 1652 | RSS: Main: 328724480 08:27:37 INFO - PROCESS | 1652 | 08:27:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:27:40 INFO - PROCESS | 1652 | RSS: Main: 229392384 08:27:40 INFO - PROCESS | 1652 | 08:27:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:42 INFO - PROCESS | 1652 | RSS: Main: 230821888 08:27:42 INFO - PROCESS | 1652 | 08:27:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:46 INFO - PROCESS | 1652 | RSS: Main: 271355904 08:27:46 INFO - PROCESS | 1652 | 08:27:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:49 INFO - PROCESS | 1652 | RSS: Main: 273424384 08:27:49 INFO - PROCESS | 1652 | 08:27:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:27:53 INFO - PROCESS | 1652 | RSS: Main: 270831616 08:27:53 INFO - PROCESS | 1652 | 08:27:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:55 INFO - PROCESS | 1652 | RSS: Main: 247922688 08:27:55 INFO - PROCESS | 1652 | 08:27:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:57 INFO - PROCESS | 1652 | RSS: Main: 251187200 08:27:57 INFO - PROCESS | 1652 | 08:28:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:00 INFO - PROCESS | 1652 | RSS: Main: 255197184 08:28:00 INFO - PROCESS | 1652 | 08:28:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:04 INFO - PROCESS | 1652 | RSS: Main: 259026944 08:28:04 INFO - PROCESS | 1652 | 08:28:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:07 INFO - PROCESS | 1652 | RSS: Main: 260308992 08:28:07 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:28:09 INFO - PROCESS | 1652 | RSS: Main: 305188864 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | __start_tp_report 08:28:09 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 08:28:09 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 08:28:09 INFO - PROCESS | 1652 | |i|pagename|runs| 08:28:09 INFO - PROCESS | 1652 | |0;ai-astar;107;116;115;115;114;116;114;115;115;114 08:28:09 INFO - PROCESS | 1652 | |1;audio-beat-detection;131;106;107;137;108;107;104;96;125;106 08:28:09 INFO - PROCESS | 1652 | |2;audio-dft;187;183;183;197;262;205;184;185;184;183 08:28:09 INFO - PROCESS | 1652 | |3;audio-fft;82;60;59;90;61;72;82;81;97;59 08:28:09 INFO - PROCESS | 1652 | |4;audio-oscillator;91;69;85;68;69;70;81;69;68;82 08:28:09 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;89;89;90;90;91;90;91;88;91;89 08:28:09 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;96;95;96;96;96;99;95;96;97 08:28:09 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;82;79;83;85;84;87;84;83;83 08:28:09 INFO - PROCESS | 1652 | |8;json-parse-financial;62;61;63;61;62;63;62;62;62;62 08:28:09 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;58;60;62;65;62;59;57;62;82;82 08:28:09 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;85;81;80;82;80;84;82;85;87;111 08:28:09 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;134;135;132;131;130;131;132;135;146;133 08:28:09 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;163;163;162;159;163;161;159;162;162;160 08:28:09 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;63;64;66;63;65;61;62;62;62;62 08:28:09 INFO - PROCESS | 1652 | __end_tp_report 08:28:09 INFO - PROCESS | 1652 | __start_cc_report 08:28:09 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2020 08:28:09 INFO - PROCESS | 1652 | __end_cc_report 08:28:09 INFO - PROCESS | 1652 | __startTimestamp1493306889439__endTimestamp 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | ------- Summary: start ------- 08:28:09 INFO - PROCESS | 1652 | Number of tests: 14 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.60 (2.3%) stddev-sans-first:0.78 08:28:09 INFO - PROCESS | 1652 | Values: 107.0 116.0 115.0 115.0 114.0 116.0 114.0 115.0 115.0 114.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:112.70 Median:116.50 stddev:13.37 (11.5%) stddev-sans-first:12.43 08:28:09 INFO - PROCESS | 1652 | Values: 131.0 106.0 107.0 137.0 108.0 107.0 104.0 96.0 125.0 106.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:195.30 Median:186.00 stddev:24.56 (13.2%) stddev-sans-first:25.87 08:28:09 INFO - PROCESS | 1652 | Values: 187.0 183.0 183.0 197.0 262.0 205.0 184.0 185.0 184.0 183.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:74.30 Median:81.50 stddev:14.06 (17.3%) stddev-sans-first:14.64 08:28:09 INFO - PROCESS | 1652 | Values: 82.0 60.0 59.0 90.0 61.0 72.0 82.0 81.0 97.0 59.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:75.50 stddev:8.64 (11.4%) stddev-sans-first:7.02 08:28:09 INFO - PROCESS | 1652 | Values: 91.0 69.0 85.0 68.0 69.0 70.0 81.0 69.0 68.0 82.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:90.00 stddev:1.03 (1.1%) stddev-sans-first:1.05 08:28:09 INFO - PROCESS | 1652 | Values: 89.0 89.0 90.0 90.0 91.0 90.0 91.0 88.0 91.0 89.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:1.20 08:28:09 INFO - PROCESS | 1652 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 99.0 95.0 96.0 97.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:83.40 Median:84.00 stddev:2.07 (2.5%) stddev-sans-first:2.18 08:28:09 INFO - PROCESS | 1652 | Values: 84.0 82.0 79.0 83.0 85.0 84.0 87.0 84.0 83.0 83.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 08:28:09 INFO - PROCESS | 1652 | Values: 62.0 61.0 63.0 61.0 62.0 63.0 62.0 62.0 62.0 62.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:62.00 stddev:9.30 (15.0%) stddev-sans-first:9.53 08:28:09 INFO - PROCESS | 1652 | Values: 58.0 60.0 62.0 65.0 62.0 59.0 57.0 62.0 82.0 82.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:83.00 stddev:9.19 (11.1%) stddev-sans-first:9.74 08:28:09 INFO - PROCESS | 1652 | Values: 85.0 81.0 80.0 82.0 80.0 84.0 82.0 85.0 87.0 111.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:133.50 stddev:4.58 (3.4%) stddev-sans-first:4.86 08:28:09 INFO - PROCESS | 1652 | Values: 134.0 135.0 132.0 131.0 130.0 131.0 132.0 135.0 146.0 133.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.56 08:28:09 INFO - PROCESS | 1652 | Values: 163.0 163.0 162.0 159.0 163.0 161.0 159.0 162.0 162.0 160.0 08:28:09 INFO - PROCESS | 1652 | 08:28:09 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.56 (2.5%) stddev-sans-first:1.66 08:28:09 INFO - PROCESS | 1652 | Values: 63.0 64.0 66.0 63.0 65.0 61.0 62.0 62.0 62.0 62.0 08:28:09 INFO - PROCESS | 1652 | -------- Summary: end -------- 08:28:09 INFO - PROCESS | 1652 | 08:28:10 INFO - TEST-INFO | 1652: exit 0 08:28:10 INFO - TEST-OK | kraken | took 58471ms 08:28:10 INFO - SUITE-END | took 1177s 08:28:10 INFO - Completed test suite (00:19:37) 08:28:10 INFO - javascript benchmark 08:28:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7936.0373642578625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3527.805970671613, 3567.3222087803333, 3573.624769399213, 3598.5142005829207, 3618.0231337538867, 6167.7841275555365, 6177.814665560035, 6207.224096987877, 6211.975024121015, 6220.7822726204595, 6149.046897730847, 6188.164597779299, 6202.596831205969, 6205.627662340252, 6229.065640153979, 5566.3598686151, 5581.665100093987, 5595.4124816894255, 5664.54683625309, 5756.165356023374, 5487.42382049885, 5505.697186654733, 5709.229254050712, 5721.199032135504, 5729.627574207684, 5527.336719593654, 5566.805161819337, 5587.38538760736, 5589.776408943638, 5592.496675299222, 5300.284461597674, 5313.3092697949405, 5332.600054995891, 5353.518183363516, 5363.517283444469, 5231.398389185254, 5310.309659744247, 5313.628046036779, 5316.9734151329385, 5343.171808369709, 5780.046292361755, 5827.0, 5914.467697907209, 6015.819525414201, 6041.939580604182, 6307.716152773136, 6321.336259692712, 6325.430711235965, 6438.6136831790245, 6492.545521813475, 6631.635260060695, 6669.799906002828, 6684.966575167093, 6686.966565167192, 6693.531452798306, 6264.21697287839, 6265.749370025239, 6313.55805093639, 6318.620882746958, 6328.968355158195, 6415.871682566322, 6473.708683109271, 6565.441937435371, 6742.561733487308, 6782.084418603524, 6278.152449419361, 6332.4934005279465, 6342.0, 6377.872442551123, 6474.805755827333, 6600.471962243009, 6612.603243805291, 6650.833729156713, 6654.866902662016, 6670.666466676646, 6539.346065393423, 6539.640319782363, 6541.542092053605, 6546.836329091716, 6558.049082882955, 6272.2159730033745, 6299.0, 6301.054841773771, 6537.477001839841, 6560.179977502812, 5178.585713143015, 5256.08018596744, 5325.920111198335, 5343.812966546152, 5355.758990845344, 4733.384659994247, 4738.123447162286, 4745.976270118627, 4756.334113224151, 4795.688280261772, 6125.418085281891, 6272.749090036347, 6284.151639528605, 6284.37156284377, 6291.716872740738, 6393.041043843461, 6441.774537891151, 6564.901526477107, 6585.5719378240265, 6585.80242592723, 6241.282252540925, 6247.406496382836, 6267.373262673696, 6284.937150628435, 6289.433950944345, 5810.157527158538, 5825.7087145642545, 5853.619514731528, 5855.912161317584, 5889.8233053007625, 6566.24488183865, 6621.139251897415, 6764.93235067643, 6805.353491418307, 6829.0, 6678.0, 6689.264180939996, 6706.094677218513, 6719.966400167968, 6720.361565651256, 6879.724811007503, 6884.793456196122, 6887.931120688729, 6899.344562266577, 6904.482163837632, 6245.3754624539, 6317.30509643948, 6473.093766872736, 6473.417392434515, 6530.444912182517, 6424.839379015375, 6439.066335381437, 6443.677816109082, 6444.7744328948265, 6446.9032964506505, 6296.748130074746, 6343.873122537431, 6359.650219237987, 6407.679616019087, 6418.454431373386, 6216.2540495140875, 6245.68771561411, 6292.4966002720585, 6314.0, 6378.90431643535, 6321.5574909757715, 6326.778562750282, 6332.620042797447, 6332.841678958063, 6334.588251763621, 5554.916676249779, 6443.0335449682925, 6449.7097630605795, 6451.0968464415955, 6451.903221451588, 6196.938030619636, 6228.377162283736, 6231.003039513656, 6247.5001999839, 6261.906071409024], "value": 6042.82849432182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.7249100359857, 769.8344855855989, 802.7671975127212, 898.74385800047, 900.464223786847, 29269.853650731744, 29584.0, 30494.84752576237, 41195.382069268984, 41272.0, 42041.0, 42173.57826421735, 42290.57709422905, 42387.940301492476, 42417.57582424175, 9420.010898855608, 9572.377795443308, 9578.616855325814, 9584.04159584043, 9597.520123993807, 7737.226277372274, 7864.528128312291, 9562.665306714267, 9684.273679474032, 11704.06367490603, 10750.462476876164, 11007.569016027905, 11802.46888890002, 11843.170978031541, 11904.821427678591, 11753.588624398148, 11770.823437648442, 11797.646070617895, 11798.46906889192, 11831.053515718722, 11511.30932144074, 11565.94217028918, 11575.958163765217, 11589.188756787029, 11613.0, 39908.60091399107, 40161.0, 40176.19647607061, 40222.396664050066, 40425.595744042774, 3935.232629637222, 4016.136530645925, 4017.7388469749667, 4033.173199494126, 4080.2655522006025, 24827.13105041333, 28170.577441338395, 28679.56980645292, 29959.0, 30733.538996914842, 3189.9154287542115, 3243.8215898125595, 3288.2765791525826, 3341.3150304187584, 3415.4364529852546, 351891.24054379563, 352149.0, 355869.0, 355872.0, 356352.2182389097, 52500.474995249555, 52542.73728631409, 52567.21149182766, 52576.47423525792, 52673.2099018515, 54745.72627136839, 54750.45249547533, 54753.0, 54800.0, 54853.72573137109, 15561.766573501407, 15670.529884103495, 15679.0, 15699.0, 15722.05667659944, 13170.07809453329, 13198.47206111764, 13198.736025279633, 13199.47202111924, 13218.669533261553, 10983.39591322469, 11169.664910052712, 11361.943190283995, 11406.771864562663, 12657.493700252071, 4363.439437857557, 4913.115639184981, 5538.113901775697, 5733.741981610838, 5757.165211044459, 764.7094104240354, 911.4759013567093, 925.2274350916925, 932.3753085432776, 954.2070270674016, 28532.0, 28656.856715716287, 28918.987835425658, 29078.836846526327, 29161.125166245045, 870.7910101575703, 1056.3872953686844, 1298.688314804459, 1305.11252348404, 1317.8616245294106, 14355.0, 14376.496822611367, 14579.0, 14666.43337415948, 14692.559223223321, 434892.0, 435451.0, 436098.0, 436299.0, 437905.0, 58246.12630810541, 58298.4170158293, 58302.7084864573, 58319.70840145772, 58363.708181458824, 1464.985350146485, 1471.3967273418275, 1515.5226103777495, 1519.840416756247, 1526.8549487798864, 25760.742392576583, 26802.329941751614, 27072.32319192036, 27133.592996105468, 27145.86427067931, 47483.52516474791, 47594.0, 47645.76177119092, 47693.761531192125, 47734.80662983453, 355621.0, 404871.902561953, 409577.0, 409647.0, 410609.0, 35290.82354588211, 35926.461103082955, 35963.64036359603, 36000.27999440049, 36123.0, 35560.82219588885, 43488.78255608702, 44410.0, 45054.0, 51301.48698513117, 33983.980480585626, 34536.48195277123, 34567.481487778205, 34623.480647790806, 35848.64151358453, 34222.48666269958, 35073.29853402969, 35363.823180883934, 35487.467687984186, 35650.8217458911, 41309.38035929403, 42144.78927605342, 42491.36262955996, 42705.57294427016, 42979.71060868179, 30994.380112398077, 34809.955701329, 34842.65157348394, 35370.0, 35996.0, 21425.785742143, 23869.64195537103, 26869.462610748065, 27559.448811024067, 27807.582886257125], "value": 19310.453581050293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.3818794459004, 400.90177906412936, 413.64013308421676, 421.47526329719494, 456.92460743977244, 13861.445542178313, 15736.842631573694, 21732.565348693017, 22108.115675372985, 22602.095916163333, 22935.885320573416, 23143.0, 23490.64764028541, 23638.645420318666, 23787.405314867137, 6521.771737989171, 7054.329838665319, 7132.251113633071, 7139.9286007140045, 7142.642867856586, 6722.462203023746, 6937.167539895195, 6947.4789390795895, 7037.049998250248, 7075.398591119761, 6995.5802651840795, 7008.194057683355, 7011.859762804766, 7014.263502332258, 7018.263082376354, 6759.290274521179, 7005.29947005298, 7060.364567188926, 7069.717211311593, 7077.07997960267, 6878.621675807829, 6886.139232595926, 7024.367806897352, 7296.890546641805, 7438.73964411243, 23747.525049498912, 23983.28050158498, 25606.87196564024, 25659.1019314325, 25848.8707556461, 2908.7672986161056, 3145.072203699914, 3433.5105061845065, 3562.1806984393734, 3582.731295152874, 13171.802422963663, 15749.68500629981, 17688.0, 18577.349792757323, 18585.977771222577, 2112.197365001305, 2167.1439781286463, 2172.728408948881, 2188.081005977493, 2247.0899285789283, 131494.0, 134476.98284525838, 155798.0, 158475.0, 163234.18382908127, 17560.38538651141, 19135.712964305545, 20720.58558828815, 23187.0, 24806.131785387424, 41982.950426239586, 42773.57226427758, 43119.353209701876, 43147.56852431435, 43195.78402107969, 9427.010163932688, 10286.845697314546, 10411.0, 10584.841227381596, 10783.13734901206, 8963.596638151299, 8966.820663586692, 8982.0, 9165.450072995642, 9167.404118732395, 7452.751931399159, 9246.4914429707, 9276.11876871696, 9704.9029509704, 9705.417674939385, 3376.4766461198556, 3949.7827619481204, 3979.602039796055, 4003.6997225208224, 4019.376996565537, 897.546738896853, 918.6187732091241, 924.6070420071577, 948.3029972969862, 975.5756246032998, 20344.287949921683, 22193.889030554743, 22229.221977230718, 22244.666330005064, 22274.777252227595, 938.2165891480554, 938.4885237545554, 964.7395203295071, 969.5152423788106, 972.557486343712, 11167.106631469464, 11374.578177727784, 11395.715107122389, 11583.594574190032, 11596.710082247842, 359625.0, 553036.8785248545, 777151.0, 782111.0, 806153.0, 155543.4445655529, 159197.0, 159971.0, 160948.0, 166281.0, 1219.6950762309423, 1248.375812093953, 1277.2528071078523, 1283.076185146693, 1283.159530507519, 18977.33579324717, 19057.71413428772, 19291.035448227813, 19351.322703705864, 19367.90316048467, 63993.68003159954, 64491.0, 64832.0, 65487.0, 65985.67007164934, 89985.0, 91254.54372728094, 92026.07973920443, 92802.07197927934, 92943.14113717552, 11191.2725672831, 11650.6504804856, 11686.24039437434, 11757.88242117602, 11762.176647634584, 12758.48966041348, 12837.871621283668, 12889.226646401246, 13197.0, 13285.933570332087, 11084.168687348643, 11112.111031117653, 11442.084633229488, 11508.94245528767, 11552.595659152226, 10281.84577231357, 10433.791324173322, 10443.530041148319, 10656.413897235416, 10682.0, 11612.88387116118, 11645.534178632759, 11649.301041937511, 11858.347790871585, 11899.881001189877, 11490.834584895674, 11493.367864767519, 11791.410429478663, 11829.408529573659, 11850.0, 11342.886571134182, 11403.372814495282, 11405.54377824911, 11431.485583148611, 11691.298522088362], "value": 11813.8225536718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1605.1492708864298, 1613.1530946253222, 1613.7418013117904, 1619.8218195998445, 1641.2204203003573, 10965.0, 11620.070394368451, 11625.244359116652, 11638.010769084616, 11638.301701897892, 10542.683719488408, 10833.29583577067, 11004.504797284122, 11015.173861960346, 11276.097912167006, 2412.071352529276, 2448.7796098351146, 2455.9631605525933, 2457.987710061447, 2461.5815311397105, 2349.4126468382906, 2445.254197469771, 2447.290285817111, 2451.2278632230878, 2460.520198561281, 2369.834111612188, 2436.1229957215387, 2449.5670033030697, 2474.7772700456953, 2487.2911220302217, 2352.5530149271585, 2448.779609835123, 2457.33651913984, 2458.201084647497, 2458.21337172105, 2424.9757502424927, 2447.36368544178, 2451.718052423976, 2452.3869032741813, 2463.802895768334, 11182.16133789969, 11473.08215342779, 11482.88517114835, 11492.712682182928, 11506.654800356002, 5921.970390148064, 6082.5742198046155, 6087.421694938974, 6092.847678808021, 6093.512518998469, 3167.303193297471, 3259.728705804738, 3586.659267369596, 3694.9261014779822, 3749.625037496256, 1252.536561472252, 1258.9802260169292, 1281.852896398538, 1301.4512729851542, 1310.8230388897473, 13893.16641001533, 14139.363728632236, 14528.709425811425, 16104.355825766956, 16282.348706051744, 4651.930221046687, 4833.830815921426, 4834.009028149221, 4868.0, 4880.219164933665, 12161.209521381259, 12173.391330433444, 12186.903178713957, 12197.878021219853, 12204.0, 5032.0, 5190.948090519122, 5779.306483221956, 5929.436703513159, 5980.192673988956, 5207.4011488678525, 5395.487428694268, 5443.972780136153, 5458.317710286215, 5458.672479651154, 3969.8809035728973, 4005.539362973237, 4031.7984100794843, 4111.8560850370095, 4138.565450627701, 1041.0214398465419, 1044.1907521670767, 1044.6761503933806, 1060.5598676549146, 1062.293574772783, 961.1781926452783, 983.8819341678901, 989.6486747204783, 990.1979396688705, 1000.6347683095618, 6686.7993960181275, 6770.458363330922, 6810.31896810315, 6844.28135045823, 6922.7923162305215, 1004.3070281505737, 1006.6728313298207, 1013.2901102288656, 1044.070777008463, 1054.404261592198, 3326.9852694927795, 3808.3716186828865, 4296.871093867189, 4350.347447882779, 4350.694791562519, 13431.529896453578, 13618.523351682643, 13757.587272381845, 14039.368228429541, 14105.36525856339, 13599.660008499866, 13889.652758681113, 13992.370343334574, 13993.3702983366, 14102.929485352714, 10001.399916005063, 10189.949050254701, 10391.649085618821, 10484.790304193873, 10487.737806554896, 7184.209736929038, 7218.711251549879, 7235.855282894207, 7326.267373262631, 7434.73978410753, 11407.25852819564, 12582.559610413591, 12778.744425111632, 13013.349332533146, 13205.207687538394, 12110.576129835414, 12615.621531354074, 13096.869031309565, 13208.27354495512, 13328.666783330107, 9282.675106371245, 9590.952045239728, 9602.66390676323, 9615.990321016192, 9616.95191524038, 10287.022732840369, 10369.429681367295, 10459.895401046197, 10483.108935740242, 10484.737881552717, 8845.55772211374, 8985.775355616162, 9034.683786067457, 9048.819023619622, 9188.310876684409, 8705.651773928972, 8723.432976856484, 8758.562071896507, 8811.0, 8816.338774591803, 8097.676092956216, 8111.66157583992, 8201.507909525448, 8206.179382061984, 8220.794480138044, 5886.764529418947, 5912.142739302863, 5962.731677074456, 6079.544034197541, 6139.693015349126, 5971.611845230046, 6137.048757442603, 6148.200733904564, 6162.691865406801, 6292.307846137013], "value": 5266.234970811108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3466107617051, 386.62883631713555, 387.3763241181697, 391.92161567686463, 393.66735108833046, 4487.775611219438, 4573.565511276432, 5011.548960593545, 5208.166693329068, 5306.416294207639, 4476.776161191944, 5139.486051394868, 5223.171889838554, 5284.497972692588, 5309.389420216677, 3435.587729472467, 3769.9057523561924, 4311.504177019651, 4402.0, 4438.9556104439025, 3951.6443520083185, 4267.893302667442, 4325.502567204764, 4406.867793966187, 4517.638588912879, 3967.1750994542545, 3968.8214030368704, 4036.313826649462, 4446.377507149002, 4484.66365022623, 3818.0982453335387, 4257.87226383209, 4283.485981682187, 4436.55634436557, 4437.267850804614, 3385.610654774683, 3593.4969104325414, 3869.941950870739, 3984.800759962019, 4004.83980640774, 4373.91425890057, 4640.83757068501, 4692.507286734912, 5107.591392688576, 5173.120569503193, 4317.158154159909, 4691.3432119503295, 4907.288443175756, 4921.586255119376, 4989.775460104268, 4635.629149668019, 5148.304978827848, 5171.793128274864, 5606.467385598362, 5620.246079421095, 4392.3191905254735, 4440.866773996785, 4447.888802779924, 4515.4129963104915, 4580.381648477446, 5322.840314790563, 5393.393093460519, 5555.944440555583, 5639.533721232468, 5967.49276311514, 3842.8078596070086, 3930.606939306104, 4138.048248902769, 4244.575542445731, 4613.76931153441, 4659.301104834302, 4669.182892993713, 4708.552687494683, 4709.529047095331, 4775.880602984884, 4499.572540608637, 4500.3249512573375, 4810.302506136591, 5008.574271186917, 5042.377963458981, 5265.289185959923, 5562.415946325658, 5645.350784659817, 5692.430756924357, 5693.0111691361535, 1439.5537383411177, 1465.3479201755117, 1614.1283706798433, 1614.4510866305513, 1621.5297563706392, 1040.1003132290514, 1044.9373037617768, 1123.5786580032488, 1187.98636311453, 1217.7442737025324, 4726.092384519351, 4763.76181190939, 5039.521245481674, 5223.876866473726, 5232.502912223333, 5239.904038384677, 5400.594955378362, 5569.443055694398, 5782.855428614318, 5825.563082768809, 4515.0, 4945.480724523945, 5105.2086926526445, 5327.680339179662, 5412.296401467784, 2636.866147556531, 2827.886884524637, 2888.870000849967, 2951.6605590356953, 2984.373281610886, 5679.346875109332, 5696.088625819932, 5851.707414629337, 5923.348431672513, 6119.326874043852, 5487.396386397493, 5550.501364631607, 5765.971170144123, 5978.671173085435, 6022.969885150634, 4888.633352498577, 5150.845474635767, 5175.948240517622, 5479.808206712746, 5914.319853216849, 5545.7522057538345, 5746.856328591819, 5765.481106700249, 5907.4683278505145, 5930.940690593039, 5015.614460239251, 5302.7083510405755, 5679.949209396275, 5684.459976302244, 5735.397783232867, 5211.290129132905, 5651.665517344786, 5981.312149102909, 6129.754809807558, 6139.877202455837, 4285.992791694011, 4923.138450771029, 5015.297858299914, 5134.5378915897745, 5156.484351564814, 5070.599811201059, 5483.314585676791, 5517.841253336845, 5599.468050535193, 5732.541396688338, 4991.900161996812, 5253.395859476209, 5498.752556135064, 5542.944570554404, 5771.480566749013, 5052.9388828346455, 5072.0, 5291.0, 5364.8122315718765, 5383.892322153613, 4581.839635612738, 4867.367242258625, 4976.527229913152, 5444.8094316698725, 5463.994802858332, 5574.386817450159, 5653.8267485250535, 5664.224529980363, 5669.262995810518, 5723.627964182315, 4563.840265590688, 5078.695278283315, 5479.808206712905, 5511.208857121372, 5574.108142697149], "value": 4263.486298126408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.4380789639356, 805.4563169860343, 832.5629044751508, 883.2139395937617, 884.7257350221431, 15616.76574851378, 16987.74518382225, 17382.478525644252, 17732.73400898986, 17783.55541111473, 15603.84396156038, 15954.84045159548, 16255.0, 16263.430779922704, 16357.345706171738, 845.9280961118297, 963.8506031565119, 964.4358050540442, 965.3194497878978, 965.7102869139266, 973.7127547373507, 976.838821594436, 995.4723996281946, 1022.2333250062453, 1026.1431704526728, 1058.253930978662, 1059.332620449116, 1059.8781140168903, 1059.9576016959313, 1060.3266925502323, 1054.6045233037612, 1055.7360659835003, 1055.9788804223872, 1056.1392465140887, 1056.487603512296, 784.6116172494594, 785.6189747972229, 786.1784435265162, 786.2609147401424, 786.8465649198408, 17377.47867563975, 17514.036727979958, 17571.648567028587, 18203.180856861472, 18485.2605895764, 12975.0, 14538.854611453857, 14809.0, 15123.395064197419, 15659.765103523456, 11361.886381136166, 11878.40607969598, 12295.385230738428, 12490.25058496484, 12694.238345699288, 3972.165845172517, 4075.1849630073807, 4098.979505102485, 4194.328907374806, 4208.26355387809, 104330.0, 104776.95223047749, 106307.0, 106761.0, 107340.0, 11617.302961822317, 11877.821832672516, 11977.580784672495, 11985.0, 12104.757904841854, 26385.868070659522, 26411.603825942628, 26667.599986000227, 26806.463870722477, 27152.592711109348, 8415.11641277657, 8468.170721357148, 8475.237228649452, 8703.825923481494, 8868.0, 4510.797014134372, 4620.514845941195, 4680.578747912704, 4685.297205419146, 4691.62467002639, 3790.886273411802, 3827.78947157909, 3838.673712734449, 3879.0690234343556, 3889.4749208857006, 604.145134634496, 667.5966520526164, 676.479111084472, 680.8263892707328, 689.4105539763531, 647.8088963755704, 700.4221517248291, 702.3959394920364, 707.5601151656457, 735.1297653048554, 10628.840567391495, 10675.412852293199, 10778.838317425245, 11149.721256968478, 11291.661250162508, 647.8736646353916, 704.1409480433863, 713.5290708132608, 715.3025799845109, 720.2509390234097, 4543.432070991126, 5125.384953805567, 5336.332958380202, 5340.839774806762, 5358.5981051421295, 93920.0, 97076.51461742647, 107517.46241268744, 108584.37123443154, 115963.42018290023, 54681.45318546764, 75774.0, 92547.44715317103, 92743.14513709822, 95825.0, 74534.62732686302, 74905.62547187229, 76833.6158319216, 79737.0, 80914.59542702249, 8730.34522410809, 11032.724181895517, 11084.778304434027, 11435.313881167156, 11441.713957151138, 46566.30150547677, 46933.06133877235, 47068.529314706415, 51422.22866656928, 53589.0, 69364.30635693579, 70213.94679079921, 70501.0, 72526.0, 73708.0, 13107.475700971854, 13440.596782096552, 13457.327133643474, 13780.242086684928, 13974.371153297923, 14973.475928342456, 14978.251087445366, 15592.0, 15909.443169489012, 16631.91684041572, 12828.55100071493, 14122.223277719413, 14665.48670796517, 14849.0, 15332.15673137988, 14129.293535323399, 14282.285885705465, 14828.0, 15053.77419338689, 15213.163276019483, 13271.270080145685, 13361.53234636783, 13780.862191377957, 14057.086289391156, 14215.786763198766, 8824.64701411962, 10556.89443105559, 10845.634659285084, 10961.671149865517, 11300.547978080785, 11619.967858176728, 11630.94184529072, 11746.236494627821, 11773.705657358634, 11835.940820295844], "value": 8070.36213303997, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1411.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 115.0, 115.0, 114.0, 116.0, 114.0, 115.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 106.0, 107.0, 137.0, 108.0, 107.0, 104.0, 96.0, 125.0, 106.0], "value": 112.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 183.0, 197.0, 262.0, 205.0, 184.0, 185.0, 184.0, 183.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 90.0, 61.0, 72.0, 82.0, 81.0, 97.0, 59.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 85.0, 68.0, 69.0, 70.0, 81.0, 69.0, 68.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 90.0, 91.0, 90.0, 91.0, 88.0, 91.0, 89.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 99.0, 95.0, 96.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 79.0, 83.0, 85.0, 84.0, 87.0, 84.0, 83.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 62.0, 65.0, 62.0, 59.0, 57.0, 62.0, 82.0, 82.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 80.0, 82.0, 80.0, 84.0, 82.0, 85.0, 87.0, 111.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 132.0, 131.0, 130.0, 131.0, 132.0, 135.0, 146.0, 133.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 159.0, 163.0, 161.0, 159.0, 162.0, 162.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 63.0, 65.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 63.0, "unit": "score"}]}]} 08:28:10 INFO - Return code: 0 08:28:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:28:10 INFO - # TBPL SUCCESS # 08:28:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:28:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:28:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:28:10 INFO - 2017-04-27 08:28:10.797 screenresolution[1656:9682] starting screenresolution argv=screenresolution get 08:28:10 INFO - 2017-04-27 08:28:10.800 screenresolution[1656:9682] Display 0: 1600x1200x32@60 08:28:10 INFO - 2017-04-27 08:28:10.806 screenresolution[1657:9685] starting screenresolution argv=screenresolution list 08:28:10 INFO - Available Modes on Display 0 08:28:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:28:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:28:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:28:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:28:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:28:11 INFO - Intel Iris: 08:28:11 INFO - Chipset Model: Intel Iris 08:28:11 INFO - Type: GPU 08:28:11 INFO - Bus: Built-In 08:28:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:28:11 INFO - Vendor: Intel (0x8086) 08:28:11 INFO - Device ID: 0x0a2e 08:28:11 INFO - Revision ID: 0x0009 08:28:11 INFO - Displays: 08:28:11 INFO - Display: 08:28:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:28:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:28:11 INFO - Display Serial Number: 1600x1200 60 08:28:11 INFO - Main Display: Yes 08:28:11 INFO - Mirror: Off 08:28:11 INFO - Online: Yes 08:28:11 INFO - Rotation: Supported 08:28:11 INFO - Return code: 0 08:28:11 INFO - Running post-action listener: _resource_record_post_action 08:28:11 INFO - [mozharness: 2017-04-27 15:28:11.042337Z] Finished run-tests step (success) 08:28:11 INFO - Running post-run listener: _resource_record_post_run 08:28:11 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 38368256; Write bytes: 422641664; Read time: 246; Write time: 1406 08:28:11 INFO - TinderboxPrint: CPU usage
53.8% 08:28:11 INFO - TinderboxPrint: I/O read bytes / time
38,368,256 / 246 08:28:11 INFO - TinderboxPrint: I/O write bytes / time
422,641,664 / 1,406 08:28:11 INFO - TinderboxPrint: CPU idle
2,209.5 (46.2%) 08:28:11 INFO - TinderboxPrint: CPU system
950.3 (19.9%) 08:28:11 INFO - TinderboxPrint: CPU user
1,617.8 (33.9%) 08:28:11 INFO - TinderboxPrint: Swap in / out
160,657,408 / 0 08:28:11 INFO - install - Wall time: 15s; CPU: 55.0%; Read bytes: 122737152; Write bytes: 114886656; Read time: 10809; Write time: 256 08:28:11 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31083520; Write bytes: 296953856; Read time: 182; Write time: 1119 08:28:11 INFO - Running post-run listener: _upload_blobber_files 08:28:11 INFO - Blob upload gear active. 08:28:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:11 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 08:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:28:11 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:13 INFO - (blobuploader) - INFO - Done attempting. 08:28:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:28:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:15 INFO - (blobuploader) - INFO - Done attempting. 08:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:16 INFO - (blobuploader) - INFO - Done attempting. 08:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:28:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:18 INFO - (blobuploader) - INFO - Done attempting. 08:28:18 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:18 INFO - Return code: 0 08:28:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88d1ca4773d2e4fab70f5c66b737fe859b3f1aa3677bddcbd9bcffdc50812dee7131446a7ae986edd2978e65f319948805c3aa6db2a980dbfb0ae53537e186a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b6f3f4ce1d2cab9b8c992bbc171759f53c712f0135c22fd26e21a1a9e9e232943a3699a9b9e5ec06700b96ead1e2b3e9e4e7837dbe5c94d1bfa0d4a18a8c61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cddbfbb37fc63b058bfa16ed2a97060177eedc62f6e1c375a736e5c6efa80abd8da49629576c92a82bdec20b3f3304e85014fe8fc1a91c46e2a01e125cf4388", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d42c91a79d5e4cf1a2ca5be05fce43ef3e96337d010a693632cfc6a62b89d5517709b32480cc66a049804d2227bd086afbc534986d7774cddda1e9dc784d569"} 08:28:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:18 INFO - Contents: 08:28:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88d1ca4773d2e4fab70f5c66b737fe859b3f1aa3677bddcbd9bcffdc50812dee7131446a7ae986edd2978e65f319948805c3aa6db2a980dbfb0ae53537e186a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b6f3f4ce1d2cab9b8c992bbc171759f53c712f0135c22fd26e21a1a9e9e232943a3699a9b9e5ec06700b96ead1e2b3e9e4e7837dbe5c94d1bfa0d4a18a8c61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cddbfbb37fc63b058bfa16ed2a97060177eedc62f6e1c375a736e5c6efa80abd8da49629576c92a82bdec20b3f3304e85014fe8fc1a91c46e2a01e125cf4388", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d42c91a79d5e4cf1a2ca5be05fce43ef3e96337d010a693632cfc6a62b89d5517709b32480cc66a049804d2227bd086afbc534986d7774cddda1e9dc784d569"} 08:28:18 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:18 INFO - Copying logs to upload dir... 08:28:18 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.446415 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-27 08:28:18.374845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 08:28:18.378693) ========= 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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88d1ca4773d2e4fab70f5c66b737fe859b3f1aa3677bddcbd9bcffdc50812dee7131446a7ae986edd2978e65f319948805c3aa6db2a980dbfb0ae53537e186a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b6f3f4ce1d2cab9b8c992bbc171759f53c712f0135c22fd26e21a1a9e9e232943a3699a9b9e5ec06700b96ead1e2b3e9e4e7837dbe5c94d1bfa0d4a18a8c61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cddbfbb37fc63b058bfa16ed2a97060177eedc62f6e1c375a736e5c6efa80abd8da49629576c92a82bdec20b3f3304e85014fe8fc1a91c46e2a01e125cf4388", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d42c91a79d5e4cf1a2ca5be05fce43ef3e96337d010a693632cfc6a62b89d5517709b32480cc66a049804d2227bd086afbc534986d7774cddda1e9dc784d569"} build_url:https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/dG5BuG09QDWDWq3YyyPCtw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/88d1ca4773d2e4fab70f5c66b737fe859b3f1aa3677bddcbd9bcffdc50812dee7131446a7ae986edd2978e65f319948805c3aa6db2a980dbfb0ae53537e186a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b6f3f4ce1d2cab9b8c992bbc171759f53c712f0135c22fd26e21a1a9e9e232943a3699a9b9e5ec06700b96ead1e2b3e9e4e7837dbe5c94d1bfa0d4a18a8c61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cddbfbb37fc63b058bfa16ed2a97060177eedc62f6e1c375a736e5c6efa80abd8da49629576c92a82bdec20b3f3304e85014fe8fc1a91c46e2a01e125cf4388", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d42c91a79d5e4cf1a2ca5be05fce43ef3e96337d010a693632cfc6a62b89d5517709b32480cc66a049804d2227bd086afbc534986d7774cddda1e9dc784d569"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 08:28:18.585857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 08:28:18.586195) ========= 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.ZeNh7cdhav/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.m1x6QYXmwZ/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.005196 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 08:28:18.765231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 08:28:18.765537) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 08:28:18.765976) ========= ========= Total master_lag: 0.48 =========