builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0070 starttime: 1489020142.3 results: success (0) buildid: 20170308151723 builduid: 1410ca6864fe4026800eda3d3e53ed90 revision: 20dda1bb565d0b18c77e01468c568f68fa1b1396 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.295338) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.295691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.295973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.322357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.322804) ========= 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.YRgmxQaKwK/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.pFOiywv70S/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-08 16:42:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.5M=0.001s 2017-03-08 16:42:22 (22.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.499297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.499588) ========= 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.YRgmxQaKwK/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.pFOiywv70S/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.028784 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:22.549755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-08 16:42:22.550109) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 20dda1bb565d0b18c77e01468c568f68fa1b1396 --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 20dda1bb565d0b18c77e01468c568f68fa1b1396 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YRgmxQaKwK/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.pFOiywv70S/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-08 16:42:22,652 truncating revision to first 12 chars 2017-03-08 16:42:22,652 Setting DEBUG logging. 2017-03-08 16:42:22,652 attempt 1/10 2017-03-08 16:42:22,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/20dda1bb565d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 16:42:24,786 unpacking tar archive at: mozilla-beta-20dda1bb565d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.395077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-08 16:42:24.968453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:24.968784) ========= script_repo_revision: 20dda1bb565d0b18c77e01468c568f68fa1b1396 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:24.969166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:24.969429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 16:42:24.988995) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-08 16:42:24.989349) ========= /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.YRgmxQaKwK/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.pFOiywv70S/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:42:25 INFO - MultiFileLogger online at 20170308 16:42:25 in /builds/slave/test 16:42:25 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 16:42:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:25 INFO - {'append_to_log': False, 16:42:25 INFO - 'base_work_dir': '/builds/slave/test', 16:42:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:42:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:25 INFO - 'branch': 'Mozilla-Beta', 16:42:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:25 INFO - 'config_files': ('talos/mac_config.py',), 16:42:25 INFO - 'default_actions': ('clobber', 16:42:25 INFO - 'read-buildbot-config', 16:42:25 INFO - 'download-and-extract', 16:42:25 INFO - 'populate-webroot', 16:42:25 INFO - 'create-virtualenv', 16:42:25 INFO - 'install', 16:42:25 INFO - 'run-tests'), 16:42:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:25 INFO - 'download_minidump_stackwalk': True, 16:42:25 INFO - 'download_symbols': 'ondemand', 16:42:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:25 INFO - 'installer_path': 'installer.exe', 16:42:25 INFO - 'log_level': 'info', 16:42:25 INFO - 'log_name': 'talos', 16:42:25 INFO - 'log_to_console': True, 16:42:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:42:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:42:25 INFO - 'opt_config_files': (), 16:42:25 INFO - 'pip_index': False, 16:42:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:42:25 INFO - 'cmd': ('bash', 16:42:25 INFO - '-c', 16:42:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:42:25 INFO - 'enabled': True, 16:42:25 INFO - 'halt_on_failure': False, 16:42:25 INFO - 'name': 'check_screen_resolution'},), 16:42:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:42:25 INFO - 'cmd': ('bash', 16:42:25 INFO - '-c', 16:42:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:42:25 INFO - 'enabled': True, 16:42:25 INFO - 'halt_on_failure': False, 16:42:25 INFO - 'name': 'check_screen_resolution'},), 16:42:25 INFO - 'run_cmd_checks_enabled': True, 16:42:25 INFO - 'sps_profile': False, 16:42:25 INFO - 'sps_profile_interval': 0, 16:42:25 INFO - 'suite': 'dromaeojs', 16:42:25 INFO - 'system_bits': '32', 16:42:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:25 INFO - 'title': 't-yosemite-r7-0070', 16:42:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:25 INFO - 'use_talos_json': True, 16:42:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:25 INFO - 'work_dir': 'build'} 16:42:25 INFO - [mozharness: 2017-03-09 00:42:25.206064Z] Running clobber step. 16:42:25 INFO - Running pre-action listener: _resource_record_pre_action 16:42:25 INFO - Running main action method: clobber 16:42:25 INFO - rmtree: /builds/slave/test/build 16:42:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:27 INFO - Running post-action listener: _resource_record_post_action 16:42:27 INFO - [mozharness: 2017-03-09 00:42:27.614015Z] Finished clobber step (success) 16:42:27 INFO - [mozharness: 2017-03-09 00:42:27.614178Z] Running read-buildbot-config step. 16:42:27 INFO - Running pre-action listener: _resource_record_pre_action 16:42:27 INFO - Running main action method: read_buildbot_config 16:42:27 INFO - Using buildbot properties: 16:42:27 INFO - { 16:42:27 INFO - "project": "", 16:42:27 INFO - "product": "firefox", 16:42:27 INFO - "script_repo_revision": "production", 16:42:27 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 16:42:27 INFO - "repository": "", 16:42:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 16:42:27 INFO - "buildid": "20170308151723", 16:42:27 INFO - "pgo_build": "False", 16:42:27 INFO - "basedir": "/builds/slave/test", 16:42:27 INFO - "buildnumber": 5, 16:42:27 INFO - "slavename": "t-yosemite-r7-0070", 16:42:27 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:42:27 INFO - "platform": "yosemite_r7", 16:42:27 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:42:27 INFO - "branch": "mozilla-beta", 16:42:27 INFO - "repo_path": "releases/mozilla-beta", 16:42:27 INFO - "revision": "20dda1bb565d0b18c77e01468c568f68fa1b1396", 16:42:27 INFO - "stage_platform": "macosx64", 16:42:27 INFO - "builduid": "1410ca6864fe4026800eda3d3e53ed90", 16:42:27 INFO - "slavebuilddir": "test" 16:42:27 INFO - } 16:42:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 16:42:27 INFO - Running post-action listener: _resource_record_post_action 16:42:27 INFO - [mozharness: 2017-03-09 00:42:27.617511Z] Finished read-buildbot-config step (success) 16:42:27 INFO - [mozharness: 2017-03-09 00:42:27.617629Z] Running download-and-extract step. 16:42:27 INFO - Running pre-action listener: _resource_record_pre_action 16:42:27 INFO - Running main action method: download_and_extract 16:42:27 INFO - mkdir: /builds/slave/test/build/tests 16:42:27 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')]} 16:42:27 INFO - trying https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 16:42:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 16:42:28 INFO - Downloaded 1165 bytes. 16:42:28 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:42:28 INFO - Using the following test package requirements: 16:42:28 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:42:28 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:42:28 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 16:42:28 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:42:28 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 16:42:28 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:42:28 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:42:28 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 16:42:28 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:42:28 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:42:28 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 16:42:28 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:42:28 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 16:42:28 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:42:28 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 16:42:28 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:42:28 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 16:42:28 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 16:42:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:42:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:42:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:42:29 INFO - Expected file size: 16103534 16:42:29 INFO - Obtained file size: 16103534 16:42:36 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:42:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:42:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:42:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:42:37 INFO - Expected file size: 16103534 16:42:37 INFO - Obtained file size: 16103534 16:42:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 16:42:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 16:42:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 16:42:44 INFO - Expected file size: 14403650 16:42:44 INFO - Obtained file size: 14403650 16:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:42:44 INFO - trying https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:42:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 16:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 16:42:46 INFO - Downloaded 58692357 bytes. 16:42:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:42:46 INFO - mkdir: /builds/slave/test/properties 16:42:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:42:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:42:46 INFO - Contents: 16:42:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:42:47 INFO - Running post-action listener: _resource_record_post_action 16:42:47 INFO - Running post-action listener: set_extra_try_arguments 16:42:47 INFO - [mozharness: 2017-03-09 00:42:47.211455Z] Finished download-and-extract step (success) 16:42:47 INFO - [mozharness: 2017-03-09 00:42:47.211568Z] Running populate-webroot step. 16:42:47 INFO - Running pre-action listener: _resource_record_pre_action 16:42:47 INFO - Running main action method: populate_webroot 16:42:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:42:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:42:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:42:47 INFO - '--tppagecycles', 16:42:47 INFO - '7'], 16:42:47 INFO - 'tests': ['tsvgm']}}, 16:42:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:42:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:42:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:42:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:42:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:42:47 INFO - 'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:42:47 INFO - 'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['damp', 'tps']}, 16:42:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:42:47 INFO - 'tests': ['damp', 'tps']}, 16:42:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['dromaeo_dom']}, 16:42:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:42:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['basic_compositor_video']}, 16:42:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:42:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['a11yr', 16:42:47 INFO - 'ts_paint', 16:42:47 INFO - 'tpaint', 16:42:47 INFO - 'sessionrestore', 16:42:47 INFO - 'sessionrestore_no_auto_restore', 16:42:47 INFO - 'tabpaint']}, 16:42:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:42:47 INFO - 'ts_paint', 16:42:47 INFO - 'tpaint', 16:42:47 INFO - 'sessionrestore', 16:42:47 INFO - 'sessionrestore_no_auto_restore', 16:42:47 INFO - 'tabpaint']}, 16:42:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:42:47 INFO - 'ts_paint', 16:42:47 INFO - 'tpaint', 16:42:47 INFO - 'sessionrestore', 16:42:47 INFO - 'sessionrestore_no_auto_restore', 16:42:47 INFO - 'tabpaint']}, 16:42:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:42:47 INFO - 'ts_paint', 16:42:47 INFO - 'tpaint', 16:42:47 INFO - 'sessionrestore', 16:42:47 INFO - 'sessionrestore_no_auto_restore', 16:42:47 INFO - 'tabpaint']}, 16:42:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['a11yr', 16:42:47 INFO - 'ts_paint', 16:42:47 INFO - 'tpaint', 16:42:47 INFO - 'sessionrestore', 16:42:47 INFO - 'sessionrestore_no_auto_restore', 16:42:47 INFO - 'tabpaint']}, 16:42:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['a11yr', 16:42:47 INFO - 'ts_paint', 16:42:47 INFO - 'tpaint', 16:42:47 INFO - 'sessionrestore', 16:42:47 INFO - 'sessionrestore_no_auto_restore', 16:42:47 INFO - 'tabpaint']}, 16:42:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['tsvgx', 16:42:47 INFO - 'tsvgr_opacity', 16:42:47 INFO - 'tart', 16:42:47 INFO - 'tscrollx', 16:42:47 INFO - 'cart', 16:42:47 INFO - 'tsvg_static']}, 16:42:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:42:47 INFO - 'tsvgr_opacity', 16:42:47 INFO - 'tart', 16:42:47 INFO - 'tscrollx', 16:42:47 INFO - 'cart', 16:42:47 INFO - 'tsvg_static']}, 16:42:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:42:47 INFO - 'talos_options': ['--disable-e10s'], 16:42:47 INFO - 'tests': ['tp5o']}, 16:42:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:42:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:42:47 INFO - 'talos_options': ['--disable-e10s', 16:42:47 INFO - '--xperf_path', 16:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:47 INFO - 'tests': ['tp5n']}, 16:42:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:42:47 INFO - 'talos_options': ['--xperf_path', 16:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:47 INFO - 'tests': ['tp5n']}}, 16:42:47 INFO - 'talos.zip': {'path': '', 16:42:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:42:47 INFO - Running post-action listener: _resource_record_post_action 16:42:47 INFO - [mozharness: 2017-03-09 00:42:47.229648Z] Finished populate-webroot step (success) 16:42:47 INFO - [mozharness: 2017-03-09 00:42:47.229784Z] Running create-virtualenv step. 16:42:47 INFO - Running pre-action listener: _resource_record_pre_action 16:42:47 INFO - Running main action method: create_virtualenv 16:42:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:42:47 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 16:42:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:42:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:42:47 INFO - Using real prefix '/tools/python27' 16:42:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:42:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:42:50 INFO - Installing pip.................done. 16:42:50 INFO - Return code: 0 16:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:42:51 INFO - Reading from file tmpfile_stdout 16:42:51 INFO - Output received: 16:42:51 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) 16:42:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:42:51 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')]} 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:51 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')]} 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:51 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:42:51 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 16:42:51 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 16:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:51 INFO - 'HOME': '/Users/cltbld', 16:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:51 INFO - 'LOGNAME': 'cltbld', 16:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:51 INFO - 'MOZ_NO_REMOTE': '1', 16:42:51 INFO - 'NO_EM_RESTART': '1', 16:42:51 INFO - 'PAGER': '/bin/cat', 16:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:51 INFO - 'PWD': '/builds/slave/test', 16:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:51 INFO - 'SHELL': '/bin/bash', 16:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:42:51 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:51 INFO - 'USER': 'cltbld', 16:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:51 INFO - 'XPC_FLAGS': '0x0', 16:42:51 INFO - 'XPC_SERVICE_NAME': '0', 16:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:51 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 16:42:51 INFO - Cleaning up... 16:42:51 INFO - Return code: 0 16:42:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:42:51 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')]} 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:51 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')]} 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:51 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:42:51 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 16:42:51 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 16:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:51 INFO - 'HOME': '/Users/cltbld', 16:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:51 INFO - 'LOGNAME': 'cltbld', 16:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:51 INFO - 'MOZ_NO_REMOTE': '1', 16:42:51 INFO - 'NO_EM_RESTART': '1', 16:42:51 INFO - 'PAGER': '/bin/cat', 16:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:51 INFO - 'PWD': '/builds/slave/test', 16:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:51 INFO - 'SHELL': '/bin/bash', 16:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:42:51 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:51 INFO - 'USER': 'cltbld', 16:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:51 INFO - 'XPC_FLAGS': '0x0', 16:42:51 INFO - 'XPC_SERVICE_NAME': '0', 16:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:51 INFO - Downloading/unpacking psutil>=3.1.1 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:42:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:55 INFO - Installing collected packages: psutil 16:42:55 INFO - Running setup.py install for psutil 16:42:55 INFO - building 'psutil._psutil_osx' extension 16:42:55 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 16:42:55 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 16:42:55 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 16:42:56 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 16:42:56 INFO - building 'psutil._psutil_posix' extension 16:42:56 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 16:42:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:42:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:42:56 INFO - ^ 16:42:56 INFO - 1 warning generated. 16:42:56 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 16:42:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:56 INFO - Successfully installed psutil 16:42:56 INFO - Cleaning up... 16:42:56 INFO - Return code: 0 16:42:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:42: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')]} 16:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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')]} 16:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:42: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:42: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 mozsystemmonitor==0.3 16:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:56 INFO - 'HOME': '/Users/cltbld', 16:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:56 INFO - 'LOGNAME': 'cltbld', 16:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:56 INFO - 'MOZ_NO_REMOTE': '1', 16:42:56 INFO - 'NO_EM_RESTART': '1', 16:42:56 INFO - 'PAGER': '/bin/cat', 16:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:56 INFO - 'PWD': '/builds/slave/test', 16:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:56 INFO - 'SHELL': '/bin/bash', 16:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:42:56 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:56 INFO - 'USER': 'cltbld', 16:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:56 INFO - 'XPC_FLAGS': '0x0', 16:42:56 INFO - 'XPC_SERVICE_NAME': '0', 16:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:42:56 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 16:42:56 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 16:42:56 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 16:42:56 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 16:42:56 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 16:42:56 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 16:42:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:42:59 INFO - Installing collected packages: mozsystemmonitor 16:42:59 INFO - Running setup.py install for mozsystemmonitor 16:42:59 INFO - Successfully installed mozsystemmonitor 16:42:59 INFO - Cleaning up... 16:42:59 INFO - Return code: 0 16:42:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:42:59 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')]} 16:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:59 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')]} 16:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:59 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:42:59 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 16:42:59 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 16:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:59 INFO - 'HOME': '/Users/cltbld', 16:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:59 INFO - 'LOGNAME': 'cltbld', 16:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:59 INFO - 'MOZ_NO_REMOTE': '1', 16:42:59 INFO - 'NO_EM_RESTART': '1', 16:42:59 INFO - 'PAGER': '/bin/cat', 16:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:59 INFO - 'PWD': '/builds/slave/test', 16:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:59 INFO - 'SHELL': '/bin/bash', 16:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:42:59 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:59 INFO - 'USER': 'cltbld', 16:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:59 INFO - 'XPC_FLAGS': '0x0', 16:42:59 INFO - 'XPC_SERVICE_NAME': '0', 16:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:59 INFO - Downloading/unpacking jsonschema==2.5.1 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:43:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:02 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:03 INFO - warning: no files found matching '*.txt' 16:43:03 INFO - no previously-included directories found matching 'build' 16:43:03 INFO - no previously-included directories found matching 'dist' 16:43:03 INFO - no previously-included directories found matching '.git*' 16:43:03 INFO - Installing collected packages: jsonschema, functools32 16:43:03 INFO - Running setup.py install for functools32 16:43:03 INFO - warning: no files found matching '*.txt' 16:43:03 INFO - no previously-included directories found matching 'build' 16:43:03 INFO - no previously-included directories found matching 'dist' 16:43:03 INFO - no previously-included directories found matching '.git*' 16:43:03 INFO - Successfully installed jsonschema functools32 16:43:03 INFO - Cleaning up... 16:43:03 INFO - Return code: 0 16:43:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:43:03 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')]} 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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')]} 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:43:03 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 16:43:03 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 16:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:03 INFO - 'HOME': '/Users/cltbld', 16:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:03 INFO - 'LOGNAME': 'cltbld', 16:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:03 INFO - 'MOZ_NO_REMOTE': '1', 16:43:03 INFO - 'NO_EM_RESTART': '1', 16:43:03 INFO - 'PAGER': '/bin/cat', 16:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:03 INFO - 'PWD': '/builds/slave/test', 16:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:03 INFO - 'SHELL': '/bin/bash', 16:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:43:03 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:03 INFO - 'USER': 'cltbld', 16:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:03 INFO - 'XPC_FLAGS': '0x0', 16:43:03 INFO - 'XPC_SERVICE_NAME': '0', 16:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:43:03 INFO - Cleaning up... 16:43:03 INFO - Return code: 0 16:43:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:43:03 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')]} 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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')]} 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:43:03 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 16:43:03 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 16:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:03 INFO - 'HOME': '/Users/cltbld', 16:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:03 INFO - 'LOGNAME': 'cltbld', 16:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:03 INFO - 'MOZ_NO_REMOTE': '1', 16:43:03 INFO - 'NO_EM_RESTART': '1', 16:43:03 INFO - 'PAGER': '/bin/cat', 16:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:03 INFO - 'PWD': '/builds/slave/test', 16:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:03 INFO - 'SHELL': '/bin/bash', 16:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:43:03 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:03 INFO - 'USER': 'cltbld', 16:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:03 INFO - 'XPC_FLAGS': '0x0', 16:43:03 INFO - 'XPC_SERVICE_NAME': '0', 16:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:03 INFO - Downloading/unpacking blobuploader==1.2.4 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43:06 INFO - Downloading blobuploader-1.2.4.tar.gz 16:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:43:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 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 16:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:43:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 INFO - Downloading docopt-0.6.1.tar.gz 16:43:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:43:07 INFO - Installing collected packages: blobuploader, requests, docopt 16:43:07 INFO - Running setup.py install for blobuploader 16:43:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:43:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:43:07 INFO - Running setup.py install for requests 16:43:08 INFO - Running setup.py install for docopt 16:43:08 INFO - Successfully installed blobuploader requests docopt 16:43:08 INFO - Cleaning up... 16:43:08 INFO - Return code: 0 16:43:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:08 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')]} 16:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:08 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')]} 16:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:08 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:43:08 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 16:43:08 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 16:43:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:43:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:08 INFO - 'HOME': '/Users/cltbld', 16:43:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:08 INFO - 'LOGNAME': 'cltbld', 16:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:08 INFO - 'MOZ_NO_REMOTE': '1', 16:43:08 INFO - 'NO_EM_RESTART': '1', 16:43:08 INFO - 'PAGER': '/bin/cat', 16:43:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:08 INFO - 'PWD': '/builds/slave/test', 16:43:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:08 INFO - 'SHELL': '/bin/bash', 16:43:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:43:08 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:43:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:08 INFO - 'USER': 'cltbld', 16:43:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:08 INFO - 'XPC_FLAGS': '0x0', 16:43:08 INFO - 'XPC_SERVICE_NAME': '0', 16:43:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:08 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-lqaqNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-JgSGqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-P9kSRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mKxVci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-oF3wXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-ovr6A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-fq4jYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-RATB1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-lekvbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:09 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-2rVJhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-a3SFB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-o_oMbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-I1GTK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-FLhURY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-6b4gI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-yKhomj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-d3gy14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:43:10 INFO - Running setup.py install for manifestparser 16:43:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:43:10 INFO - Running setup.py install for mozcrash 16:43:11 INFO - Running setup.py install for mozdebug 16:43:11 INFO - Running setup.py install for mozdevice 16:43:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Running setup.py install for mozfile 16:43:11 INFO - Running setup.py install for mozhttpd 16:43:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Running setup.py install for mozinfo 16:43:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Running setup.py install for mozInstall 16:43:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:43:11 INFO - Running setup.py install for mozleak 16:43:12 INFO - Running setup.py install for mozlog 16:43:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:43:12 INFO - Running setup.py install for moznetwork 16:43:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:43:12 INFO - Running setup.py install for mozprocess 16:43:12 INFO - Running setup.py install for mozprofile 16:43:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:43:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:43:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:43:12 INFO - Running setup.py install for mozrunner 16:43:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:43:12 INFO - Running setup.py install for mozscreenshot 16:43:13 INFO - Running setup.py install for moztest 16:43:13 INFO - Running setup.py install for mozversion 16:43:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:43:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:43:13 INFO - Cleaning up... 16:43:13 INFO - Return code: 0 16:43:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:13 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')]} 16:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:13 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')]} 16:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:13 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:43:13 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 16:43:13 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 16:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:13 INFO - 'HOME': '/Users/cltbld', 16:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:13 INFO - 'LOGNAME': 'cltbld', 16:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:13 INFO - 'MOZ_NO_REMOTE': '1', 16:43:13 INFO - 'NO_EM_RESTART': '1', 16:43:13 INFO - 'PAGER': '/bin/cat', 16:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:13 INFO - 'PWD': '/builds/slave/test', 16:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:13 INFO - 'SHELL': '/bin/bash', 16:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:43:13 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:13 INFO - 'USER': 'cltbld', 16:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:13 INFO - 'XPC_FLAGS': '0x0', 16:43:13 INFO - 'XPC_SERVICE_NAME': '0', 16:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-JfVLjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:13 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)) 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-TqHsnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:13 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)) 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-J0A1qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:13 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)) 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-c3_r8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-bIeouK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-_paqDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5QNM40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-3p8ta3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-E4Aqyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-li7eG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-_zi8Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Ao8CXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-WXmvGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:14 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)) 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-zBNUYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:15 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)) 16:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-WFzOa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:15 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)) 16:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-b6I9Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:15 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)) 16:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-NCrQog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:15 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)) 16:43:15 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)) 16:43:15 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)) 16:43:15 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)) 16:43:15 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)) 16:43:15 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)) 16:43:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43:15 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 16:43:15 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 16:43:15 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 16:43:15 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 16:43:15 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 16:43:15 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 16:43:18 INFO - Downloading blessings-1.6.tar.gz 16:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:43:18 INFO - Installing collected packages: blessings 16:43:18 INFO - Running setup.py install for blessings 16:43:18 INFO - Successfully installed blessings 16:43:18 INFO - Cleaning up... 16:43:18 INFO - Return code: 0 16:43:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:43:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:18 INFO - Reading from file tmpfile_stdout 16:43:18 INFO - Current package versions: 16:43:18 INFO - blessings == 1.6 16:43:18 INFO - blobuploader == 1.2.4 16:43:18 INFO - docopt == 0.6.1 16:43:18 INFO - functools32 == 3.2.3-2 16:43:18 INFO - jsonschema == 2.5.1 16:43:18 INFO - manifestparser == 1.1 16:43:18 INFO - mozInstall == 1.12 16:43:18 INFO - mozcrash == 1.0 16:43:18 INFO - mozdebug == 0.1 16:43:18 INFO - mozdevice == 0.49 16:43:18 INFO - mozfile == 1.2 16:43:18 INFO - mozhttpd == 0.7 16:43:18 INFO - mozinfo == 0.9 16:43:18 INFO - mozleak == 0.1 16:43:18 INFO - mozlog == 3.4 16:43:18 INFO - moznetwork == 0.27 16:43:18 INFO - mozprocess == 0.24 16:43:18 INFO - mozprofile == 0.28 16:43:18 INFO - mozrunner == 6.13 16:43:18 INFO - mozscreenshot == 0.1 16:43:18 INFO - mozsystemmonitor == 0.3 16:43:18 INFO - moztest == 0.8 16:43:18 INFO - mozversion == 1.4 16:43:18 INFO - psutil == 3.1.1 16:43:18 INFO - requests == 1.2.3 16:43:18 INFO - wsgiref == 0.1.2 16:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:19 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:43:19 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 16:43:19 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 16:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:19 INFO - 'HOME': '/Users/cltbld', 16:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:19 INFO - 'LOGNAME': 'cltbld', 16:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:19 INFO - 'MOZ_NO_REMOTE': '1', 16:43:19 INFO - 'NO_EM_RESTART': '1', 16:43:19 INFO - 'PAGER': '/bin/cat', 16:43:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:19 INFO - 'PWD': '/builds/slave/test', 16:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:19 INFO - 'SHELL': '/bin/bash', 16:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:43:19 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:19 INFO - 'USER': 'cltbld', 16:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:19 INFO - 'XPC_FLAGS': '0x0', 16:43:19 INFO - 'XPC_SERVICE_NAME': '0', 16:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 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)) 16:43:19 INFO - Cleaning up... 16:43:19 INFO - Return code: 0 16:43:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:20 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 0x1046c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc750d5c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, '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.YRgmxQaKwK/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.pFOiywv70S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 16:43:20 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 16:43:20 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 16:43:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:43:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:20 INFO - 'HOME': '/Users/cltbld', 16:43:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:20 INFO - 'LOGNAME': 'cltbld', 16:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:20 INFO - 'MOZ_NO_REMOTE': '1', 16:43:20 INFO - 'NO_EM_RESTART': '1', 16:43:20 INFO - 'PAGER': '/bin/cat', 16:43:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:20 INFO - 'PWD': '/builds/slave/test', 16:43:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:20 INFO - 'SHELL': '/bin/bash', 16:43:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:43:20 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:43:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:20 INFO - 'USER': 'cltbld', 16:43:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:20 INFO - 'XPC_FLAGS': '0x0', 16:43:20 INFO - 'XPC_SERVICE_NAME': '0', 16:43:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:43:20 INFO - Cleaning up... 16:43:20 INFO - Return code: 0 16:43:20 INFO - Running post-action listener: _resource_record_post_action 16:43:20 INFO - Running post-action listener: _start_resource_monitoring 16:43:20 INFO - Starting resource monitoring. 16:43:20 INFO - [mozharness: 2017-03-09 00:43:20.448973Z] Finished create-virtualenv step (success) 16:43:20 INFO - [mozharness: 2017-03-09 00:43:20.450016Z] Running install step. 16:43:20 INFO - Running pre-action listener: _resource_record_pre_action 16:43:20 INFO - Running main action method: install 16:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:20 INFO - Reading from file tmpfile_stdout 16:43:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:20 INFO - Reading from file tmpfile_stdout 16:43:20 INFO - Output received: 16:43:20 INFO - Usage: mozinstall [options] installer 16:43:20 INFO - Options: 16:43:20 INFO - -h, --help show this help message and exit 16:43:20 INFO - -d DEST, --destination=DEST 16:43:20 INFO - Directory to install application into. [default: 16:43:20 INFO - "/builds/slave/test"] 16:43:20 INFO - --app=APP Application being installed. [default: firefox] 16:43:20 INFO - mkdir: /builds/slave/test/build/application 16:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:43:35 INFO - Reading from file tmpfile_stdout 16:43:35 INFO - Output received: 16:43:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:43:35 INFO - Running post-action listener: _resource_record_post_action 16:43:35 INFO - [mozharness: 2017-03-09 00:43:35.415195Z] Finished install step (success) 16:43:35 INFO - [mozharness: 2017-03-09 00:43:35.415336Z] Running run-tests step. 16:43:35 INFO - Running pre-action listener: _resource_record_pre_action 16:43:35 INFO - Running main action method: run_tests 16:43:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:43:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:43:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:43:35 INFO - 2017-03-08 16:43:35.429 screenresolution[1624:7323] starting screenresolution argv=screenresolution get 16:43:35 INFO - 2017-03-08 16:43:35.432 screenresolution[1624:7323] Display 0: 1600x1200x32@60 16:43:35 INFO - 2017-03-08 16:43:35.438 screenresolution[1625:7325] starting screenresolution argv=screenresolution list 16:43:35 INFO - Available Modes on Display 0 16:43:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:43:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:43:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:43:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:43:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:43:35 INFO - Intel Iris: 16:43:35 INFO - Chipset Model: Intel Iris 16:43:35 INFO - Type: GPU 16:43:35 INFO - Bus: Built-In 16:43:35 INFO - VRAM (Dynamic, Max): 1536 MB 16:43:35 INFO - Vendor: Intel (0x8086) 16:43:35 INFO - Device ID: 0x0a2e 16:43:35 INFO - Revision ID: 0x0009 16:43:35 INFO - Displays: 16:43:35 INFO - Display: 16:43:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:43:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:43:35 INFO - Display Serial Number: 1600x1200 60 16:43:35 INFO - Main Display: Yes 16:43:35 INFO - Mirror: Off 16:43:35 INFO - Online: Yes 16:43:35 INFO - Rotation: Supported 16:43:35 INFO - Return code: 0 16:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:35 INFO - Python 2.7.3 16:43:35 INFO - Return code: 0 16:43:35 INFO - grabbing minidump binary from tooltool 16:43:35 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')]} 16:43:35 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 0x1044a3d30>, '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 0x1043cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104498be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:35 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 16:43:35 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 16:43:35 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 16:43:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:35 INFO - Return code: 0 16:43:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:43:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:43:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:35 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/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 16:43:35 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/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --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 16:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YRgmxQaKwK/Render', 16:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:35 INFO - 'HOME': '/Users/cltbld', 16:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:35 INFO - 'LOGNAME': 'cltbld', 16:43:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:35 INFO - 'MOZ_NO_REMOTE': '1', 16:43:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:35 INFO - 'NO_EM_RESTART': '1', 16:43:35 INFO - 'PAGER': '/bin/cat', 16:43:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:35 INFO - 'PWD': '/builds/slave/test', 16:43:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:35 INFO - 'SHELL': '/bin/bash', 16:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFOiywv70S/Listeners', 16:43:35 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 16:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:35 INFO - 'USER': 'cltbld', 16:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:35 INFO - 'XPC_FLAGS': '0x0', 16:43:35 INFO - 'XPC_SERVICE_NAME': '0', 16:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:35 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/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 16:43:36 INFO - mozversion application_buildid: 20170308151723 16:43:36 INFO - mozversion application_changeset: 20dda1bb565d0b18c77e01468c568f68fa1b1396 16:43:36 INFO - mozversion application_display_name: Firefox 16:43:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:36 INFO - mozversion application_name: Firefox 16:43:36 INFO - mozversion application_remotingname: firefox 16:43:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:43:36 INFO - mozversion application_vendor: Mozilla 16:43:36 INFO - mozversion application_version: 53.0 16:43:36 INFO - mozversion platform_buildid: 20170308151723 16:43:36 INFO - mozversion platform_changeset: 20dda1bb565d0b18c77e01468c568f68fa1b1396 16:43:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:43:36 INFO - mozversion platform_version: 53.0 16:43:36 INFO - using testdate: 1489020216 16:43:36 INFO - actual date: 1489020216 16:43:36 INFO - starting webserver on 'localhost:49241' 16:43:36 INFO - SUITE-START | Running 2 tests 16:43:36 INFO - TEST-START | dromaeo_css 16:43:36 INFO - operating with platform_type : mac_ 16:43:36 INFO - Initialising browser for dromaeo_css test... 16:43:36 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpOrZ83c/profile http://localhost:49241/getInfo.html) 16:43:38 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 16:43:38 INFO - PROCESS | 1635 | colorDepth:24 16:43:38 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 16:43:38 INFO - PROCESS | 1635 | __metrics 16:43:38 INFO - PROCESS | 1635 | 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" 16:43:38 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:39 INFO - TEST-INFO | 1635: exit 0 16:43:39 INFO - Browser initialized. 16:43:39 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:39 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpOrZ83c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:51 INFO - PROCESS | 1638 | RSS: Main: 163106816 16:43:51 INFO - PROCESS | 1638 | 16:46:54 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 16:46:56 INFO - PROCESS | 1638 | RSS: Main: 310366208 16:46:56 INFO - PROCESS | 1638 | 16:49:59 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 16:49:59 INFO - PROCESS | 1638 | RSS: Main: 310513664 16:49:59 INFO - PROCESS | 1638 | 16:53:02 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 16:53:02 INFO - PROCESS | 1638 | RSS: Main: 270872576 16:53:02 INFO - PROCESS | 1638 | 16:56:04 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 16:56:05 INFO - PROCESS | 1638 | RSS: Main: 294330368 16:56:05 INFO - PROCESS | 1638 | 16:59:08 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 16:59:09 INFO - PROCESS | 1638 | RSS: Main: 271945728 16:59:09 INFO - PROCESS | 1638 | 17:02:12 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 17:02:13 INFO - PROCESS | 1638 | RSS: Main: 331726848 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | __start_tp_report 17:02:13 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 17:02:13 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 17:02:13 INFO - PROCESS | 1638 | |i|pagename|runs| 17:02:13 INFO - PROCESS | 1638 | |0;dojo.html;3476.930461390772;3500.579930408351;3517.9296414071737;3518.3315170117676;3563.037979745469;6056.394360563947;6064.696765161746;6065.605735627181;6077.5441841861875;6087.178230938827;5970.104484327353;6015.909761353583;6027.126066720323;6060.939335616261;6065.363136870631;5235.947640523594;5348.893022139574;5386.946130538703;5409.83770486886;5484.232207490954;3933.5476420211758;5220.504052115043;5462.781488740466;5475.0966090595;5529.30883639545;5389.703566303851;5438.6736795792185;5461.262729531502;5461.590380721462;5462.781488740466;5455.645383050089;5464.180372944051;5472;5477.75350109242;5482.698451585161;5323.520883120537;5408.594355423359;5410.729463526847;5422.2951016368015;5435.076037073707;6095.317435523651;6111.816645500642;6127.203463549755;6129.601575897597;6130.540209484307;6195.349488303708;6216.440520353145;6231.470325022378;6241.531885108635;6254.15568898202;6369.26753423353;6369.713362898634;6372.076048972873;6379.776707815204;6385.840353991141;5061.342025536694;6042.788502402439;6110.297315808694;6110.969445152746;6113.419225173601;6257.499400047986;6308.8422789429715;6319.96840015797;6462.541104940589;6495.025746138022;6226.782062627786;6266.843328916722;6287.276963149205;6297.937020629735;6302.558820882494;6320.652364120017;6322.747090116436;6324.114623952651;6333.8733225336155;6336.8415789604705;6207.255129384413;6244.718987645567;6254.15568898202;6262.279837818618;6276.843078922972;6185.690715464209;6195.845103872439;6227.532935029801;6231.532635052389;6261.78083767066;5175.06848767218;5183.766730497136;5193.1171700810955;5195.272661827347;5200.895982080413;4618;4620;4625.583697467244;4627.467841198238;4630.58324750774;5828.591998560145;5891.941080589225;5906;5942.227510423617;5944.524438044946;6243.43809057178;6291.591046581958;6293.244810622755;6297.27581328144;6297.811065668037;5839.591228614041;5913;5916.881662366729;5942.851428714317;5953.464188222994;5616.5787565932715;5634.1830434586755;5635.21107045014;5637.098064309691;5645.5201307888465;5346.304980352529;6336.556441049082;6345.270293916166;6404.135441715309;6446.935530644633;6370.394812492806;6378.808635740936;6383.776567820104;6390.93609063922;6397.168368112116;6441.645709486023;6452.612843229421;6470.22357317125;6482.319356467503;6493.318201588765;6194.287656919331;6260.436560709558;6288.748450061947;6290.9056364155485;6313.463355614824;6254.28075771274;6336.651484168415;6353.7140828661895;6357.014662727284;6367.93632063692;6240.12638230639;6241.656708880873;6246.531510136667;6256.374362563707;6290.150829637941;6229.127922091002;6242.781502647385;6248.4688801452385;6253.5935164216;6259.561830671809;6133.4786543142545;6169.136320915165;6178.104174894525;6243.531735119794;6316.463100636497;6260.624362538262;6262.4990000800735;6268.059791031199;6269.592476489196;6283.7800676976085;6221;6236.18929539157;6308.589941653778;6308.621482711052;6310.432061114522 17:02:13 INFO - PROCESS | 1638 | |1;ext.html;519.2600544224482;522.1124089048617;524.3131497737961;535.9517643412095;563.6364544868559;32465.701371945124;43107;44644.77677611607;44673.10653786922;46046.309305360446;46283.537164628346;46538.53461465384;46588.767056164754;46611.53388466114;46743;9671.419714817099;9892.40645561265;9908.653197138101;9930.45382503962;9990.950045249763;9080.228180604656;9311.348205625609;9326.207272381856;9362.204212641933;9400.106989835955;11905.10711696622;12161.209521381126;12173.087018473605;12264.325462099581;12368.13423060386;12016.519339226421;12053.698657533589;12071.336076515789;12075.396230188455;12076.818847717292;12076.275423474532;12168.391580420943;12172.452239649148;12188.451519681636;12196.14626976112;32748.508772368434;43200.351994720106;43309;43410.565894341285;43417.56582434167;4149.522804877448;4184.3932629768815;4186.853460128911;4191.958080419187;4194.706370554062;29222.85388573065;31141.75547316977;32243.35513289721;32522;33423.16442088943;3302.6036875575087;3347.5648165738544;3348.983255083733;3398.9830050849587;3529.435290353531;434760;497423.9999999964;497710;497766;497931;65182.67408662926;65754;65800.67099664567;65827.34172658308;65976;61240.69379653073;67796.6610166946;70386.77679339256;70461.94307085397;70564.64717676378;17892.015939123474;18048.729269060976;18054.09729513519;18059.638807224044;18082.276708931757;13889.652758681113;13938.860611393959;13968.441262349595;13989.3704783285;14005.369758360897;13277.73444531104;15437.614059648375;15873.920630397006;15877.015373078366;17028.14859257057;6585.5719378240265;7727.265909738566;7829.569373684502;7847.293743562993;7893.486923349964;896.233720169259;896.3635818568758;905.090384163911;931.59475628102;934.4673536084366;30595;30806.38387232243;30872.53691194634;31436.37127257442;31636;1109.7336639206533;1133.8469306643497;1149.9885001150049;1156.2195518025298;1247.5416674943895;16072.196390180445;16496;16556.66886662284;16582.336706531605;16668.41660541875;613614;622647;624512.877435619;625272;626561;57322.42677573254;57617;63903.360966389744;64374.35625643683;64661;1509.3509790789847;1522.4290890915906;1522.7715842623695;1532.3947040918997;1536.892417530762;32016.839915800272;33215.83392083024;33348;33449.16377090592;33826.3234735299;54136;55047;55372.72313638406;55401;55563.16655250255;591854;591876;602519;605056;617324;40354.596454036255;41457.58542414537;41701;41922.37116443317;41964.37053444262;49581.752091239316;49710;50188;50279.49720502748;50381.4885553434;39209.607903920594;40127.59872401355;40943.38584921169;41926;42131;40819.59180408158;41239.63395770846;41492.54776082822;41884;41940;37693;38160.618393815705;38531;38875.222495549366;39694.60305396909;33065.50401744024;33729.494057588665;34974.65025349714;35863.28273434569;35896.64103358933;20770;25419.983200672505;25958.22125336243;26157.084502042337;26388.736112638628 17:02:13 INFO - PROCESS | 1638 | |2;jquery.html;397.89455794214535;405.1572728724253;409.37570205436725;418.79688351149684;435.0038412036437;20614.381568552948;20701.585968280626;22041.448963775914;22147.446313842163;22199.001044952976;14341.067830591004;18130.733658292713;22627.886860565715;23109.96005179767;23283.95222215;5281.656692315007;5594.300712410949;5603.831885043435;5612.971935140318;5618;5325.813596524123;5480.314960629921;5500.80747173849;5598.720063996784;5603.7478313475995;5537.390887002426;5539.362973258087;5542.722863856791;5544.306961629796;5545.639533430334;4975.925361119586;5016.799328026893;5532.170174473841;5533.833984980457;5546;5430.3755068167275;5437.483439073281;5438.483344082306;5442.6462279952075;5458.0721277382545;13732.970027247997;14271;23810.92850821717;25556.23331300064;27447.725522744717;2538.4161642822255;2671.505771432272;2720.9591856122174;2743.7667798237176;2759.765419939308;10522.057464777532;10556.918596533262;10964.671059868137;11057.889421105767;11246.481724967107;1845.815418458157;1861.0601646168734;1893.6591413545557;1898.7531620889197;1903.6287923854854;132778;136116;138927;139733;142530;11734.295942243492;12221.266723996589;12273.938630306791;12300.200486968319;12317.322547259808;16558.089305088095;16585.66828663444;16605.00369977805;16608;16640.3343866244;7622.199669034671;9051.185393314634;9220.8616870747;9250.352475326798;9321.254299656011;8998.370114092082;9007.729768106967;9029.954850225708;9209.17117459432;9216.539173041321;4892.241702536113;4982.725950072709;4985.9501404985485;4993.325901003318;5077.441481437039;1790.5613124784252;2078.303768237657;2088.081244252524;2088.7702352741185;2090.1952748192057;716.1227070575045;1024.2727663358949;1025.4308858583559;1047.177965297238;1094.3912448700398;19980.10089545974;22326;22401.775982240295;22460.10159593598;22636.868156592103;1075.473018221066;1083.8807731149568;1083.9891601084046;1117.541807858774;1120.2718233148519;9737.951310243403;11551.595694150665;11634.36011019402;11726.046005253891;11831.349275789742;761875;767684;782206;784520;794607;130204;136156.31921840328;146866;147975.26012369868;152877;1007.2848277722899;1013.4274135113637;1039.1167507618616;1040.7554224757175;1041.8541404203418;15455.768163477333;18828.341008064654;19746.60506789885;19794.60410791805;19797.604047918674;48784.780380490774;57258;57478.42521574731;58994.70502647459;59602.80794384002;81663.69186003128;83429.58285208535;84060;85083.57458212669;91983.54008229917;7458.179600244077;7672.38620910337;7769.533827970114;8143.307818835466;8938.4190027648;7887.369010479262;9041.909580904106;12495.562655307021;13182.538611148564;13620.046596738133;11391.088712903114;11393.34796454526;11492.597759078391;11505.597304094652;11701.941490292495;11491.367974761468;11616.94191529037;11782.528698852293;11889.28664280146;11930.701732456759;11330.94334528322;11566.479508421973;11827.467763950815;11882.82175767347;12143.635690929286;7516.285952834472;7655.157932627518;7748.883766743616;7934.682612695427;7996.760097197093;5821.883562328814;8447.155284471504;9034.825472688508;9188.219001384958;11276.267042642203 17:02:13 INFO - PROCESS | 1638 | |3;mootools.html;1487.7247709173803;1491.157496014751;1510.952659146856;1512.2741084279546;1517.8026856508657;8197.098319184885;8572.871406928902;8575.356848236384;8583.613737381816;8592.527410992392;7628.389728821695;7820.0224971878515;8180.550069746161;8370.916290837089;8389.832203355945;2373.845700029497;2418.22616762636;2421.4914867877765;2422.0432928993037;2427.2960841355984;2393.7845593896545;2411.3007227903886;2424.648425978232;2427.053449154831;2427.490227052312;2388.3909603051284;2391.1033362489065;2414.2274472168915;2416.9879150604224;2420.685310909588;2371.478274779563;2379.1078345620394;2403.6875206223253;2404.6873906392143;2405.482821193434;1979.30724246514;2412.48131651694;2439.4633180700216;2441.633754936756;2443.022790883643;8523.872141917876;8591.183837535424;8605.053444121142;8606.397552171351;8611;5162.148245539519;5315.521603055705;5317.335333083364;5324.467553244684;5326.520613144836;3502.1733521227275;3555.822208889571;3557.4880675712975;3620.6922411595046;3632.382494975834;1134.9829752553635;1159.3507635724022;1277.6039427777325;1285.6721536008351;1344.69744307531;11043.006129448308;11048.950349716764;11052.226344155912;11056.99999999992;11061.391623460706;4451.866444006685;4778.426588809365;4824.541668541483;4827.275908613666;4833.347498087784;9702.611895524242;9712.902870971342;9725.85411218818;9726;9734.561944712505;5385.542228910508;5387.164989426645;5388.622796404214;5396.568274538106;5399.892002159935;4297.613214810682;4434.556544345604;4436.889077773017;4833.516648335139;4920.138975679313;3962.4650672159464;3987.940180897289;4082.7142100053306;4110.917781644351;4142.772147531915;1315.5001099582098;1315.7763180259378;1323.7484877873173;1329.4349901291912;1338.8460327062319;913.9634414623473;914.5595686793328;930.7254359963827;938.8216238914584;988.2143695761887;5424.457554244544;5481.040817856939;5592.5246354059545;5666.461686139893;5703.144528320785;580.5906835680835;598.4255115089476;601.8946684330225;607.5382709141085;608.6378604730179;3688.0226739913946;3694.704423646102;3707.703383729295;3795.981020094937;3822.4075268333454;9591.952040239754;10071.992800719869;10074.891761906185;10169.694909152737;10177.542010609392;10029.69910902674;10029.949850250701;10128.341657792367;10129;10167.694969150938;7878.763637090782;7982.560959147187;7984.201579842085;8084.676612935535;8104.189581041848;5356.892862142658;5377.865553361041;5497.340319161726;5546.334439867242;5653.491185793298;9329.533523323942;9345.345825792128;9409.247260219028;9418.4819834907;9449.149576538144;8540.35947303967;9444.102810233016;9444.102810233016;9559;9570.569324380558;6819.795406137824;7024.789256322319;7030.121234845645;7313.926860731324;7465.962670186832;6492.253390860112;7923.326517246099;8082.757517274491;8167.591620419074;8177.4684645497855;7016.614086225307;7111.715531378687;7129.572225666477;7182.96408517954;7276.745313913988;6067.393260674074;6991.580505169706;7061.540999834994;7172.856542869218;7227.819304517429;6447.9355206447335;6448.709808058742;6452.677366131768;6492.675366231575;6597.835054123493;4936.531029552187;5012.1980483122525;5018.84943451697;5051.267566202953;5062.443131255633;4293.677974152014;4854.83008094715;5003.799848006184;5067.113255180255;5191.974040129775 17:02:13 INFO - PROCESS | 1638 | |4;prototype.html;370.70899344014947;376.6572419098621;383.1474968195765;391.8785176595254;393.6240889950098;5015.9749201254035;5090.287359769631;5146.416138489733;5327.61482014676;5454.972725136378;5083.847484575459;5219.243209734586;5224.7387630618505;5250.501202385767;5335.306410166682;4025.4163146343762;4209.936850947231;4245.299525578292;4255.000074982377;4282.173765314893;3524.9295014099703;3567.6075631680496;3776.45241439991;3893.9875632335516;4243.299855523835;3726.049857286388;4056.0236393403297;4210.200061988227;4245.257080011002;4247.872563823074;3816.274907767543;4188.052555561679;4194.531913830166;4213.776461007332;4227.978860105695;2970.7474864636315;3171.777975541713;3749.8687545935763;3750.1187221003042;3750.549934007909;4687.6249900007915;4965.478624744386;5169.741512924339;5183.870403239912;5193.63644544882;3934.7639141651307;4874.805007799684;4906.90186196274;4913.213885778258;4931.926021109686;5647.632903861236;5663.405342439026;5664.187460012798;5677.091665333527;5689.553491998439;3947.388154836005;4001.8599349022934;4176.016392213704;4176.582341765829;4193.832246710128;5714.885702285973;5891.234139561872;5893;5909.7636094556165;5976.7128079556505;4228.344606585984;4247.214265360918;4249.2563801334645;4252.702310838212;4256.723312984646;3709.9072523187137;4297.957020429818;4331.393604895317;4332.220200363965;4355.194289056535;3571.267935051498;3995.4805875236616;4106.835726570904;4394.98915249488;4747.548982846624;5081.669691470042;5329;5737.913931291034;5755.913661295084;5766.163906233656;1248.0514808745238;1286.633309506786;1310.2204188507822;1311.2232924387508;1316.8880645145077;862.7576290142175;886.5257087458178;889.915458031486;892.790194304338;900.8468560344758;4327.805248763813;4333.458317710286;4845.5881250094135;4974.651774375831;5022.522860328263;5057.974710126499;5217.947820521822;5249.868753281198;5319.46805319465;5535.557155427556;4160.334346504545;4327.545607711208;4631.745254011062;4874;5101.948980510221;2425.866577338263;2810.2693299741804;2872.6983666715114;2897.27568107973;2922.459345021178;5123.769430375642;5573.7770489179975;5585.1901474286005;5651.519620832275;5663.490285874291;4993.325901003318;5040.47075057121;5651.485089135295;5996;6005.759769609167;5261.921775761146;5662.886742265132;5894.469497745224;5975.103734439782;6045.21412216409;4621.745803980813;4874.707517548958;4920.704757714549;5903.343495427161;6022.457978781756;5780.971095144498;5788.421157884178;5807.796727114531;5819.214406055128;5822.214001109796;5624.353199382123;5832.825015249549;5951.345352011189;5954.612950158225;5981.6840295135;3401.557797486311;3720.609336019679;3787.9242415150993;3952.9209415810947;4002.479057957957;5077.822276220315;5217.34783152106;5335.706536140549;5707.143928410605;5866.472017518444;4758.333833263415;5672.744726487401;5686.687232202268;5729.427057294237;5735.225744524602;5373.435789242073;5404.5406140476925;5682.204491371129;5701.287339082614;5701.320379421665;4958.107540642719;5329.520343169133;5449.23710680513;5586.385497595343;5615.017371959809;4778.020505796373;4988.625853061108;5507.807226747044;5515.283013208257;5646.322441307069;4690.835820746258;5296.861174847426;5570.944290557205;5574.219609254626;5589.127642239732 17:02:13 INFO - PROCESS | 1638 | |5;yui.html;727.5852763924559;748.8914107454419;749.6589051981346;800.0399520575307;842.8145807922257;13044.413001414936;15083.170425626586;15561.455349062786;15681.215939203037;15682.999999999985;13772;13910.721785564308;13913.791293130611;13929;13930.233837138954;721;740.3706849178183;890.1410139215656;905.959231834569;910.6266430763388;732.0154392342317;856.2336708645759;877.057163549184;894.0924961164424;912.2838571721201;963.2679163835465;963.585658166988;965.7344230336679;967.1778987860333;970.3256236915312;954.2985905359556;958.0371726414909;961.3462845265217;961.5192403798101;963.1187463470916;711.7651175112201;712.0743034055758;712.7006657203987;714.3428046197458;715.7995761186824;15188.772168417483;15492.302846371827;15548.22258887051;15777.842221577866;16039.599010024725;12198.390080496029;14573.34419951094;15290.694186116327;15317.693646127014;15542.766858497132;11723.824142637868;11940.582079627258;12022.939885300604;12086.214396064228;12245.872527122698;3851.691864650821;3852.5569559500736;3896.6882649388263;4056.127932494528;4057.3305404608204;111756.4412177942;112420.31369529382;115015;115127;117021.414892925;10640.361578305326;11307.886921130848;11593.826092608617;11747.236429632047;11934.522619095313;23826.642600361007;24200.75799241985;24744.010239590574;24800;24813.503729925662;8099.757007289791;8124.796880077927;8151.225633564802;8232.259096681328;8445.142068744866;4372.1692878353015;4482.641388688897;4559.3844830948065;4590.40324757786;4606.930896036562;3452.2405070884365;3543.167355671415;3543.2736289061195;3544.149404142987;3546.7871927684423;665.2349797732646;667.4426853577318;677.3598948993155;696.5576858694766;699.6921354603958;618.8143556932902;644.9000404937242;670.5942904542779;681.7477533312706;683.2757277286092;8932.928048634205;9175;9779.804403911881;9864.111255802845;11148.940850619178;548.9862753431196;559.1780083277657;577.0910815465659;653.3368630839701;728.6975904999472;4422.7346359218545;4747.952520474751;4950.950490495121;5106.15748401517;5144.485551444825;86742;89925.50372481349;96025;96362;97908.51045744725;72348.63825680838;81792;86191;86925;87197.56401217953;68941.65529172422;72612.63693681498;80035;81476;81822;10995.670129896116;11136.554537818396;11218;11282.153838462313;11341.603043893425;48098;48318.51681483281;48544.514554854;49288;49365.50634493609;63180.368196317446;63982.36017639764;63994.68002659957;65592.67203663952;66881.66559167173;10562.086064010335;12849.379269083038;12954;13007.284599347127;13139.21164730081;14265.144091354552;14309.200693489634;14541.200233987232;14547.27263636835;14846.85153148498;13188.142770719873;13337.266450345323;13731.313434328444;13752.106113102616;13766.174029558259;12806.551770687982;13448.193108413527;13557.118787278796;13601.359340997908;13694.657633558842;12407.31759753186;13354.732905342033;13478.056536042383;13642.93178534101;13939.930300348433;11112.333260004425;11407.37259450705;11422.31466112036;11499.137564682514;11888.405579721153;10931.125509959025;10974.429579080883;11018.11855051578;11215.43922803873;11249.437528123397 17:02:13 INFO - PROCESS | 1638 | __end_tp_report 17:02:13 INFO - PROCESS | 1638 | __start_cc_report 17:02:13 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1417 17:02:13 INFO - PROCESS | 1638 | __end_cc_report 17:02:13 INFO - PROCESS | 1638 | __startTimestamp1489021333139__endTimestamp 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | ------- Summary: start ------- 17:02:13 INFO - PROCESS | 1638 | Number of tests: 6 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5906.41 Median:6195.85 stddev:631.48 (10.2%) stddev-sans-first:603.97 17:02:13 INFO - PROCESS | 1638 | Values: 3476.9 3500.6 3517.9 3518.3 3563.0 6056.4 6064.7 6065.6 6077.5 6087.2 5970.1 6015.9 6027.1 6060.9 6065.4 5235.9 5348.9 5386.9 5409.8 5484.2 3933.5 5220.5 5462.8 5475.1 5529.3 5389.7 5438.7 5461.3 5461.6 5462.8 5455.6 5464.2 5472.0 5477.8 5482.7 5323.5 5408.6 5410.7 5422.3 5435.1 6095.3 6111.8 6127.2 6129.6 6130.5 6195.3 6216.4 6231.5 6241.5 6254.2 6369.3 6369.7 6372.1 6379.8 6385.8 5061.3 6042.8 6110.3 6111.0 6113.4 6257.5 6308.8 6320.0 6462.5 6495.0 6226.8 6266.8 6287.3 6297.9 6302.6 6320.7 6322.7 6324.1 6333.9 6336.8 6207.3 6244.7 6254.2 6262.3 6276.8 6185.7 6195.8 6227.5 6231.5 6261.8 5175.1 5183.8 5193.1 5195.3 5200.9 4618.0 4620.0 4625.6 4627.5 4630.6 5828.6 5891.9 5906.0 5942.2 5944.5 6243.4 6291.6 6293.2 6297.3 6297.8 5839.6 5913.0 5916.9 5942.9 5953.5 5616.6 5634.2 5635.2 5637.1 5645.5 5346.3 6336.6 6345.3 6404.1 6446.9 6370.4 6378.8 6383.8 6390.9 6397.2 6441.6 6452.6 6470.2 6482.3 6493.3 6194.3 6260.4 6288.7 6290.9 6313.5 6254.3 6336.7 6353.7 6357.0 6367.9 6240.1 6241.7 6246.5 6256.4 6290.2 6229.1 6242.8 6248.5 6253.6 6259.6 6133.5 6169.1 6178.1 6243.5 6316.5 6260.6 6262.5 6268.1 6269.6 6283.8 6221.0 6236.2 6308.6 6308.6 6310.4 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:72128.89 Median:41596.77 stddev:152781.92 (367.3%) stddev-sans-first:153115.91 17:02:13 INFO - PROCESS | 1638 | Values: 519.3 522.1 524.3 536.0 563.6 32465.7 43107.0 44644.8 44673.1 46046.3 46283.5 46538.5 46588.8 46611.5 46743.0 9671.4 9892.4 9908.7 9930.5 9991.0 9080.2 9311.3 9326.2 9362.2 9400.1 11905.1 12161.2 12173.1 12264.3 12368.1 12016.5 12053.7 12071.3 12075.4 12076.8 12076.3 12168.4 12172.5 12188.5 12196.1 32748.5 43200.4 43309.0 43410.6 43417.6 4149.5 4184.4 4186.9 4192.0 4194.7 29222.9 31141.8 32243.4 32522.0 33423.2 3302.6 3347.6 3349.0 3399.0 3529.4 434760.0 497424.0 497710.0 497766.0 497931.0 65182.7 65754.0 65800.7 65827.3 65976.0 61240.7 67796.7 70386.8 70461.9 70564.6 17892.0 18048.7 18054.1 18059.6 18082.3 13889.7 13938.9 13968.4 13989.4 14005.4 13277.7 15437.6 15873.9 15877.0 17028.1 6585.6 7727.3 7829.6 7847.3 7893.5 896.2 896.4 905.1 931.6 934.5 30595.0 30806.4 30872.5 31436.4 31636.0 1109.7 1133.8 1150.0 1156.2 1247.5 16072.2 16496.0 16556.7 16582.3 16668.4 613614.0 622647.0 624512.9 625272.0 626561.0 57322.4 57617.0 63903.4 64374.4 64661.0 1509.4 1522.4 1522.8 1532.4 1536.9 32016.8 33215.8 33348.0 33449.2 33826.3 54136.0 55047.0 55372.7 55401.0 55563.2 591854.0 591876.0 602519.0 605056.0 617324.0 40354.6 41457.6 41701.0 41922.4 41964.4 49581.8 49710.0 50188.0 50279.5 50381.5 39209.6 40127.6 40943.4 41926.0 42131.0 40819.6 41239.6 41492.5 41884.0 41940.0 37693.0 38160.6 38531.0 38875.2 39694.6 33065.5 33729.5 34974.7 35863.3 35896.6 20770.0 25420.0 25958.2 26157.1 26388.7 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:41285.88 Median:22632.38 stddev:129277.26 (571.2%) stddev-sans-first:129603.46 17:02:13 INFO - PROCESS | 1638 | Values: 397.9 405.2 409.4 418.8 435.0 20614.4 20701.6 22041.4 22147.4 22199.0 14341.1 18130.7 22627.9 23110.0 23284.0 5281.7 5594.3 5603.8 5613.0 5618.0 5325.8 5480.3 5500.8 5598.7 5603.7 5537.4 5539.4 5542.7 5544.3 5545.6 4975.9 5016.8 5532.2 5533.8 5546.0 5430.4 5437.5 5438.5 5442.6 5458.1 13733.0 14271.0 23810.9 25556.2 27447.7 2538.4 2671.5 2721.0 2743.8 2759.8 10522.1 10556.9 10964.7 11057.9 11246.5 1845.8 1861.1 1893.7 1898.8 1903.6 132778.0 136116.0 138927.0 139733.0 142530.0 11734.3 12221.3 12273.9 12300.2 12317.3 16558.1 16585.7 16605.0 16608.0 16640.3 7622.2 9051.2 9220.9 9250.4 9321.3 8998.4 9007.7 9030.0 9209.2 9216.5 4892.2 4982.7 4986.0 4993.3 5077.4 1790.6 2078.3 2088.1 2088.8 2090.2 716.1 1024.3 1025.4 1047.2 1094.4 19980.1 22326.0 22401.8 22460.1 22636.9 1075.5 1083.9 1084.0 1117.5 1120.3 9738.0 11551.6 11634.4 11726.0 11831.3 761875.0 767684.0 782206.0 784520.0 794607.0 130204.0 136156.3 146866.0 147975.3 152877.0 1007.3 1013.4 1039.1 1040.8 1041.9 15455.8 18828.3 19746.6 19794.6 19797.6 48784.8 57258.0 57478.4 58994.7 59602.8 81663.7 83429.6 84060.0 85083.6 91983.5 7458.2 7672.4 7769.5 8143.3 8938.4 7887.4 9041.9 12495.6 13182.5 13620.0 11391.1 11393.3 11492.6 11505.6 11701.9 11491.4 11616.9 11782.5 11889.3 11930.7 11330.9 11566.5 11827.5 11882.8 12143.6 7516.3 7655.2 7748.9 7934.7 7996.8 5821.9 8447.2 9034.8 9188.2 11276.3 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5503.28 Median:5316.43 stddev:2997.29 (56.4%) stddev-sans-first:2990.50 17:02:13 INFO - PROCESS | 1638 | Values: 1487.7 1491.2 1511.0 1512.3 1517.8 8197.1 8572.9 8575.4 8583.6 8592.5 7628.4 7820.0 8180.6 8370.9 8389.8 2373.8 2418.2 2421.5 2422.0 2427.3 2393.8 2411.3 2424.6 2427.1 2427.5 2388.4 2391.1 2414.2 2417.0 2420.7 2371.5 2379.1 2403.7 2404.7 2405.5 1979.3 2412.5 2439.5 2441.6 2443.0 8523.9 8591.2 8605.1 8606.4 8611.0 5162.1 5315.5 5317.3 5324.5 5326.5 3502.2 3555.8 3557.5 3620.7 3632.4 1135.0 1159.4 1277.6 1285.7 1344.7 11043.0 11049.0 11052.2 11057.0 11061.4 4451.9 4778.4 4824.5 4827.3 4833.3 9702.6 9712.9 9725.9 9726.0 9734.6 5385.5 5387.2 5388.6 5396.6 5399.9 4297.6 4434.6 4436.9 4833.5 4920.1 3962.5 3987.9 4082.7 4110.9 4142.8 1315.5 1315.8 1323.7 1329.4 1338.8 914.0 914.6 930.7 938.8 988.2 5424.5 5481.0 5592.5 5666.5 5703.1 580.6 598.4 601.9 607.5 608.6 3688.0 3694.7 3707.7 3796.0 3822.4 9592.0 10072.0 10074.9 10169.7 10177.5 10029.7 10029.9 10128.3 10129.0 10167.7 7878.8 7982.6 7984.2 8084.7 8104.2 5356.9 5377.9 5497.3 5546.3 5653.5 9329.5 9345.3 9409.2 9418.5 9449.1 8540.4 9444.1 9444.1 9559.0 9570.6 6819.8 7024.8 7030.1 7313.9 7466.0 6492.3 7923.3 8082.8 8167.6 8177.5 7016.6 7111.7 7129.6 7183.0 7276.7 6067.4 6991.6 7061.5 7172.9 7227.8 6447.9 6448.7 6452.7 6492.7 6597.8 4936.5 5012.2 5018.8 5051.3 5062.4 4293.7 4854.8 5003.8 5067.1 5192.0 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4547.77 Median:5031.50 stddev:1375.74 (27.3%) stddev-sans-first:1343.40 17:02:13 INFO - PROCESS | 1638 | Values: 370.7 376.7 383.1 391.9 393.6 5016.0 5090.3 5146.4 5327.6 5455.0 5083.8 5219.2 5224.7 5250.5 5335.3 4025.4 4209.9 4245.3 4255.0 4282.2 3524.9 3567.6 3776.5 3894.0 4243.3 3726.0 4056.0 4210.2 4245.3 4247.9 3816.3 4188.1 4194.5 4213.8 4228.0 2970.7 3171.8 3749.9 3750.1 3750.5 4687.6 4965.5 5169.7 5183.9 5193.6 3934.8 4874.8 4906.9 4913.2 4931.9 5647.6 5663.4 5664.2 5677.1 5689.6 3947.4 4001.9 4176.0 4176.6 4193.8 5714.9 5891.2 5893.0 5909.8 5976.7 4228.3 4247.2 4249.3 4252.7 4256.7 3709.9 4298.0 4331.4 4332.2 4355.2 3571.3 3995.5 4106.8 4395.0 4747.5 5081.7 5329.0 5737.9 5755.9 5766.2 1248.1 1286.6 1310.2 1311.2 1316.9 862.8 886.5 889.9 892.8 900.8 4327.8 4333.5 4845.6 4974.7 5022.5 5058.0 5217.9 5249.9 5319.5 5535.6 4160.3 4327.5 4631.7 4874.0 5101.9 2425.9 2810.3 2872.7 2897.3 2922.5 5123.8 5573.8 5585.2 5651.5 5663.5 4993.3 5040.5 5651.5 5996.0 6005.8 5261.9 5662.9 5894.5 5975.1 6045.2 4621.7 4874.7 4920.7 5903.3 6022.5 5781.0 5788.4 5807.8 5819.2 5822.2 5624.4 5832.8 5951.3 5954.6 5981.7 3401.6 3720.6 3787.9 3952.9 4002.5 5077.8 5217.3 5335.7 5707.1 5866.5 4758.3 5672.7 5686.7 5729.4 5735.2 5373.4 5404.5 5682.2 5701.3 5701.3 4958.1 5329.5 5449.2 5586.4 5615.0 4778.0 4988.6 5507.8 5515.3 5646.3 4690.8 5296.9 5570.9 5574.2 5589.1 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20305.42 Median:4214.75 stddev:28784.91 (683.0%) stddev-sans-first:28828.12 17:02:13 INFO - PROCESS | 1638 | Values: 727.6 748.9 749.7 800.0 842.8 13044.4 15083.2 15561.5 15681.2 15683.0 13772.0 13910.7 13913.8 13929.0 13930.2 721.0 740.4 890.1 906.0 910.6 732.0 856.2 877.1 894.1 912.3 963.3 963.6 965.7 967.2 970.3 954.3 958.0 961.3 961.5 963.1 711.8 712.1 712.7 714.3 715.8 15188.8 15492.3 15548.2 15777.8 16039.6 12198.4 14573.3 15290.7 15317.7 15542.8 11723.8 11940.6 12022.9 12086.2 12245.9 3851.7 3852.6 3896.7 4056.1 4057.3 111756.4 112420.3 115015.0 115127.0 117021.4 10640.4 11307.9 11593.8 11747.2 11934.5 23826.6 24200.8 24744.0 24800.0 24813.5 8099.8 8124.8 8151.2 8232.3 8445.1 4372.2 4482.6 4559.4 4590.4 4606.9 3452.2 3543.2 3543.3 3544.1 3546.8 665.2 667.4 677.4 696.6 699.7 618.8 644.9 670.6 681.7 683.3 8932.9 9175.0 9779.8 9864.1 11148.9 549.0 559.2 577.1 653.3 728.7 4422.7 4748.0 4951.0 5106.2 5144.5 86742.0 89925.5 96025.0 96362.0 97908.5 72348.6 81792.0 86191.0 86925.0 87197.6 68941.7 72612.6 80035.0 81476.0 81822.0 10995.7 11136.6 11218.0 11282.2 11341.6 48098.0 48318.5 48544.5 49288.0 49365.5 63180.4 63982.4 63994.7 65592.7 66881.7 10562.1 12849.4 12954.0 13007.3 13139.2 14265.1 14309.2 14541.2 14547.3 14846.9 13188.1 13337.3 13731.3 13752.1 13766.2 12806.6 13448.2 13557.1 13601.4 13694.7 12407.3 13354.7 13478.1 13642.9 13939.9 11112.3 11407.4 11422.3 11499.1 11888.4 10931.1 10974.4 11018.1 11215.4 11249.4 17:02:13 INFO - PROCESS | 1638 | -------- Summary: end -------- 17:02:13 INFO - PROCESS | 1638 | 17:02:13 INFO - TEST-INFO | 1638: exit 0 17:02:13 INFO - TEST-OK | dromaeo_css | took 1117728ms 17:02:13 INFO - TEST-START | kraken 17:02:13 INFO - operating with platform_type : mac_ 17:02:13 INFO - Initialising browser for kraken test... 17:02:13 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpreXNa5/profile http://localhost:49241/getInfo.html) 17:02:15 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 17:02:15 INFO - PROCESS | 1647 | colorDepth:24 17:02:15 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 17:02:15 INFO - PROCESS | 1647 | __metrics 17:02:16 INFO - PROCESS | 1647 | 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" 17:02:16 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:02:16 INFO - TEST-INFO | 1647: exit 0 17:02:16 INFO - Browser initialized. 17:02:16 INFO - Running cycle 1/1 for kraken test... 17:02:16 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpreXNa5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:28 INFO - PROCESS | 1649 | RSS: Main: 162754560 17:02:28 INFO - PROCESS | 1649 | 17:02:31 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:32 INFO - PROCESS | 1649 | RSS: Main: 213823488 17:02:32 INFO - PROCESS | 1649 | 17:02:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 17:02:35 INFO - PROCESS | 1649 | RSS: Main: 229519360 17:02:35 INFO - PROCESS | 1649 | 17:02:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 17:02:39 INFO - PROCESS | 1649 | RSS: Main: 326647808 17:02:39 INFO - PROCESS | 1649 | 17:02:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 17:02:42 INFO - PROCESS | 1649 | RSS: Main: 230182912 17:02:42 INFO - PROCESS | 1649 | 17:02:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:44 INFO - PROCESS | 1649 | RSS: Main: 232054784 17:02:44 INFO - PROCESS | 1649 | 17:02:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:48 INFO - PROCESS | 1649 | RSS: Main: 270831616 17:02:48 INFO - PROCESS | 1649 | 17:02:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 17:02:51 INFO - PROCESS | 1649 | RSS: Main: 268693504 17:02:51 INFO - PROCESS | 1649 | 17:02:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 17:02:55 INFO - PROCESS | 1649 | RSS: Main: 265822208 17:02:55 INFO - PROCESS | 1649 | 17:02:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:02:57 INFO - PROCESS | 1649 | RSS: Main: 244420608 17:02:57 INFO - PROCESS | 1649 | 17:02:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:02:59 INFO - PROCESS | 1649 | RSS: Main: 248135680 17:02:59 INFO - PROCESS | 1649 | 17:03:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:02 INFO - PROCESS | 1649 | RSS: Main: 250388480 17:03:02 INFO - PROCESS | 1649 | 17:03:05 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:03:06 INFO - PROCESS | 1649 | RSS: Main: 268234752 17:03:06 INFO - PROCESS | 1649 | 17:03:09 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:09 INFO - PROCESS | 1649 | RSS: Main: 262107136 17:03:09 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 17:03:11 INFO - PROCESS | 1649 | RSS: Main: 306180096 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | __start_tp_report 17:03:11 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 17:03:11 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 17:03:11 INFO - PROCESS | 1649 | |i|pagename|runs| 17:03:11 INFO - PROCESS | 1649 | |0;ai-astar;104;123;171;154;115;115;114;113;115;115 17:03:11 INFO - PROCESS | 1649 | |1;audio-beat-detection;139;106;106;142;108;106;105;110;153;138 17:03:11 INFO - PROCESS | 1649 | |2;audio-dft;183;227;266;184;184;183;182;181;182;181 17:03:11 INFO - PROCESS | 1649 | |3;audio-fft;78;56;58;88;58;59;56;59;72;57 17:03:11 INFO - PROCESS | 1649 | |4;audio-oscillator;91;91;117;101;70;67;80;67;68;81 17:03:11 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;86;83;86;85;86;83;87;84;89;83 17:03:11 INFO - PROCESS | 1649 | |6;imaging-darkroom;95;95;94;105;94;96;96;127;167;151 17:03:11 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;97;132;86;85;84;85;86;87;87 17:03:11 INFO - PROCESS | 1649 | |8;json-parse-financial;54;51;51;51;55;59;64;66;79;54 17:03:11 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;74;68;74;75;75;70;70;71;70;70 17:03:11 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;82;80;81;83;78;81;81;101;100;90 17:03:11 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;135;136;142;135;139;144;139;144;194;160 17:03:11 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;162;165;164;164;162;161;162;162;162;163 17:03:11 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;64;64;64;65;65;63;66;65;66;78 17:03:11 INFO - PROCESS | 1649 | __end_tp_report 17:03:11 INFO - PROCESS | 1649 | __start_cc_report 17:03:11 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1940 17:03:11 INFO - PROCESS | 1649 | __end_cc_report 17:03:11 INFO - PROCESS | 1649 | __startTimestamp1489021391723__endTimestamp 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | ------- Summary: start ------- 17:03:11 INFO - PROCESS | 1649 | Number of tests: 14 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:123.90 Median:115.00 stddev:21.23 (18.5%) stddev-sans-first:21.26 17:03:11 INFO - PROCESS | 1649 | Values: 104.0 123.0 171.0 154.0 115.0 115.0 114.0 113.0 115.0 115.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:121.30 Median:124.00 stddev:19.14 (15.4%) stddev-sans-first:19.20 17:03:11 INFO - PROCESS | 1649 | Values: 139.0 106.0 106.0 142.0 108.0 106.0 105.0 110.0 153.0 138.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:195.30 Median:183.50 stddev:28.53 (15.5%) stddev-sans-first:29.91 17:03:11 INFO - PROCESS | 1649 | Values: 183.0 227.0 266.0 184.0 184.0 183.0 182.0 181.0 182.0 181.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:64.10 Median:59.00 stddev:11.23 (19.0%) stddev-sans-first:10.73 17:03:11 INFO - PROCESS | 1649 | Values: 78.0 56.0 58.0 88.0 58.0 59.0 56.0 59.0 72.0 57.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:75.00 stddev:16.75 (22.3%) stddev-sans-first:17.54 17:03:11 INFO - PROCESS | 1649 | Values: 91.0 91.0 117.0 101.0 70.0 67.0 80.0 67.0 68.0 81.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.99 (2.3%) stddev-sans-first:2.09 17:03:11 INFO - PROCESS | 1649 | Values: 86.0 83.0 86.0 85.0 86.0 83.0 87.0 84.0 89.0 83.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:94.50 stddev:26.99 (28.6%) stddev-sans-first:27.92 17:03:11 INFO - PROCESS | 1649 | Values: 95.0 95.0 94.0 105.0 94.0 96.0 96.0 127.0 167.0 151.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:91.50 Median:86.00 stddev:14.69 (17.1%) stddev-sans-first:15.45 17:03:11 INFO - PROCESS | 1649 | Values: 86.0 97.0 132.0 86.0 85.0 84.0 85.0 86.0 87.0 87.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:9.00 (15.8%) stddev-sans-first:9.40 17:03:11 INFO - PROCESS | 1649 | Values: 54.0 51.0 51.0 51.0 55.0 59.0 64.0 66.0 79.0 54.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:2.54 (3.5%) stddev-sans-first:2.55 17:03:11 INFO - PROCESS | 1649 | Values: 74.0 68.0 74.0 75.0 75.0 70.0 70.0 71.0 70.0 70.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:81.00 stddev:8.41 (10.4%) stddev-sans-first:8.81 17:03:11 INFO - PROCESS | 1649 | Values: 82.0 80.0 81.0 83.0 78.0 81.0 81.0 101.0 100.0 90.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:143.00 stddev:18.13 (12.7%) stddev-sans-first:18.72 17:03:11 INFO - PROCESS | 1649 | Values: 135.0 136.0 142.0 135.0 139.0 144.0 139.0 144.0 194.0 160.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 17:03:11 INFO - PROCESS | 1649 | Values: 162.0 165.0 164.0 164.0 162.0 161.0 162.0 162.0 162.0 163.0 17:03:11 INFO - PROCESS | 1649 | 17:03:11 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.00 stddev:4.32 (6.6%) stddev-sans-first:4.52 17:03:11 INFO - PROCESS | 1649 | Values: 64.0 64.0 64.0 65.0 65.0 63.0 66.0 65.0 66.0 78.0 17:03:11 INFO - PROCESS | 1649 | -------- Summary: end -------- 17:03:11 INFO - PROCESS | 1649 | 17:03:12 INFO - TEST-INFO | 1649: exit 0 17:03:12 INFO - TEST-OK | kraken | took 58801ms 17:03:12 INFO - SUITE-END | took 1176s 17:03:12 INFO - Completed test suite (00:19:36) 17:03:12 INFO - javascript benchmark 17:03:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3476.930461390772, 3500.579930408351, 3517.9296414071737, 3518.3315170117676, 3563.037979745469, 6056.394360563947, 6064.696765161746, 6065.605735627181, 6077.5441841861875, 6087.178230938827, 5970.104484327353, 6015.909761353583, 6027.126066720323, 6060.939335616261, 6065.363136870631, 5235.947640523594, 5348.893022139574, 5386.946130538703, 5409.83770486886, 5484.232207490954, 3933.5476420211758, 5220.504052115043, 5462.781488740466, 5475.0966090595, 5529.30883639545, 5389.703566303851, 5438.6736795792185, 5461.262729531502, 5461.590380721462, 5462.781488740466, 5455.645383050089, 5464.180372944051, 5472.0, 5477.75350109242, 5482.698451585161, 5323.520883120537, 5408.594355423359, 5410.729463526847, 5422.2951016368015, 5435.076037073707, 6095.317435523651, 6111.816645500642, 6127.203463549755, 6129.601575897597, 6130.540209484307, 6195.349488303708, 6216.440520353145, 6231.470325022378, 6241.531885108635, 6254.15568898202, 6369.26753423353, 6369.713362898634, 6372.076048972873, 6379.776707815204, 6385.840353991141, 5061.342025536694, 6042.788502402439, 6110.297315808694, 6110.969445152746, 6113.419225173601, 6257.499400047986, 6308.8422789429715, 6319.96840015797, 6462.541104940589, 6495.025746138022, 6226.782062627786, 6266.843328916722, 6287.276963149205, 6297.937020629735, 6302.558820882494, 6320.652364120017, 6322.747090116436, 6324.114623952651, 6333.8733225336155, 6336.8415789604705, 6207.255129384413, 6244.718987645567, 6254.15568898202, 6262.279837818618, 6276.843078922972, 6185.690715464209, 6195.845103872439, 6227.532935029801, 6231.532635052389, 6261.78083767066, 5175.06848767218, 5183.766730497136, 5193.1171700810955, 5195.272661827347, 5200.895982080413, 4618.0, 4620.0, 4625.583697467244, 4627.467841198238, 4630.58324750774, 5828.591998560145, 5891.941080589225, 5906.0, 5942.227510423617, 5944.524438044946, 6243.43809057178, 6291.591046581958, 6293.244810622755, 6297.27581328144, 6297.811065668037, 5839.591228614041, 5913.0, 5916.881662366729, 5942.851428714317, 5953.464188222994, 5616.5787565932715, 5634.1830434586755, 5635.21107045014, 5637.098064309691, 5645.5201307888465, 5346.304980352529, 6336.556441049082, 6345.270293916166, 6404.135441715309, 6446.935530644633, 6370.394812492806, 6378.808635740936, 6383.776567820104, 6390.93609063922, 6397.168368112116, 6441.645709486023, 6452.612843229421, 6470.22357317125, 6482.319356467503, 6493.318201588765, 6194.287656919331, 6260.436560709558, 6288.748450061947, 6290.9056364155485, 6313.463355614824, 6254.28075771274, 6336.651484168415, 6353.7140828661895, 6357.014662727284, 6367.93632063692, 6240.12638230639, 6241.656708880873, 6246.531510136667, 6256.374362563707, 6290.150829637941, 6229.127922091002, 6242.781502647385, 6248.4688801452385, 6253.5935164216, 6259.561830671809, 6133.4786543142545, 6169.136320915165, 6178.104174894525, 6243.531735119794, 6316.463100636497, 6260.624362538262, 6262.4990000800735, 6268.059791031199, 6269.592476489196, 6283.7800676976085, 6221.0, 6236.18929539157, 6308.589941653778, 6308.621482711052, 6310.432061114522], "value": 5868.322387584601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.2600544224482, 522.1124089048617, 524.3131497737961, 535.9517643412095, 563.6364544868559, 32465.701371945124, 43107.0, 44644.77677611607, 44673.10653786922, 46046.309305360446, 46283.537164628346, 46538.53461465384, 46588.767056164754, 46611.53388466114, 46743.0, 9671.419714817099, 9892.40645561265, 9908.653197138101, 9930.45382503962, 9990.950045249763, 9080.228180604656, 9311.348205625609, 9326.207272381856, 9362.204212641933, 9400.106989835955, 11905.10711696622, 12161.209521381126, 12173.087018473605, 12264.325462099581, 12368.13423060386, 12016.519339226421, 12053.698657533589, 12071.336076515789, 12075.396230188455, 12076.818847717292, 12076.275423474532, 12168.391580420943, 12172.452239649148, 12188.451519681636, 12196.14626976112, 32748.508772368434, 43200.351994720106, 43309.0, 43410.565894341285, 43417.56582434167, 4149.522804877448, 4184.3932629768815, 4186.853460128911, 4191.958080419187, 4194.706370554062, 29222.85388573065, 31141.75547316977, 32243.35513289721, 32522.0, 33423.16442088943, 3302.6036875575087, 3347.5648165738544, 3348.983255083733, 3398.9830050849587, 3529.435290353531, 434760.0, 497423.9999999964, 497710.0, 497766.0, 497931.0, 65182.67408662926, 65754.0, 65800.67099664567, 65827.34172658308, 65976.0, 61240.69379653073, 67796.6610166946, 70386.77679339256, 70461.94307085397, 70564.64717676378, 17892.015939123474, 18048.729269060976, 18054.09729513519, 18059.638807224044, 18082.276708931757, 13889.652758681113, 13938.860611393959, 13968.441262349595, 13989.3704783285, 14005.369758360897, 13277.73444531104, 15437.614059648375, 15873.920630397006, 15877.015373078366, 17028.14859257057, 6585.5719378240265, 7727.265909738566, 7829.569373684502, 7847.293743562993, 7893.486923349964, 896.233720169259, 896.3635818568758, 905.090384163911, 931.59475628102, 934.4673536084366, 30595.0, 30806.38387232243, 30872.53691194634, 31436.37127257442, 31636.0, 1109.7336639206533, 1133.8469306643497, 1149.9885001150049, 1156.2195518025298, 1247.5416674943895, 16072.196390180445, 16496.0, 16556.66886662284, 16582.336706531605, 16668.41660541875, 613614.0, 622647.0, 624512.877435619, 625272.0, 626561.0, 57322.42677573254, 57617.0, 63903.360966389744, 64374.35625643683, 64661.0, 1509.3509790789847, 1522.4290890915906, 1522.7715842623695, 1532.3947040918997, 1536.892417530762, 32016.839915800272, 33215.83392083024, 33348.0, 33449.16377090592, 33826.3234735299, 54136.0, 55047.0, 55372.72313638406, 55401.0, 55563.16655250255, 591854.0, 591876.0, 602519.0, 605056.0, 617324.0, 40354.596454036255, 41457.58542414537, 41701.0, 41922.37116443317, 41964.37053444262, 49581.752091239316, 49710.0, 50188.0, 50279.49720502748, 50381.4885553434, 39209.607903920594, 40127.59872401355, 40943.38584921169, 41926.0, 42131.0, 40819.59180408158, 41239.63395770846, 41492.54776082822, 41884.0, 41940.0, 37693.0, 38160.618393815705, 38531.0, 38875.222495549366, 39694.60305396909, 33065.50401744024, 33729.494057588665, 34974.65025349714, 35863.28273434569, 35896.64103358933, 20770.0, 25419.983200672505, 25958.22125336243, 26157.084502042337, 26388.736112638628], "value": 21438.216884028145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.89455794214535, 405.1572728724253, 409.37570205436725, 418.79688351149684, 435.0038412036437, 20614.381568552948, 20701.585968280626, 22041.448963775914, 22147.446313842163, 22199.001044952976, 14341.067830591004, 18130.733658292713, 22627.886860565715, 23109.96005179767, 23283.95222215, 5281.656692315007, 5594.300712410949, 5603.831885043435, 5612.971935140318, 5618.0, 5325.813596524123, 5480.314960629921, 5500.80747173849, 5598.720063996784, 5603.7478313475995, 5537.390887002426, 5539.362973258087, 5542.722863856791, 5544.306961629796, 5545.639533430334, 4975.925361119586, 5016.799328026893, 5532.170174473841, 5533.833984980457, 5546.0, 5430.3755068167275, 5437.483439073281, 5438.483344082306, 5442.6462279952075, 5458.0721277382545, 13732.970027247997, 14271.0, 23810.92850821717, 25556.23331300064, 27447.725522744717, 2538.4161642822255, 2671.505771432272, 2720.9591856122174, 2743.7667798237176, 2759.765419939308, 10522.057464777532, 10556.918596533262, 10964.671059868137, 11057.889421105767, 11246.481724967107, 1845.815418458157, 1861.0601646168734, 1893.6591413545557, 1898.7531620889197, 1903.6287923854854, 132778.0, 136116.0, 138927.0, 139733.0, 142530.0, 11734.295942243492, 12221.266723996589, 12273.938630306791, 12300.200486968319, 12317.322547259808, 16558.089305088095, 16585.66828663444, 16605.00369977805, 16608.0, 16640.3343866244, 7622.199669034671, 9051.185393314634, 9220.8616870747, 9250.352475326798, 9321.254299656011, 8998.370114092082, 9007.729768106967, 9029.954850225708, 9209.17117459432, 9216.539173041321, 4892.241702536113, 4982.725950072709, 4985.9501404985485, 4993.325901003318, 5077.441481437039, 1790.5613124784252, 2078.303768237657, 2088.081244252524, 2088.7702352741185, 2090.1952748192057, 716.1227070575045, 1024.2727663358949, 1025.4308858583559, 1047.177965297238, 1094.3912448700398, 19980.10089545974, 22326.0, 22401.775982240295, 22460.10159593598, 22636.868156592103, 1075.473018221066, 1083.8807731149568, 1083.9891601084046, 1117.541807858774, 1120.2718233148519, 9737.951310243403, 11551.595694150665, 11634.36011019402, 11726.046005253891, 11831.349275789742, 761875.0, 767684.0, 782206.0, 784520.0, 794607.0, 130204.0, 136156.31921840328, 146866.0, 147975.26012369868, 152877.0, 1007.2848277722899, 1013.4274135113637, 1039.1167507618616, 1040.7554224757175, 1041.8541404203418, 15455.768163477333, 18828.341008064654, 19746.60506789885, 19794.60410791805, 19797.604047918674, 48784.780380490774, 57258.0, 57478.42521574731, 58994.70502647459, 59602.80794384002, 81663.69186003128, 83429.58285208535, 84060.0, 85083.57458212669, 91983.54008229917, 7458.179600244077, 7672.38620910337, 7769.533827970114, 8143.307818835466, 8938.4190027648, 7887.369010479262, 9041.909580904106, 12495.562655307021, 13182.538611148564, 13620.046596738133, 11391.088712903114, 11393.34796454526, 11492.597759078391, 11505.597304094652, 11701.941490292495, 11491.367974761468, 11616.94191529037, 11782.528698852293, 11889.28664280146, 11930.701732456759, 11330.94334528322, 11566.479508421973, 11827.467763950815, 11882.82175767347, 12143.635690929286, 7516.285952834472, 7655.157932627518, 7748.883766743616, 7934.682612695427, 7996.760097197093, 5821.883562328814, 8447.155284471504, 9034.825472688508, 9188.219001384958, 11276.267042642203], "value": 9868.941921333155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.7247709173803, 1491.157496014751, 1510.952659146856, 1512.2741084279546, 1517.8026856508657, 8197.098319184885, 8572.871406928902, 8575.356848236384, 8583.613737381816, 8592.527410992392, 7628.389728821695, 7820.0224971878515, 8180.550069746161, 8370.916290837089, 8389.832203355945, 2373.845700029497, 2418.22616762636, 2421.4914867877765, 2422.0432928993037, 2427.2960841355984, 2393.7845593896545, 2411.3007227903886, 2424.648425978232, 2427.053449154831, 2427.490227052312, 2388.3909603051284, 2391.1033362489065, 2414.2274472168915, 2416.9879150604224, 2420.685310909588, 2371.478274779563, 2379.1078345620394, 2403.6875206223253, 2404.6873906392143, 2405.482821193434, 1979.30724246514, 2412.48131651694, 2439.4633180700216, 2441.633754936756, 2443.022790883643, 8523.872141917876, 8591.183837535424, 8605.053444121142, 8606.397552171351, 8611.0, 5162.148245539519, 5315.521603055705, 5317.335333083364, 5324.467553244684, 5326.520613144836, 3502.1733521227275, 3555.822208889571, 3557.4880675712975, 3620.6922411595046, 3632.382494975834, 1134.9829752553635, 1159.3507635724022, 1277.6039427777325, 1285.6721536008351, 1344.69744307531, 11043.006129448308, 11048.950349716764, 11052.226344155912, 11056.99999999992, 11061.391623460706, 4451.866444006685, 4778.426588809365, 4824.541668541483, 4827.275908613666, 4833.347498087784, 9702.611895524242, 9712.902870971342, 9725.85411218818, 9726.0, 9734.561944712505, 5385.542228910508, 5387.164989426645, 5388.622796404214, 5396.568274538106, 5399.892002159935, 4297.613214810682, 4434.556544345604, 4436.889077773017, 4833.516648335139, 4920.138975679313, 3962.4650672159464, 3987.940180897289, 4082.7142100053306, 4110.917781644351, 4142.772147531915, 1315.5001099582098, 1315.7763180259378, 1323.7484877873173, 1329.4349901291912, 1338.8460327062319, 913.9634414623473, 914.5595686793328, 930.7254359963827, 938.8216238914584, 988.2143695761887, 5424.457554244544, 5481.040817856939, 5592.5246354059545, 5666.461686139893, 5703.144528320785, 580.5906835680835, 598.4255115089476, 601.8946684330225, 607.5382709141085, 608.6378604730179, 3688.0226739913946, 3694.704423646102, 3707.703383729295, 3795.981020094937, 3822.4075268333454, 9591.952040239754, 10071.992800719869, 10074.891761906185, 10169.694909152737, 10177.542010609392, 10029.69910902674, 10029.949850250701, 10128.341657792367, 10129.0, 10167.694969150938, 7878.763637090782, 7982.560959147187, 7984.201579842085, 8084.676612935535, 8104.189581041848, 5356.892862142658, 5377.865553361041, 5497.340319161726, 5546.334439867242, 5653.491185793298, 9329.533523323942, 9345.345825792128, 9409.247260219028, 9418.4819834907, 9449.149576538144, 8540.35947303967, 9444.102810233016, 9444.102810233016, 9559.0, 9570.569324380558, 6819.795406137824, 7024.789256322319, 7030.121234845645, 7313.926860731324, 7465.962670186832, 6492.253390860112, 7923.326517246099, 8082.757517274491, 8167.591620419074, 8177.4684645497855, 7016.614086225307, 7111.715531378687, 7129.572225666477, 7182.96408517954, 7276.745313913988, 6067.393260674074, 6991.580505169706, 7061.540999834994, 7172.856542869218, 7227.819304517429, 6447.9355206447335, 6448.709808058742, 6452.677366131768, 6492.675366231575, 6597.835054123493, 4936.531029552187, 5012.1980483122525, 5018.84943451697, 5051.267566202953, 5062.443131255633, 4293.677974152014, 4854.83008094715, 5003.799848006184, 5067.113255180255, 5191.974040129775], "value": 4450.206762164022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.70899344014947, 376.6572419098621, 383.1474968195765, 391.8785176595254, 393.6240889950098, 5015.9749201254035, 5090.287359769631, 5146.416138489733, 5327.61482014676, 5454.972725136378, 5083.847484575459, 5219.243209734586, 5224.7387630618505, 5250.501202385767, 5335.306410166682, 4025.4163146343762, 4209.936850947231, 4245.299525578292, 4255.000074982377, 4282.173765314893, 3524.9295014099703, 3567.6075631680496, 3776.45241439991, 3893.9875632335516, 4243.299855523835, 3726.049857286388, 4056.0236393403297, 4210.200061988227, 4245.257080011002, 4247.872563823074, 3816.274907767543, 4188.052555561679, 4194.531913830166, 4213.776461007332, 4227.978860105695, 2970.7474864636315, 3171.777975541713, 3749.8687545935763, 3750.1187221003042, 3750.549934007909, 4687.6249900007915, 4965.478624744386, 5169.741512924339, 5183.870403239912, 5193.63644544882, 3934.7639141651307, 4874.805007799684, 4906.90186196274, 4913.213885778258, 4931.926021109686, 5647.632903861236, 5663.405342439026, 5664.187460012798, 5677.091665333527, 5689.553491998439, 3947.388154836005, 4001.8599349022934, 4176.016392213704, 4176.582341765829, 4193.832246710128, 5714.885702285973, 5891.234139561872, 5893.0, 5909.7636094556165, 5976.7128079556505, 4228.344606585984, 4247.214265360918, 4249.2563801334645, 4252.702310838212, 4256.723312984646, 3709.9072523187137, 4297.957020429818, 4331.393604895317, 4332.220200363965, 4355.194289056535, 3571.267935051498, 3995.4805875236616, 4106.835726570904, 4394.98915249488, 4747.548982846624, 5081.669691470042, 5329.0, 5737.913931291034, 5755.913661295084, 5766.163906233656, 1248.0514808745238, 1286.633309506786, 1310.2204188507822, 1311.2232924387508, 1316.8880645145077, 862.7576290142175, 886.5257087458178, 889.915458031486, 892.790194304338, 900.8468560344758, 4327.805248763813, 4333.458317710286, 4845.5881250094135, 4974.651774375831, 5022.522860328263, 5057.974710126499, 5217.947820521822, 5249.868753281198, 5319.46805319465, 5535.557155427556, 4160.334346504545, 4327.545607711208, 4631.745254011062, 4874.0, 5101.948980510221, 2425.866577338263, 2810.2693299741804, 2872.6983666715114, 2897.27568107973, 2922.459345021178, 5123.769430375642, 5573.7770489179975, 5585.1901474286005, 5651.519620832275, 5663.490285874291, 4993.325901003318, 5040.47075057121, 5651.485089135295, 5996.0, 6005.759769609167, 5261.921775761146, 5662.886742265132, 5894.469497745224, 5975.103734439782, 6045.21412216409, 4621.745803980813, 4874.707517548958, 4920.704757714549, 5903.343495427161, 6022.457978781756, 5780.971095144498, 5788.421157884178, 5807.796727114531, 5819.214406055128, 5822.214001109796, 5624.353199382123, 5832.825015249549, 5951.345352011189, 5954.612950158225, 5981.6840295135, 3401.557797486311, 3720.609336019679, 3787.9242415150993, 3952.9209415810947, 4002.479057957957, 5077.822276220315, 5217.34783152106, 5335.706536140549, 5707.143928410605, 5866.472017518444, 4758.333833263415, 5672.744726487401, 5686.687232202268, 5729.427057294237, 5735.225744524602, 5373.435789242073, 5404.5406140476925, 5682.204491371129, 5701.287339082614, 5701.320379421665, 4958.107540642719, 5329.520343169133, 5449.23710680513, 5586.385497595343, 5615.017371959809, 4778.020505796373, 4988.625853061108, 5507.807226747044, 5515.283013208257, 5646.322441307069, 4690.835820746258, 5296.861174847426, 5570.944290557205, 5574.219609254626, 5589.127642239732], "value": 4127.375455269279, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.5852763924559, 748.8914107454419, 749.6589051981346, 800.0399520575307, 842.8145807922257, 13044.413001414936, 15083.170425626586, 15561.455349062786, 15681.215939203037, 15682.999999999985, 13772.0, 13910.721785564308, 13913.791293130611, 13929.0, 13930.233837138954, 721.0, 740.3706849178183, 890.1410139215656, 905.959231834569, 910.6266430763388, 732.0154392342317, 856.2336708645759, 877.057163549184, 894.0924961164424, 912.2838571721201, 963.2679163835465, 963.585658166988, 965.7344230336679, 967.1778987860333, 970.3256236915312, 954.2985905359556, 958.0371726414909, 961.3462845265217, 961.5192403798101, 963.1187463470916, 711.7651175112201, 712.0743034055758, 712.7006657203987, 714.3428046197458, 715.7995761186824, 15188.772168417483, 15492.302846371827, 15548.22258887051, 15777.842221577866, 16039.599010024725, 12198.390080496029, 14573.34419951094, 15290.694186116327, 15317.693646127014, 15542.766858497132, 11723.824142637868, 11940.582079627258, 12022.939885300604, 12086.214396064228, 12245.872527122698, 3851.691864650821, 3852.5569559500736, 3896.6882649388263, 4056.127932494528, 4057.3305404608204, 111756.4412177942, 112420.31369529382, 115015.0, 115127.0, 117021.414892925, 10640.361578305326, 11307.886921130848, 11593.826092608617, 11747.236429632047, 11934.522619095313, 23826.642600361007, 24200.75799241985, 24744.010239590574, 24800.0, 24813.503729925662, 8099.757007289791, 8124.796880077927, 8151.225633564802, 8232.259096681328, 8445.142068744866, 4372.1692878353015, 4482.641388688897, 4559.3844830948065, 4590.40324757786, 4606.930896036562, 3452.2405070884365, 3543.167355671415, 3543.2736289061195, 3544.149404142987, 3546.7871927684423, 665.2349797732646, 667.4426853577318, 677.3598948993155, 696.5576858694766, 699.6921354603958, 618.8143556932902, 644.9000404937242, 670.5942904542779, 681.7477533312706, 683.2757277286092, 8932.928048634205, 9175.0, 9779.804403911881, 9864.111255802845, 11148.940850619178, 548.9862753431196, 559.1780083277657, 577.0910815465659, 653.3368630839701, 728.6975904999472, 4422.7346359218545, 4747.952520474751, 4950.950490495121, 5106.15748401517, 5144.485551444825, 86742.0, 89925.50372481349, 96025.0, 96362.0, 97908.51045744725, 72348.63825680838, 81792.0, 86191.0, 86925.0, 87197.56401217953, 68941.65529172422, 72612.63693681498, 80035.0, 81476.0, 81822.0, 10995.670129896116, 11136.554537818396, 11218.0, 11282.153838462313, 11341.603043893425, 48098.0, 48318.51681483281, 48544.514554854, 49288.0, 49365.50634493609, 63180.368196317446, 63982.36017639764, 63994.68002659957, 65592.67203663952, 66881.66559167173, 10562.086064010335, 12849.379269083038, 12954.0, 13007.284599347127, 13139.21164730081, 14265.144091354552, 14309.200693489634, 14541.200233987232, 14547.27263636835, 14846.85153148498, 13188.142770719873, 13337.266450345323, 13731.313434328444, 13752.106113102616, 13766.174029558259, 12806.551770687982, 13448.193108413527, 13557.118787278796, 13601.359340997908, 13694.657633558842, 12407.31759753186, 13354.732905342033, 13478.056536042383, 13642.93178534101, 13939.930300348433, 11112.333260004425, 11407.37259450705, 11422.31466112036, 11499.137564682514, 11888.405579721153, 10931.125509959025, 10974.429579080883, 11018.11855051578, 11215.43922803873, 11249.437528123397], "value": 7609.8469078195885, "unit": "score"}], "name": "dromaeo_css", "value": 7468.649725241663, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 123.0, 171.0, 154.0, 115.0, 115.0, 114.0, 113.0, 115.0, 115.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 106.0, 106.0, 142.0, 108.0, 106.0, 105.0, 110.0, 153.0, 138.0], "value": 121.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 227.0, 266.0, 184.0, 184.0, 183.0, 182.0, 181.0, 182.0, 181.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 56.0, 58.0, 88.0, 58.0, 59.0, 56.0, 59.0, 72.0, 57.0], "value": 64.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 117.0, 101.0, 70.0, 67.0, 80.0, 67.0, 68.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 85.0, 86.0, 83.0, 87.0, 84.0, 89.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 105.0, 94.0, 96.0, 96.0, 127.0, 167.0, 151.0], "value": 112.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 132.0, 86.0, 85.0, 84.0, 85.0, 86.0, 87.0, 87.0], "value": 91.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 51.0, 55.0, 59.0, 64.0, 66.0, 79.0, 54.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 74.0, 75.0, 75.0, 70.0, 70.0, 71.0, 70.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 81.0, 83.0, 78.0, 81.0, 81.0, 101.0, 100.0, 90.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 142.0, 135.0, 139.0, 144.0, 139.0, 144.0, 194.0, 160.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 164.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 66.0, 65.0, 66.0, 78.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1467.9, "alertThreshold": 2.0}]} 17:03:12 INFO - Return code: 0 17:03:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:03:13 INFO - # TBPL SUCCESS # 17:03:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:03:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:03:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:03:13 INFO - 2017-03-08 17:03:13.040 screenresolution[1653:9657] starting screenresolution argv=screenresolution get 17:03:13 INFO - 2017-03-08 17:03:13.042 screenresolution[1653:9657] Display 0: 1600x1200x32@60 17:03:13 INFO - 2017-03-08 17:03:13.048 screenresolution[1654:9660] starting screenresolution argv=screenresolution list 17:03:13 INFO - Available Modes on Display 0 17:03:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:03:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:03:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:03:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:03:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:03:13 INFO - Intel Iris: 17:03:13 INFO - Chipset Model: Intel Iris 17:03:13 INFO - Type: GPU 17:03:13 INFO - Bus: Built-In 17:03:13 INFO - VRAM (Dynamic, Max): 1536 MB 17:03:13 INFO - Vendor: Intel (0x8086) 17:03:13 INFO - Device ID: 0x0a2e 17:03:13 INFO - Revision ID: 0x0009 17:03:13 INFO - Displays: 17:03:13 INFO - Display: 17:03:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:03:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:03:13 INFO - Display Serial Number: 1600x1200 60 17:03:13 INFO - Main Display: Yes 17:03:13 INFO - Mirror: Off 17:03:13 INFO - Online: Yes 17:03:13 INFO - Rotation: Supported 17:03:13 INFO - Return code: 0 17:03:13 INFO - Running post-action listener: _resource_record_post_action 17:03:13 INFO - [mozharness: 2017-03-09 01:03:13.287530Z] Finished run-tests step (success) 17:03:13 INFO - Running post-run listener: _resource_record_post_run 17:03:13 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 39220224; Write bytes: 418937856; Read time: 381; Write time: 1840 17:03:13 INFO - TinderboxPrint: CPU usage
53.6% 17:03:13 INFO - TinderboxPrint: I/O read bytes / time
39,220,224 / 381 17:03:13 INFO - TinderboxPrint: I/O write bytes / time
418,937,856 / 1,840 17:03:13 INFO - TinderboxPrint: CPU idle
2,210.8 (46.4%) 17:03:13 INFO - TinderboxPrint: CPU system
959.0 (20.1%) 17:03:13 INFO - TinderboxPrint: CPU user
1,599.9 (33.5%) 17:03:13 INFO - TinderboxPrint: Swap in / out
160,718,848 / 0 17:03:13 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 109904384; Write bytes: 102223872; Read time: 10030; Write time: 186 17:03:13 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38290432; Write bytes: 296238080; Read time: 367; Write time: 1597 17:03:13 INFO - Running post-run listener: _upload_blobber_files 17:03:13 INFO - Blob upload gear active. 17:03:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:03:13 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 17:03:13 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'] 17:03:13 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 17:03:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:03:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:15 INFO - (blobuploader) - INFO - Done attempting. 17:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:16 INFO - (blobuploader) - INFO - Done attempting. 17:03:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:03:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:17 INFO - (blobuploader) - INFO - Done attempting. 17:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:03:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:03:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:03:20 INFO - (blobuploader) - INFO - Done attempting. 17:03:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:03:20 INFO - Return code: 0 17:03:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:03:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:03:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb23bd220d24a823c0128e173e3d8034c67587ec1e9d013c85a1571fdf95e5d718f9906f62da61e03c7148ad3c6b96fe76f444ccf2199562c8f5567dfcef6e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c2fde907e4d15d28218843be132b2e5c12b99b09905efd7e3e0e06d2842e41a91268c95c718bca74827d65439716535ebded733c1d37a0dbfa1d9f5b821552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5801e70bd31e446df7ce19ea1d5979039ee3510b9513e4fb3afd96d9cfba1673994dcadf7c73cefb61a1a3cf3f922ac8ca4ab84f7f98a97a8464fe825f060de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b88f7c452f26703749ab629d37d34168f945bae0a6bb30eccf1c74407d8ea75523d8fece137eee16bed36971065788fdcf5afacd0dc902aa42dc8c89fcad3f27"} 17:03:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:03:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:03:20 INFO - Contents: 17:03:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb23bd220d24a823c0128e173e3d8034c67587ec1e9d013c85a1571fdf95e5d718f9906f62da61e03c7148ad3c6b96fe76f444ccf2199562c8f5567dfcef6e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c2fde907e4d15d28218843be132b2e5c12b99b09905efd7e3e0e06d2842e41a91268c95c718bca74827d65439716535ebded733c1d37a0dbfa1d9f5b821552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5801e70bd31e446df7ce19ea1d5979039ee3510b9513e4fb3afd96d9cfba1673994dcadf7c73cefb61a1a3cf3f922ac8ca4ab84f7f98a97a8464fe825f060de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b88f7c452f26703749ab629d37d34168f945bae0a6bb30eccf1c74407d8ea75523d8fece137eee16bed36971065788fdcf5afacd0dc902aa42dc8c89fcad3f27"} 17:03:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:03:20 INFO - Copying logs to upload dir... 17:03:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:03:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.163936 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-08 17:03:20.192831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 17:03:20.196258) ========= 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.YRgmxQaKwK/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.pFOiywv70S/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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/bb23bd220d24a823c0128e173e3d8034c67587ec1e9d013c85a1571fdf95e5d718f9906f62da61e03c7148ad3c6b96fe76f444ccf2199562c8f5567dfcef6e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c2fde907e4d15d28218843be132b2e5c12b99b09905efd7e3e0e06d2842e41a91268c95c718bca74827d65439716535ebded733c1d37a0dbfa1d9f5b821552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5801e70bd31e446df7ce19ea1d5979039ee3510b9513e4fb3afd96d9cfba1673994dcadf7c73cefb61a1a3cf3f922ac8ca4ab84f7f98a97a8464fe825f060de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b88f7c452f26703749ab629d37d34168f945bae0a6bb30eccf1c74407d8ea75523d8fece137eee16bed36971065788fdcf5afacd0dc902aa42dc8c89fcad3f27"} build_url:https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010987 build_url: 'https://queue.taskcluster.net/v1/task/Ok7w3KMES6igQt9uVWvcAw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb23bd220d24a823c0128e173e3d8034c67587ec1e9d013c85a1571fdf95e5d718f9906f62da61e03c7148ad3c6b96fe76f444ccf2199562c8f5567dfcef6e6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c2fde907e4d15d28218843be132b2e5c12b99b09905efd7e3e0e06d2842e41a91268c95c718bca74827d65439716535ebded733c1d37a0dbfa1d9f5b821552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5801e70bd31e446df7ce19ea1d5979039ee3510b9513e4fb3afd96d9cfba1673994dcadf7c73cefb61a1a3cf3f922ac8ca4ab84f7f98a97a8464fe825f060de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b88f7c452f26703749ab629d37d34168f945bae0a6bb30eccf1c74407d8ea75523d8fece137eee16bed36971065788fdcf5afacd0dc902aa42dc8c89fcad3f27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 17:03:20.230471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 17:03:20.230785) ========= 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.YRgmxQaKwK/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.pFOiywv70S/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005266 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 17:03:20.282084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 17:03:20.283206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 17:03:20.283929) ========= ========= Total master_lag: 0.18 =========