builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0115 starttime: 1494193989.53 results: success (0) buildid: 20170507135942 builduid: 64eb17a83b3a4a508c8068778967707b revision: e767c39dad3a388a9014ef6dbbaa708c31b71279 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.532441) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.532940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.533235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.559864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.560432) ========= 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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-05-07 14:53:09-- 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% 138M=0s 2017-05-07 14:53:09 (138 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162331 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.749411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.749814) ========= 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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.021089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:09.803507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 14:53:09.804021) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e767c39dad3a388a9014ef6dbbaa708c31b71279 --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 e767c39dad3a388a9014ef6dbbaa708c31b71279 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-05-07 14:53:09,879 truncating revision to first 12 chars 2017-05-07 14:53:09,879 Setting DEBUG logging. 2017-05-07 14:53:09,879 attempt 1/10 2017-05-07 14:53:09,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e767c39dad3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-07 14:53:11,074 unpacking tar archive at: mozilla-beta-e767c39dad3a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.448501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 14:53:11.274747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.275106) ========= script_repo_revision: e767c39dad3a388a9014ef6dbbaa708c31b71279 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.275979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.276269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.296911) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-07 14:53:11.297324) ========= /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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:53:11 INFO - MultiFileLogger online at 20170507 14:53:11 in /builds/slave/test 14:53:11 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 14:53:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:11 INFO - {'append_to_log': False, 14:53:11 INFO - 'base_work_dir': '/builds/slave/test', 14:53:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:53:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:11 INFO - 'branch': 'Mozilla-Beta', 14:53:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:11 INFO - 'config_files': ('talos/mac_config.py',), 14:53:11 INFO - 'default_actions': ('clobber', 14:53:11 INFO - 'read-buildbot-config', 14:53:11 INFO - 'download-and-extract', 14:53:11 INFO - 'populate-webroot', 14:53:11 INFO - 'create-virtualenv', 14:53:11 INFO - 'install', 14:53:11 INFO - 'run-tests'), 14:53:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:11 INFO - 'download_minidump_stackwalk': True, 14:53:11 INFO - 'download_symbols': 'ondemand', 14:53:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:11 INFO - 'gecko_profile': False, 14:53:11 INFO - 'gecko_profile_interval': 0, 14:53:11 INFO - 'installer_path': 'installer.exe', 14:53:11 INFO - 'log_level': 'info', 14:53:11 INFO - 'log_name': 'talos', 14:53:11 INFO - 'log_to_console': True, 14:53:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:53:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:53:11 INFO - 'opt_config_files': (), 14:53:11 INFO - 'pip_index': False, 14:53:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:11 INFO - 'cmd': ('bash', 14:53:11 INFO - '-c', 14:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:11 INFO - 'enabled': True, 14:53:11 INFO - 'halt_on_failure': False, 14:53:11 INFO - 'name': 'check_screen_resolution'},), 14:53:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:11 INFO - 'cmd': ('bash', 14:53:11 INFO - '-c', 14:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:11 INFO - 'enabled': True, 14:53:11 INFO - 'halt_on_failure': False, 14:53:11 INFO - 'name': 'check_screen_resolution'},), 14:53:11 INFO - 'run_cmd_checks_enabled': True, 14:53:11 INFO - 'suite': 'dromaeojs', 14:53:11 INFO - 'system_bits': '32', 14:53:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:11 INFO - 'title': 't-yosemite-r7-0115', 14:53:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:11 INFO - 'use_talos_json': True, 14:53:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:11 INFO - 'work_dir': 'build'} 14:53:11 INFO - [mozharness: 2017-05-07 21:53:11.515284Z] Running clobber step. 14:53:11 INFO - Running pre-action listener: _resource_record_pre_action 14:53:11 INFO - Running main action method: clobber 14:53:11 INFO - rmtree: /builds/slave/test/build 14:53:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:11 INFO - Running post-action listener: _resource_record_post_action 14:53:11 INFO - [mozharness: 2017-05-07 21:53:11.907215Z] Finished clobber step (success) 14:53:11 INFO - [mozharness: 2017-05-07 21:53:11.907327Z] Running read-buildbot-config step. 14:53:11 INFO - Running pre-action listener: _resource_record_pre_action 14:53:11 INFO - Running main action method: read_buildbot_config 14:53:11 INFO - Using buildbot properties: 14:53:11 INFO - { 14:53:11 INFO - "project": "", 14:53:11 INFO - "product": "firefox", 14:53:11 INFO - "script_repo_revision": "production", 14:53:11 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:53:11 INFO - "repository": "", 14:53:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:53:11 INFO - "buildid": "20170507135942", 14:53:11 INFO - "pgo_build": "False", 14:53:11 INFO - "basedir": "/builds/slave/test", 14:53:11 INFO - "buildnumber": 6, 14:53:11 INFO - "slavename": "t-yosemite-r7-0115", 14:53:11 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:53:11 INFO - "platform": "yosemite_r7", 14:53:11 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:53:11 INFO - "branch": "mozilla-beta", 14:53:11 INFO - "repo_path": "releases/mozilla-beta", 14:53:11 INFO - "revision": "e767c39dad3a388a9014ef6dbbaa708c31b71279", 14:53:11 INFO - "stage_platform": "macosx64", 14:53:11 INFO - "builduid": "64eb17a83b3a4a508c8068778967707b", 14:53:11 INFO - "slavebuilddir": "test" 14:53:11 INFO - } 14:53:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 14:53:11 INFO - Running post-action listener: _resource_record_post_action 14:53:11 INFO - [mozharness: 2017-05-07 21:53:11.910867Z] Finished read-buildbot-config step (success) 14:53:11 INFO - [mozharness: 2017-05-07 21:53:11.911005Z] Running download-and-extract step. 14:53:11 INFO - Running pre-action listener: _resource_record_pre_action 14:53:11 INFO - Running main action method: download_and_extract 14:53:11 INFO - mkdir: /builds/slave/test/build/tests 14:53:11 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')]} 14:53:11 INFO - trying https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 14:53:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 14:53:12 INFO - Downloaded 1287 bytes. 14:53:12 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:53:12 INFO - Using the following test package requirements: 14:53:12 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 14:53:12 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:53:12 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 14:53:12 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 14:53:12 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:53:12 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 14:53:12 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:53:12 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 14:53:12 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 14:53:12 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 14:53:12 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:12 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 14:53:12 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 14:53:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:53:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:53:12 INFO - Fetch https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:53:14 INFO - Expected file size: 51226373 14:53:14 INFO - Obtained file size: 51226373 14:53:30 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:53:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:53:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:53:30 INFO - Fetch https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:53:33 INFO - Expected file size: 51226373 14:53:33 INFO - Obtained file size: 51226373 14:53:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 14:53:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 14:53:48 INFO - Fetch https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 14:53:50 INFO - Expected file size: 14404449 14:53:50 INFO - Obtained file size: 14404449 14:53:50 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')]} 14:53:50 INFO - trying https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:53:50 INFO - Downloading https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 14:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 14:53:52 INFO - Downloaded 59565746 bytes. 14:53:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:53:52 INFO - mkdir: /builds/slave/test/properties 14:53:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:52 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:52 INFO - Contents: 14:53:52 INFO - build_url:https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:53:53 INFO - Running post-action listener: _resource_record_post_action 14:53:53 INFO - Running post-action listener: set_extra_try_arguments 14:53:53 INFO - [mozharness: 2017-05-07 21:53:53.306558Z] Finished download-and-extract step (success) 14:53:53 INFO - [mozharness: 2017-05-07 21:53:53.306724Z] Running populate-webroot step. 14:53:53 INFO - Running pre-action listener: _resource_record_pre_action 14:53:53 INFO - Running main action method: populate_webroot 14:53:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:53 INFO - '--tppagecycles', 14:53:53 INFO - '7'], 14:53:53 INFO - 'tests': ['tsvgm']}}, 14:53:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:53:53 INFO - 'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:53:53 INFO - 'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['damp', 'tps']}, 14:53:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:53:53 INFO - 'tests': ['damp', 'tps']}, 14:53:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['dromaeo_dom']}, 14:53:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['basic_compositor_video']}, 14:53:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:53:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['a11yr', 14:53:53 INFO - 'ts_paint', 14:53:53 INFO - 'tpaint', 14:53:53 INFO - 'sessionrestore', 14:53:53 INFO - 'sessionrestore_no_auto_restore', 14:53:53 INFO - 'tabpaint']}, 14:53:53 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:53 INFO - 'ts_paint', 14:53:53 INFO - 'tpaint', 14:53:53 INFO - 'sessionrestore', 14:53:53 INFO - 'sessionrestore_no_auto_restore', 14:53:53 INFO - 'tabpaint']}, 14:53:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:53 INFO - 'ts_paint', 14:53:53 INFO - 'tpaint', 14:53:53 INFO - 'sessionrestore', 14:53:53 INFO - 'sessionrestore_no_auto_restore', 14:53:53 INFO - 'tabpaint']}, 14:53:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:53 INFO - 'ts_paint', 14:53:53 INFO - 'tpaint', 14:53:53 INFO - 'sessionrestore', 14:53:53 INFO - 'sessionrestore_no_auto_restore', 14:53:53 INFO - 'tabpaint']}, 14:53:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['a11yr', 14:53:53 INFO - 'ts_paint', 14:53:53 INFO - 'tpaint', 14:53:53 INFO - 'sessionrestore', 14:53:53 INFO - 'sessionrestore_no_auto_restore', 14:53:53 INFO - 'tabpaint']}, 14:53:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['a11yr', 14:53:53 INFO - 'ts_paint', 14:53:53 INFO - 'tpaint', 14:53:53 INFO - 'sessionrestore', 14:53:53 INFO - 'sessionrestore_no_auto_restore', 14:53:53 INFO - 'tabpaint']}, 14:53:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['tsvgx', 14:53:53 INFO - 'tsvgr_opacity', 14:53:53 INFO - 'tart', 14:53:53 INFO - 'tscrollx', 14:53:53 INFO - 'cart', 14:53:53 INFO - 'tsvg_static']}, 14:53:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:53 INFO - 'tsvgr_opacity', 14:53:53 INFO - 'tart', 14:53:53 INFO - 'tscrollx', 14:53:53 INFO - 'cart', 14:53:53 INFO - 'tsvg_static']}, 14:53:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:53:53 INFO - 'talos_options': ['--disable-e10s'], 14:53:53 INFO - 'tests': ['tp5o']}, 14:53:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:53:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:53:53 INFO - 'talos_options': ['--disable-e10s', 14:53:53 INFO - '--xperf_path', 14:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:53 INFO - 'tests': ['tp5n']}, 14:53:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:53:53 INFO - 'talos_options': ['--xperf_path', 14:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:53 INFO - 'tests': ['tp5n']}}, 14:53:53 INFO - 'talos.zip': {'path': '', 14:53:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:53 INFO - Running post-action listener: _resource_record_post_action 14:53:53 INFO - [mozharness: 2017-05-07 21:53:53.325223Z] Finished populate-webroot step (success) 14:53:53 INFO - [mozharness: 2017-05-07 21:53:53.325315Z] Running create-virtualenv step. 14:53:53 INFO - Running pre-action listener: _resource_record_pre_action 14:53:53 INFO - Running main action method: create_virtualenv 14:53:53 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:53 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 14:53:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:53 INFO - Using real prefix '/tools/python27' 14:53:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:54 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:57 INFO - Installing pip.................done. 14:53:57 INFO - Return code: 0 14:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:53:57 INFO - Reading from file tmpfile_stdout 14:53:57 INFO - Output received: 14:53:57 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) 14:53:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:57 INFO - 'HOME': '/Users/cltbld', 14:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:57 INFO - 'LOGNAME': 'cltbld', 14:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:57 INFO - 'MOZ_NO_REMOTE': '1', 14:53:57 INFO - 'NO_EM_RESTART': '1', 14:53:57 INFO - 'PAGER': '/bin/cat', 14:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:57 INFO - 'PWD': '/builds/slave/test', 14:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:57 INFO - 'SHELL': '/bin/bash', 14:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:53:57 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:57 INFO - 'USER': 'cltbld', 14:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:57 INFO - 'XPC_FLAGS': '0x0', 14:53:57 INFO - 'XPC_SERVICE_NAME': '0', 14:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:57 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 14:53:57 INFO - Cleaning up... 14:53:57 INFO - Return code: 0 14:53:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:57 INFO - 'HOME': '/Users/cltbld', 14:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:57 INFO - 'LOGNAME': 'cltbld', 14:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:57 INFO - 'MOZ_NO_REMOTE': '1', 14:53:57 INFO - 'NO_EM_RESTART': '1', 14:53:57 INFO - 'PAGER': '/bin/cat', 14:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:57 INFO - 'PWD': '/builds/slave/test', 14:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:57 INFO - 'SHELL': '/bin/bash', 14:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:53:57 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:57 INFO - 'USER': 'cltbld', 14:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:57 INFO - 'XPC_FLAGS': '0x0', 14:53:57 INFO - 'XPC_SERVICE_NAME': '0', 14:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:57 INFO - Downloading/unpacking psutil>=3.1.1 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:00 INFO - Installing collected packages: psutil 14:54:00 INFO - Running setup.py install for psutil 14:54:00 INFO - building 'psutil._psutil_osx' extension 14:54:00 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 14:54:00 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 14:54:00 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 14:54:00 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 14:54:00 INFO - building 'psutil._psutil_posix' extension 14:54:00 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 14:54:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:54:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:54:00 INFO - ^ 14:54:01 INFO - 1 warning generated. 14:54:01 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 14:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:01 INFO - Successfully installed psutil 14:54:01 INFO - Cleaning up... 14:54:01 INFO - Return code: 0 14:54:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:54:01 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')]} 14:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:01 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')]} 14:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:01 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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54:01 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 14:54:01 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 14:54:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:01 INFO - 'HOME': '/Users/cltbld', 14:54:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:01 INFO - 'LOGNAME': 'cltbld', 14:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:01 INFO - 'MOZ_NO_REMOTE': '1', 14:54:01 INFO - 'NO_EM_RESTART': '1', 14:54:01 INFO - 'PAGER': '/bin/cat', 14:54:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:01 INFO - 'PWD': '/builds/slave/test', 14:54:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:01 INFO - 'SHELL': '/bin/bash', 14:54:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:01 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:01 INFO - 'USER': 'cltbld', 14:54:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:01 INFO - 'XPC_FLAGS': '0x0', 14:54:01 INFO - 'XPC_SERVICE_NAME': '0', 14:54:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:54:02 INFO - Installing collected packages: mozsystemmonitor 14:54:02 INFO - Running setup.py install for mozsystemmonitor 14:54:03 INFO - Successfully installed mozsystemmonitor 14:54:03 INFO - Cleaning up... 14:54:03 INFO - Return code: 0 14:54:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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', '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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:54: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 jsonschema==2.5.1 14:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:03 INFO - 'HOME': '/Users/cltbld', 14:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:03 INFO - 'LOGNAME': 'cltbld', 14:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:03 INFO - 'MOZ_NO_REMOTE': '1', 14:54:03 INFO - 'NO_EM_RESTART': '1', 14:54:03 INFO - 'PAGER': '/bin/cat', 14:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:03 INFO - 'PWD': '/builds/slave/test', 14:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:03 INFO - 'SHELL': '/bin/bash', 14:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:03 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:03 INFO - 'USER': 'cltbld', 14:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:03 INFO - 'XPC_FLAGS': '0x0', 14:54:03 INFO - 'XPC_SERVICE_NAME': '0', 14:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:03 INFO - Downloading/unpacking jsonschema==2.5.1 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:05 INFO - warning: no files found matching '*.txt' 14:54:05 INFO - no previously-included directories found matching 'build' 14:54:05 INFO - no previously-included directories found matching 'dist' 14:54:05 INFO - no previously-included directories found matching '.git*' 14:54:05 INFO - Installing collected packages: jsonschema, functools32 14:54:05 INFO - Running setup.py install for functools32 14:54:05 INFO - warning: no files found matching '*.txt' 14:54:05 INFO - no previously-included directories found matching 'build' 14:54:05 INFO - no previously-included directories found matching 'dist' 14:54:05 INFO - no previously-included directories found matching '.git*' 14:54:05 INFO - Successfully installed jsonschema functools32 14:54:05 INFO - Cleaning up... 14:54:05 INFO - Return code: 0 14:54:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:05 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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54:05 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 14:54:05 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 14:54:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:05 INFO - 'HOME': '/Users/cltbld', 14:54:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:05 INFO - 'LOGNAME': 'cltbld', 14:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:05 INFO - 'MOZ_NO_REMOTE': '1', 14:54:05 INFO - 'NO_EM_RESTART': '1', 14:54:05 INFO - 'PAGER': '/bin/cat', 14:54:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:05 INFO - 'PWD': '/builds/slave/test', 14:54:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:05 INFO - 'SHELL': '/bin/bash', 14:54:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:05 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:05 INFO - 'USER': 'cltbld', 14:54:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:05 INFO - 'XPC_FLAGS': '0x0', 14:54:05 INFO - 'XPC_SERVICE_NAME': '0', 14:54:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:54:05 INFO - Cleaning up... 14:54:05 INFO - Return code: 0 14:54:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:05 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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54:05 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 14:54:05 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 14:54:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:05 INFO - 'HOME': '/Users/cltbld', 14:54:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:05 INFO - 'LOGNAME': 'cltbld', 14:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:05 INFO - 'MOZ_NO_REMOTE': '1', 14:54:05 INFO - 'NO_EM_RESTART': '1', 14:54:05 INFO - 'PAGER': '/bin/cat', 14:54:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:05 INFO - 'PWD': '/builds/slave/test', 14:54:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:05 INFO - 'SHELL': '/bin/bash', 14:54:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:05 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:05 INFO - 'USER': 'cltbld', 14:54:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:05 INFO - 'XPC_FLAGS': '0x0', 14:54:05 INFO - 'XPC_SERVICE_NAME': '0', 14:54:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:05 INFO - Downloading/unpacking blobuploader==1.2.4 14:54:05 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 14:54:05 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 14:54:05 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 14:54:05 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 14:54:05 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 14:54:05 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 14:54:07 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54:08 INFO - Downloading docopt-0.6.1.tar.gz 14:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:08 INFO - Running setup.py install for blobuploader 14:54:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:08 INFO - Running setup.py install for requests 14:54:08 INFO - Running setup.py install for docopt 14:54:08 INFO - Successfully installed blobuploader requests docopt 14:54:08 INFO - Cleaning up... 14:54:09 INFO - Return code: 0 14:54:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:09 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')]} 14:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:09 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')]} 14:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:09 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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54:09 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 14:54:09 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 14:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:09 INFO - 'HOME': '/Users/cltbld', 14:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:09 INFO - 'LOGNAME': 'cltbld', 14:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:09 INFO - 'MOZ_NO_REMOTE': '1', 14:54:09 INFO - 'NO_EM_RESTART': '1', 14:54:09 INFO - 'PAGER': '/bin/cat', 14:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:09 INFO - 'PWD': '/builds/slave/test', 14:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:09 INFO - 'SHELL': '/bin/bash', 14:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:09 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:09 INFO - 'USER': 'cltbld', 14:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:09 INFO - 'XPC_FLAGS': '0x0', 14:54:09 INFO - 'XPC_SERVICE_NAME': '0', 14:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:09 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-nhvMQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:09 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-oEbTa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:09 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-vR1Dqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:09 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Oo7JUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:09 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-5jhi3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:09 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-DGid72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:09 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-KLUqfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-_pGvTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-qtbNN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-iYrRRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Z97pbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-S792D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-vC_3dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-h3AFsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-wgfiID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-xPL2jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:10 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Rp7L4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:11 INFO - Running setup.py install for manifestparser 14:54:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:11 INFO - Running setup.py install for mozcrash 14:54:11 INFO - Running setup.py install for mozdebug 14:54:11 INFO - Running setup.py install for mozdevice 14:54:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:11 INFO - Running setup.py install for mozfile 14:54:11 INFO - Running setup.py install for mozhttpd 14:54:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:11 INFO - Running setup.py install for mozinfo 14:54:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Running setup.py install for mozInstall 14:54:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Running setup.py install for mozleak 14:54:12 INFO - Running setup.py install for mozlog 14:54:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Running setup.py install for moznetwork 14:54:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Running setup.py install for mozprocess 14:54:12 INFO - Running setup.py install for mozprofile 14:54:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Running setup.py install for mozrunner 14:54:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Running setup.py install for mozscreenshot 14:54:13 INFO - Running setup.py install for moztest 14:54:13 INFO - Running setup.py install for mozversion 14:54:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:13 INFO - Cleaning up... 14:54:13 INFO - Return code: 0 14:54:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54: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 14:54: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 14:54:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:13 INFO - 'HOME': '/Users/cltbld', 14:54:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:13 INFO - 'LOGNAME': 'cltbld', 14:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:13 INFO - 'MOZ_NO_REMOTE': '1', 14:54:13 INFO - 'NO_EM_RESTART': '1', 14:54:13 INFO - 'PAGER': '/bin/cat', 14:54:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:13 INFO - 'PWD': '/builds/slave/test', 14:54:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:13 INFO - 'SHELL': '/bin/bash', 14:54:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:13 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:13 INFO - 'USER': 'cltbld', 14:54:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:13 INFO - 'XPC_FLAGS': '0x0', 14:54:13 INFO - 'XPC_SERVICE_NAME': '0', 14:54:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:13 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-v1W8Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:14 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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-YakvJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:14 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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-uAjaVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:14 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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-17p5To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54: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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-hPfA4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54: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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-1pajVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54: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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-jA7OvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54: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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Zb5pFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54: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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-aXhZHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54: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)) 14:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:14 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-XgPMSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:15 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)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:15 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-P6cgGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:15 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)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:15 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-MhB_1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:15 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-WL3xdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:15 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)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:15 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Mzvhed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54: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)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:15 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-xsOPk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54: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)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:15 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-86E9uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54: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)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:15 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-DseQoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54: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)) 14:54: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)) 14:54: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)) 14:54: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)) 14:54: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)) 14:54: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)) 14:54:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54: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 14:54:17 INFO - Downloading blessings-1.6.tar.gz 14:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:54:17 INFO - Installing collected packages: blessings 14:54:17 INFO - Running setup.py install for blessings 14:54:17 INFO - Successfully installed blessings 14:54:17 INFO - Cleaning up... 14:54:17 INFO - Return code: 0 14:54:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:17 INFO - Reading from file tmpfile_stdout 14:54:17 INFO - Current package versions: 14:54:17 INFO - blessings == 1.6 14:54:17 INFO - blobuploader == 1.2.4 14:54:17 INFO - docopt == 0.6.1 14:54:17 INFO - functools32 == 3.2.3-2 14:54:17 INFO - jsonschema == 2.5.1 14:54:17 INFO - manifestparser == 1.1 14:54:17 INFO - mozInstall == 1.12 14:54:17 INFO - mozcrash == 1.0 14:54:17 INFO - mozdebug == 0.1 14:54:17 INFO - mozdevice == 0.49 14:54:17 INFO - mozfile == 1.2 14:54:17 INFO - mozhttpd == 0.7 14:54:17 INFO - mozinfo == 0.9 14:54:17 INFO - mozleak == 0.1 14:54:17 INFO - mozlog == 3.4 14:54:17 INFO - moznetwork == 0.27 14:54:17 INFO - mozprocess == 0.25 14:54:17 INFO - mozprofile == 0.28 14:54:17 INFO - mozrunner == 6.13 14:54:17 INFO - mozscreenshot == 0.1 14:54:17 INFO - mozsystemmonitor == 0.3 14:54:17 INFO - moztest == 0.8 14:54:17 INFO - mozversion == 1.4 14:54:17 INFO - psutil == 3.1.1 14:54:17 INFO - requests == 1.2.3 14:54:17 INFO - wsgiref == 0.1.2 14:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:17 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')]} 14:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:17 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')]} 14:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:17 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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54:17 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 14:54:17 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 14:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:17 INFO - 'HOME': '/Users/cltbld', 14:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:17 INFO - 'LOGNAME': 'cltbld', 14:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:17 INFO - 'MOZ_NO_REMOTE': '1', 14:54:17 INFO - 'NO_EM_RESTART': '1', 14:54:17 INFO - 'PAGER': '/bin/cat', 14:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:17 INFO - 'PWD': '/builds/slave/test', 14:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:17 INFO - 'SHELL': '/bin/bash', 14:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:17 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:17 INFO - 'USER': 'cltbld', 14:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:17 INFO - 'XPC_FLAGS': '0x0', 14:54:17 INFO - 'XPC_SERVICE_NAME': '0', 14:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 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)) 14:54:18 INFO - Cleaning up... 14:54:18 INFO - Return code: 0 14:54:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:18 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 0x105f5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa731662830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, '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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 14:54:18 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 14:54:18 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 14:54:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:18 INFO - 'HOME': '/Users/cltbld', 14:54:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:18 INFO - 'LOGNAME': 'cltbld', 14:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:18 INFO - 'MOZ_NO_REMOTE': '1', 14:54:18 INFO - 'NO_EM_RESTART': '1', 14:54:18 INFO - 'PAGER': '/bin/cat', 14:54:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:18 INFO - 'PWD': '/builds/slave/test', 14:54:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:18 INFO - 'SHELL': '/bin/bash', 14:54:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:18 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:18 INFO - 'USER': 'cltbld', 14:54:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:18 INFO - 'XPC_FLAGS': '0x0', 14:54:18 INFO - 'XPC_SERVICE_NAME': '0', 14:54:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:54:18 INFO - Cleaning up... 14:54:18 INFO - Return code: 0 14:54:18 INFO - Running post-action listener: _resource_record_post_action 14:54:18 INFO - Running post-action listener: _start_resource_monitoring 14:54:18 INFO - Starting resource monitoring. 14:54:18 INFO - [mozharness: 2017-05-07 21:54:18.340762Z] Finished create-virtualenv step (success) 14:54:18 INFO - [mozharness: 2017-05-07 21:54:18.341701Z] Running install step. 14:54:18 INFO - Running pre-action listener: _resource_record_pre_action 14:54:18 INFO - Running main action method: install 14:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:18 INFO - Reading from file tmpfile_stdout 14:54:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:18 INFO - Reading from file tmpfile_stdout 14:54:18 INFO - Output received: 14:54:18 INFO - Usage: mozinstall [options] installer 14:54:18 INFO - Options: 14:54:18 INFO - -h, --help show this help message and exit 14:54:18 INFO - -d DEST, --destination=DEST 14:54:18 INFO - Directory to install application into. [default: 14:54:18 INFO - "/builds/slave/test"] 14:54:18 INFO - --app=APP Application being installed. [default: firefox] 14:54:18 INFO - mkdir: /builds/slave/test/build/application 14:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:54:33 INFO - Reading from file tmpfile_stdout 14:54:33 INFO - Output received: 14:54:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:54:33 INFO - Running post-action listener: _resource_record_post_action 14:54:33 INFO - [mozharness: 2017-05-07 21:54:33.440248Z] Finished install step (success) 14:54:33 INFO - [mozharness: 2017-05-07 21:54:33.440383Z] Running run-tests step. 14:54:33 INFO - Running pre-action listener: _resource_record_pre_action 14:54:33 INFO - Running main action method: run_tests 14:54:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:54:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:54:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:54:33 INFO - 2017-05-07 14:54:33.454 screenresolution[1972:280670] starting screenresolution argv=screenresolution get 14:54:33 INFO - 2017-05-07 14:54:33.457 screenresolution[1972:280670] Display 0: 1600x1200x32@60 14:54:33 INFO - 2017-05-07 14:54:33.463 screenresolution[1973:280672] starting screenresolution argv=screenresolution list 14:54:33 INFO - Available Modes on Display 0 14:54:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:54:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:54:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:54:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:54:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:54:33 INFO - Intel Iris: 14:54:33 INFO - Chipset Model: Intel Iris 14:54:33 INFO - Type: GPU 14:54:33 INFO - Bus: Built-In 14:54:33 INFO - VRAM (Dynamic, Max): 1536 MB 14:54:33 INFO - Vendor: Intel (0x8086) 14:54:33 INFO - Device ID: 0x0a2e 14:54:33 INFO - Revision ID: 0x0009 14:54:33 INFO - Displays: 14:54:33 INFO - Display: 14:54:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:54:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:54:33 INFO - Display Serial Number: 1600x1200 60 14:54:33 INFO - Main Display: Yes 14:54:33 INFO - Mirror: Off 14:54:33 INFO - Online: Yes 14:54:33 INFO - Rotation: Supported 14:54:33 INFO - Return code: 0 14:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:54:33 INFO - Python 2.7.3 14:54:33 INFO - Return code: 0 14:54:33 INFO - grabbing minidump binary from tooltool 14:54:33 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')]} 14:54:33 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 0x105d39d30>, '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 0x105c60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d2ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:54:33 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 14:54:33 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 14:54:33 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 14:54:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:54:33 INFO - Return code: 0 14:54:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:54:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:54:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:54:33 INFO - ENV: RUST_BACKTRACE is now 1 14:54:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:54:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:54:33 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/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 14:54:33 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/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0115 --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 14:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uS7z7CfoCR/Render', 14:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:33 INFO - 'HOME': '/Users/cltbld', 14:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:33 INFO - 'LOGNAME': 'cltbld', 14:54:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:54:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:33 INFO - 'MOZ_NO_REMOTE': '1', 14:54:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:54:33 INFO - 'NO_EM_RESTART': '1', 14:54:33 INFO - 'PAGER': '/bin/cat', 14:54:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:33 INFO - 'PWD': '/builds/slave/test', 14:54:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:33 INFO - 'RUST_BACKTRACE': '1', 14:54:33 INFO - 'SHELL': '/bin/bash', 14:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nIXcf4TEhQ/Listeners', 14:54:33 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 14:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:33 INFO - 'USER': 'cltbld', 14:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:33 INFO - 'XPC_FLAGS': '0x0', 14:54:33 INFO - 'XPC_SERVICE_NAME': '0', 14:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:33 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/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 14:54:34 INFO - mozversion application_buildid: 20170507135942 14:54:34 INFO - mozversion application_changeset: e767c39dad3a388a9014ef6dbbaa708c31b71279 14:54:34 INFO - mozversion application_display_name: Firefox 14:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:54:34 INFO - mozversion application_name: Firefox 14:54:34 INFO - mozversion application_remotingname: firefox 14:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:54:34 INFO - mozversion application_vendor: Mozilla 14:54:34 INFO - mozversion application_version: 54.0 14:54:34 INFO - mozversion platform_buildid: 20170507135942 14:54:34 INFO - mozversion platform_changeset: e767c39dad3a388a9014ef6dbbaa708c31b71279 14:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:54:34 INFO - mozversion platform_version: 54.0 14:54:34 INFO - using testdate: 1494194074 14:54:34 INFO - actual date: 1494194074 14:54:34 INFO - starting webserver on 'localhost:49311' 14:54:34 INFO - SUITE-START | Running 2 tests 14:54:34 INFO - TEST-START | dromaeo_css 14:54:34 INFO - operating with platform_type : mac_ 14:54:34 INFO - Initialising browser for dromaeo_css test... 14:54:34 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpyuDrhh/profile http://localhost:49311/getInfo.html) 14:54:36 INFO - PROCESS | 1983 | __metrics Screen width/height:1600/1200 14:54:36 INFO - PROCESS | 1983 | colorDepth:24 14:54:36 INFO - PROCESS | 1983 | Browser inner width/height: 1024/689 14:54:36 INFO - PROCESS | 1983 | __metrics 14:54:36 INFO - PROCESS | 1983 | 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" 14:54:36 INFO - PROCESS | 1983 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:54:37 INFO - TEST-INFO | 1983: exit 0 14:54:37 INFO - Browser initialized. 14:54:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:54:37 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpyuDrhh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:49 INFO - PROCESS | 1988 | RSS: Main: 164929536 14:54:49 INFO - PROCESS | 1988 | 14:57:53 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49311/tests/dromaeo/cssquery-ext.html) 14:57:54 INFO - PROCESS | 1988 | RSS: Main: 291160064 14:57:54 INFO - PROCESS | 1988 | 15:00:57 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-ext.html (next: http://localhost:49311/tests/dromaeo/cssquery-jquery.html) 15:00:58 INFO - PROCESS | 1988 | RSS: Main: 304279552 15:00:58 INFO - PROCESS | 1988 | 15:04:00 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49311/tests/dromaeo/cssquery-mootools.html) 15:04:01 INFO - PROCESS | 1988 | RSS: Main: 284909568 15:04:01 INFO - PROCESS | 1988 | 15:07:03 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49311/tests/dromaeo/cssquery-prototype.html) 15:07:04 INFO - PROCESS | 1988 | RSS: Main: 282525696 15:07:04 INFO - PROCESS | 1988 | 15:10:07 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49311/tests/dromaeo/cssquery-yui.html) 15:10:08 INFO - PROCESS | 1988 | RSS: Main: 275251200 15:10:08 INFO - PROCESS | 1988 | 15:13:11 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-yui.html (next: http://localhost:49311/tests/dromaeo/cssquery-dojo.html) 15:13:12 INFO - PROCESS | 1988 | RSS: Main: 394407936 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | __start_tp_report 15:13:12 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 15:13:12 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 15:13:12 INFO - PROCESS | 1988 | |i|pagename|runs| 15:13:12 INFO - PROCESS | 1988 | |0;dojo.html;3542.167590616205;3563.4298512238047;3567.7324200684957;3599.442086476594;3626.782393056417;6173.166622505961;6174.7530098796105;6198.132261483396;6199.628022318653;6235.59468634539;6182.505399568035;6227.470664993481;6242.937570624293;6245.56281060326;6260.436560709547;5453.509184173424;5475.890482190353;5504.339479262494;5520.309961254843;5600.18797274395;5383.784648614051;5392.110301800199;5425.538829199523;5584.050711379075;5598.104303311471;4241.978790106045;5495.890082198353;5496.230527726121;5532.972335138339;5540.085885828834;5527.364353099385;5559.499645031967;5574.247476590649;5575.024370735106;5579.13523403873;5425.701586412746;5496.961653977776;5518.530924871391;5519.586031047647;5520.751566179531;5046.671966322214;5991.221141251653;6015.398460153993;6125.540584456184;6197.03945888388;6325.841853953642;6345.9365406345805;6351.142595749561;6353.491720662382;6394.360563943615;5347.973260133714;6548;6574.441172500343;6620.834479138012;7015.088038555006;6262.154609127755;6273.12176295319;6287.811365659038;6292.685365731695;6302.023186406114;6467.062275970052;6486.05952136947;6786.966065169642;6789.524733268722;6815.693293801791;6306.054091886162;6320.051992201206;6334.461570766536;6360.681965901686;6398.840028999219;6487.578307410004;6488.480921526267;6501;6525.738970441224;6532.346765323429;6269.7178626961895;6453.322401147906;6465.935340646533;6467.644279564669;6468.838279043061;6334.271558770708;6347.52393570484;6432.581882177644;6499.350064993558;6504.739810407626;5273;5291.365036195604;5291.656042357235;5298.70857102863;5327.573794096463;4703.0593881223895;4704.082703872712;4720.291956206596;4727.196376615983;4758.5241475852135;6120.969395152996;6185.195924529872;6243.344448832898;6252.499800015988;6297.055441683692;6573.342665733484;6611.140551728245;6630.7679231226675;6634.933650663528;6647.966760166169;6302.905456418157;6312.4634406076;6312.589681670676;6324.936750632527;6343.238811342576;5569.693666848362;5668.121441176624;5720.342160651495;5809.215755872903;5824.039033559416;5950.226470558886;6804.523683342317;6840.48696347766;6857.074294970115;6886.724531018703;6598.736050558116;6601.306862779531;6604.735810567524;6614.536982411185;6624.238212605612;6428.582142160744;6703.8324041897395;6802;6870.244273130052;6892.965535172292;6379.776707815204;6415.647139407378;6447.451966582893;6470.967645161744;6525.64108974011;6316.557840951089;6577.769778057745;6590.176227971504;6592.967035164794;6599.9010014848855;6236.469900058364;6248.812535623939;6309.936900630935;6326.652034137983;6372.36276372359;6364.395382438661;6379.585326953733;6391.6804159792755;6393.584417012879;6398.424141827258;6158.815235542941;6198.442140207403;6232.127502149612;6238.251409830849;6283.7800676976085;6363.490920726424;6404.711787969646;6421.518386121153;6423.96788016057;6426.357364263723;6287.088372185916;6309.652969086561;6317.873642527032;6318.652474113968;6323.051542268697 15:13:12 INFO - PROCESS | 1988 | |1;ext.html;784.4234487651576;816.6692489541736;833.1543483364385;917.7017469322471;918.1828172926092;21968.78031219687;41625.95935101624;41985.7900710496;42051.57948420515;42304.36543451843;34420.1394965126;43726.78136609313;43729.78135109328;43763.56236437635;43801.56198438015;7874.803129921741;9616.278779091579;9772.853407198898;9778.559964801565;9782.168515676176;7914.24814642608;11773.411329433537;11942.880571194308;11943.34311612861;11949.223300485484;11950.402479876015;11982.94008529956;12030.33833139177;12046.096542759284;12065.939670301635;11971.46128424223;11983;12014.69963250917;12023.098267629963;12029.939850300692;11627.76744465106;11678.532858685643;11685.474153663106;11687.415629218505;11692.532298708042;40887.591124088976;40989.795051024856;41090;41176;41228.38157427641;3958.4656071430277;4012.558618551957;4014.3978403239457;4017.4576432181575;4031.7984100794843;28070.43859122806;29011.854940725163;29502.409951800844;30368.54447183294;30820;3271.6401195868434;3295.6869097435706;3327.367800117994;3439.4324936385465;3440.707539859115;275773.24226757674;312552;315045;317681.4115929429;317729;51123;51320.716982075;51460;51470.65440746339;51489.742551287;54960;54960;54989.450105499236;55118.448815512136;55249;15040.623984400478;15171.924140379228;15513.534593961973;15591.532254032398;15612.063276203464;11986.580469683518;12142.392880355947;13179.14335568185;13202.405891734896;13217.867821321664;11016.889831101747;12601.495940162291;12619;12724.363781810873;12765.361731913366;5377.354717433933;5400.378956420062;5401.405845357008;5407.270018547524;5408.756605952742;949.1505102932837;963.6097380560884;969.6557722008727;987.6395115782688;999.6201443451442;28546.857265713537;28799;28817.711822881924;29099.27251818679;29295.707042929724;981.7398389426808;1036.8496567997597;1090.8472813806075;1168.1414160591958;1330.7205486847677;12141.304564580107;14442.783358249635;14528.904774011036;14766.0402073867;14768.818494520627;467886;468329;468461;468954;470623;58958.70520647369;59146;59191;59205.11192332119;59406.70296648489;1443.3793468808512;1461.2547600723708;1482.1699848085107;1497.7603583426599;1526.9847301527066;27238.72761272362;27541.724582753915;28861.422771544872;29346.413071738018;29466.705332946396;39589.80205098956;39730.602693973844;39740.403893942195;39745.80127099346;39770.403443947784;423532;424410.7558924371;424598;424820;425803;26181.607275890496;26579.867100665146;29846;30252.69747302587;30366.544501832934;32395.51406728948;32473.51289730703;32858;33381.49927751134;42102.789486053596;27304.044358447358;27987.020454284004;29312.41375172527;30131.698683013765;30292.091237262917;29155.85422072876;29200.26999324949;29271;29344.853275733483;30103.849480752455;34361;34983.9504814856;35171.12072198215;35239.647603523634;35313.64686353104;27692.169234922985;28739.712602873704;29232.707672923;30159.396812064075;30339;18721;22811.88594057019;23831.24569719158;23857.761422385553;24035.27894163178 15:13:12 INFO - PROCESS | 1988 | |2;jquery.html;428.6913422335917;436.58742488348514;439.8174757475648;447.03663604931364;449.07042422186066;19637.803621963776;20761.377158685245;21833;22111.668324975137;22166.445838854015;21038;23076.307710768702;23076.307710768702;23987.76012239877;24278.271651850428;6640.667966601663;6921.757738479154;6923.996020577013;6926.030355750199;7512.661930213126;7733.767986960372;7849.175836537167;7862.528248305091;7870.252326029018;7873.8031549211155;7805.60971951403;7808.687652493893;7810;7940.920590794105;7991.600419979007;7646.120696119961;7860.528368297863;7867.567283799389;7962.601869906482;7972.322352600036;7462.403007759366;7656.425768067362;7698.076230852277;7708.03649543807;7710.537367757896;25649.358766030997;26007.479850402888;26240.9503619855;26432.86783566089;26633.46733065328;2868.770498360147;2937.9118626441027;3007.8496075196153;3052.893148739806;3066.340736741611;15532.61168470786;16344.18279086041;16518.917405412896;17163.227654755567;17223.483295501028;2091.581683663258;2110.0610228448195;2126.5002724359765;2202.801747842702;2212.0267082483656;115235.42382288034;147419.52580474166;150805.24597377054;154123;162112.18943905324;18980.14589343483;19939;20109.49726256855;20132.6648438164;20241.696374554394;31515;32235.35529289401;32345.67654323474;32372.35255294928;32486.837565812493;8750.69372571957;10447.947760261302;10561.313514621525;10687.038166565046;10885.673429797118;8979.730608081769;8985.191332780081;9008.63965441388;9036.63853445868;9166.26669866409;7421.220771818989;9275.443473391619;9304.627814887328;9404.529773511296;9432;3576.91057723559;3839.424086387064;3948.7433316834313;4042.3936409538805;4057.33054046085;937.5031233446284;1041.3439533094102;1050.9700493516398;1074.6990842564094;1112.22700223344;21941.041328629366;22625.54748905013;22638.886805566195;22648.773512264997;22669.773302266767;1061.2913209732326;1063.9414832184304;1085.8154113800672;1093.5899037860802;1099.7360633447915;10724.356538607708;11065.391403472726;11111.944365285284;11598.420078996016;11615;678669;752588;792570;802003;810300;157859;160848;162059;162534;169944.1502792503;1318.960431187066;1320.8150858879765;1373.2858913364994;1375.24361601119;1381.4819442708983;19529.511762206057;19845.900770496057;20301.898490507454;20302.390928272176;20328.89835550813;62374.68812655908;62675.68662156843;62857.68571157115;63034.36965630285;64475;74336.25663743293;82365;88883.55558222167;89468.5526572389;90873;10535.473226338805;11450.370229637118;11599.76800464003;11754.764904701688;11966.22219555726;11066.667999960015;12596.307203103917;12739.80890286628;13078.80381794293;13156.342182890625;11109.388983605655;11339.773204536028;11395.658130256106;11454;11609.30344179352;8579.699710510102;10308.12380947628;10423.11403530678;10492.213084018576;10565.735856603646;9759.707208783748;11030.889691102986;11470.483828227583;11715.062794976211;11828.290302581872;11639.825402619137;11746.58886938953;11904.642860714192;11936.16446848747;11972.58095966637;10820.621278255223;11246.887531124585;11359.602413915472;11407.37259450705;11430.542778289107 15:13:12 INFO - PROCESS | 1988 | |3;mootools.html;1427.0866645346973;1617.4662361420733;1647.7940257467817;1653.1816750708394;1661.0448991829696;9301.767455813608;9385.624575017;9788.657396991106;11018.834717479243;11107.555697772079;10950.288231264962;11044.392558409305;11111.499982500787;11171.83242251367;11173.553057877674;2425.417899704076;2470.6788117544693;2475.4677744284977;2475.938101547467;2477.467344520928;2095.706601075851;2167.9241226557074;2420.5279970405777;2493.7506249375097;2497.2133777859917;2435.0138194031447;2435.391152211947;2460.052879641333;2465.642481840132;2469.370310570802;2463.5442443148077;2466.728659847415;2468.7284398716215;2468.7654672806057;2469.703635563744;2376.417777644488;2406.6991626046743;2415.347856078849;2428.065194899976;2468.9135880244107;11605.535778568847;11683.941580292128;11690.649280521598;11692.532298708042;11698.824517632242;5948.434898684618;6124.234470691164;6127.816165515042;6135.570510064297;6141;3619.1856832212807;3649.8905032848793;3820.3123437781187;3879.4180872869297;3891.20230352777;1212.9818052729215;1250.9687257818628;1282.6665067082533;1297.2540789046336;1311.4426368793224;15671.529854104281;15822.76265856013;15823.28795204207;15835.524934251991;15844.603884902854;4097.89755256115;4776.307435421844;5111.616628752859;5113.539781419616;5114.181730923035;13275.867241327656;13297.3351332433;13297.534586289434;13310;13353.265570393527;6148.1699970504305;6158.969205153946;6160.845978850564;6171.105189747462;6177.104319873593;4734.928976065362;5467.371252306036;5511.669299842022;5549.19536667181;5604.8038318658655;3791.75353602015;3874.965643037428;4122.711410201257;4227.725197862129;4268.829246830092;1162.4071723421116;1170.9590164344206;1179.4928180882132;1191.184038933316;1191.7497325561728;968.5205823117602;992.2905122837062;995.5619527407918;996.0139461932635;1005.3465247589126;6608.537402381787;6800.285969973181;6854.691538880762;6910;6947.652617369111;1023.8668973033458;1034.9223808214415;1069.7004838645191;1083.6153165626247;1101.5703875488566;4256.59562341577;4290.849820256339;4295.162443323522;4407.47110346754;4437.600615944581;11098;14010.089344192595;14156.575302740934;14165.78751318731;14234.715305694035;13712.862871371359;14285.500007499688;14322.427102915975;14331.355089021019;14341.99606027568;10337.844932326021;10467.115919134476;10480.109190718875;10489.790204195873;10493.632722854663;6326.810195694136;6595.241547221939;6738.797836064926;6765.763198288037;6809.863802724017;12532.997360210979;12602.747945040865;12700.745985080432;12701.745965080832;12707.745845083231;12706.047046471736;12790;12815.295158765985;12864.421101050662;13046.54337098197;9232.307576931622;9463.195628371666;9475.952620236854;9479.573419196015;9500.762480938032;8909.420887642282;10035.297529172887;10364.015418535228;10421.270511064153;10677.519511622151;9114.954425227832;9191.724248272563;9251.352405331561;9296.884373875178;9458.38520496193;7261.3101755333155;8896.5996530155;8921.553922303729;8977.7755556109;9001.504917229615;8116.188381162073;8286.792830179294;8302.54336011525;8302.54336011525;8306;5594.6363486374885;6025.18659980897;6143.201383820075;6207.565470417208;6245.125682404558;6093.299270583762;6125.9693701531205;6273.184486016971;6305.085762564311;6394.680265986589 15:13:12 INFO - PROCESS | 1988 | |4;prototype.html;307.9846007699615;391.1160776644782;391.26051762169504;397.9375068566926;398.77469229885094;4683.414573178353;5119.283300337951;5136.64043516954;5152.536271735547;5188.818391356303;4215.578442155783;4643.07138572286;5014.373203349582;5019.146745053341;5070.847874563759;3711.7565615518834;3780.319542482352;4031.5565287818317;4147.831429413435;4148.647364973974;3600.5859326177433;3709.3694072007825;4173;4209.452771139748;4232.244147958773;3652.812835828353;3695.9118098274525;3927.5876033016552;4178.97910510447;4183.924815260781;3520.929581408383;3613;3811.6278139869623;3993.9400908986245;4019.3167161582455;2941.6615439974976;3242.367738291034;3247.691469310412;3867.57456679765;3885.8834234972715;4251.7669875736;4598.195100988394;4624.3988281523525;4829.879253018703;4977.701337919736;4080.2859499587453;4099.344104943195;4188.91622167558;4815.868270956323;4831.879203019917;4852.587530059949;5290.629655924087;5320.973395133038;5358.535073866026;5387.299651045379;4090.2778471591005;4266.080263881235;4286.478300203414;4353.129374125156;4385.7149285296355;4855.975720121447;5178.482151784791;5546.417626149277;5639.605227634067;5776.075827867563;3740.4576336431064;3902.35611124167;4166.104287578125;4277.230098582285;4419.248727716296;4084.326086195744;4518.367428560005;4539.886502837389;4541.909161816745;4596.540345965377;4832.589229915497;4858.6356023298395;4898.485659005824;4904.411470623548;4915.43472500667;4570.71464267866;4640.303954406799;4975.109458405783;5320.65891007963;5474.890502189934;1279.9232046077266;1513.7577987521943;1517.719221943944;1521.5967768541345;1523.5886310696271;1040.599369242847;1049.842523621463;1101.130107215291;1123.4495097402214;1191.4757506697026;4197.300093462152;5161.948380516222;5168.379794424618;5174.896502069938;5174.97412512935;5161.922571161435;5393.865153371119;5584.3857175711455;5622.245099901019;5657.915131273035;4166.1251137261515;4967.304577359173;5055.876531856629;5160.045391602565;5236.764345604457;2612.0949180974567;2630.842149471038;2688.7311268872954;2897.7539657946863;2918.5038543447663;5252.133397989365;5412.729363531807;5432.809851655173;5554.638948468337;5775.8556036099435;4482.955170448319;5365.968227951195;5628.7053977584565;5684.715764211773;5718.542516598662;5578.191162281528;5655.842955427757;5691.715414229272;5773.826785196535;5857.912131318119;4733.928991065068;5123.513266239701;5522.481317637682;5582.665040097607;5609.411011843697;5324.893502130013;5486.91769623448;5507.779688812403;5604.271444712162;5604.663720176639;5832.475077243069;5844.6785426801935;5844.970775146097;5846.473817356288;5884.911291411103;4073.3746965200403;4113.85601503946;4533.008214578363;4549.112922979987;4571;4705.517761904989;5333.9466605335;5353.812616558402;5503.724813759216;5716.657000579979;4618.6536009800075;5220.530152286313;5405.24326594285;5449.700266485382;5467.863303417446;4739.454962679336;4899.86855717764;5111.207762796773;5359.926455893471;5361.812336568201;4796.688215265996;5254.0069547143685;5339.490439493432;5340.332458442695;5349.465053494775;4346.587074227943;4967.453580106113;5396.541293990055;5443.455654434525;5444.482774136451;5140.56305214046;5301.443348448512;5335.706536140549;5348.304720386325;5349.4650534946195 15:13:12 INFO - PROCESS | 1988 | |5;yui.html;742.3033294194909;773.2615352338514;885.8804061451704;898.4923518212214;904.9954351112287;12409.627711168669;15639.296231669574;16644.750328745078;16656;16830.747538786927;13129;14576.562703118923;15517.844821551782;15817.446389376375;15833.60415989601;966.0484422843493;969.8205831921117;970.6990832841807;971.1259866120478;986.8667729856468;967.0281367225928;970.4662435660393;978.7748817771917;1013.6401577440013;1023.8976102389738;1062.3731998121107;1062.6918193723811;1063.8404239364118;1064.914806815453;1066.4188017530464;1059.8887116852773;1060.2207377577474;1060.522764755863;1060.7878424315168;1064.0211005874576;781.3007358414187;781.6443518199205;781.8788087846336;782.0302824497638;783.2559068884583;16948.915255423766;17126.571835704082;17168.828311716847;17675.911620441817;17929;14590.781138282935;14601;14607.196604186765;14821.629459263497;14842.332095055748;11005.232992773486;11406.08751299894;11428.771424571545;11745.236559623683;12140.392980350947;3693.445983102556;3818.7899665518385;3877.651011408987;3905.2775236581324;3964.167524819791;86702;87211.56394217988;87937;108999;115052.99999999916;9425.811483770287;11394.772104558027;11446.942765286287;12070.973967212885;12086.637400877988;23031.88484057569;23240.3027909163;23716.288511344686;23785.88107059488;23861.164859229844;6550.6069635822005;7747.225277472207;7750.302472777477;7750.689972401041;7866.213378662088;4492.236319825637;4535.931961020521;4586.793594288199;4639.605633521121;4660.277656963176;3578;3648.7628304160144;3654;3668.9633103669157;3697.8335974881193;666.6733300682728;673.7507122364757;681.2131987554383;683.719674933275;689.689639662144;693.5977133262695;716.813628456605;716.8781307177792;722.1803253307429;774;8611.698590549426;8839.51382673959;10304.690859274233;10550.788984220273;10574.11708653454;692.1486571516962;701.1411021498624;753.175273075981;755.7266006778596;757.8938948547208;4833.371661683958;5165.251038599382;5183.196604526304;5194.714290714047;5198.350206224222;88329;91130;91971;95792.08415831644;96474.51762741142;55259.72370138204;63572.04641930375;83225;86263.13736862551;86319.56840215759;60437.69781151066;64741.05776826703;69405.65297173482;70299.99999999898;72591.63704181445;11058.025238761978;11277.436128193393;11310;11355.37545435009;11414;49250;49560.75219623879;49599.50400495949;49732.50267497423;51501.7424912873;60539;60675.69662151838;60963.39036609577;62934.426639334386;62971.74056518936;12909.677258068623;13131.671708207372;13191.604251872459;13207;13316.33418329099;14445.855541444871;14815.92592037033;15141.697166056838;15357.923210383877;15409.84590154084;12964.968944099379;13260.602181934557;14274.700185534062;14438.133711977314;14937.580929811651;13191.868081319448;14106.224157671017;14151.00942934026;14271.857281427052;14334.354954026885;13257.07200495956;14376.28118594087;14446.494372696905;14524.346404411615;14532.636684082983;9628.855567166358;9884.863240727409;10272;10350.689479315633;10568.68293951152;10173.593056277961;10306.536205870903;11366.488508016993;11597.420128993348;11599.76800464003 15:13:12 INFO - PROCESS | 1988 | __end_tp_report 15:13:12 INFO - PROCESS | 1988 | __start_cc_report 15:13:12 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,1258 15:13:12 INFO - PROCESS | 1988 | __end_cc_report 15:13:12 INFO - PROCESS | 1988 | __startTimestamp1494195192080__endTimestamp 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | ------- Summary: start ------- 15:13:12 INFO - PROCESS | 1988 | Number of tests: 6 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | [#0] dojo.html Cycles:165 Average:6064.87 Median:6306.05 stddev:677.08 (10.7%) stddev-sans-first:649.59 15:13:12 INFO - PROCESS | 1988 | Values: 3542.2 3563.4 3567.7 3599.4 3626.8 6173.2 6174.8 6198.1 6199.6 6235.6 6182.5 6227.5 6242.9 6245.6 6260.4 5453.5 5475.9 5504.3 5520.3 5600.2 5383.8 5392.1 5425.5 5584.1 5598.1 4242.0 5495.9 5496.2 5533.0 5540.1 5527.4 5559.5 5574.2 5575.0 5579.1 5425.7 5497.0 5518.5 5519.6 5520.8 5046.7 5991.2 6015.4 6125.5 6197.0 6325.8 6345.9 6351.1 6353.5 6394.4 5348.0 6548.0 6574.4 6620.8 7015.1 6262.2 6273.1 6287.8 6292.7 6302.0 6467.1 6486.1 6787.0 6789.5 6815.7 6306.1 6320.1 6334.5 6360.7 6398.8 6487.6 6488.5 6501.0 6525.7 6532.3 6269.7 6453.3 6465.9 6467.6 6468.8 6334.3 6347.5 6432.6 6499.4 6504.7 5273.0 5291.4 5291.7 5298.7 5327.6 4703.1 4704.1 4720.3 4727.2 4758.5 6121.0 6185.2 6243.3 6252.5 6297.1 6573.3 6611.1 6630.8 6634.9 6648.0 6302.9 6312.5 6312.6 6324.9 6343.2 5569.7 5668.1 5720.3 5809.2 5824.0 5950.2 6804.5 6840.5 6857.1 6886.7 6598.7 6601.3 6604.7 6614.5 6624.2 6428.6 6703.8 6802.0 6870.2 6893.0 6379.8 6415.6 6447.5 6471.0 6525.6 6316.6 6577.8 6590.2 6593.0 6599.9 6236.5 6248.8 6309.9 6326.7 6372.4 6364.4 6379.6 6391.7 6393.6 6398.4 6158.8 6198.4 6232.1 6238.3 6283.8 6363.5 6404.7 6421.5 6424.0 6426.4 6287.1 6309.7 6317.9 6318.7 6323.1 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | [#1] ext.html Cycles:180 Average:54195.58 Median:313798.50 stddev:107719.53 (34.3%) stddev-sans-first:107947.07 15:13:12 INFO - PROCESS | 1988 | Values: 784.4 816.7 833.2 917.7 918.2 21968.8 41626.0 41985.8 42051.6 42304.4 34420.1 43726.8 43729.8 43763.6 43801.6 7874.8 9616.3 9772.9 9778.6 9782.2 7914.2 11773.4 11942.9 11943.3 11949.2 11950.4 11982.9 12030.3 12046.1 12065.9 11971.5 11983.0 12014.7 12023.1 12029.9 11627.8 11678.5 11685.5 11687.4 11692.5 40887.6 40989.8 41090.0 41176.0 41228.4 3958.5 4012.6 4014.4 4017.5 4031.8 28070.4 29011.9 29502.4 30368.5 30820.0 3271.6 3295.7 3327.4 3439.4 3440.7 275773.2 312552.0 315045.0 317681.4 317729.0 51123.0 51320.7 51460.0 51470.7 51489.7 54960.0 54960.0 54989.5 55118.4 55249.0 15040.6 15171.9 15513.5 15591.5 15612.1 11986.6 12142.4 13179.1 13202.4 13217.9 11016.9 12601.5 12619.0 12724.4 12765.4 5377.4 5400.4 5401.4 5407.3 5408.8 949.2 963.6 969.7 987.6 999.6 28546.9 28799.0 28817.7 29099.3 29295.7 981.7 1036.8 1090.8 1168.1 1330.7 12141.3 14442.8 14528.9 14766.0 14768.8 467886.0 468329.0 468461.0 468954.0 470623.0 58958.7 59146.0 59191.0 59205.1 59406.7 1443.4 1461.3 1482.2 1497.8 1527.0 27238.7 27541.7 28861.4 29346.4 29466.7 39589.8 39730.6 39740.4 39745.8 39770.4 423532.0 424410.8 424598.0 424820.0 425803.0 26181.6 26579.9 29846.0 30252.7 30366.5 32395.5 32473.5 32858.0 33381.5 42102.8 27304.0 27987.0 29312.4 30131.7 30292.1 29155.9 29200.3 29271.0 29344.9 30103.8 34361.0 34984.0 35171.1 35239.6 35313.6 27692.2 28739.7 29232.7 30159.4 30339.0 18721.0 22811.9 23831.2 23857.8 24035.3 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | [#2] jquery.html Cycles:180 Average:43783.45 Median:12161.85 stddev:128071.60 (1053.1%) stddev-sans-first:128389.50 15:13:12 INFO - PROCESS | 1988 | Values: 428.7 436.6 439.8 447.0 449.1 19637.8 20761.4 21833.0 22111.7 22166.4 21038.0 23076.3 23076.3 23987.8 24278.3 6640.7 6921.8 6924.0 6926.0 7512.7 7733.8 7849.2 7862.5 7870.3 7873.8 7805.6 7808.7 7810.0 7940.9 7991.6 7646.1 7860.5 7867.6 7962.6 7972.3 7462.4 7656.4 7698.1 7708.0 7710.5 25649.4 26007.5 26241.0 26432.9 26633.5 2868.8 2937.9 3007.8 3052.9 3066.3 15532.6 16344.2 16518.9 17163.2 17223.5 2091.6 2110.1 2126.5 2202.8 2212.0 115235.4 147419.5 150805.2 154123.0 162112.2 18980.1 19939.0 20109.5 20132.7 20241.7 31515.0 32235.4 32345.7 32372.4 32486.8 8750.7 10447.9 10561.3 10687.0 10885.7 8979.7 8985.2 9008.6 9036.6 9166.3 7421.2 9275.4 9304.6 9404.5 9432.0 3576.9 3839.4 3948.7 4042.4 4057.3 937.5 1041.3 1051.0 1074.7 1112.2 21941.0 22625.5 22638.9 22648.8 22669.8 1061.3 1063.9 1085.8 1093.6 1099.7 10724.4 11065.4 11111.9 11598.4 11615.0 678669.0 752588.0 792570.0 802003.0 810300.0 157859.0 160848.0 162059.0 162534.0 169944.2 1319.0 1320.8 1373.3 1375.2 1381.5 19529.5 19845.9 20301.9 20302.4 20328.9 62374.7 62675.7 62857.7 63034.4 64475.0 74336.3 82365.0 88883.6 89468.6 90873.0 10535.5 11450.4 11599.8 11754.8 11966.2 11066.7 12596.3 12739.8 13078.8 13156.3 11109.4 11339.8 11395.7 11454.0 11609.3 8579.7 10308.1 10423.1 10492.2 10565.7 9759.7 11030.9 11470.5 11715.1 11828.3 11639.8 11746.6 11904.6 11936.2 11972.6 10820.6 11246.9 11359.6 11407.4 11430.5 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | [#3] mootools.html Cycles:180 Average:6943.34 Median:2470.19 stddev:4340.74 (175.7%) stddev-sans-first:4333.12 15:13:12 INFO - PROCESS | 1988 | Values: 1427.1 1617.5 1647.8 1653.2 1661.0 9301.8 9385.6 9788.7 11018.8 11107.6 10950.3 11044.4 11111.5 11171.8 11173.6 2425.4 2470.7 2475.5 2475.9 2477.5 2095.7 2167.9 2420.5 2493.8 2497.2 2435.0 2435.4 2460.1 2465.6 2469.4 2463.5 2466.7 2468.7 2468.8 2469.7 2376.4 2406.7 2415.3 2428.1 2468.9 11605.5 11683.9 11690.6 11692.5 11698.8 5948.4 6124.2 6127.8 6135.6 6141.0 3619.2 3649.9 3820.3 3879.4 3891.2 1213.0 1251.0 1282.7 1297.3 1311.4 15671.5 15822.8 15823.3 15835.5 15844.6 4097.9 4776.3 5111.6 5113.5 5114.2 13275.9 13297.3 13297.5 13310.0 13353.3 6148.2 6159.0 6160.8 6171.1 6177.1 4734.9 5467.4 5511.7 5549.2 5604.8 3791.8 3875.0 4122.7 4227.7 4268.8 1162.4 1171.0 1179.5 1191.2 1191.7 968.5 992.3 995.6 996.0 1005.3 6608.5 6800.3 6854.7 6910.0 6947.7 1023.9 1034.9 1069.7 1083.6 1101.6 4256.6 4290.8 4295.2 4407.5 4437.6 11098.0 14010.1 14156.6 14165.8 14234.7 13712.9 14285.5 14322.4 14331.4 14342.0 10337.8 10467.1 10480.1 10489.8 10493.6 6326.8 6595.2 6738.8 6765.8 6809.9 12533.0 12602.7 12700.7 12701.7 12707.7 12706.0 12790.0 12815.3 12864.4 13046.5 9232.3 9463.2 9476.0 9479.6 9500.8 8909.4 10035.3 10364.0 10421.3 10677.5 9115.0 9191.7 9251.4 9296.9 9458.4 7261.3 8896.6 8921.6 8977.8 9001.5 8116.2 8286.8 8302.5 8302.5 8306.0 5594.6 6025.2 6143.2 6207.6 6245.1 6093.3 6126.0 6273.2 6305.1 6394.7 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | [#4] prototype.html Cycles:180 Average:4481.56 Median:4857.31 stddev:1286.15 (26.5%) stddev-sans-first:1251.02 15:13:12 INFO - PROCESS | 1988 | Values: 308.0 391.1 391.3 397.9 398.8 4683.4 5119.3 5136.6 5152.5 5188.8 4215.6 4643.1 5014.4 5019.1 5070.8 3711.8 3780.3 4031.6 4147.8 4148.6 3600.6 3709.4 4173.0 4209.5 4232.2 3652.8 3695.9 3927.6 4179.0 4183.9 3520.9 3613.0 3811.6 3993.9 4019.3 2941.7 3242.4 3247.7 3867.6 3885.9 4251.8 4598.2 4624.4 4829.9 4977.7 4080.3 4099.3 4188.9 4815.9 4831.9 4852.6 5290.6 5321.0 5358.5 5387.3 4090.3 4266.1 4286.5 4353.1 4385.7 4856.0 5178.5 5546.4 5639.6 5776.1 3740.5 3902.4 4166.1 4277.2 4419.2 4084.3 4518.4 4539.9 4541.9 4596.5 4832.6 4858.6 4898.5 4904.4 4915.4 4570.7 4640.3 4975.1 5320.7 5474.9 1279.9 1513.8 1517.7 1521.6 1523.6 1040.6 1049.8 1101.1 1123.4 1191.5 4197.3 5161.9 5168.4 5174.9 5175.0 5161.9 5393.9 5584.4 5622.2 5657.9 4166.1 4967.3 5055.9 5160.0 5236.8 2612.1 2630.8 2688.7 2897.8 2918.5 5252.1 5412.7 5432.8 5554.6 5775.9 4483.0 5366.0 5628.7 5684.7 5718.5 5578.2 5655.8 5691.7 5773.8 5857.9 4733.9 5123.5 5522.5 5582.7 5609.4 5324.9 5486.9 5507.8 5604.3 5604.7 5832.5 5844.7 5845.0 5846.5 5884.9 4073.4 4113.9 4533.0 4549.1 4571.0 4705.5 5333.9 5353.8 5503.7 5716.7 4618.7 5220.5 5405.2 5449.7 5467.9 4739.5 4899.9 5111.2 5359.9 5361.8 4796.7 5254.0 5339.5 5340.3 5349.5 4346.6 4967.5 5396.5 5443.5 5444.5 5140.6 5301.4 5335.7 5348.3 5349.5 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - PROCESS | 1988 | [#5] yui.html Cycles:180 Average:19391.87 Median:3651.38 stddev:26268.42 (719.4%) stddev-sans-first:26304.78 15:13:12 INFO - PROCESS | 1988 | Values: 742.3 773.3 885.9 898.5 905.0 12409.6 15639.3 16644.8 16656.0 16830.7 13129.0 14576.6 15517.8 15817.4 15833.6 966.0 969.8 970.7 971.1 986.9 967.0 970.5 978.8 1013.6 1023.9 1062.4 1062.7 1063.8 1064.9 1066.4 1059.9 1060.2 1060.5 1060.8 1064.0 781.3 781.6 781.9 782.0 783.3 16948.9 17126.6 17168.8 17675.9 17929.0 14590.8 14601.0 14607.2 14821.6 14842.3 11005.2 11406.1 11428.8 11745.2 12140.4 3693.4 3818.8 3877.7 3905.3 3964.2 86702.0 87211.6 87937.0 108999.0 115053.0 9425.8 11394.8 11446.9 12071.0 12086.6 23031.9 23240.3 23716.3 23785.9 23861.2 6550.6 7747.2 7750.3 7750.7 7866.2 4492.2 4535.9 4586.8 4639.6 4660.3 3578.0 3648.8 3654.0 3669.0 3697.8 666.7 673.8 681.2 683.7 689.7 693.6 716.8 716.9 722.2 774.0 8611.7 8839.5 10304.7 10550.8 10574.1 692.1 701.1 753.2 755.7 757.9 4833.4 5165.3 5183.2 5194.7 5198.4 88329.0 91130.0 91971.0 95792.1 96474.5 55259.7 63572.0 83225.0 86263.1 86319.6 60437.7 64741.1 69405.7 70300.0 72591.6 11058.0 11277.4 11310.0 11355.4 11414.0 49250.0 49560.8 49599.5 49732.5 51501.7 60539.0 60675.7 60963.4 62934.4 62971.7 12909.7 13131.7 13191.6 13207.0 13316.3 14445.9 14815.9 15141.7 15357.9 15409.8 12965.0 13260.6 14274.7 14438.1 14937.6 13191.9 14106.2 14151.0 14271.9 14334.4 13257.1 14376.3 14446.5 14524.3 14532.6 9628.9 9884.9 10272.0 10350.7 10568.7 10173.6 10306.5 11366.5 11597.4 11599.8 15:13:12 INFO - PROCESS | 1988 | -------- Summary: end -------- 15:13:12 INFO - PROCESS | 1988 | 15:13:12 INFO - TEST-INFO | 1988: exit 0 15:13:12 INFO - TEST-OK | dromaeo_css | took 1118650ms 15:13:12 INFO - TEST-START | kraken 15:13:12 INFO - operating with platform_type : mac_ 15:13:12 INFO - Initialising browser for kraken test... 15:13:12 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpq4h95D/profile http://localhost:49311/getInfo.html) 15:13:14 INFO - PROCESS | 1991 | __metrics Screen width/height:1600/1200 15:13:14 INFO - PROCESS | 1991 | colorDepth:24 15:13:14 INFO - PROCESS | 1991 | Browser inner width/height: 1024/689 15:13:14 INFO - PROCESS | 1991 | __metrics 15:13:15 INFO - PROCESS | 1991 | 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" 15:13:15 INFO - PROCESS | 1991 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:13:15 INFO - TEST-INFO | 1991: exit 0 15:13:15 INFO - Browser initialized. 15:13:15 INFO - Running cycle 1/1 for kraken test... 15:13:15 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpq4h95D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:27 INFO - PROCESS | 1993 | RSS: Main: 165019648 15:13:27 INFO - PROCESS | 1993 | 15:13:30 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-beat-detection) 15:13:31 INFO - PROCESS | 1993 | RSS: Main: 215506944 15:13:31 INFO - PROCESS | 1993 | 15:13:33 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-dft) 15:13:34 INFO - PROCESS | 1993 | RSS: Main: 231063552 15:13:34 INFO - PROCESS | 1993 | 15:13:37 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-fft) 15:13:38 INFO - PROCESS | 1993 | RSS: Main: 326311936 15:13:38 INFO - PROCESS | 1993 | 15:13:40 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-oscillator) 15:13:40 INFO - PROCESS | 1993 | RSS: Main: 229888000 15:13:40 INFO - PROCESS | 1993 | 15:13:42 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:43 INFO - PROCESS | 1993 | RSS: Main: 231735296 15:13:43 INFO - PROCESS | 1993 | 15:13:46 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:47 INFO - PROCESS | 1993 | RSS: Main: 273166336 15:13:47 INFO - PROCESS | 1993 | 15:13:50 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:50 INFO - PROCESS | 1993 | RSS: Main: 272191488 15:13:50 INFO - PROCESS | 1993 | 15:13:53 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49311/tests/kraken/driver.html?testName=json-parse-financial) 15:13:54 INFO - PROCESS | 1993 | RSS: Main: 271523840 15:13:54 INFO - PROCESS | 1993 | 15:13:56 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:56 INFO - PROCESS | 1993 | RSS: Main: 247308288 15:13:56 INFO - PROCESS | 1993 | 15:13:58 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:59 INFO - PROCESS | 1993 | RSS: Main: 251105280 15:13:59 INFO - PROCESS | 1993 | 15:14:01 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:14:02 INFO - PROCESS | 1993 | RSS: Main: 256876544 15:14:02 INFO - PROCESS | 1993 | 15:14:04 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:05 INFO - PROCESS | 1993 | RSS: Main: 261152768 15:14:05 INFO - PROCESS | 1993 | 15:14:08 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:08 INFO - PROCESS | 1993 | RSS: Main: 262631424 15:14:08 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49311/tests/kraken/driver.html?testName=ai-astar) 15:14:10 INFO - PROCESS | 1993 | RSS: Main: 307175424 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | __start_tp_report 15:14:10 INFO - PROCESS | 1993 | _x_x_mozilla_page_load 15:14:10 INFO - PROCESS | 1993 | _x_x_mozilla_page_load_details 15:14:10 INFO - PROCESS | 1993 | |i|pagename|runs| 15:14:10 INFO - PROCESS | 1993 | |0;ai-astar;106;169;163;113;114;114;114;120;114;114 15:14:10 INFO - PROCESS | 1993 | |1;audio-beat-detection;141;109;109;144;110;105;109;106;125;106 15:14:10 INFO - PROCESS | 1993 | |2;audio-dft;186;185;187;184;185;185;185;187;185;185 15:14:10 INFO - PROCESS | 1993 | |3;audio-fft;84;58;59;91;62;61;58;60;76;59 15:14:10 INFO - PROCESS | 1993 | |4;audio-oscillator;89;69;85;70;68;70;82;54;68;95 15:14:10 INFO - PROCESS | 1993 | |5;imaging-gaussian-blur;80;124;135;104;88;88;88;87;88;87 15:14:10 INFO - PROCESS | 1993 | |6;imaging-darkroom;94;95;98;95;98;139;151;94;94;95 15:14:10 INFO - PROCESS | 1993 | |7;imaging-desaturate;87;84;84;93;137;83;84;84;89;75 15:14:10 INFO - PROCESS | 1993 | |8;json-parse-financial;62;62;63;61;62;65;65;66;64;66 15:14:10 INFO - PROCESS | 1993 | |9;json-stringify-tinderbox;55;57;65;64;64;60;60;61;60;75 15:14:10 INFO - PROCESS | 1993 | |10;stanford-crypto-aes;85;83;84;80;84;83;80;86;88;100 15:14:10 INFO - PROCESS | 1993 | |11;stanford-crypto-ccm;136;136;134;133;137;133;128;134;149;136 15:14:10 INFO - PROCESS | 1993 | |12;stanford-crypto-pbkdf2;161;167;162;201;159;161;161;161;159;161 15:14:10 INFO - PROCESS | 1993 | |13;stanford-crypto-sha256-iterative;64;62;66;64;64;63;64;63;63;62 15:14:10 INFO - PROCESS | 1993 | __end_tp_report 15:14:10 INFO - PROCESS | 1993 | __start_cc_report 15:14:10 INFO - PROCESS | 1993 | _x_x_mozilla_cycle_collect,2032 15:14:10 INFO - PROCESS | 1993 | __end_cc_report 15:14:10 INFO - PROCESS | 1993 | __startTimestamp1494195250846__endTimestamp 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | ------- Summary: start ------- 15:14:10 INFO - PROCESS | 1993 | Number of tests: 14 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#0] ai-astar Cycles:10 Average:124.10 Median:114.00 stddev:22.38 (19.6%) stddev-sans-first:22.76 15:14:10 INFO - PROCESS | 1993 | Values: 106.0 169.0 163.0 113.0 114.0 114.0 114.0 120.0 114.0 114.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:109.50 stddev:14.88 (13.6%) stddev-sans-first:12.85 15:14:10 INFO - PROCESS | 1993 | Values: 141.0 109.0 109.0 144.0 110.0 105.0 109.0 106.0 125.0 106.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.00 stddev:0.97 (0.5%) stddev-sans-first:1.00 15:14:10 INFO - PROCESS | 1993 | Values: 186.0 185.0 187.0 184.0 185.0 185.0 185.0 187.0 185.0 185.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.50 stddev:12.23 (19.9%) stddev-sans-first:11.27 15:14:10 INFO - PROCESS | 1993 | Values: 84.0 58.0 59.0 91.0 62.0 61.0 58.0 60.0 76.0 59.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:12.34 (16.2%) stddev-sans-first:12.00 15:14:10 INFO - PROCESS | 1993 | Values: 89.0 69.0 85.0 70.0 68.0 70.0 82.0 54.0 68.0 95.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:87.50 stddev:18.36 (21.0%) stddev-sans-first:18.43 15:14:10 INFO - PROCESS | 1993 | Values: 80.0 124.0 135.0 104.0 88.0 88.0 88.0 87.0 88.0 87.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:95.00 stddev:21.17 (22.3%) stddev-sans-first:22.05 15:14:10 INFO - PROCESS | 1993 | Values: 94.0 95.0 98.0 95.0 98.0 139.0 151.0 94.0 94.0 95.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#7] imaging-desaturate Cycles:10 Average:90.00 Median:84.00 stddev:17.15 (20.4%) stddev-sans-first:18.15 15:14:10 INFO - PROCESS | 1993 | Values: 87.0 84.0 84.0 93.0 137.0 83.0 84.0 84.0 89.0 75.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.50 stddev:1.84 (2.8%) stddev-sans-first:1.86 15:14:10 INFO - PROCESS | 1993 | Values: 62.0 62.0 63.0 61.0 62.0 65.0 65.0 66.0 64.0 66.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.50 stddev:5.51 (8.8%) stddev-sans-first:5.21 15:14:10 INFO - PROCESS | 1993 | Values: 55.0 57.0 65.0 64.0 64.0 60.0 60.0 61.0 60.0 75.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:5.72 (6.8%) stddev-sans-first:6.06 15:14:10 INFO - PROCESS | 1993 | Values: 85.0 83.0 84.0 80.0 84.0 83.0 80.0 86.0 88.0 100.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:136.00 stddev:5.36 (3.9%) stddev-sans-first:5.68 15:14:10 INFO - PROCESS | 1993 | Values: 136.0 136.0 134.0 133.0 137.0 133.0 128.0 134.0 149.0 136.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:161.00 stddev:12.74 (7.9%) stddev-sans-first:13.41 15:14:10 INFO - PROCESS | 1993 | Values: 161.0 167.0 162.0 201.0 159.0 161.0 161.0 161.0 159.0 161.0 15:14:10 INFO - PROCESS | 1993 | 15:14:10 INFO - PROCESS | 1993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 15:14:10 INFO - PROCESS | 1993 | Values: 64.0 62.0 66.0 64.0 64.0 63.0 64.0 63.0 63.0 62.0 15:14:10 INFO - PROCESS | 1993 | -------- Summary: end -------- 15:14:10 INFO - PROCESS | 1993 | 15:14:11 INFO - TEST-INFO | 1993: exit 0 15:14:11 INFO - TEST-OK | kraken | took 59027ms 15:14:11 INFO - SUITE-END | took 1177s 15:14:11 INFO - Completed test suite (00:19:37) 15:14:11 INFO - javascript benchmark 15:14:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7826.442418779814, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3542.167590616205, 3563.4298512238047, 3567.7324200684957, 3599.442086476594, 3626.782393056417, 6173.166622505961, 6174.7530098796105, 6198.132261483396, 6199.628022318653, 6235.59468634539, 6182.505399568035, 6227.470664993481, 6242.937570624293, 6245.56281060326, 6260.436560709547, 5453.509184173424, 5475.890482190353, 5504.339479262494, 5520.309961254843, 5600.18797274395, 5383.784648614051, 5392.110301800199, 5425.538829199523, 5584.050711379075, 5598.104303311471, 4241.978790106045, 5495.890082198353, 5496.230527726121, 5532.972335138339, 5540.085885828834, 5527.364353099385, 5559.499645031967, 5574.247476590649, 5575.024370735106, 5579.13523403873, 5425.701586412746, 5496.961653977776, 5518.530924871391, 5519.586031047647, 5520.751566179531, 5046.671966322214, 5991.221141251653, 6015.398460153993, 6125.540584456184, 6197.03945888388, 6325.841853953642, 6345.9365406345805, 6351.142595749561, 6353.491720662382, 6394.360563943615, 5347.973260133714, 6548.0, 6574.441172500343, 6620.834479138012, 7015.088038555006, 6262.154609127755, 6273.12176295319, 6287.811365659038, 6292.685365731695, 6302.023186406114, 6467.062275970052, 6486.05952136947, 6786.966065169642, 6789.524733268722, 6815.693293801791, 6306.054091886162, 6320.051992201206, 6334.461570766536, 6360.681965901686, 6398.840028999219, 6487.578307410004, 6488.480921526267, 6501.0, 6525.738970441224, 6532.346765323429, 6269.7178626961895, 6453.322401147906, 6465.935340646533, 6467.644279564669, 6468.838279043061, 6334.271558770708, 6347.52393570484, 6432.581882177644, 6499.350064993558, 6504.739810407626, 5273.0, 5291.365036195604, 5291.656042357235, 5298.70857102863, 5327.573794096463, 4703.0593881223895, 4704.082703872712, 4720.291956206596, 4727.196376615983, 4758.5241475852135, 6120.969395152996, 6185.195924529872, 6243.344448832898, 6252.499800015988, 6297.055441683692, 6573.342665733484, 6611.140551728245, 6630.7679231226675, 6634.933650663528, 6647.966760166169, 6302.905456418157, 6312.4634406076, 6312.589681670676, 6324.936750632527, 6343.238811342576, 5569.693666848362, 5668.121441176624, 5720.342160651495, 5809.215755872903, 5824.039033559416, 5950.226470558886, 6804.523683342317, 6840.48696347766, 6857.074294970115, 6886.724531018703, 6598.736050558116, 6601.306862779531, 6604.735810567524, 6614.536982411185, 6624.238212605612, 6428.582142160744, 6703.8324041897395, 6802.0, 6870.244273130052, 6892.965535172292, 6379.776707815204, 6415.647139407378, 6447.451966582893, 6470.967645161744, 6525.64108974011, 6316.557840951089, 6577.769778057745, 6590.176227971504, 6592.967035164794, 6599.9010014848855, 6236.469900058364, 6248.812535623939, 6309.936900630935, 6326.652034137983, 6372.36276372359, 6364.395382438661, 6379.585326953733, 6391.6804159792755, 6393.584417012879, 6398.424141827258, 6158.815235542941, 6198.442140207403, 6232.127502149612, 6238.251409830849, 6283.7800676976085, 6363.490920726424, 6404.711787969646, 6421.518386121153, 6423.96788016057, 6426.357364263723, 6287.088372185916, 6309.652969086561, 6317.873642527032, 6318.652474113968, 6323.051542268697], "value": 6022.915800126554, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.4234487651576, 816.6692489541736, 833.1543483364385, 917.7017469322471, 918.1828172926092, 21968.78031219687, 41625.95935101624, 41985.7900710496, 42051.57948420515, 42304.36543451843, 34420.1394965126, 43726.78136609313, 43729.78135109328, 43763.56236437635, 43801.56198438015, 7874.803129921741, 9616.278779091579, 9772.853407198898, 9778.559964801565, 9782.168515676176, 7914.24814642608, 11773.411329433537, 11942.880571194308, 11943.34311612861, 11949.223300485484, 11950.402479876015, 11982.94008529956, 12030.33833139177, 12046.096542759284, 12065.939670301635, 11971.46128424223, 11983.0, 12014.69963250917, 12023.098267629963, 12029.939850300692, 11627.76744465106, 11678.532858685643, 11685.474153663106, 11687.415629218505, 11692.532298708042, 40887.591124088976, 40989.795051024856, 41090.0, 41176.0, 41228.38157427641, 3958.4656071430277, 4012.558618551957, 4014.3978403239457, 4017.4576432181575, 4031.7984100794843, 28070.43859122806, 29011.854940725163, 29502.409951800844, 30368.54447183294, 30820.0, 3271.6401195868434, 3295.6869097435706, 3327.367800117994, 3439.4324936385465, 3440.707539859115, 275773.24226757674, 312552.0, 315045.0, 317681.4115929429, 317729.0, 51123.0, 51320.716982075, 51460.0, 51470.65440746339, 51489.742551287, 54960.0, 54960.0, 54989.450105499236, 55118.448815512136, 55249.0, 15040.623984400478, 15171.924140379228, 15513.534593961973, 15591.532254032398, 15612.063276203464, 11986.580469683518, 12142.392880355947, 13179.14335568185, 13202.405891734896, 13217.867821321664, 11016.889831101747, 12601.495940162291, 12619.0, 12724.363781810873, 12765.361731913366, 5377.354717433933, 5400.378956420062, 5401.405845357008, 5407.270018547524, 5408.756605952742, 949.1505102932837, 963.6097380560884, 969.6557722008727, 987.6395115782688, 999.6201443451442, 28546.857265713537, 28799.0, 28817.711822881924, 29099.27251818679, 29295.707042929724, 981.7398389426808, 1036.8496567997597, 1090.8472813806075, 1168.1414160591958, 1330.7205486847677, 12141.304564580107, 14442.783358249635, 14528.904774011036, 14766.0402073867, 14768.818494520627, 467886.0, 468329.0, 468461.0, 468954.0, 470623.0, 58958.70520647369, 59146.0, 59191.0, 59205.11192332119, 59406.70296648489, 1443.3793468808512, 1461.2547600723708, 1482.1699848085107, 1497.7603583426599, 1526.9847301527066, 27238.72761272362, 27541.724582753915, 28861.422771544872, 29346.413071738018, 29466.705332946396, 39589.80205098956, 39730.602693973844, 39740.403893942195, 39745.80127099346, 39770.403443947784, 423532.0, 424410.7558924371, 424598.0, 424820.0, 425803.0, 26181.607275890496, 26579.867100665146, 29846.0, 30252.69747302587, 30366.544501832934, 32395.51406728948, 32473.51289730703, 32858.0, 33381.49927751134, 42102.789486053596, 27304.044358447358, 27987.020454284004, 29312.41375172527, 30131.698683013765, 30292.091237262917, 29155.85422072876, 29200.26999324949, 29271.0, 29344.853275733483, 30103.849480752455, 34361.0, 34983.9504814856, 35171.12072198215, 35239.647603523634, 35313.64686353104, 27692.169234922985, 28739.712602873704, 29232.707672923, 30159.396812064075, 30339.0, 18721.0, 22811.88594057019, 23831.24569719158, 23857.761422385553, 24035.27894163178], "value": 18818.755455252485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.6913422335917, 436.58742488348514, 439.8174757475648, 447.03663604931364, 449.07042422186066, 19637.803621963776, 20761.377158685245, 21833.0, 22111.668324975137, 22166.445838854015, 21038.0, 23076.307710768702, 23076.307710768702, 23987.76012239877, 24278.271651850428, 6640.667966601663, 6921.757738479154, 6923.996020577013, 6926.030355750199, 7512.661930213126, 7733.767986960372, 7849.175836537167, 7862.528248305091, 7870.252326029018, 7873.8031549211155, 7805.60971951403, 7808.687652493893, 7810.0, 7940.920590794105, 7991.600419979007, 7646.120696119961, 7860.528368297863, 7867.567283799389, 7962.601869906482, 7972.322352600036, 7462.403007759366, 7656.425768067362, 7698.076230852277, 7708.03649543807, 7710.537367757896, 25649.358766030997, 26007.479850402888, 26240.9503619855, 26432.86783566089, 26633.46733065328, 2868.770498360147, 2937.9118626441027, 3007.8496075196153, 3052.893148739806, 3066.340736741611, 15532.61168470786, 16344.18279086041, 16518.917405412896, 17163.227654755567, 17223.483295501028, 2091.581683663258, 2110.0610228448195, 2126.5002724359765, 2202.801747842702, 2212.0267082483656, 115235.42382288034, 147419.52580474166, 150805.24597377054, 154123.0, 162112.18943905324, 18980.14589343483, 19939.0, 20109.49726256855, 20132.6648438164, 20241.696374554394, 31515.0, 32235.35529289401, 32345.67654323474, 32372.35255294928, 32486.837565812493, 8750.69372571957, 10447.947760261302, 10561.313514621525, 10687.038166565046, 10885.673429797118, 8979.730608081769, 8985.191332780081, 9008.63965441388, 9036.63853445868, 9166.26669866409, 7421.220771818989, 9275.443473391619, 9304.627814887328, 9404.529773511296, 9432.0, 3576.91057723559, 3839.424086387064, 3948.7433316834313, 4042.3936409538805, 4057.33054046085, 937.5031233446284, 1041.3439533094102, 1050.9700493516398, 1074.6990842564094, 1112.22700223344, 21941.041328629366, 22625.54748905013, 22638.886805566195, 22648.773512264997, 22669.773302266767, 1061.2913209732326, 1063.9414832184304, 1085.8154113800672, 1093.5899037860802, 1099.7360633447915, 10724.356538607708, 11065.391403472726, 11111.944365285284, 11598.420078996016, 11615.0, 678669.0, 752588.0, 792570.0, 802003.0, 810300.0, 157859.0, 160848.0, 162059.0, 162534.0, 169944.1502792503, 1318.960431187066, 1320.8150858879765, 1373.2858913364994, 1375.24361601119, 1381.4819442708983, 19529.511762206057, 19845.900770496057, 20301.898490507454, 20302.390928272176, 20328.89835550813, 62374.68812655908, 62675.68662156843, 62857.68571157115, 63034.36965630285, 64475.0, 74336.25663743293, 82365.0, 88883.55558222167, 89468.5526572389, 90873.0, 10535.473226338805, 11450.370229637118, 11599.76800464003, 11754.764904701688, 11966.22219555726, 11066.667999960015, 12596.307203103917, 12739.80890286628, 13078.80381794293, 13156.342182890625, 11109.388983605655, 11339.773204536028, 11395.658130256106, 11454.0, 11609.30344179352, 8579.699710510102, 10308.12380947628, 10423.11403530678, 10492.213084018576, 10565.735856603646, 9759.707208783748, 11030.889691102986, 11470.483828227583, 11715.062794976211, 11828.290302581872, 11639.825402619137, 11746.58886938953, 11904.642860714192, 11936.16446848747, 11972.58095966637, 10820.621278255223, 11246.887531124585, 11359.602413915472, 11407.37259450705, 11430.542778289107], "value": 11946.12497017739, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.0866645346973, 1617.4662361420733, 1647.7940257467817, 1653.1816750708394, 1661.0448991829696, 9301.767455813608, 9385.624575017, 9788.657396991106, 11018.834717479243, 11107.555697772079, 10950.288231264962, 11044.392558409305, 11111.499982500787, 11171.83242251367, 11173.553057877674, 2425.417899704076, 2470.6788117544693, 2475.4677744284977, 2475.938101547467, 2477.467344520928, 2095.706601075851, 2167.9241226557074, 2420.5279970405777, 2493.7506249375097, 2497.2133777859917, 2435.0138194031447, 2435.391152211947, 2460.052879641333, 2465.642481840132, 2469.370310570802, 2463.5442443148077, 2466.728659847415, 2468.7284398716215, 2468.7654672806057, 2469.703635563744, 2376.417777644488, 2406.6991626046743, 2415.347856078849, 2428.065194899976, 2468.9135880244107, 11605.535778568847, 11683.941580292128, 11690.649280521598, 11692.532298708042, 11698.824517632242, 5948.434898684618, 6124.234470691164, 6127.816165515042, 6135.570510064297, 6141.0, 3619.1856832212807, 3649.8905032848793, 3820.3123437781187, 3879.4180872869297, 3891.20230352777, 1212.9818052729215, 1250.9687257818628, 1282.6665067082533, 1297.2540789046336, 1311.4426368793224, 15671.529854104281, 15822.76265856013, 15823.28795204207, 15835.524934251991, 15844.603884902854, 4097.89755256115, 4776.307435421844, 5111.616628752859, 5113.539781419616, 5114.181730923035, 13275.867241327656, 13297.3351332433, 13297.534586289434, 13310.0, 13353.265570393527, 6148.1699970504305, 6158.969205153946, 6160.845978850564, 6171.105189747462, 6177.104319873593, 4734.928976065362, 5467.371252306036, 5511.669299842022, 5549.19536667181, 5604.8038318658655, 3791.75353602015, 3874.965643037428, 4122.711410201257, 4227.725197862129, 4268.829246830092, 1162.4071723421116, 1170.9590164344206, 1179.4928180882132, 1191.184038933316, 1191.7497325561728, 968.5205823117602, 992.2905122837062, 995.5619527407918, 996.0139461932635, 1005.3465247589126, 6608.537402381787, 6800.285969973181, 6854.691538880762, 6910.0, 6947.652617369111, 1023.8668973033458, 1034.9223808214415, 1069.7004838645191, 1083.6153165626247, 1101.5703875488566, 4256.59562341577, 4290.849820256339, 4295.162443323522, 4407.47110346754, 4437.600615944581, 11098.0, 14010.089344192595, 14156.575302740934, 14165.78751318731, 14234.715305694035, 13712.862871371359, 14285.500007499688, 14322.427102915975, 14331.355089021019, 14341.99606027568, 10337.844932326021, 10467.115919134476, 10480.109190718875, 10489.790204195873, 10493.632722854663, 6326.810195694136, 6595.241547221939, 6738.797836064926, 6765.763198288037, 6809.863802724017, 12532.997360210979, 12602.747945040865, 12700.745985080432, 12701.745965080832, 12707.745845083231, 12706.047046471736, 12790.0, 12815.295158765985, 12864.421101050662, 13046.54337098197, 9232.307576931622, 9463.195628371666, 9475.952620236854, 9479.573419196015, 9500.762480938032, 8909.420887642282, 10035.297529172887, 10364.015418535228, 10421.270511064153, 10677.519511622151, 9114.954425227832, 9191.724248272563, 9251.352405331561, 9296.884373875178, 9458.38520496193, 7261.3101755333155, 8896.5996530155, 8921.553922303729, 8977.7755556109, 9001.504917229615, 8116.188381162073, 8286.792830179294, 8302.54336011525, 8302.54336011525, 8306.0, 5594.6363486374885, 6025.18659980897, 6143.201383820075, 6207.565470417208, 6245.125682404558, 6093.299270583762, 6125.9693701531205, 6273.184486016971, 6305.085762564311, 6394.680265986589], "value": 5317.681778566991, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.9846007699615, 391.1160776644782, 391.26051762169504, 397.9375068566926, 398.77469229885094, 4683.414573178353, 5119.283300337951, 5136.64043516954, 5152.536271735547, 5188.818391356303, 4215.578442155783, 4643.07138572286, 5014.373203349582, 5019.146745053341, 5070.847874563759, 3711.7565615518834, 3780.319542482352, 4031.5565287818317, 4147.831429413435, 4148.647364973974, 3600.5859326177433, 3709.3694072007825, 4173.0, 4209.452771139748, 4232.244147958773, 3652.812835828353, 3695.9118098274525, 3927.5876033016552, 4178.97910510447, 4183.924815260781, 3520.929581408383, 3613.0, 3811.6278139869623, 3993.9400908986245, 4019.3167161582455, 2941.6615439974976, 3242.367738291034, 3247.691469310412, 3867.57456679765, 3885.8834234972715, 4251.7669875736, 4598.195100988394, 4624.3988281523525, 4829.879253018703, 4977.701337919736, 4080.2859499587453, 4099.344104943195, 4188.91622167558, 4815.868270956323, 4831.879203019917, 4852.587530059949, 5290.629655924087, 5320.973395133038, 5358.535073866026, 5387.299651045379, 4090.2778471591005, 4266.080263881235, 4286.478300203414, 4353.129374125156, 4385.7149285296355, 4855.975720121447, 5178.482151784791, 5546.417626149277, 5639.605227634067, 5776.075827867563, 3740.4576336431064, 3902.35611124167, 4166.104287578125, 4277.230098582285, 4419.248727716296, 4084.326086195744, 4518.367428560005, 4539.886502837389, 4541.909161816745, 4596.540345965377, 4832.589229915497, 4858.6356023298395, 4898.485659005824, 4904.411470623548, 4915.43472500667, 4570.71464267866, 4640.303954406799, 4975.109458405783, 5320.65891007963, 5474.890502189934, 1279.9232046077266, 1513.7577987521943, 1517.719221943944, 1521.5967768541345, 1523.5886310696271, 1040.599369242847, 1049.842523621463, 1101.130107215291, 1123.4495097402214, 1191.4757506697026, 4197.300093462152, 5161.948380516222, 5168.379794424618, 5174.896502069938, 5174.97412512935, 5161.922571161435, 5393.865153371119, 5584.3857175711455, 5622.245099901019, 5657.915131273035, 4166.1251137261515, 4967.304577359173, 5055.876531856629, 5160.045391602565, 5236.764345604457, 2612.0949180974567, 2630.842149471038, 2688.7311268872954, 2897.7539657946863, 2918.5038543447663, 5252.133397989365, 5412.729363531807, 5432.809851655173, 5554.638948468337, 5775.8556036099435, 4482.955170448319, 5365.968227951195, 5628.7053977584565, 5684.715764211773, 5718.542516598662, 5578.191162281528, 5655.842955427757, 5691.715414229272, 5773.826785196535, 5857.912131318119, 4733.928991065068, 5123.513266239701, 5522.481317637682, 5582.665040097607, 5609.411011843697, 5324.893502130013, 5486.91769623448, 5507.779688812403, 5604.271444712162, 5604.663720176639, 5832.475077243069, 5844.6785426801935, 5844.970775146097, 5846.473817356288, 5884.911291411103, 4073.3746965200403, 4113.85601503946, 4533.008214578363, 4549.112922979987, 4571.0, 4705.517761904989, 5333.9466605335, 5353.812616558402, 5503.724813759216, 5716.657000579979, 4618.6536009800075, 5220.530152286313, 5405.24326594285, 5449.700266485382, 5467.863303417446, 4739.454962679336, 4899.86855717764, 5111.207762796773, 5359.926455893471, 5361.812336568201, 4796.688215265996, 5254.0069547143685, 5339.490439493432, 5340.332458442695, 5349.465053494775, 4346.587074227943, 4967.453580106113, 5396.541293990055, 5443.455654434525, 5444.482774136451, 5140.56305214046, 5301.443348448512, 5335.706536140549, 5348.304720386325, 5349.4650534946195], "value": 4108.611435838196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.3033294194909, 773.2615352338514, 885.8804061451704, 898.4923518212214, 904.9954351112287, 12409.627711168669, 15639.296231669574, 16644.750328745078, 16656.0, 16830.747538786927, 13129.0, 14576.562703118923, 15517.844821551782, 15817.446389376375, 15833.60415989601, 966.0484422843493, 969.8205831921117, 970.6990832841807, 971.1259866120478, 986.8667729856468, 967.0281367225928, 970.4662435660393, 978.7748817771917, 1013.6401577440013, 1023.8976102389738, 1062.3731998121107, 1062.6918193723811, 1063.8404239364118, 1064.914806815453, 1066.4188017530464, 1059.8887116852773, 1060.2207377577474, 1060.522764755863, 1060.7878424315168, 1064.0211005874576, 781.3007358414187, 781.6443518199205, 781.8788087846336, 782.0302824497638, 783.2559068884583, 16948.915255423766, 17126.571835704082, 17168.828311716847, 17675.911620441817, 17929.0, 14590.781138282935, 14601.0, 14607.196604186765, 14821.629459263497, 14842.332095055748, 11005.232992773486, 11406.08751299894, 11428.771424571545, 11745.236559623683, 12140.392980350947, 3693.445983102556, 3818.7899665518385, 3877.651011408987, 3905.2775236581324, 3964.167524819791, 86702.0, 87211.56394217988, 87937.0, 108999.0, 115052.99999999916, 9425.811483770287, 11394.772104558027, 11446.942765286287, 12070.973967212885, 12086.637400877988, 23031.88484057569, 23240.3027909163, 23716.288511344686, 23785.88107059488, 23861.164859229844, 6550.6069635822005, 7747.225277472207, 7750.302472777477, 7750.689972401041, 7866.213378662088, 4492.236319825637, 4535.931961020521, 4586.793594288199, 4639.605633521121, 4660.277656963176, 3578.0, 3648.7628304160144, 3654.0, 3668.9633103669157, 3697.8335974881193, 666.6733300682728, 673.7507122364757, 681.2131987554383, 683.719674933275, 689.689639662144, 693.5977133262695, 716.813628456605, 716.8781307177792, 722.1803253307429, 774.0, 8611.698590549426, 8839.51382673959, 10304.690859274233, 10550.788984220273, 10574.11708653454, 692.1486571516962, 701.1411021498624, 753.175273075981, 755.7266006778596, 757.8938948547208, 4833.371661683958, 5165.251038599382, 5183.196604526304, 5194.714290714047, 5198.350206224222, 88329.0, 91130.0, 91971.0, 95792.08415831644, 96474.51762741142, 55259.72370138204, 63572.04641930375, 83225.0, 86263.13736862551, 86319.56840215759, 60437.69781151066, 64741.05776826703, 69405.65297173482, 70299.99999999898, 72591.63704181445, 11058.025238761978, 11277.436128193393, 11310.0, 11355.37545435009, 11414.0, 49250.0, 49560.75219623879, 49599.50400495949, 49732.50267497423, 51501.7424912873, 60539.0, 60675.69662151838, 60963.39036609577, 62934.426639334386, 62971.74056518936, 12909.677258068623, 13131.671708207372, 13191.604251872459, 13207.0, 13316.33418329099, 14445.855541444871, 14815.92592037033, 15141.697166056838, 15357.923210383877, 15409.84590154084, 12964.968944099379, 13260.602181934557, 14274.700185534062, 14438.133711977314, 14937.580929811651, 13191.868081319448, 14106.224157671017, 14151.00942934026, 14271.857281427052, 14334.354954026885, 13257.07200495956, 14376.28118594087, 14446.494372696905, 14524.346404411615, 14532.636684082983, 9628.855567166358, 9884.863240727409, 10272.0, 10350.689479315633, 10568.68293951152, 10173.593056277961, 10306.536205870903, 11366.488508016993, 11597.420128993348, 11599.76800464003], "value": 7767.876999408041, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1435.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 169.0, 163.0, 113.0, 114.0, 114.0, 114.0, 120.0, 114.0, 114.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 109.0, 144.0, 110.0, 105.0, 109.0, 106.0, 125.0, 106.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 187.0, 184.0, 185.0, 185.0, 185.0, 187.0, 185.0, 185.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 91.0, 62.0, 61.0, 58.0, 60.0, 76.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 85.0, 70.0, 68.0, 70.0, 82.0, 54.0, 68.0, 95.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 124.0, 135.0, 104.0, 88.0, 88.0, 88.0, 87.0, 88.0, 87.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 98.0, 95.0, 98.0, 139.0, 151.0, 94.0, 94.0, 95.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 93.0, 137.0, 83.0, 84.0, 84.0, 89.0, 75.0], "value": 90.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 62.0, 65.0, 65.0, 66.0, 64.0, 66.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 65.0, 64.0, 64.0, 60.0, 60.0, 61.0, 60.0, 75.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 80.0, 84.0, 83.0, 80.0, 86.0, 88.0, 100.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 134.0, 133.0, 137.0, 133.0, 128.0, 134.0, 149.0, 136.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 167.0, 162.0, 201.0, 159.0, 161.0, 161.0, 161.0, 159.0, 161.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 66.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 62.0], "value": 63.5, "unit": "score"}]}]} 15:14:12 INFO - Return code: 0 15:14:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:14:12 INFO - # TBPL SUCCESS # 15:14:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:14:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:14:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:14:12 INFO - 2017-05-07 15:14:12.187 screenresolution[1997:282776] starting screenresolution argv=screenresolution get 15:14:12 INFO - 2017-05-07 15:14:12.190 screenresolution[1997:282776] Display 0: 1600x1200x32@60 15:14:12 INFO - 2017-05-07 15:14:12.195 screenresolution[1998:282779] starting screenresolution argv=screenresolution list 15:14:12 INFO - Available Modes on Display 0 15:14:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:14:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:14:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:14:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:14:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:14:12 INFO - Intel Iris: 15:14:12 INFO - Chipset Model: Intel Iris 15:14:12 INFO - Type: GPU 15:14:12 INFO - Bus: Built-In 15:14:12 INFO - VRAM (Dynamic, Max): 1536 MB 15:14:12 INFO - Vendor: Intel (0x8086) 15:14:12 INFO - Device ID: 0x0a2e 15:14:12 INFO - Revision ID: 0x0009 15:14:12 INFO - Displays: 15:14:12 INFO - Display: 15:14:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:14:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:14:12 INFO - Display Serial Number: 1600x1200 60 15:14:12 INFO - Main Display: Yes 15:14:12 INFO - Mirror: Off 15:14:12 INFO - Online: Yes 15:14:12 INFO - Rotation: Supported 15:14:12 INFO - Return code: 0 15:14:12 INFO - Running post-action listener: _resource_record_post_action 15:14:12 INFO - [mozharness: 2017-05-07 22:14:12.430993Z] Finished run-tests step (success) 15:14:12 INFO - Running post-run listener: _resource_record_post_run 15:14:12 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 7502336; Write bytes: 426540544; Read time: 66; Write time: 1489 15:14:12 INFO - TinderboxPrint: CPU usage
53.6% 15:14:12 INFO - TinderboxPrint: I/O read bytes / time
7,502,336 / 66 15:14:12 INFO - TinderboxPrint: I/O write bytes / time
426,540,544 / 1,489 15:14:12 INFO - TinderboxPrint: CPU idle
2,215.5 (46.4%) 15:14:12 INFO - TinderboxPrint: CPU system
950.7 (19.9%) 15:14:12 INFO - TinderboxPrint: CPU user
1,607.5 (33.7%) 15:14:12 INFO - TinderboxPrint: Swap in / out
138,690,560 / 0 15:14:12 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122825216; Write bytes: 127629312; Read time: 11252; Write time: 326 15:14:12 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 7367168; Write bytes: 297494016; Read time: 64; Write time: 1156 15:14:12 INFO - Running post-run listener: _upload_blobber_files 15:14:12 INFO - Blob upload gear active. 15:14:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:12 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 15:14:12 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'] 15:14:12 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 15:14:13 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:14:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:14 INFO - (blobuploader) - INFO - Done attempting. 15:14:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:14:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:14:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:15 INFO - (blobuploader) - INFO - Done attempting. 15:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:16 INFO - (blobuploader) - INFO - Done attempting. 15:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:18 INFO - (blobuploader) - INFO - Done attempting. 15:14:18 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:18 INFO - Return code: 0 15:14:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad012812a2ab1936feab8c38c5fe0e0415d654990d0867a874c1421fbee4afbbab298a3521c4afbd1c08f4ee1c07adf0faf26905b5f1ae11cd81cc6ddb875328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d1992a1980016dceacd7a894aaadf8c6b9c03188d157ca9b86c542553da851206919b9e2c3fa1e122bcfb40cd2b98e943747f4c9a9d3c5364cf684780a01290", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2170b6f58ec3ddc5e46c1e14fd6322ee0b051dc8fcc2096053a0e49ed855f5861c1d94e176a16056dbd7915e48bf4e5308ee7b0f225c5d0bffbc2c0af0234a01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d5673f3c49193c4096d11f8d2de3da583034b1ef2f563e353ad2519a399013c313914923d5a71db6e1132ebd3aab4d574524daf223a6cfbfebe9a4ca6596caf"} 15:14:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:18 INFO - Contents: 15:14:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad012812a2ab1936feab8c38c5fe0e0415d654990d0867a874c1421fbee4afbbab298a3521c4afbd1c08f4ee1c07adf0faf26905b5f1ae11cd81cc6ddb875328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d1992a1980016dceacd7a894aaadf8c6b9c03188d157ca9b86c542553da851206919b9e2c3fa1e122bcfb40cd2b98e943747f4c9a9d3c5364cf684780a01290", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2170b6f58ec3ddc5e46c1e14fd6322ee0b051dc8fcc2096053a0e49ed855f5861c1d94e176a16056dbd7915e48bf4e5308ee7b0f225c5d0bffbc2c0af0234a01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d5673f3c49193c4096d11f8d2de3da583034b1ef2f563e353ad2519a399013c313914923d5a71db6e1132ebd3aab4d574524daf223a6cfbfebe9a4ca6596caf"} 15:14:18 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:18 INFO - Copying logs to upload dir... 15:14:18 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.160562 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-07 15:14:18.498298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.501581) ========= 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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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/ad012812a2ab1936feab8c38c5fe0e0415d654990d0867a874c1421fbee4afbbab298a3521c4afbd1c08f4ee1c07adf0faf26905b5f1ae11cd81cc6ddb875328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d1992a1980016dceacd7a894aaadf8c6b9c03188d157ca9b86c542553da851206919b9e2c3fa1e122bcfb40cd2b98e943747f4c9a9d3c5364cf684780a01290", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2170b6f58ec3ddc5e46c1e14fd6322ee0b051dc8fcc2096053a0e49ed855f5861c1d94e176a16056dbd7915e48bf4e5308ee7b0f225c5d0bffbc2c0af0234a01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d5673f3c49193c4096d11f8d2de3da583034b1ef2f563e353ad2519a399013c313914923d5a71db6e1132ebd3aab4d574524daf223a6cfbfebe9a4ca6596caf"} build_url:https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad012812a2ab1936feab8c38c5fe0e0415d654990d0867a874c1421fbee4afbbab298a3521c4afbd1c08f4ee1c07adf0faf26905b5f1ae11cd81cc6ddb875328", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d1992a1980016dceacd7a894aaadf8c6b9c03188d157ca9b86c542553da851206919b9e2c3fa1e122bcfb40cd2b98e943747f4c9a9d3c5364cf684780a01290", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2170b6f58ec3ddc5e46c1e14fd6322ee0b051dc8fcc2096053a0e49ed855f5861c1d94e176a16056dbd7915e48bf4e5308ee7b0f225c5d0bffbc2c0af0234a01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d5673f3c49193c4096d11f8d2de3da583034b1ef2f563e353ad2519a399013c313914923d5a71db6e1132ebd3aab4d574524daf223a6cfbfebe9a4ca6596caf"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.539258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.539588) ========= 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.uS7z7CfoCR/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.nIXcf4TEhQ/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005205 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.588007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 15:14:18.588344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 15:14:18.588659) ========= ========= Total master_lag: 0.19 =========