builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0101 starttime: 1493392905.41 results: success (0) buildid: 20170428062524 builduid: 6102bb83415349b4a11fcd6b165e8527 revision: d9d5690e22ee0a9826f3b6f177169b6810ce789c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.413031) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.413495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.413790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.441770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.442171) ========= 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.M1qptOynwu/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.MM2QgJgHch/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-28 08:21:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2017-04-28 08:21:45 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090118 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.557910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.558290) ========= 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.M1qptOynwu/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.MM2QgJgHch/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.035214 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:45.616439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 08:21:45.616817) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d9d5690e22ee0a9826f3b6f177169b6810ce789c --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 d9d5690e22ee0a9826f3b6f177169b6810ce789c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M1qptOynwu/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.MM2QgJgHch/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-28 08:21:45,728 truncating revision to first 12 chars 2017-04-28 08:21:45,728 Setting DEBUG logging. 2017-04-28 08:21:45,728 attempt 1/10 2017-04-28 08:21:45,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d9d5690e22ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 08:21:46,820 unpacking tar archive at: mozilla-beta-d9d5690e22ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 08:21:47.013411) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:47.013750) ========= script_repo_revision: d9d5690e22ee0a9826f3b6f177169b6810ce789c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:47.014143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:47.014411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 08:21:47.035040) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-28 08:21:47.035523) ========= /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.M1qptOynwu/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.MM2QgJgHch/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:21:47 INFO - MultiFileLogger online at 20170428 08:21:47 in /builds/slave/test 08:21:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:21:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:47 INFO - {'append_to_log': False, 08:21:47 INFO - 'base_work_dir': '/builds/slave/test', 08:21:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:21:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:47 INFO - 'branch': 'Mozilla-Beta', 08:21:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:47 INFO - 'config_files': ('talos/mac_config.py',), 08:21:47 INFO - 'default_actions': ('clobber', 08:21:47 INFO - 'read-buildbot-config', 08:21:47 INFO - 'download-and-extract', 08:21:47 INFO - 'populate-webroot', 08:21:47 INFO - 'create-virtualenv', 08:21:47 INFO - 'install', 08:21:47 INFO - 'run-tests'), 08:21:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:47 INFO - 'download_minidump_stackwalk': True, 08:21:47 INFO - 'download_symbols': 'ondemand', 08:21:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:47 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:47 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:47 INFO - 'gecko_profile': False, 08:21:47 INFO - 'gecko_profile_interval': 0, 08:21:47 INFO - 'installer_path': 'installer.exe', 08:21:47 INFO - 'log_level': 'info', 08:21:47 INFO - 'log_name': 'talos', 08:21:47 INFO - 'log_to_console': True, 08:21:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:21:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:21:47 INFO - 'opt_config_files': (), 08:21:47 INFO - 'pip_index': False, 08:21:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:21:47 INFO - 'cmd': ('bash', 08:21:47 INFO - '-c', 08:21:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:21:47 INFO - 'enabled': True, 08:21:47 INFO - 'halt_on_failure': False, 08:21:47 INFO - 'name': 'check_screen_resolution'},), 08:21:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:21:47 INFO - 'cmd': ('bash', 08:21:47 INFO - '-c', 08:21:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:21:47 INFO - 'enabled': True, 08:21:47 INFO - 'halt_on_failure': False, 08:21:47 INFO - 'name': 'check_screen_resolution'},), 08:21:47 INFO - 'run_cmd_checks_enabled': True, 08:21:47 INFO - 'suite': 'dromaeojs', 08:21:47 INFO - 'system_bits': '32', 08:21:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:47 INFO - 'title': 't-yosemite-r7-0101', 08:21:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:47 INFO - 'use_talos_json': True, 08:21:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:47 INFO - 'work_dir': 'build'} 08:21:47 INFO - [mozharness: 2017-04-28 15:21:47.255753Z] Running clobber step. 08:21:47 INFO - Running pre-action listener: _resource_record_pre_action 08:21:47 INFO - Running main action method: clobber 08:21:47 INFO - rmtree: /builds/slave/test/build 08:21:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:49 INFO - Running post-action listener: _resource_record_post_action 08:21:49 INFO - [mozharness: 2017-04-28 15:21:49.731235Z] Finished clobber step (success) 08:21:49 INFO - [mozharness: 2017-04-28 15:21:49.731365Z] Running read-buildbot-config step. 08:21:49 INFO - Running pre-action listener: _resource_record_pre_action 08:21:49 INFO - Running main action method: read_buildbot_config 08:21:49 INFO - Using buildbot properties: 08:21:49 INFO - { 08:21:49 INFO - "project": "", 08:21:49 INFO - "product": "firefox", 08:21:49 INFO - "script_repo_revision": "production", 08:21:49 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:21:49 INFO - "repository": "", 08:21:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:21:49 INFO - "buildid": "20170428062524", 08:21:49 INFO - "pgo_build": "False", 08:21:49 INFO - "basedir": "/builds/slave/test", 08:21:49 INFO - "buildnumber": 1, 08:21:49 INFO - "slavename": "t-yosemite-r7-0101", 08:21:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:21:49 INFO - "platform": "yosemite_r7", 08:21:49 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:21:49 INFO - "branch": "mozilla-beta", 08:21:49 INFO - "repo_path": "releases/mozilla-beta", 08:21:49 INFO - "revision": "d9d5690e22ee0a9826f3b6f177169b6810ce789c", 08:21:49 INFO - "stage_platform": "macosx64", 08:21:49 INFO - "builduid": "6102bb83415349b4a11fcd6b165e8527", 08:21:49 INFO - "slavebuilddir": "test" 08:21:49 INFO - } 08:21:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 08:21:49 INFO - Running post-action listener: _resource_record_post_action 08:21:49 INFO - [mozharness: 2017-04-28 15:21:49.734800Z] Finished read-buildbot-config step (success) 08:21:49 INFO - [mozharness: 2017-04-28 15:21:49.734920Z] Running download-and-extract step. 08:21:49 INFO - Running pre-action listener: _resource_record_pre_action 08:21:49 INFO - Running main action method: download_and_extract 08:21:49 INFO - mkdir: /builds/slave/test/build/tests 08:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:49 INFO - trying https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 08:21:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 08:21:51 INFO - Downloaded 1165 bytes. 08:21:51 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:21:51 INFO - Using the following test package requirements: 08:21:51 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:21:51 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:21:51 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 08:21:51 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:21:51 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 08:21:51 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:21:51 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:21:51 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 08:21:51 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:21:51 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:21:51 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 08:21:51 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:21:51 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 08:21:51 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:21:51 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 08:21:51 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:21:51 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 08:21:51 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 08:21:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:21:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:21:51 INFO - Fetch https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:21:52 INFO - Expected file size: 51222775 08:21:52 INFO - Obtained file size: 51222775 08:22:09 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:22:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:22:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:22:09 INFO - Fetch https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:22:11 INFO - Expected file size: 51222775 08:22:11 INFO - Obtained file size: 51222775 08:22:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 08:22:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 08:22:26 INFO - Fetch https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 08:22:27 INFO - Expected file size: 14404449 08:22:27 INFO - Obtained file size: 14404449 08:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:28 INFO - trying https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:22:28 INFO - Downloading https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 08:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 08:22:29 INFO - Downloaded 59541622 bytes. 08:22:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:22:29 INFO - mkdir: /builds/slave/test/properties 08:22:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:22:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:22:29 INFO - Contents: 08:22:29 INFO - build_url:https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:22:30 INFO - Running post-action listener: _resource_record_post_action 08:22:30 INFO - Running post-action listener: set_extra_try_arguments 08:22:30 INFO - [mozharness: 2017-04-28 15:22:30.555769Z] Finished download-and-extract step (success) 08:22:30 INFO - [mozharness: 2017-04-28 15:22:30.555890Z] Running populate-webroot step. 08:22:30 INFO - Running pre-action listener: _resource_record_pre_action 08:22:30 INFO - Running main action method: populate_webroot 08:22:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:22:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:22:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:22:30 INFO - '--tppagecycles', 08:22:30 INFO - '7'], 08:22:30 INFO - 'tests': ['tsvgm']}}, 08:22:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:22:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:22:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:22:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:22:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:22:30 INFO - 'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:22:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:22:30 INFO - 'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['damp', 'tps']}, 08:22:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:22:30 INFO - 'tests': ['damp', 'tps']}, 08:22:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['dromaeo_dom']}, 08:22:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:22:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['basic_compositor_video']}, 08:22:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:22:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['a11yr', 08:22:30 INFO - 'ts_paint', 08:22:30 INFO - 'tpaint', 08:22:30 INFO - 'sessionrestore', 08:22:30 INFO - 'sessionrestore_no_auto_restore', 08:22:30 INFO - 'tabpaint']}, 08:22:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:22:30 INFO - 'ts_paint', 08:22:30 INFO - 'tpaint', 08:22:30 INFO - 'sessionrestore', 08:22:30 INFO - 'sessionrestore_no_auto_restore', 08:22:30 INFO - 'tabpaint']}, 08:22:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:22:30 INFO - 'ts_paint', 08:22:30 INFO - 'tpaint', 08:22:30 INFO - 'sessionrestore', 08:22:30 INFO - 'sessionrestore_no_auto_restore', 08:22:30 INFO - 'tabpaint']}, 08:22:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:22:30 INFO - 'ts_paint', 08:22:30 INFO - 'tpaint', 08:22:30 INFO - 'sessionrestore', 08:22:30 INFO - 'sessionrestore_no_auto_restore', 08:22:30 INFO - 'tabpaint']}, 08:22:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['a11yr', 08:22:30 INFO - 'ts_paint', 08:22:30 INFO - 'tpaint', 08:22:30 INFO - 'sessionrestore', 08:22:30 INFO - 'sessionrestore_no_auto_restore', 08:22:30 INFO - 'tabpaint']}, 08:22:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['a11yr', 08:22:30 INFO - 'ts_paint', 08:22:30 INFO - 'tpaint', 08:22:30 INFO - 'sessionrestore', 08:22:30 INFO - 'sessionrestore_no_auto_restore', 08:22:30 INFO - 'tabpaint']}, 08:22:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['tsvgx', 08:22:30 INFO - 'tsvgr_opacity', 08:22:30 INFO - 'tart', 08:22:30 INFO - 'tscrollx', 08:22:30 INFO - 'cart', 08:22:30 INFO - 'tsvg_static']}, 08:22:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:22:30 INFO - 'tsvgr_opacity', 08:22:30 INFO - 'tart', 08:22:30 INFO - 'tscrollx', 08:22:30 INFO - 'cart', 08:22:30 INFO - 'tsvg_static']}, 08:22:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:22:30 INFO - 'talos_options': ['--disable-e10s'], 08:22:30 INFO - 'tests': ['tp5o']}, 08:22:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:22:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:22:30 INFO - 'talos_options': ['--disable-e10s', 08:22:30 INFO - '--xperf_path', 08:22:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:30 INFO - 'tests': ['tp5n']}, 08:22:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:22:30 INFO - 'talos_options': ['--xperf_path', 08:22:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:30 INFO - 'tests': ['tp5n']}}, 08:22:30 INFO - 'talos.zip': {'path': '', 08:22:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:22:30 INFO - Running post-action listener: _resource_record_post_action 08:22:30 INFO - [mozharness: 2017-04-28 15:22:30.574403Z] Finished populate-webroot step (success) 08:22:30 INFO - [mozharness: 2017-04-28 15:22:30.574525Z] Running create-virtualenv step. 08:22:30 INFO - Running pre-action listener: _resource_record_pre_action 08:22:30 INFO - Running main action method: create_virtualenv 08:22:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:22:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:22:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:22:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:22:30 INFO - Using real prefix '/tools/python27' 08:22:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:22:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:22:34 INFO - Installing pip.................done. 08:22:34 INFO - Return code: 0 08:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:22:34 INFO - Reading from file tmpfile_stdout 08:22:34 INFO - Output received: 08:22:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:22:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:34 INFO - 'HOME': '/Users/cltbld', 08:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:34 INFO - 'LOGNAME': 'cltbld', 08:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:34 INFO - 'MOZ_NO_REMOTE': '1', 08:22:34 INFO - 'NO_EM_RESTART': '1', 08:22:34 INFO - 'PAGER': '/bin/cat', 08:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:34 INFO - 'PWD': '/builds/slave/test', 08:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:34 INFO - 'SHELL': '/bin/bash', 08:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:34 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:34 INFO - 'USER': 'cltbld', 08:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:34 INFO - 'XPC_FLAGS': '0x0', 08:22:34 INFO - 'XPC_SERVICE_NAME': '0', 08:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:22:34 INFO - Cleaning up... 08:22:34 INFO - Return code: 0 08:22:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:34 INFO - 'HOME': '/Users/cltbld', 08:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:34 INFO - 'LOGNAME': 'cltbld', 08:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:34 INFO - 'MOZ_NO_REMOTE': '1', 08:22:34 INFO - 'NO_EM_RESTART': '1', 08:22:34 INFO - 'PAGER': '/bin/cat', 08:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:34 INFO - 'PWD': '/builds/slave/test', 08:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:34 INFO - 'SHELL': '/bin/bash', 08:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:34 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:34 INFO - 'USER': 'cltbld', 08:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:34 INFO - 'XPC_FLAGS': '0x0', 08:22:34 INFO - 'XPC_SERVICE_NAME': '0', 08:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:35 INFO - Downloading/unpacking psutil>=3.1.1 08:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:22:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:38 INFO - Installing collected packages: psutil 08:22:38 INFO - Running setup.py install for psutil 08:22:38 INFO - building 'psutil._psutil_osx' extension 08:22:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:22:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:22:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:22:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:22:39 INFO - building 'psutil._psutil_posix' extension 08:22:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:22:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:22:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:22:39 INFO - ^ 08:22:39 INFO - 1 warning generated. 08:22:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:22:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:39 INFO - Successfully installed psutil 08:22:39 INFO - Cleaning up... 08:22:39 INFO - Return code: 0 08:22:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:39 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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:22:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:39 INFO - 'HOME': '/Users/cltbld', 08:22:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:39 INFO - 'LOGNAME': 'cltbld', 08:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:39 INFO - 'MOZ_NO_REMOTE': '1', 08:22:39 INFO - 'NO_EM_RESTART': '1', 08:22:39 INFO - 'PAGER': '/bin/cat', 08:22:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:39 INFO - 'PWD': '/builds/slave/test', 08:22:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:39 INFO - 'SHELL': '/bin/bash', 08:22:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:39 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:39 INFO - 'USER': 'cltbld', 08:22:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:39 INFO - 'XPC_FLAGS': '0x0', 08:22:39 INFO - 'XPC_SERVICE_NAME': '0', 08:22:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:22:42 INFO - Installing collected packages: mozsystemmonitor 08:22:42 INFO - Running setup.py install for mozsystemmonitor 08:22:42 INFO - Successfully installed mozsystemmonitor 08:22:42 INFO - Cleaning up... 08:22:43 INFO - Return code: 0 08:22:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:43 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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:22:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:43 INFO - 'HOME': '/Users/cltbld', 08:22:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:43 INFO - 'LOGNAME': 'cltbld', 08:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:43 INFO - 'MOZ_NO_REMOTE': '1', 08:22:43 INFO - 'NO_EM_RESTART': '1', 08:22:43 INFO - 'PAGER': '/bin/cat', 08:22:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:43 INFO - 'PWD': '/builds/slave/test', 08:22:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:43 INFO - 'SHELL': '/bin/bash', 08:22:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:43 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:43 INFO - 'USER': 'cltbld', 08:22:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:43 INFO - 'XPC_FLAGS': '0x0', 08:22:43 INFO - 'XPC_SERVICE_NAME': '0', 08:22:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:44 INFO - Downloading/unpacking jsonschema==2.5.1 08:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:47 INFO - warning: no files found matching '*.txt' 08:22:47 INFO - no previously-included directories found matching 'build' 08:22:47 INFO - no previously-included directories found matching 'dist' 08:22:47 INFO - no previously-included directories found matching '.git*' 08:22:47 INFO - Installing collected packages: jsonschema, functools32 08:22:47 INFO - Running setup.py install for functools32 08:22:47 INFO - warning: no files found matching '*.txt' 08:22:47 INFO - no previously-included directories found matching 'build' 08:22:47 INFO - no previously-included directories found matching 'dist' 08:22:47 INFO - no previously-included directories found matching '.git*' 08:22:47 INFO - Successfully installed jsonschema functools32 08:22:47 INFO - Cleaning up... 08:22:47 INFO - Return code: 0 08:22:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:47 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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:22:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:47 INFO - 'HOME': '/Users/cltbld', 08:22:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:47 INFO - 'LOGNAME': 'cltbld', 08:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:47 INFO - 'MOZ_NO_REMOTE': '1', 08:22:47 INFO - 'NO_EM_RESTART': '1', 08:22:47 INFO - 'PAGER': '/bin/cat', 08:22:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:47 INFO - 'PWD': '/builds/slave/test', 08:22:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:47 INFO - 'SHELL': '/bin/bash', 08:22:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:47 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:47 INFO - 'USER': 'cltbld', 08:22:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:47 INFO - 'XPC_FLAGS': '0x0', 08:22:47 INFO - 'XPC_SERVICE_NAME': '0', 08:22:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:22:48 INFO - Cleaning up... 08:22:48 INFO - Return code: 0 08:22:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:22:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:48 INFO - 'HOME': '/Users/cltbld', 08:22:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:48 INFO - 'LOGNAME': 'cltbld', 08:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:48 INFO - 'MOZ_NO_REMOTE': '1', 08:22:48 INFO - 'NO_EM_RESTART': '1', 08:22:48 INFO - 'PAGER': '/bin/cat', 08:22:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:48 INFO - 'PWD': '/builds/slave/test', 08:22:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:48 INFO - 'SHELL': '/bin/bash', 08:22:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:48 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:48 INFO - 'USER': 'cltbld', 08:22:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:48 INFO - 'XPC_FLAGS': '0x0', 08:22:48 INFO - 'XPC_SERVICE_NAME': '0', 08:22:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:52 INFO - Downloading docopt-0.6.1.tar.gz 08:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:52 INFO - Running setup.py install for blobuploader 08:22:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:52 INFO - Running setup.py install for requests 08:22:53 INFO - Running setup.py install for docopt 08:22:53 INFO - Successfully installed blobuploader requests docopt 08:22:53 INFO - Cleaning up... 08:22:53 INFO - Return code: 0 08:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:53 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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:53 INFO - 'HOME': '/Users/cltbld', 08:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:53 INFO - 'LOGNAME': 'cltbld', 08:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:53 INFO - 'MOZ_NO_REMOTE': '1', 08:22:53 INFO - 'NO_EM_RESTART': '1', 08:22:53 INFO - 'PAGER': '/bin/cat', 08:22:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:53 INFO - 'PWD': '/builds/slave/test', 08:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:53 INFO - 'SHELL': '/bin/bash', 08:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:53 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:53 INFO - 'USER': 'cltbld', 08:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:53 INFO - 'XPC_FLAGS': '0x0', 08:22:53 INFO - 'XPC_SERVICE_NAME': '0', 08:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-PVnttS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-d0ZWF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-b4vd6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-sZO14s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-PX_uX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-yQIUqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-rYFQPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-s0NGQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Ais8Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-mD2HRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-gbPBSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-xiyuC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:54 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-RYoBhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:55 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-5IrGWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:55 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Pmq0TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:55 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-3OW2To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:55 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-p_HAOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:55 INFO - Running setup.py install for manifestparser 08:22:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:55 INFO - Running setup.py install for mozcrash 08:22:55 INFO - Running setup.py install for mozdebug 08:22:55 INFO - Running setup.py install for mozdevice 08:22:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Running setup.py install for mozfile 08:22:56 INFO - Running setup.py install for mozhttpd 08:22:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Running setup.py install for mozinfo 08:22:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Running setup.py install for mozInstall 08:22:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Running setup.py install for mozleak 08:22:56 INFO - Running setup.py install for mozlog 08:22:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Running setup.py install for moznetwork 08:22:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozprocess 08:22:57 INFO - Running setup.py install for mozprofile 08:22:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozrunner 08:22:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozscreenshot 08:22:57 INFO - Running setup.py install for moztest 08:22:57 INFO - Running setup.py install for mozversion 08:22:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:58 INFO - Cleaning up... 08:22:58 INFO - Return code: 0 08:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:58 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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:22:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:58 INFO - 'HOME': '/Users/cltbld', 08:22:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:58 INFO - 'LOGNAME': 'cltbld', 08:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:58 INFO - 'MOZ_NO_REMOTE': '1', 08:22:58 INFO - 'NO_EM_RESTART': '1', 08:22:58 INFO - 'PAGER': '/bin/cat', 08:22:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:58 INFO - 'PWD': '/builds/slave/test', 08:22:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:58 INFO - 'SHELL': '/bin/bash', 08:22:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:22:58 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:22:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:58 INFO - 'USER': 'cltbld', 08:22:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:58 INFO - 'XPC_FLAGS': '0x0', 08:22:58 INFO - 'XPC_SERVICE_NAME': '0', 08:22:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:58 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-CMAqbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:58 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-kD9olw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:58 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-gQLUWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:58 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-i0Ogp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:58 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-fvyS_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:58 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-vYb7vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Kf2722-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-OfLoCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-iVb5KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-4Cbqkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-9AoLKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-I5BCRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-tKtC5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-BAQQ60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-jeMxpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:59 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-RtFjuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:00 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-6DRx6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:02 INFO - Downloading blessings-1.6.tar.gz 08:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:02 INFO - Installing collected packages: blessings 08:23:02 INFO - Running setup.py install for blessings 08:23:03 INFO - Successfully installed blessings 08:23:03 INFO - Cleaning up... 08:23:03 INFO - Return code: 0 08:23:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:03 INFO - Reading from file tmpfile_stdout 08:23:03 INFO - Current package versions: 08:23:03 INFO - blessings == 1.6 08:23:03 INFO - blobuploader == 1.2.4 08:23:03 INFO - docopt == 0.6.1 08:23:03 INFO - functools32 == 3.2.3-2 08:23:03 INFO - jsonschema == 2.5.1 08:23:03 INFO - manifestparser == 1.1 08:23:03 INFO - mozInstall == 1.12 08:23:03 INFO - mozcrash == 1.0 08:23:03 INFO - mozdebug == 0.1 08:23:03 INFO - mozdevice == 0.49 08:23:03 INFO - mozfile == 1.2 08:23:03 INFO - mozhttpd == 0.7 08:23:03 INFO - mozinfo == 0.9 08:23:03 INFO - mozleak == 0.1 08:23:03 INFO - mozlog == 3.4 08:23:03 INFO - moznetwork == 0.27 08:23:03 INFO - mozprocess == 0.25 08:23:03 INFO - mozprofile == 0.28 08:23:03 INFO - mozrunner == 6.13 08:23:03 INFO - mozscreenshot == 0.1 08:23:03 INFO - mozsystemmonitor == 0.3 08:23:03 INFO - moztest == 0.8 08:23:03 INFO - mozversion == 1.4 08:23:03 INFO - psutil == 3.1.1 08:23:03 INFO - requests == 1.2.3 08:23:03 INFO - wsgiref == 0.1.2 08:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:03 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 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:03 INFO - 'HOME': '/Users/cltbld', 08:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:03 INFO - 'LOGNAME': 'cltbld', 08:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:03 INFO - 'MOZ_NO_REMOTE': '1', 08:23:03 INFO - 'NO_EM_RESTART': '1', 08:23:03 INFO - 'PAGER': '/bin/cat', 08:23:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:03 INFO - 'PWD': '/builds/slave/test', 08:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:03 INFO - 'SHELL': '/bin/bash', 08:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:23:03 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:03 INFO - 'USER': 'cltbld', 08:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:03 INFO - 'XPC_FLAGS': '0x0', 08:23:03 INFO - 'XPC_SERVICE_NAME': '0', 08:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:03 INFO - Cleaning up... 08:23:03 INFO - Return code: 0 08:23:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829b59f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, '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.M1qptOynwu/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.MM2QgJgHch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23: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'] in /builds/slave/test/build 08:23: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 08:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:03 INFO - 'HOME': '/Users/cltbld', 08:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:03 INFO - 'LOGNAME': 'cltbld', 08:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:03 INFO - 'MOZ_NO_REMOTE': '1', 08:23:03 INFO - 'NO_EM_RESTART': '1', 08:23:03 INFO - 'PAGER': '/bin/cat', 08:23:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:03 INFO - 'PWD': '/builds/slave/test', 08:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:03 INFO - 'SHELL': '/bin/bash', 08:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:23:03 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:03 INFO - 'USER': 'cltbld', 08:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:03 INFO - 'XPC_FLAGS': '0x0', 08:23:03 INFO - 'XPC_SERVICE_NAME': '0', 08:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:04 INFO - Cleaning up... 08:23:04 INFO - Return code: 0 08:23:04 INFO - Running post-action listener: _resource_record_post_action 08:23:04 INFO - Running post-action listener: _start_resource_monitoring 08:23:04 INFO - Starting resource monitoring. 08:23:04 INFO - [mozharness: 2017-04-28 15:23:04.063116Z] Finished create-virtualenv step (success) 08:23:04 INFO - [mozharness: 2017-04-28 15:23:04.064120Z] Running install step. 08:23:04 INFO - Running pre-action listener: _resource_record_pre_action 08:23:04 INFO - Running main action method: install 08:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:04 INFO - Reading from file tmpfile_stdout 08:23:04 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:04 INFO - Reading from file tmpfile_stdout 08:23:04 INFO - Output received: 08:23:04 INFO - Usage: mozinstall [options] installer 08:23:04 INFO - Options: 08:23:04 INFO - -h, --help show this help message and exit 08:23:04 INFO - -d DEST, --destination=DEST 08:23:04 INFO - Directory to install application into. [default: 08:23:04 INFO - "/builds/slave/test"] 08:23:04 INFO - --app=APP Application being installed. [default: firefox] 08:23:04 INFO - mkdir: /builds/slave/test/build/application 08:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:23:18 INFO - Reading from file tmpfile_stdout 08:23:18 INFO - Output received: 08:23:18 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:23:18 INFO - Running post-action listener: _resource_record_post_action 08:23:18 INFO - [mozharness: 2017-04-28 15:23:18.974335Z] Finished install step (success) 08:23:18 INFO - [mozharness: 2017-04-28 15:23:18.974465Z] Running run-tests step. 08:23:18 INFO - Running pre-action listener: _resource_record_pre_action 08:23:18 INFO - Running main action method: run_tests 08:23:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:23:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:23:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:23:18 INFO - 2017-04-28 08:23:18.988 screenresolution[1624:7327] starting screenresolution argv=screenresolution get 08:23:18 INFO - 2017-04-28 08:23:18.991 screenresolution[1624:7327] Display 0: 1600x1200x32@60 08:23:18 INFO - 2017-04-28 08:23:18.997 screenresolution[1625:7329] starting screenresolution argv=screenresolution list 08:23:19 INFO - Available Modes on Display 0 08:23:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:23:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:23:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:23:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:23:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:23:19 INFO - Intel Iris: 08:23:19 INFO - Chipset Model: Intel Iris 08:23:19 INFO - Type: GPU 08:23:19 INFO - Bus: Built-In 08:23:19 INFO - VRAM (Dynamic, Max): 1536 MB 08:23:19 INFO - Vendor: Intel (0x8086) 08:23:19 INFO - Device ID: 0x0a2e 08:23:19 INFO - Revision ID: 0x0009 08:23:19 INFO - Displays: 08:23:19 INFO - Display: 08:23:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:23:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:23:19 INFO - Display Serial Number: 1600x1200 60 08:23:19 INFO - Main Display: Yes 08:23:19 INFO - Mirror: Off 08:23:19 INFO - Online: Yes 08:23:19 INFO - Rotation: Supported 08:23:19 INFO - Return code: 0 08:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:19 INFO - Python 2.7.3 08:23:19 INFO - Return code: 0 08:23:19 INFO - grabbing minidump binary from tooltool 08:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9fdd30>, '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 0x10b924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:23:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:23:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:23:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:19 INFO - Return code: 0 08:23:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:23:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - ENV: RUST_BACKTRACE is now 1 08:23:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:23:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:19 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/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:23:19 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/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M1qptOynwu/Render', 08:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:19 INFO - 'HOME': '/Users/cltbld', 08:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:19 INFO - 'LOGNAME': 'cltbld', 08:23:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:19 INFO - 'MOZ_NO_REMOTE': '1', 08:23:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:19 INFO - 'NO_EM_RESTART': '1', 08:23:19 INFO - 'PAGER': '/bin/cat', 08:23:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:19 INFO - 'PWD': '/builds/slave/test', 08:23:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:19 INFO - 'RUST_BACKTRACE': '1', 08:23:19 INFO - 'SHELL': '/bin/bash', 08:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MM2QgJgHch/Listeners', 08:23:19 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 08:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:19 INFO - 'USER': 'cltbld', 08:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:19 INFO - 'XPC_FLAGS': '0x0', 08:23:19 INFO - 'XPC_SERVICE_NAME': '0', 08:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:19 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/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:23:19 INFO - mozversion application_buildid: 20170428062524 08:23:19 INFO - mozversion application_changeset: d9d5690e22ee0a9826f3b6f177169b6810ce789c 08:23:19 INFO - mozversion application_display_name: Firefox 08:23:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:19 INFO - mozversion application_name: Firefox 08:23:19 INFO - mozversion application_remotingname: firefox 08:23:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:23:19 INFO - mozversion application_vendor: Mozilla 08:23:19 INFO - mozversion application_version: 54.0 08:23:19 INFO - mozversion platform_buildid: 20170428062524 08:23:19 INFO - mozversion platform_changeset: d9d5690e22ee0a9826f3b6f177169b6810ce789c 08:23:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:23:19 INFO - mozversion platform_version: 54.0 08:23:19 INFO - using testdate: 1493392999 08:23:19 INFO - actual date: 1493392999 08:23:19 INFO - starting webserver on 'localhost:49236' 08:23:19 INFO - SUITE-START | Running 2 tests 08:23:19 INFO - TEST-START | dromaeo_css 08:23:19 INFO - operating with platform_type : mac_ 08:23:19 INFO - Initialising browser for dromaeo_css test... 08:23:19 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpoWum5d/profile http://localhost:49236/getInfo.html) 08:23:21 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 08:23:21 INFO - PROCESS | 1635 | colorDepth:24 08:23:21 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 08:23:21 INFO - PROCESS | 1635 | __metrics 08:23:22 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:23:22 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:22 INFO - TEST-INFO | 1635: exit 0 08:23:22 INFO - Browser initialized. 08:23:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:22 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpoWum5d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:34 INFO - PROCESS | 1638 | RSS: Main: 165310464 08:23:34 INFO - PROCESS | 1638 | 08:26:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:26:39 INFO - PROCESS | 1638 | RSS: Main: 330272768 08:26:39 INFO - PROCESS | 1638 | 08:29:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:29:43 INFO - PROCESS | 1638 | RSS: Main: 298860544 08:29:43 INFO - PROCESS | 1638 | 08:32:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 08:32:46 INFO - PROCESS | 1638 | RSS: Main: 282292224 08:32:46 INFO - PROCESS | 1638 | 08:35:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 08:35:49 INFO - PROCESS | 1638 | RSS: Main: 275898368 08:35:49 INFO - PROCESS | 1638 | 08:38:53 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:38:54 INFO - PROCESS | 1638 | RSS: Main: 269123584 08:38:54 INFO - PROCESS | 1638 | 08:41:56 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:41:57 INFO - PROCESS | 1638 | RSS: Main: 477208576 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | __start_tp_report 08:41:57 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 08:41:57 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 08:41:57 INFO - PROCESS | 1638 | |i|pagename|runs| 08:41:57 INFO - PROCESS | 1638 | |0;dojo.html;3420.2817408344245;3553.093961039935;3558.2527669189467;3582.6417358264175;3635.83638736257;6159.137720719103;6167.136600875875;6177.073438984155;6180.876382472348;6225.066240063987;6198.132261483396;6206;6252.812415627538;6253.781117660883;6270.937290627093;5495;5514.558835293187;5525;5526.115821468556;5632.35227948785;5377.516023557879;5428.294321738169;5452.754626041838;5488.286522752037;5606.074997625387;5516.586256030793;5521;5521.475459831309;5522.641028333165;5524.475174858382;5491.36849262332;5494.752736126864;5495.230667706524;5500;5503.532199763025;4487.955120448786;5371.570274378079;5455.990641731292;5456.317960254968;5462.9726851365485;6146.170267013986;6146.938530614681;6149.985252433343;6160.921838678213;6171.9691401542705;6311.652859092748;6332.1135041094285;6370.458511026568;6378.170837791057;6380.585261957958;5465.207544906006;6543.705533251015;6547.770828021044;6555.278919318871;6560.212774467047;6228.657423841732;6257.812265631993;6266.342034086447;6285.088662144055;6295.433410992987;6388.680565971683;6419.197600299963;6430.549861509649;6579.47364210862;6600.537962342686;5252.369715634149;6393.424591786761;6394.200724909387;6404.327545607737;6404.807855764335;6448.065030570635;6496.870062598816;6506.251781045145;6514.967425162844;6519.674016299166;6233.189685340967;6367.522435817332;6370.808875733643;6423.42189202974;6484.897567413456;6364.77723279683;6365.809025729143;6407;6419.16550848396;6420.422162005442;4033.4151548025957;5242.816501422432;5246.449122842047;5264.684118952875;5290.603204759658;4534.546545345439;4600.861974140781;4605.516420775837;4667.533246675305;4679.672422930362;6150.907736383958;6171.444569988723;6197.380261973766;6247.844148832481;6251.6561589112125;6535.640539770358;6544.803655890331;6552.803415897531;6554.901676474857;6555.573887697285;6319.968400158062;6328.11406403104;6334.113224148623;6337.524685648595;6354.904676429857;5529.447055294519;5586.217929489874;5635.6618602883955;5673.489385955284;5736.6844823534275;6745.224299205556;6793.490488213404;6806.353396427331;6806.523543351917;6831.316868313328;6071.605345652519;6527.804165875032;6539.019147127969;6540.444062254572;6558.508111891722;6446.226452825691;6474.255460622088;6693.062971183941;6809.455243580601;6818.488613354118;6339.5562310637815;6362.141110949962;6418.0693799397895;6430.935690643034;6432.388923052303;6522.902156467751;6524.967375163284;6527.902081468686;6532.706028228836;6539.084528165966;6274.152989346562;6281.309056003744;6295.3389894060465;6352.841178970562;6376.3623637635865;6128.3503509891225;6250.156228909039;6339.683015849097;6396.26442959047;6403.199600049994;6394.328595497405;6409.166808314889;6427.389398007182;6428.325025872403;6447;6296.716647750954;6305.684715764285;6361.173047503795;6363.140975968185;6379.362063793769;6319.46284565817;6377.043443483514;6395.42441180296;6403.9359606405205;6407.839804004937 08:41:57 INFO - PROCESS | 1638 | |1;ext.html;670.3397153803503;831.5883637599387;842.3050982939077;905.5879574793465;924.0205382294764;29092;41443.58556414435;41802.58197418025;41886.58113418865;42028.579714202846;34111.488327675106;41665.37501937466;41780.79109604455;41830.790846045726;41873.162536749245;9715.417074975507;9876.259280553952;9888.752781180456;9901.603935842557;9908.405495670248;7843.137254901956;7994.760157195294;11703.5903743369;11736.237144585617;11881.405929703524;10043.196544276478;11974.521019159223;11988;12000.879991200107;12009.399530023464;11882.465289062013;11915.404229788475;11959;11969.162158648855;11995.880041199563;11603.4198290086;11659.417029148508;11668.299902005907;11672.066234701204;11674.182807203499;40490;40726.38910416346;40887.7955610223;40951.7952410239;40992.59007409918;4124.13393187431;4141.358089496133;4150.3566947123245;4160.812763425653;4166.395872598457;29018.854905725337;29545.704542954725;30854.84572577123;31057;31084.533731994037;3247.9188020299443;3270.721988630969;3279.114639047468;3313.1054615253747;3420.3159368126476;361424.38575614436;361963;363154;363785;363903;53580.73209633927;53592;53594.660133496975;53686.92626147455;53784.73107634437;54221;54293;54499.72750136224;55595.722021389636;55623;15540.766888496682;15635.843641563439;15649.530514084368;15655.217239137997;15657.921710391374;11845.526178952745;11979.401029948467;13273.336333183495;13283.136596121221;13290.269035203157;10511.84232236517;11935.224210426468;12112.515499380102;12142.210756300989;12271.325077120844;5758.712064396847;5775.5668324875805;5792.971035144881;5811.82564523065;5834.795782147605;903.7740564858653;908.927285817133;913.2374467319729;949.4066208619613;962.2109869906609;27846.721532784817;28216;28627.713722862503;29069;29622;1124.606387764276;1128.1426116151783;1128.729105014807;1164.0687450039934;1166.731651720109;10254.436006019741;11596.88403115958;13964.294934170033;14023.78964315536;14077.436902523988;393456;396449;398019;398118.00940995687;398391;47511.76244118757;47546.762266188445;47606.80982975384;47683.807904802656;47689.5231047692;1278.9680257993625;1487.21177775779;1495.2224843081538;1506.1791323728594;1532.8467153284582;26974.055908043123;27142.72857271402;27674.723252767213;27975.580366294114;28069.57895631608;41284.1743165129;62587;63346.68326658337;63471.36528634655;63691.0446343296;503777;508738;509009;509581;509718.9028109671;37477.6252237485;37653.2469350606;38067.80966095152;38347.42478862875;39175.82472525829;48195;48351;49156.75421622869;49168.26247606217;49440.752796235785;31031.913883014888;31585.368292634477;32324.67675323217;33228.1692957678;33319.333613327115;32755.836220818743;32798;32825.01524954255;32995.505067423524;33825.154371139935;40358.39462408125;40392.596074038884;40494.392584111854;42746;44291.33562996493;41107.383389249786;41394.793026035884;41895;42431.575684243995;42921.926951826455;31963;32763.508547371333;32767;32843.02941823403;33659.99020029403 08:41:57 INFO - PROCESS | 1638 | |2;jquery.html;424;432.0341769893583;437.9058502421979;439.9384086227927;456.5845877778886;20031.298904538344;20514.794852051476;21837.798921059337;22060.669089963623;22066.779332206694;22111.557768844614;22852.65721014186;22905.770942290572;22909.541809163806;23175.536489270205;6640.169978752656;7035;7036.085308909835;7043.859122817541;7409.296116868889;7729.72945946892;7836.451448398614;7861.646225919819;7863.921360786405;7876.291133797957;7595.810104747398;7755.922440775576;7823.3350165236025;7823.921760782405;7842.568658723768;7550.093988721361;7693.269139431801;7763.378929685611;7813.648385822623;7872.173421790715;7431.888521672179;7444.478886477948;7530.58581778002;7532.623368831537;7543.471956963015;20865.68701469479;25892.87053564739;25969.610455843176;26332.21003369902;26667.866660666765;3049.1005153479555;3053.4503789317914;3105.2081719161697;3216.276337823971;3260.005698262029;15831;16031.038137711774;16133.91933040339;16582.75125873113;17049.977001379833;2080.906359213839;2160.7191065161587;2180.0516775202677;2190.507135894411;2208.6355751301016;145691.27154364265;159497.60753588704;170849;173946;177006;16430.917845410695;19040.667153299135;19405.4178374649;20009.09959051846;20047.69928451045;25736.74263257381;32070.679293207235;32111.35777284441;32155.678443215736;32175.51736723904;10252.692419227435;10292.588296468208;10486;10505.31715438494;10608.628697995533;8762.255208307366;8771;8798.208161265517;8918;8943.776405589782;7340.853182936311;8972.237359824358;9156.496392698333;9196.988331283554;9241.537923103819;3398.745094117951;3933.940990885139;3984.4820173377275;3989.7007724420782;4030.6775457963295;1066.594694016269;1069.4652673663168;1085.9619913302997;1093.8632670916136;1136.6646839182295;20299.695504567444;20579.58840823175;20763.79236207649;20809.37571872846;20811.68782468264;1081.5403453532217;1098.4397957041965;1109.6393672056613;1110.5280255891214;1118.9440527973568;10302.33034852732;11037.392943388191;11096.5561377544;11131.276467029616;11144.554217831359;629331;638765;771931;791896;812605;148856.32433891762;161339.70622056344;162059.5691064635;168176.15911920363;172336;1255.1904021906003;1297.7145028093805;1350.034725171507;1350.9459621615222;1355.0717758335572;15804.73562115005;18209.81790182134;19044.904775476032;19163.945982971072;19717.70423443678;62390;62832.74334513193;63383;64787;64947;49920;74523;78946;81104.59447702723;91149;10725.356478611307;11348.262362946381;11427.371494567878;11597.188196826479;11693.766124677288;12096.153269271066;12198.57304994321;12425.813612795635;12512.43694033789;12601.306928119042;8801.251893589117;10472.371657700562;10828.675139745821;10930.508127134457;11000.339979601249;10072.546735396778;10180.862018976099;10394.636187733393;10463.581456741646;10475.371477711362;10967.725806854893;11154.330740155616;11167.441627918734;11258.831117533407;11269.985701286923;9593.568289427132;10882.61910833117;10949.397783122005;11423.543058277575;11463.598774042868;10736.946315268373;10754.085902698358;10857.891421086004;10863.456827158452;11120.221584489009 08:41:57 INFO - PROCESS | 1638 | |3;mootools.html;1407.0853944935784;1623.4642567952576;1642.8110767261765;1653.9586510337247;1655.7847479827624;9510.239180865532;9917.603295868166;11233.999999999989;11477.081833453325;11740.471678774455;11350;11434.371109588968;11440.427978601077;11450.656480305583;11509.827352589718;2007.4780557055162;2487.0549191307277;2487.61441976493;2490.066225165563;2494.2641920633364;2106.936791896238;2168.728908886389;2431.659567660529;2493.551160791057;2513.3842208658903;2466.4203912080648;2468.049800826686;2493.563626365388;2497.1759319424546;2499.600063989753;2475.8638274894874;2480.7643273888953;2484;2484.428581426273;2485.2047344849657;2412.1316326122583;2449.1795248591743;2449.363165576945;2457.2505385857307;2458.323960910746;11417.828732569018;11489.540418383254;11658.6502404928;11673.70815729605;11696.707582310426;6016.067509536029;6180.721867515973;6187.443130118266;6193.969030154865;6205.596636218631;3554.4200206549945;3612.7832330060282;3777.773333599993;3823.751456155341;3826.349520581508;1203.9398030098548;1220.4934951994912;1245.0848626259692;1258.5657948008013;1266.9049821263443;12603.621891343275;14038.859611403857;16146.677066458606;16277.348906043744;16304.83695163045;4254.851080212177;4970.2793095001025;5021.849344519597;5087.440381558025;5234.816781412632;11113.444327783578;13081.542146024844;13098.476060957646;13118.803217951738;13132.277724725232;6148.047052706837;6150.3849615039035;6151.477124444473;6152.477039451607;6153.96923015391;4705.082508910798;5277.498637629419;5548.944510554924;5557.166425036277;5643.858903527444;3834.8082595870096;4206.348016057516;4245.724027938236;4283.957160428356;4328.848490302824;1176.8940795328463;1178.5757127434117;1178.7642471505733;1192.6958625550428;1197.3055627735891;953.046953046953;982.5283863745442;982.9901700983041;996.7009897030862;999.3104757717152;6712.228093769181;6724.562903411263;6855.314468553204;6901.551399159039;6985.371316581431;838.8112674648155;1001.7395477175987;1003.6136087606178;1019.8980101989741;1035.891231420705;3889.4943657324366;3985.5815139409942;4324.8486302979245;4398.758068306274;4465.129299786576;13594.524191653443;13886.305684715724;14024;14035;14035.368408421646;12031.458584363725;13620.93189534046;13852;14012;14042.087264327785;9945.80108397828;10154.289199756095;10328.690139295682;10493.842592361121;10496.73758156037;6551.508636852351;6888.380045795902;7000.089988301488;7040.260772619006;7101.964490177516;11910.464029118537;11990.100742444178;12582.748345033231;12735.363231838557;12742.61772146837;12435.502579896704;12500.124991250525;12519.812202816784;12631.621051368473;12727.427265773247;9456.101670341306;9572.521373931137;9637.951810241184;9663.661771837951;9677.903220967983;10505.737356566147;10700.090492308242;10704.197185210984;10717.624883129052;10735.355878647306;7515.549067055994;9055.230305424113;9126.224270937044;9132.680356187502;9139.268858491438;7821.648025838965;8573.22840944318;8816.779580510281;8818.941726992802;8878.067802880605;8018.879716804136;8153.714619988272;8154.1030486647605;8166.387520935835;8173.591320434073;5628.718564071862;5660.433956604306;5678.6308889923675;5834.970825145847;5883.882322353615;6054.212952316171;6086.69566521681;6136.938630613815;6171.783987560593;6360.745570177141 08:41:57 INFO - PROCESS | 1638 | |4;prototype.html;389.5500696695317;392.6544640716169;395.4226828829912;397.48922634414765;403.33651143868354;5108.489151084889;5113.463086375933;5163.793448262065;5218.8695282617955;5221.817236396727;3976.9801150994276;4190.548529110466;4485.798139083741;4922.630802689795;5111.69329840209;3521.3097713097727;3559.964400356002;4122.690798190133;4217.45173127493;4264.8507302244425;3561.465780132975;3912.4913761211;3990.221906728189;4242.087951090515;4291.356296555526;3724.608916063815;3917.764934103963;4048.9797551012352;4240.321548552232;4253.893652658678;3399.847006884696;3730.5150330457136;4250.681198910063;4306.523748844412;4311.396404503372;3341.446227504198;3495.353359628477;3860.8841734748003;3939.4878665773554;3965.365541513344;4986.706115187018;5019.52314530119;5033.446320904697;5039.72281524516;5048.823291184791;4900.632452566072;4900.754962251873;4940.7035577865445;4942.87642808929;4943.530364615356;4658.021815418766;4827.710337379768;5090.567301779316;5123.38519377677;5406.945930540684;3833.3708174026206;3962.346212874901;4294.840393093878;4377.627901628365;4393.53867843875;4902.730349830722;5237.800123947951;5434.918476222821;5764.855878603068;5792.82621521355;3969.134506781808;4039.171969746195;4472.485664148599;4474.6420286377015;4496.6177874881005;3905.082305658168;4377.649788016951;4547.272436410159;4569.337446070301;4585.243434833215;3723.8696645617815;4315.115401342718;4548.95451045492;4857.417109946829;4965.542056681893;4627.5603817637275;5340.383212225981;5379.462053794589;5386.48828361305;5462.344518657707;1396.7834985577251;1440.3302464353917;1542.1749364090158;1559.2048055491555;1566.8248813389957;1005.6178652112151;1015.4313584392763;1169.906407487399;1175.189119507537;1185.4191446191305;4696.412948381452;4771.71369717818;4933.309336692866;4946.5407704727195;5070.554891855803;4550.931736023962;5290.73022474611;5352.693573272455;5611.887762244733;5656.660600363992;4490.316131450706;4587.816487340469;4855.4173499179615;4994.925076123861;5145.382554093458;2506.7618576235227;2531.278585603094;2926.473234817753;2945.985270073636;2949.380630067667;5014.548690617789;5214.661047031931;5493.395726470085;5857.297124345106;5870.911936320958;4876.4879687633;5181.222816577468;5197.610179236573;5237.16205407133;5680.68756218412;4978.32792572998;5255.553277971415;5256.764660304825;5385.73071346439;5732.541396688255;4833.758312084452;5070.721110338819;5180.507851754077;5322.513753491469;5615.859603509945;4773.2577609173095;4988.201887697951;5380.946190538201;5472.890542189213;5489.505944465017;4987.182242033239;5149.588032957429;5578.2748242728185;5729.341125770589;5849.824505264849;4259.808308626181;4403.2132366165715;4426.716252286801;4453.265211240109;4475.776211189493;4695.389599352199;5298.840410277913;5461.1808228766;5634.915476267941;5675.602707810413;4397.36238245459;4831.541003604652;5083.517065878736;5084.559411482583;5114.414531495248;4486.353051699513;4959.652824302264;5450.957863975727;5466.234727138124;5505.724713764215;4999.675021123615;5301.019311427398;5345.22494238341;5384.353877534721;5390.380106287827;4862.513748625109;5200.791968321225;5496.5053145217125;5548.583856210719;5555.250041244381;4854.95145048545;5050.646454748279;5137.91724965033;5355.22349259363;5462.126059830408 08:41:57 INFO - PROCESS | 1638 | |5;yui.html;797.3780451248025;812.1756417236506;847.8134810341722;883.2801266967421;897.9551022448878;16064.196790160504;17144.657106857856;17484.65030699385;17776.733348999776;17841.197146128423;15966.7604985925;16203.675926481463;16426.589335266624;16463.588410289747;16465.506034818944;967.8596603492507;987.1411871671655;987.9160271376942;990.173205373514;990.4552496127137;997.9201663866874;1005.6027868991744;1029.963951261706;1030.1346868630349;1030.6392762533128;1065.6217042949756;1070.0690399352536;1070.2775626452153;1071.212658695858;1075.2849355178796;1061.3790932304573;1062.5749700119936;1063.6649455421518;1064.6167379743247;1065.6217042949718;791.3985371117934;791.7664289034691;792.211749309435;793.2147174297462;793.4564823096198;17603.911980440145;17751.934883907008;17774.55563610907;18150.09249537518;18357.63284734298;14557;14843.480478183212;14942;14964.775528367083;15331.386744530206;11896.345700986441;11910;12163.270203787713;12282.631521054383;12364.876351236462;3748;3809.5428548574073;3824.7131465140224;3897.902552436183;3907.199024200032;110446;119360.80639193584;120589;121019;122470.77529224772;11210.607628732956;11537.88462115368;11570.88429115698;11591.304521728554;11693.707657308636;24205.39486512816;24444.388890277885;24621.261362159163;24631;24640;7268.164161121433;7923.643436045391;7983.720569780146;8058.758237252891;8464;4631.143238500888;4702.6473014524045;4755.824294849176;4853.927191092136;4954.677945933503;3412.0446275043028;3457.377672019061;3494.405950988338;3505.088676943962;3509.508668786372;567.3503838105429;575.3872126185599;603.6709993053796;621.273110460762;624.8375422390211;575.7322844877068;697.7484920271511;722.3462766196601;747.872861613527;757.3865169212955;8630;10327.76346411643;10866;10998.780024399468;11199.888001119885;696.6168607266085;697.4594689115976;712.7113519024804;742.6769355330448;752.3304259209308;4288.914221715549;4923.556879880828;5221.537969368583;5263.5525980292105;5285.180796976475;88560;90765;97158.51420742992;102918.48540757249;108700;73060.90408643875;89168.5541572288;89290.55354723184;90067;94197;81871.59064204879;82635;83668.32053690395;84137.15862841293;85219.29561408737;11324.547018119183;11358.204925655125;11446.542138314708;11564.884351156381;11625.59310424131;51809.481905180466;52040.739796300775;52953;52991;54012.45987540232;64658.67670661616;65872.67063664651;66655;67477.66261168662;68344.3165568338;13163.407646656115;13318;13577.660558485723;13662.316884155554;13847.930760346133;14912.328945197276;15393.69212615719;15840;15945.920270398574;16505.422310219084;14218.715625687222;14661.780073298696;14788.260586970824;14790.48233311872;15315.693686125993;12746.298953557643;14164.504242351468;14660.120392776467;14675.266236688336;14758.704825903207;14307.64230894236;14507.1295722257;14531.27343632793;14533;14985.175815330262;10028.29801913859;10152.898471015491;10527;10586.206034547286;10671.679849604525;10162;11559.959603635712;11776.234544754563;11805.055595552163;11823.231489953125 08:41:57 INFO - PROCESS | 1638 | __end_tp_report 08:41:57 INFO - PROCESS | 1638 | __start_cc_report 08:41:57 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1847 08:41:57 INFO - PROCESS | 1638 | __end_cc_report 08:41:57 INFO - PROCESS | 1638 | __startTimestamp1493394117168__endTimestamp 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | ------- Summary: start ------- 08:41:57 INFO - PROCESS | 1638 | Number of tests: 6 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:6036.66 Median:6319.46 stddev:685.86 (10.9%) stddev-sans-first:656.54 08:41:57 INFO - PROCESS | 1638 | Values: 3420.3 3553.1 3558.3 3582.6 3635.8 6159.1 6167.1 6177.1 6180.9 6225.1 6198.1 6206.0 6252.8 6253.8 6270.9 5495.0 5514.6 5525.0 5526.1 5632.4 5377.5 5428.3 5452.8 5488.3 5606.1 5516.6 5521.0 5521.5 5522.6 5524.5 5491.4 5494.8 5495.2 5500.0 5503.5 4488.0 5371.6 5456.0 5456.3 5463.0 6146.2 6146.9 6150.0 6160.9 6172.0 6311.7 6332.1 6370.5 6378.2 6380.6 5465.2 6543.7 6547.8 6555.3 6560.2 6228.7 6257.8 6266.3 6285.1 6295.4 6388.7 6419.2 6430.5 6579.5 6600.5 5252.4 6393.4 6394.2 6404.3 6404.8 6448.1 6496.9 6506.3 6515.0 6519.7 6233.2 6367.5 6370.8 6423.4 6484.9 6364.8 6365.8 6407.0 6419.2 6420.4 4033.4 5242.8 5246.4 5264.7 5290.6 4534.5 4600.9 4605.5 4667.5 4679.7 6150.9 6171.4 6197.4 6247.8 6251.7 6535.6 6544.8 6552.8 6554.9 6555.6 6320.0 6328.1 6334.1 6337.5 6354.9 5529.4 5586.2 5635.7 5673.5 5736.7 6745.2 6793.5 6806.4 6806.5 6831.3 6071.6 6527.8 6539.0 6540.4 6558.5 6446.2 6474.3 6693.1 6809.5 6818.5 6339.6 6362.1 6418.1 6430.9 6432.4 6522.9 6525.0 6527.9 6532.7 6539.1 6274.2 6281.3 6295.3 6352.8 6376.4 6128.4 6250.2 6339.7 6396.3 6403.2 6394.3 6409.2 6427.4 6428.3 6447.0 6296.7 6305.7 6361.2 6363.1 6379.4 6319.5 6377.0 6395.4 6403.9 6407.8 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:57898.39 Median:37565.44 stddev:113076.48 (301.0%) stddev-sans-first:113312.05 08:41:57 INFO - PROCESS | 1638 | Values: 670.3 831.6 842.3 905.6 924.0 29092.0 41443.6 41802.6 41886.6 42028.6 34111.5 41665.4 41780.8 41830.8 41873.2 9715.4 9876.3 9888.8 9901.6 9908.4 7843.1 7994.8 11703.6 11736.2 11881.4 10043.2 11974.5 11988.0 12000.9 12009.4 11882.5 11915.4 11959.0 11969.2 11995.9 11603.4 11659.4 11668.3 11672.1 11674.2 40490.0 40726.4 40887.8 40951.8 40992.6 4124.1 4141.4 4150.4 4160.8 4166.4 29018.9 29545.7 30854.8 31057.0 31084.5 3247.9 3270.7 3279.1 3313.1 3420.3 361424.4 361963.0 363154.0 363785.0 363903.0 53580.7 53592.0 53594.7 53686.9 53784.7 54221.0 54293.0 54499.7 55595.7 55623.0 15540.8 15635.8 15649.5 15655.2 15657.9 11845.5 11979.4 13273.3 13283.1 13290.3 10511.8 11935.2 12112.5 12142.2 12271.3 5758.7 5775.6 5793.0 5811.8 5834.8 903.8 908.9 913.2 949.4 962.2 27846.7 28216.0 28627.7 29069.0 29622.0 1124.6 1128.1 1128.7 1164.1 1166.7 10254.4 11596.9 13964.3 14023.8 14077.4 393456.0 396449.0 398019.0 398118.0 398391.0 47511.8 47546.8 47606.8 47683.8 47689.5 1279.0 1487.2 1495.2 1506.2 1532.8 26974.1 27142.7 27674.7 27975.6 28069.6 41284.2 62587.0 63346.7 63471.4 63691.0 503777.0 508738.0 509009.0 509581.0 509718.9 37477.6 37653.2 38067.8 38347.4 39175.8 48195.0 48351.0 49156.8 49168.3 49440.8 31031.9 31585.4 32324.7 33228.2 33319.3 32755.8 32798.0 32825.0 32995.5 33825.2 40358.4 40392.6 40494.4 42746.0 44291.3 41107.4 41394.8 41895.0 42431.6 42921.9 31963.0 32763.5 32767.0 32843.0 33660.0 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:42706.18 Median:20838.69 stddev:122953.79 (590.0%) stddev-sans-first:123257.72 08:41:57 INFO - PROCESS | 1638 | Values: 424.0 432.0 437.9 439.9 456.6 20031.3 20514.8 21837.8 22060.7 22066.8 22111.6 22852.7 22905.8 22909.5 23175.5 6640.2 7035.0 7036.1 7043.9 7409.3 7729.7 7836.5 7861.6 7863.9 7876.3 7595.8 7755.9 7823.3 7823.9 7842.6 7550.1 7693.3 7763.4 7813.6 7872.2 7431.9 7444.5 7530.6 7532.6 7543.5 20865.7 25892.9 25969.6 26332.2 26667.9 3049.1 3053.5 3105.2 3216.3 3260.0 15831.0 16031.0 16133.9 16582.8 17050.0 2080.9 2160.7 2180.1 2190.5 2208.6 145691.3 159497.6 170849.0 173946.0 177006.0 16430.9 19040.7 19405.4 20009.1 20047.7 25736.7 32070.7 32111.4 32155.7 32175.5 10252.7 10292.6 10486.0 10505.3 10608.6 8762.3 8771.0 8798.2 8918.0 8943.8 7340.9 8972.2 9156.5 9197.0 9241.5 3398.7 3933.9 3984.5 3989.7 4030.7 1066.6 1069.5 1086.0 1093.9 1136.7 20299.7 20579.6 20763.8 20809.4 20811.7 1081.5 1098.4 1109.6 1110.5 1118.9 10302.3 11037.4 11096.6 11131.3 11144.6 629331.0 638765.0 771931.0 791896.0 812605.0 148856.3 161339.7 162059.6 168176.2 172336.0 1255.2 1297.7 1350.0 1350.9 1355.1 15804.7 18209.8 19044.9 19163.9 19717.7 62390.0 62832.7 63383.0 64787.0 64947.0 49920.0 74523.0 78946.0 81104.6 91149.0 10725.4 11348.3 11427.4 11597.2 11693.8 12096.2 12198.6 12425.8 12512.4 12601.3 8801.3 10472.4 10828.7 10930.5 11000.3 10072.5 10180.9 10394.6 10463.6 10475.4 10967.7 11154.3 11167.4 11258.8 11270.0 9593.6 10882.6 10949.4 11423.5 11463.6 10736.9 10754.1 10857.9 10863.5 11120.2 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6902.66 Median:2493.56 stddev:4283.00 (171.8%) stddev-sans-first:4275.11 08:41:57 INFO - PROCESS | 1638 | Values: 1407.1 1623.5 1642.8 1654.0 1655.8 9510.2 9917.6 11234.0 11477.1 11740.5 11350.0 11434.4 11440.4 11450.7 11509.8 2007.5 2487.1 2487.6 2490.1 2494.3 2106.9 2168.7 2431.7 2493.6 2513.4 2466.4 2468.0 2493.6 2497.2 2499.6 2475.9 2480.8 2484.0 2484.4 2485.2 2412.1 2449.2 2449.4 2457.3 2458.3 11417.8 11489.5 11658.7 11673.7 11696.7 6016.1 6180.7 6187.4 6194.0 6205.6 3554.4 3612.8 3777.8 3823.8 3826.3 1203.9 1220.5 1245.1 1258.6 1266.9 12603.6 14038.9 16146.7 16277.3 16304.8 4254.9 4970.3 5021.8 5087.4 5234.8 11113.4 13081.5 13098.5 13118.8 13132.3 6148.0 6150.4 6151.5 6152.5 6154.0 4705.1 5277.5 5548.9 5557.2 5643.9 3834.8 4206.3 4245.7 4284.0 4328.8 1176.9 1178.6 1178.8 1192.7 1197.3 953.0 982.5 983.0 996.7 999.3 6712.2 6724.6 6855.3 6901.6 6985.4 838.8 1001.7 1003.6 1019.9 1035.9 3889.5 3985.6 4324.8 4398.8 4465.1 13594.5 13886.3 14024.0 14035.0 14035.4 12031.5 13620.9 13852.0 14012.0 14042.1 9945.8 10154.3 10328.7 10493.8 10496.7 6551.5 6888.4 7000.1 7040.3 7102.0 11910.5 11990.1 12582.7 12735.4 12742.6 12435.5 12500.1 12519.8 12631.6 12727.4 9456.1 9572.5 9638.0 9663.7 9677.9 10505.7 10700.1 10704.2 10717.6 10735.4 7515.5 9055.2 9126.2 9132.7 9139.3 7821.6 8573.2 8816.8 8818.9 8878.1 8018.9 8153.7 8154.1 8166.4 8173.6 5628.7 5660.4 5678.6 5835.0 5883.9 6054.2 6086.7 6136.9 6171.8 6360.7 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4463.91 Median:4900.69 stddev:1243.02 (25.4%) stddev-sans-first:1208.30 08:41:57 INFO - PROCESS | 1638 | Values: 389.6 392.7 395.4 397.5 403.3 5108.5 5113.5 5163.8 5218.9 5221.8 3977.0 4190.5 4485.8 4922.6 5111.7 3521.3 3560.0 4122.7 4217.5 4264.9 3561.5 3912.5 3990.2 4242.1 4291.4 3724.6 3917.8 4049.0 4240.3 4253.9 3399.8 3730.5 4250.7 4306.5 4311.4 3341.4 3495.4 3860.9 3939.5 3965.4 4986.7 5019.5 5033.4 5039.7 5048.8 4900.6 4900.8 4940.7 4942.9 4943.5 4658.0 4827.7 5090.6 5123.4 5406.9 3833.4 3962.3 4294.8 4377.6 4393.5 4902.7 5237.8 5434.9 5764.9 5792.8 3969.1 4039.2 4472.5 4474.6 4496.6 3905.1 4377.6 4547.3 4569.3 4585.2 3723.9 4315.1 4549.0 4857.4 4965.5 4627.6 5340.4 5379.5 5386.5 5462.3 1396.8 1440.3 1542.2 1559.2 1566.8 1005.6 1015.4 1169.9 1175.2 1185.4 4696.4 4771.7 4933.3 4946.5 5070.6 4550.9 5290.7 5352.7 5611.9 5656.7 4490.3 4587.8 4855.4 4994.9 5145.4 2506.8 2531.3 2926.5 2946.0 2949.4 5014.5 5214.7 5493.4 5857.3 5870.9 4876.5 5181.2 5197.6 5237.2 5680.7 4978.3 5255.6 5256.8 5385.7 5732.5 4833.8 5070.7 5180.5 5322.5 5615.9 4773.3 4988.2 5380.9 5472.9 5489.5 4987.2 5149.6 5578.3 5729.3 5849.8 4259.8 4403.2 4426.7 4453.3 4475.8 4695.4 5298.8 5461.2 5634.9 5675.6 4397.4 4831.5 5083.5 5084.6 5114.4 4486.4 4959.7 5451.0 5466.2 5505.7 4999.7 5301.0 5345.2 5384.4 5390.4 4862.5 5200.8 5496.5 5548.6 5555.3 4855.0 5050.6 5137.9 5355.2 5462.1 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:21396.50 Median:17775.64 stddev:30247.13 (170.2%) stddev-sans-first:30292.43 08:41:57 INFO - PROCESS | 1638 | Values: 797.4 812.2 847.8 883.3 898.0 16064.2 17144.7 17484.7 17776.7 17841.2 15966.8 16203.7 16426.6 16463.6 16465.5 967.9 987.1 987.9 990.2 990.5 997.9 1005.6 1030.0 1030.1 1030.6 1065.6 1070.1 1070.3 1071.2 1075.3 1061.4 1062.6 1063.7 1064.6 1065.6 791.4 791.8 792.2 793.2 793.5 17603.9 17751.9 17774.6 18150.1 18357.6 14557.0 14843.5 14942.0 14964.8 15331.4 11896.3 11910.0 12163.3 12282.6 12364.9 3748.0 3809.5 3824.7 3897.9 3907.2 110446.0 119360.8 120589.0 121019.0 122470.8 11210.6 11537.9 11570.9 11591.3 11693.7 24205.4 24444.4 24621.3 24631.0 24640.0 7268.2 7923.6 7983.7 8058.8 8464.0 4631.1 4702.6 4755.8 4853.9 4954.7 3412.0 3457.4 3494.4 3505.1 3509.5 567.4 575.4 603.7 621.3 624.8 575.7 697.7 722.3 747.9 757.4 8630.0 10327.8 10866.0 10998.8 11199.9 696.6 697.5 712.7 742.7 752.3 4288.9 4923.6 5221.5 5263.6 5285.2 88560.0 90765.0 97158.5 102918.5 108700.0 73060.9 89168.6 89290.6 90067.0 94197.0 81871.6 82635.0 83668.3 84137.2 85219.3 11324.5 11358.2 11446.5 11564.9 11625.6 51809.5 52040.7 52953.0 52991.0 54012.5 64658.7 65872.7 66655.0 67477.7 68344.3 13163.4 13318.0 13577.7 13662.3 13847.9 14912.3 15393.7 15840.0 15945.9 16505.4 14218.7 14661.8 14788.3 14790.5 15315.7 12746.3 14164.5 14660.1 14675.3 14758.7 14307.6 14507.1 14531.3 14533.0 14985.2 10028.3 10152.9 10527.0 10586.2 10671.7 10162.0 11560.0 11776.2 11805.1 11823.2 08:41:57 INFO - PROCESS | 1638 | -------- Summary: end -------- 08:41:57 INFO - PROCESS | 1638 | 08:41:57 INFO - TEST-INFO | 1638: exit 0 08:41:57 INFO - TEST-OK | dromaeo_css | took 1118212ms 08:41:57 INFO - TEST-START | kraken 08:41:57 INFO - operating with platform_type : mac_ 08:41:57 INFO - Initialising browser for kraken test... 08:41:57 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp5NS5WU/profile http://localhost:49236/getInfo.html) 08:42:00 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 08:42:00 INFO - PROCESS | 1648 | colorDepth:24 08:42:00 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 08:42:00 INFO - PROCESS | 1648 | __metrics 08:42:00 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:42:00 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:01 INFO - TEST-INFO | 1648: exit 0 08:42:01 INFO - Browser initialized. 08:42:01 INFO - Running cycle 1/1 for kraken test... 08:42:01 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp5NS5WU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:13 INFO - PROCESS | 1650 | RSS: Main: 169406464 08:42:13 INFO - PROCESS | 1650 | 08:42:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:16 INFO - PROCESS | 1650 | RSS: Main: 219471872 08:42:16 INFO - PROCESS | 1650 | 08:42:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:42:19 INFO - PROCESS | 1650 | RSS: Main: 229396480 08:42:19 INFO - PROCESS | 1650 | 08:42:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:42:23 INFO - PROCESS | 1650 | RSS: Main: 325984256 08:42:23 INFO - PROCESS | 1650 | 08:42:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:42:26 INFO - PROCESS | 1650 | RSS: Main: 230621184 08:42:26 INFO - PROCESS | 1650 | 08:42:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:29 INFO - PROCESS | 1650 | RSS: Main: 232329216 08:42:29 INFO - PROCESS | 1650 | 08:42:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:32 INFO - PROCESS | 1650 | RSS: Main: 272740352 08:42:32 INFO - PROCESS | 1650 | 08:42:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:36 INFO - PROCESS | 1650 | RSS: Main: 273760256 08:42:36 INFO - PROCESS | 1650 | 08:42:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:42:39 INFO - PROCESS | 1650 | RSS: Main: 270884864 08:42:39 INFO - PROCESS | 1650 | 08:42:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:41 INFO - PROCESS | 1650 | RSS: Main: 248881152 08:42:41 INFO - PROCESS | 1650 | 08:42:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:44 INFO - PROCESS | 1650 | RSS: Main: 253980672 08:42:44 INFO - PROCESS | 1650 | 08:42:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:47 INFO - PROCESS | 1650 | RSS: Main: 255578112 08:42:47 INFO - PROCESS | 1650 | 08:42:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:50 INFO - PROCESS | 1650 | RSS: Main: 270708736 08:42:50 INFO - PROCESS | 1650 | 08:42:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:54 INFO - PROCESS | 1650 | RSS: Main: 264699904 08:42:54 INFO - PROCESS | 1650 | 08:42:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:42:56 INFO - PROCESS | 1650 | RSS: Main: 309628928 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | __start_tp_report 08:42:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:42:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:42:56 INFO - PROCESS | 1650 | |i|pagename|runs| 08:42:56 INFO - PROCESS | 1650 | |0;ai-astar;118;118;119;117;117;118;115;118;118;117 08:42:56 INFO - PROCESS | 1650 | |1;audio-beat-detection;136;106;106;141;110;107;106;150;124;109 08:42:56 INFO - PROCESS | 1650 | |2;audio-dft;183;184;183;192;253;222;184;182;184;186 08:42:56 INFO - PROCESS | 1650 | |3;audio-fft;82;59;59;92;62;60;59;64;93;81 08:42:56 INFO - PROCESS | 1650 | |4;audio-oscillator;88;68;86;72;70;68;81;69;67;82 08:42:56 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;86;85;86;86;86;86;86;86;86;85 08:42:56 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;93;93;93;93;93;93;93;93;93 08:42:56 INFO - PROCESS | 1650 | |7;imaging-desaturate;85;84;82;84;83;83;83;85;85;82 08:42:56 INFO - PROCESS | 1650 | |8;json-parse-financial;63;60;59;58;62;61;61;62;62;62 08:42:56 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;57;57;68;66;62;58;58;59;58;60 08:42:56 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;82;81;81;81;83;99;97;98;80;81 08:42:56 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;137;132;140;137;139;136;138;139;181;136 08:42:56 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;164;163;161;162;161;159;161;162;160;161 08:42:56 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;64;63;64;64;64;64;63;63;63;72 08:42:56 INFO - PROCESS | 1650 | __end_tp_report 08:42:56 INFO - PROCESS | 1650 | __start_cc_report 08:42:56 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2077 08:42:56 INFO - PROCESS | 1650 | __end_cc_report 08:42:56 INFO - PROCESS | 1650 | __startTimestamp1493394176133__endTimestamp 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:42:56 INFO - PROCESS | 1650 | Number of tests: 14 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:117.50 Median:118.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 08:42:56 INFO - PROCESS | 1650 | Values: 118.0 118.0 119.0 117.0 117.0 118.0 115.0 118.0 118.0 117.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:117.00 stddev:16.96 (14.5%) stddev-sans-first:16.90 08:42:56 INFO - PROCESS | 1650 | Values: 136.0 106.0 106.0 141.0 110.0 107.0 106.0 150.0 124.0 109.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:195.30 Median:185.00 stddev:23.58 (12.7%) stddev-sans-first:24.58 08:42:56 INFO - PROCESS | 1650 | Values: 183.0 184.0 183.0 192.0 253.0 222.0 184.0 182.0 184.0 186.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:71.10 Median:72.50 stddev:14.26 (19.7%) stddev-sans-first:14.56 08:42:56 INFO - PROCESS | 1650 | Values: 82.0 59.0 59.0 92.0 62.0 60.0 59.0 64.0 93.0 81.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.50 stddev:8.21 (10.7%) stddev-sans-first:7.26 08:42:56 INFO - PROCESS | 1650 | Values: 88.0 68.0 86.0 72.0 70.0 68.0 81.0 69.0 67.0 82.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 08:42:56 INFO - PROCESS | 1650 | Values: 86.0 85.0 86.0 86.0 86.0 86.0 86.0 86.0 86.0 85.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:42:56 INFO - PROCESS | 1650 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:1.17 (1.4%) stddev-sans-first:1.13 08:42:56 INFO - PROCESS | 1650 | Values: 85.0 84.0 82.0 84.0 83.0 83.0 83.0 85.0 85.0 82.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:62.00 stddev:1.56 (2.5%) stddev-sans-first:1.48 08:42:56 INFO - PROCESS | 1650 | Values: 63.0 60.0 59.0 58.0 62.0 61.0 61.0 62.0 62.0 62.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:59.50 stddev:3.86 (6.5%) stddev-sans-first:3.91 08:42:56 INFO - PROCESS | 1650 | Values: 57.0 57.0 68.0 66.0 62.0 58.0 58.0 59.0 58.0 60.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:82.50 stddev:8.12 (9.8%) stddev-sans-first:8.47 08:42:56 INFO - PROCESS | 1650 | Values: 82.0 81.0 81.0 81.0 83.0 99.0 97.0 98.0 80.0 81.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:138.50 stddev:14.06 (10.1%) stddev-sans-first:14.82 08:42:56 INFO - PROCESS | 1650 | Values: 137.0 132.0 140.0 137.0 139.0 136.0 138.0 139.0 181.0 136.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.17 08:42:56 INFO - PROCESS | 1650 | Values: 164.0 163.0 161.0 162.0 161.0 159.0 161.0 162.0 160.0 161.0 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:2.72 (4.2%) stddev-sans-first:2.88 08:42:56 INFO - PROCESS | 1650 | Values: 64.0 63.0 64.0 64.0 64.0 64.0 63.0 63.0 63.0 72.0 08:42:56 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:42:56 INFO - PROCESS | 1650 | 08:42:56 INFO - TEST-INFO | 1650: exit 0 08:42:57 INFO - TEST-OK | kraken | took 59228ms 08:42:57 INFO - SUITE-END | took 1177s 08:42:57 INFO - Completed test suite (00:19:37) 08:42:57 INFO - javascript benchmark 08:42:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7909.19767842428, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.2817408344245, 3553.093961039935, 3558.2527669189467, 3582.6417358264175, 3635.83638736257, 6159.137720719103, 6167.136600875875, 6177.073438984155, 6180.876382472348, 6225.066240063987, 6198.132261483396, 6206.0, 6252.812415627538, 6253.781117660883, 6270.937290627093, 5495.0, 5514.558835293187, 5525.0, 5526.115821468556, 5632.35227948785, 5377.516023557879, 5428.294321738169, 5452.754626041838, 5488.286522752037, 5606.074997625387, 5516.586256030793, 5521.0, 5521.475459831309, 5522.641028333165, 5524.475174858382, 5491.36849262332, 5494.752736126864, 5495.230667706524, 5500.0, 5503.532199763025, 4487.955120448786, 5371.570274378079, 5455.990641731292, 5456.317960254968, 5462.9726851365485, 6146.170267013986, 6146.938530614681, 6149.985252433343, 6160.921838678213, 6171.9691401542705, 6311.652859092748, 6332.1135041094285, 6370.458511026568, 6378.170837791057, 6380.585261957958, 5465.207544906006, 6543.705533251015, 6547.770828021044, 6555.278919318871, 6560.212774467047, 6228.657423841732, 6257.812265631993, 6266.342034086447, 6285.088662144055, 6295.433410992987, 6388.680565971683, 6419.197600299963, 6430.549861509649, 6579.47364210862, 6600.537962342686, 5252.369715634149, 6393.424591786761, 6394.200724909387, 6404.327545607737, 6404.807855764335, 6448.065030570635, 6496.870062598816, 6506.251781045145, 6514.967425162844, 6519.674016299166, 6233.189685340967, 6367.522435817332, 6370.808875733643, 6423.42189202974, 6484.897567413456, 6364.77723279683, 6365.809025729143, 6407.0, 6419.16550848396, 6420.422162005442, 4033.4151548025957, 5242.816501422432, 5246.449122842047, 5264.684118952875, 5290.603204759658, 4534.546545345439, 4600.861974140781, 4605.516420775837, 4667.533246675305, 4679.672422930362, 6150.907736383958, 6171.444569988723, 6197.380261973766, 6247.844148832481, 6251.6561589112125, 6535.640539770358, 6544.803655890331, 6552.803415897531, 6554.901676474857, 6555.573887697285, 6319.968400158062, 6328.11406403104, 6334.113224148623, 6337.524685648595, 6354.904676429857, 5529.447055294519, 5586.217929489874, 5635.6618602883955, 5673.489385955284, 5736.6844823534275, 6745.224299205556, 6793.490488213404, 6806.353396427331, 6806.523543351917, 6831.316868313328, 6071.605345652519, 6527.804165875032, 6539.019147127969, 6540.444062254572, 6558.508111891722, 6446.226452825691, 6474.255460622088, 6693.062971183941, 6809.455243580601, 6818.488613354118, 6339.5562310637815, 6362.141110949962, 6418.0693799397895, 6430.935690643034, 6432.388923052303, 6522.902156467751, 6524.967375163284, 6527.902081468686, 6532.706028228836, 6539.084528165966, 6274.152989346562, 6281.309056003744, 6295.3389894060465, 6352.841178970562, 6376.3623637635865, 6128.3503509891225, 6250.156228909039, 6339.683015849097, 6396.26442959047, 6403.199600049994, 6394.328595497405, 6409.166808314889, 6427.389398007182, 6428.325025872403, 6447.0, 6296.716647750954, 6305.684715764285, 6361.173047503795, 6363.140975968185, 6379.362063793769, 6319.46284565817, 6377.043443483514, 6395.42441180296, 6403.9359606405205, 6407.839804004937], "value": 5992.895280338448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.3397153803503, 831.5883637599387, 842.3050982939077, 905.5879574793465, 924.0205382294764, 29092.0, 41443.58556414435, 41802.58197418025, 41886.58113418865, 42028.579714202846, 34111.488327675106, 41665.37501937466, 41780.79109604455, 41830.790846045726, 41873.162536749245, 9715.417074975507, 9876.259280553952, 9888.752781180456, 9901.603935842557, 9908.405495670248, 7843.137254901956, 7994.760157195294, 11703.5903743369, 11736.237144585617, 11881.405929703524, 10043.196544276478, 11974.521019159223, 11988.0, 12000.879991200107, 12009.399530023464, 11882.465289062013, 11915.404229788475, 11959.0, 11969.162158648855, 11995.880041199563, 11603.4198290086, 11659.417029148508, 11668.299902005907, 11672.066234701204, 11674.182807203499, 40490.0, 40726.38910416346, 40887.7955610223, 40951.7952410239, 40992.59007409918, 4124.13393187431, 4141.358089496133, 4150.3566947123245, 4160.812763425653, 4166.395872598457, 29018.854905725337, 29545.704542954725, 30854.84572577123, 31057.0, 31084.533731994037, 3247.9188020299443, 3270.721988630969, 3279.114639047468, 3313.1054615253747, 3420.3159368126476, 361424.38575614436, 361963.0, 363154.0, 363785.0, 363903.0, 53580.73209633927, 53592.0, 53594.660133496975, 53686.92626147455, 53784.73107634437, 54221.0, 54293.0, 54499.72750136224, 55595.722021389636, 55623.0, 15540.766888496682, 15635.843641563439, 15649.530514084368, 15655.217239137997, 15657.921710391374, 11845.526178952745, 11979.401029948467, 13273.336333183495, 13283.136596121221, 13290.269035203157, 10511.84232236517, 11935.224210426468, 12112.515499380102, 12142.210756300989, 12271.325077120844, 5758.712064396847, 5775.5668324875805, 5792.971035144881, 5811.82564523065, 5834.795782147605, 903.7740564858653, 908.927285817133, 913.2374467319729, 949.4066208619613, 962.2109869906609, 27846.721532784817, 28216.0, 28627.713722862503, 29069.0, 29622.0, 1124.606387764276, 1128.1426116151783, 1128.729105014807, 1164.0687450039934, 1166.731651720109, 10254.436006019741, 11596.88403115958, 13964.294934170033, 14023.78964315536, 14077.436902523988, 393456.0, 396449.0, 398019.0, 398118.00940995687, 398391.0, 47511.76244118757, 47546.762266188445, 47606.80982975384, 47683.807904802656, 47689.5231047692, 1278.9680257993625, 1487.21177775779, 1495.2224843081538, 1506.1791323728594, 1532.8467153284582, 26974.055908043123, 27142.72857271402, 27674.723252767213, 27975.580366294114, 28069.57895631608, 41284.1743165129, 62587.0, 63346.68326658337, 63471.36528634655, 63691.0446343296, 503777.0, 508738.0, 509009.0, 509581.0, 509718.9028109671, 37477.6252237485, 37653.2469350606, 38067.80966095152, 38347.42478862875, 39175.82472525829, 48195.0, 48351.0, 49156.75421622869, 49168.26247606217, 49440.752796235785, 31031.913883014888, 31585.368292634477, 32324.67675323217, 33228.1692957678, 33319.333613327115, 32755.836220818743, 32798.0, 32825.01524954255, 32995.505067423524, 33825.154371139935, 40358.39462408125, 40392.596074038884, 40494.392584111854, 42746.0, 44291.33562996493, 41107.383389249786, 41394.793026035884, 41895.0, 42431.575684243995, 42921.926951826455, 31963.0, 32763.508547371333, 32767.0, 32843.02941823403, 33659.99020029403], "value": 19862.0387800367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.0, 432.0341769893583, 437.9058502421979, 439.9384086227927, 456.5845877778886, 20031.298904538344, 20514.794852051476, 21837.798921059337, 22060.669089963623, 22066.779332206694, 22111.557768844614, 22852.65721014186, 22905.770942290572, 22909.541809163806, 23175.536489270205, 6640.169978752656, 7035.0, 7036.085308909835, 7043.859122817541, 7409.296116868889, 7729.72945946892, 7836.451448398614, 7861.646225919819, 7863.921360786405, 7876.291133797957, 7595.810104747398, 7755.922440775576, 7823.3350165236025, 7823.921760782405, 7842.568658723768, 7550.093988721361, 7693.269139431801, 7763.378929685611, 7813.648385822623, 7872.173421790715, 7431.888521672179, 7444.478886477948, 7530.58581778002, 7532.623368831537, 7543.471956963015, 20865.68701469479, 25892.87053564739, 25969.610455843176, 26332.21003369902, 26667.866660666765, 3049.1005153479555, 3053.4503789317914, 3105.2081719161697, 3216.276337823971, 3260.005698262029, 15831.0, 16031.038137711774, 16133.91933040339, 16582.75125873113, 17049.977001379833, 2080.906359213839, 2160.7191065161587, 2180.0516775202677, 2190.507135894411, 2208.6355751301016, 145691.27154364265, 159497.60753588704, 170849.0, 173946.0, 177006.0, 16430.917845410695, 19040.667153299135, 19405.4178374649, 20009.09959051846, 20047.69928451045, 25736.74263257381, 32070.679293207235, 32111.35777284441, 32155.678443215736, 32175.51736723904, 10252.692419227435, 10292.588296468208, 10486.0, 10505.31715438494, 10608.628697995533, 8762.255208307366, 8771.0, 8798.208161265517, 8918.0, 8943.776405589782, 7340.853182936311, 8972.237359824358, 9156.496392698333, 9196.988331283554, 9241.537923103819, 3398.745094117951, 3933.940990885139, 3984.4820173377275, 3989.7007724420782, 4030.6775457963295, 1066.594694016269, 1069.4652673663168, 1085.9619913302997, 1093.8632670916136, 1136.6646839182295, 20299.695504567444, 20579.58840823175, 20763.79236207649, 20809.37571872846, 20811.68782468264, 1081.5403453532217, 1098.4397957041965, 1109.6393672056613, 1110.5280255891214, 1118.9440527973568, 10302.33034852732, 11037.392943388191, 11096.5561377544, 11131.276467029616, 11144.554217831359, 629331.0, 638765.0, 771931.0, 791896.0, 812605.0, 148856.32433891762, 161339.70622056344, 162059.5691064635, 168176.15911920363, 172336.0, 1255.1904021906003, 1297.7145028093805, 1350.034725171507, 1350.9459621615222, 1355.0717758335572, 15804.73562115005, 18209.81790182134, 19044.904775476032, 19163.945982971072, 19717.70423443678, 62390.0, 62832.74334513193, 63383.0, 64787.0, 64947.0, 49920.0, 74523.0, 78946.0, 81104.59447702723, 91149.0, 10725.356478611307, 11348.262362946381, 11427.371494567878, 11597.188196826479, 11693.766124677288, 12096.153269271066, 12198.57304994321, 12425.813612795635, 12512.43694033789, 12601.306928119042, 8801.251893589117, 10472.371657700562, 10828.675139745821, 10930.508127134457, 11000.339979601249, 10072.546735396778, 10180.862018976099, 10394.636187733393, 10463.581456741646, 10475.371477711362, 10967.725806854893, 11154.330740155616, 11167.441627918734, 11258.831117533407, 11269.985701286923, 9593.568289427132, 10882.61910833117, 10949.397783122005, 11423.543058277575, 11463.598774042868, 10736.946315268373, 10754.085902698358, 10857.891421086004, 10863.456827158452, 11120.221584489009], "value": 11751.865377591881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.0853944935784, 1623.4642567952576, 1642.8110767261765, 1653.9586510337247, 1655.7847479827624, 9510.239180865532, 9917.603295868166, 11233.999999999989, 11477.081833453325, 11740.471678774455, 11350.0, 11434.371109588968, 11440.427978601077, 11450.656480305583, 11509.827352589718, 2007.4780557055162, 2487.0549191307277, 2487.61441976493, 2490.066225165563, 2494.2641920633364, 2106.936791896238, 2168.728908886389, 2431.659567660529, 2493.551160791057, 2513.3842208658903, 2466.4203912080648, 2468.049800826686, 2493.563626365388, 2497.1759319424546, 2499.600063989753, 2475.8638274894874, 2480.7643273888953, 2484.0, 2484.428581426273, 2485.2047344849657, 2412.1316326122583, 2449.1795248591743, 2449.363165576945, 2457.2505385857307, 2458.323960910746, 11417.828732569018, 11489.540418383254, 11658.6502404928, 11673.70815729605, 11696.707582310426, 6016.067509536029, 6180.721867515973, 6187.443130118266, 6193.969030154865, 6205.596636218631, 3554.4200206549945, 3612.7832330060282, 3777.773333599993, 3823.751456155341, 3826.349520581508, 1203.9398030098548, 1220.4934951994912, 1245.0848626259692, 1258.5657948008013, 1266.9049821263443, 12603.621891343275, 14038.859611403857, 16146.677066458606, 16277.348906043744, 16304.83695163045, 4254.851080212177, 4970.2793095001025, 5021.849344519597, 5087.440381558025, 5234.816781412632, 11113.444327783578, 13081.542146024844, 13098.476060957646, 13118.803217951738, 13132.277724725232, 6148.047052706837, 6150.3849615039035, 6151.477124444473, 6152.477039451607, 6153.96923015391, 4705.082508910798, 5277.498637629419, 5548.944510554924, 5557.166425036277, 5643.858903527444, 3834.8082595870096, 4206.348016057516, 4245.724027938236, 4283.957160428356, 4328.848490302824, 1176.8940795328463, 1178.5757127434117, 1178.7642471505733, 1192.6958625550428, 1197.3055627735891, 953.046953046953, 982.5283863745442, 982.9901700983041, 996.7009897030862, 999.3104757717152, 6712.228093769181, 6724.562903411263, 6855.314468553204, 6901.551399159039, 6985.371316581431, 838.8112674648155, 1001.7395477175987, 1003.6136087606178, 1019.8980101989741, 1035.891231420705, 3889.4943657324366, 3985.5815139409942, 4324.8486302979245, 4398.758068306274, 4465.129299786576, 13594.524191653443, 13886.305684715724, 14024.0, 14035.0, 14035.368408421646, 12031.458584363725, 13620.93189534046, 13852.0, 14012.0, 14042.087264327785, 9945.80108397828, 10154.289199756095, 10328.690139295682, 10493.842592361121, 10496.73758156037, 6551.508636852351, 6888.380045795902, 7000.089988301488, 7040.260772619006, 7101.964490177516, 11910.464029118537, 11990.100742444178, 12582.748345033231, 12735.363231838557, 12742.61772146837, 12435.502579896704, 12500.124991250525, 12519.812202816784, 12631.621051368473, 12727.427265773247, 9456.101670341306, 9572.521373931137, 9637.951810241184, 9663.661771837951, 9677.903220967983, 10505.737356566147, 10700.090492308242, 10704.197185210984, 10717.624883129052, 10735.355878647306, 7515.549067055994, 9055.230305424113, 9126.224270937044, 9132.680356187502, 9139.268858491438, 7821.648025838965, 8573.22840944318, 8816.779580510281, 8818.941726992802, 8878.067802880605, 8018.879716804136, 8153.714619988272, 8154.1030486647605, 8166.387520935835, 8173.591320434073, 5628.718564071862, 5660.433956604306, 5678.6308889923675, 5834.970825145847, 5883.882322353615, 6054.212952316171, 6086.69566521681, 6136.938630613815, 6171.783987560593, 6360.745570177141], "value": 5286.338977108268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.5500696695317, 392.6544640716169, 395.4226828829912, 397.48922634414765, 403.33651143868354, 5108.489151084889, 5113.463086375933, 5163.793448262065, 5218.8695282617955, 5221.817236396727, 3976.9801150994276, 4190.548529110466, 4485.798139083741, 4922.630802689795, 5111.69329840209, 3521.3097713097727, 3559.964400356002, 4122.690798190133, 4217.45173127493, 4264.8507302244425, 3561.465780132975, 3912.4913761211, 3990.221906728189, 4242.087951090515, 4291.356296555526, 3724.608916063815, 3917.764934103963, 4048.9797551012352, 4240.321548552232, 4253.893652658678, 3399.847006884696, 3730.5150330457136, 4250.681198910063, 4306.523748844412, 4311.396404503372, 3341.446227504198, 3495.353359628477, 3860.8841734748003, 3939.4878665773554, 3965.365541513344, 4986.706115187018, 5019.52314530119, 5033.446320904697, 5039.72281524516, 5048.823291184791, 4900.632452566072, 4900.754962251873, 4940.7035577865445, 4942.87642808929, 4943.530364615356, 4658.021815418766, 4827.710337379768, 5090.567301779316, 5123.38519377677, 5406.945930540684, 3833.3708174026206, 3962.346212874901, 4294.840393093878, 4377.627901628365, 4393.53867843875, 4902.730349830722, 5237.800123947951, 5434.918476222821, 5764.855878603068, 5792.82621521355, 3969.134506781808, 4039.171969746195, 4472.485664148599, 4474.6420286377015, 4496.6177874881005, 3905.082305658168, 4377.649788016951, 4547.272436410159, 4569.337446070301, 4585.243434833215, 3723.8696645617815, 4315.115401342718, 4548.95451045492, 4857.417109946829, 4965.542056681893, 4627.5603817637275, 5340.383212225981, 5379.462053794589, 5386.48828361305, 5462.344518657707, 1396.7834985577251, 1440.3302464353917, 1542.1749364090158, 1559.2048055491555, 1566.8248813389957, 1005.6178652112151, 1015.4313584392763, 1169.906407487399, 1175.189119507537, 1185.4191446191305, 4696.412948381452, 4771.71369717818, 4933.309336692866, 4946.5407704727195, 5070.554891855803, 4550.931736023962, 5290.73022474611, 5352.693573272455, 5611.887762244733, 5656.660600363992, 4490.316131450706, 4587.816487340469, 4855.4173499179615, 4994.925076123861, 5145.382554093458, 2506.7618576235227, 2531.278585603094, 2926.473234817753, 2945.985270073636, 2949.380630067667, 5014.548690617789, 5214.661047031931, 5493.395726470085, 5857.297124345106, 5870.911936320958, 4876.4879687633, 5181.222816577468, 5197.610179236573, 5237.16205407133, 5680.68756218412, 4978.32792572998, 5255.553277971415, 5256.764660304825, 5385.73071346439, 5732.541396688255, 4833.758312084452, 5070.721110338819, 5180.507851754077, 5322.513753491469, 5615.859603509945, 4773.2577609173095, 4988.201887697951, 5380.946190538201, 5472.890542189213, 5489.505944465017, 4987.182242033239, 5149.588032957429, 5578.2748242728185, 5729.341125770589, 5849.824505264849, 4259.808308626181, 4403.2132366165715, 4426.716252286801, 4453.265211240109, 4475.776211189493, 4695.389599352199, 5298.840410277913, 5461.1808228766, 5634.915476267941, 5675.602707810413, 4397.36238245459, 4831.541003604652, 5083.517065878736, 5084.559411482583, 5114.414531495248, 4486.353051699513, 4959.652824302264, 5450.957863975727, 5466.234727138124, 5505.724713764215, 4999.675021123615, 5301.019311427398, 5345.22494238341, 5384.353877534721, 5390.380106287827, 4862.513748625109, 5200.791968321225, 5496.5053145217125, 5548.583856210719, 5555.250041244381, 4854.95145048545, 5050.646454748279, 5137.91724965033, 5355.22349259363, 5462.126059830408], "value": 4109.301764260393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.3780451248025, 812.1756417236506, 847.8134810341722, 883.2801266967421, 897.9551022448878, 16064.196790160504, 17144.657106857856, 17484.65030699385, 17776.733348999776, 17841.197146128423, 15966.7604985925, 16203.675926481463, 16426.589335266624, 16463.588410289747, 16465.506034818944, 967.8596603492507, 987.1411871671655, 987.9160271376942, 990.173205373514, 990.4552496127137, 997.9201663866874, 1005.6027868991744, 1029.963951261706, 1030.1346868630349, 1030.6392762533128, 1065.6217042949756, 1070.0690399352536, 1070.2775626452153, 1071.212658695858, 1075.2849355178796, 1061.3790932304573, 1062.5749700119936, 1063.6649455421518, 1064.6167379743247, 1065.6217042949718, 791.3985371117934, 791.7664289034691, 792.211749309435, 793.2147174297462, 793.4564823096198, 17603.911980440145, 17751.934883907008, 17774.55563610907, 18150.09249537518, 18357.63284734298, 14557.0, 14843.480478183212, 14942.0, 14964.775528367083, 15331.386744530206, 11896.345700986441, 11910.0, 12163.270203787713, 12282.631521054383, 12364.876351236462, 3748.0, 3809.5428548574073, 3824.7131465140224, 3897.902552436183, 3907.199024200032, 110446.0, 119360.80639193584, 120589.0, 121019.0, 122470.77529224772, 11210.607628732956, 11537.88462115368, 11570.88429115698, 11591.304521728554, 11693.707657308636, 24205.39486512816, 24444.388890277885, 24621.261362159163, 24631.0, 24640.0, 7268.164161121433, 7923.643436045391, 7983.720569780146, 8058.758237252891, 8464.0, 4631.143238500888, 4702.6473014524045, 4755.824294849176, 4853.927191092136, 4954.677945933503, 3412.0446275043028, 3457.377672019061, 3494.405950988338, 3505.088676943962, 3509.508668786372, 567.3503838105429, 575.3872126185599, 603.6709993053796, 621.273110460762, 624.8375422390211, 575.7322844877068, 697.7484920271511, 722.3462766196601, 747.872861613527, 757.3865169212955, 8630.0, 10327.76346411643, 10866.0, 10998.780024399468, 11199.888001119885, 696.6168607266085, 697.4594689115976, 712.7113519024804, 742.6769355330448, 752.3304259209308, 4288.914221715549, 4923.556879880828, 5221.537969368583, 5263.5525980292105, 5285.180796976475, 88560.0, 90765.0, 97158.51420742992, 102918.48540757249, 108700.0, 73060.90408643875, 89168.5541572288, 89290.55354723184, 90067.0, 94197.0, 81871.59064204879, 82635.0, 83668.32053690395, 84137.15862841293, 85219.29561408737, 11324.547018119183, 11358.204925655125, 11446.542138314708, 11564.884351156381, 11625.59310424131, 51809.481905180466, 52040.739796300775, 52953.0, 52991.0, 54012.45987540232, 64658.67670661616, 65872.67063664651, 66655.0, 67477.66261168662, 68344.3165568338, 13163.407646656115, 13318.0, 13577.660558485723, 13662.316884155554, 13847.930760346133, 14912.328945197276, 15393.69212615719, 15840.0, 15945.920270398574, 16505.422310219084, 14218.715625687222, 14661.780073298696, 14788.260586970824, 14790.48233311872, 15315.693686125993, 12746.298953557643, 14164.504242351468, 14660.120392776467, 14675.266236688336, 14758.704825903207, 14307.64230894236, 14507.1295722257, 14531.27343632793, 14533.0, 14985.175815330262, 10028.29801913859, 10152.898471015491, 10527.0, 10586.206034547286, 10671.679849604525, 10162.0, 11559.959603635712, 11776.234544754563, 11805.055595552163, 11823.231489953125], "value": 8054.909073666239, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1415.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 117.0, 117.0, 118.0, 115.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 106.0, 106.0, 141.0, 110.0, 107.0, 106.0, 150.0, 124.0, 109.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 192.0, 253.0, 222.0, 184.0, 182.0, 184.0, 186.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 92.0, 62.0, 60.0, 59.0, 64.0, 93.0, 81.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 86.0, 72.0, 70.0, 68.0, 81.0, 69.0, 67.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 82.0, 84.0, 83.0, 83.0, 83.0, 85.0, 85.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 59.0, 58.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 68.0, 66.0, 62.0, 58.0, 58.0, 59.0, 58.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 81.0, 83.0, 99.0, 97.0, 98.0, 80.0, 81.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 140.0, 137.0, 139.0, 136.0, 138.0, 139.0, 181.0, 136.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 162.0, 161.0, 159.0, 161.0, 162.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 72.0], "value": 64.4, "unit": "score"}]}]} 08:42:57 INFO - Return code: 0 08:42:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:42:57 INFO - # TBPL SUCCESS # 08:42:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:42:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:42:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:42:57 INFO - 2017-04-28 08:42:57.473 screenresolution[1654:9708] starting screenresolution argv=screenresolution get 08:42:57 INFO - 2017-04-28 08:42:57.475 screenresolution[1654:9708] Display 0: 1600x1200x32@60 08:42:57 INFO - 2017-04-28 08:42:57.481 screenresolution[1655:9711] starting screenresolution argv=screenresolution list 08:42:57 INFO - Available Modes on Display 0 08:42:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:42:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:42:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:42:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:42:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:42:57 INFO - Intel Iris: 08:42:57 INFO - Chipset Model: Intel Iris 08:42:57 INFO - Type: GPU 08:42:57 INFO - Bus: Built-In 08:42:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:42:57 INFO - Vendor: Intel (0x8086) 08:42:57 INFO - Device ID: 0x0a2e 08:42:57 INFO - Revision ID: 0x0009 08:42:57 INFO - Displays: 08:42:57 INFO - Display: 08:42:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:42:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:42:57 INFO - Display Serial Number: 1600x1200 60 08:42:57 INFO - Main Display: Yes 08:42:57 INFO - Mirror: Off 08:42:57 INFO - Online: Yes 08:42:57 INFO - Rotation: Supported 08:42:57 INFO - Return code: 0 08:42:57 INFO - Running post-action listener: _resource_record_post_action 08:42:57 INFO - [mozharness: 2017-04-28 15:42:57.717923Z] Finished run-tests step (success) 08:42:57 INFO - Running post-run listener: _resource_record_post_run 08:42:57 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38315008; Write bytes: 422237184; Read time: 377; Write time: 1463 08:42:57 INFO - TinderboxPrint: CPU usage
53.8% 08:42:57 INFO - TinderboxPrint: I/O read bytes / time
38,315,008 / 377 08:42:57 INFO - TinderboxPrint: I/O write bytes / time
422,237,184 / 1,463 08:42:57 INFO - TinderboxPrint: CPU idle
2,204.6 (46.2%) 08:42:57 INFO - TinderboxPrint: CPU system
952.1 (19.9%) 08:42:57 INFO - TinderboxPrint: CPU user
1,617.0 (33.9%) 08:42:57 INFO - TinderboxPrint: Swap in / out
160,088,064 / 0 08:42:57 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 110746112; Write bytes: 105010688; Read time: 9892; Write time: 265 08:42:57 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37344256; Write bytes: 297438720; Read time: 361; Write time: 1146 08:42:58 INFO - Running post-run listener: _upload_blobber_files 08:42:58 INFO - Blob upload gear active. 08:42:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:59 INFO - (blobuploader) - INFO - Done attempting. 08:42:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:42:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:00 INFO - (blobuploader) - INFO - Done attempting. 08:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:43:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:01 INFO - (blobuploader) - INFO - Done attempting. 08:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:04 INFO - (blobuploader) - INFO - Done attempting. 08:43:04 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:04 INFO - Return code: 0 08:43:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30a1e17012df0a48191b7bf1c1856dc28849d950d651320cbdb7ef4f7de4a4e35b34279413445c8741c4314085ef14c618953665df039c2c543ac30e0c15d68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d349347e667625592665ccebbd6adc8cfee0210c4c85612d83cda71ed2aba8c3e8a49fc9352590240b11dd15a29bbe5020a5760afa7799fe05a2c773a4b592ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239ed4a261c01a9a8768dc49ce1395195cb5d08957705693131000a10270ddd5387b2ea68a975f9e1099c96c5c973e9c3be1e555f687afa82ba57fbe8e754bfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e2b8f8666d04128825db6f4b13174e47910c2b171a2d3904b9e85c1b281e3b6d212f7457bb81931b419bf9e1d27cfd85f8ae0ba36163706f4cd2f89f562dd6d"} 08:43:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:04 INFO - Contents: 08:43:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30a1e17012df0a48191b7bf1c1856dc28849d950d651320cbdb7ef4f7de4a4e35b34279413445c8741c4314085ef14c618953665df039c2c543ac30e0c15d68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d349347e667625592665ccebbd6adc8cfee0210c4c85612d83cda71ed2aba8c3e8a49fc9352590240b11dd15a29bbe5020a5760afa7799fe05a2c773a4b592ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239ed4a261c01a9a8768dc49ce1395195cb5d08957705693131000a10270ddd5387b2ea68a975f9e1099c96c5c973e9c3be1e555f687afa82ba57fbe8e754bfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e2b8f8666d04128825db6f4b13174e47910c2b171a2d3904b9e85c1b281e3b6d212f7457bb81931b419bf9e1d27cfd85f8ae0ba36163706f4cd2f89f562dd6d"} 08:43:04 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:04 INFO - Copying logs to upload dir... 08:43:04 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.045021 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-28 08:43:04.124914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 08:43:04.128419) ========= 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.M1qptOynwu/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.MM2QgJgHch/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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/30a1e17012df0a48191b7bf1c1856dc28849d950d651320cbdb7ef4f7de4a4e35b34279413445c8741c4314085ef14c618953665df039c2c543ac30e0c15d68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d349347e667625592665ccebbd6adc8cfee0210c4c85612d83cda71ed2aba8c3e8a49fc9352590240b11dd15a29bbe5020a5760afa7799fe05a2c773a4b592ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239ed4a261c01a9a8768dc49ce1395195cb5d08957705693131000a10270ddd5387b2ea68a975f9e1099c96c5c973e9c3be1e555f687afa82ba57fbe8e754bfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e2b8f8666d04128825db6f4b13174e47910c2b171a2d3904b9e85c1b281e3b6d212f7457bb81931b419bf9e1d27cfd85f8ae0ba36163706f4cd2f89f562dd6d"} build_url:https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010983 build_url: 'https://queue.taskcluster.net/v1/task/HBEzxeEQQailfwwCsWoiTg/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/30a1e17012df0a48191b7bf1c1856dc28849d950d651320cbdb7ef4f7de4a4e35b34279413445c8741c4314085ef14c618953665df039c2c543ac30e0c15d68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d349347e667625592665ccebbd6adc8cfee0210c4c85612d83cda71ed2aba8c3e8a49fc9352590240b11dd15a29bbe5020a5760afa7799fe05a2c773a4b592ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/239ed4a261c01a9a8768dc49ce1395195cb5d08957705693131000a10270ddd5387b2ea68a975f9e1099c96c5c973e9c3be1e555f687afa82ba57fbe8e754bfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e2b8f8666d04128825db6f4b13174e47910c2b171a2d3904b9e85c1b281e3b6d212f7457bb81931b419bf9e1d27cfd85f8ae0ba36163706f4cd2f89f562dd6d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 08:43:04.166274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:43:04.166924) ========= 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.M1qptOynwu/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.MM2QgJgHch/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.004966 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:43:04.217962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 08:43:04.218432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 08:43:04.218942) ========= ========= Total master_lag: 0.19 =========