builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0337 starttime: 1479154863.01 results: success (0) buildid: 20161114091743 builduid: 42ed84f7fcb64e2fb957c8f0e52037f0 revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:03.015110) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:03.015561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:03.015896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:03.042397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:21:03.042748) ========= 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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 --2016-11-14 12:21:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.45M=0.002s 2016-11-14 12:21:03 (7.45 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113407 ========= master_lag: 1.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:21:04.425205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:04.425535) ========= 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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.021204 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:04.473257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:21:04.473630) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --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 fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G6sp5sB5fy/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.U5TEfkmtQK/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 2016-11-14 12:21:04,564 truncating revision to first 12 chars 2016-11-14 12:21:04,564 Setting DEBUG logging. 2016-11-14 12:21:04,564 attempt 1/10 2016-11-14 12:21:04,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fd3c6c15ec64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 12:21:05,409 unpacking tar archive at: mozilla-beta-fd3c6c15ec64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.125901 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:21:05.627377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:05.627763) ========= script_repo_revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:05.628201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:05.628479) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:21:05.646778) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-14 12:21:05.647191) ========= /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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:05 INFO - MultiFileLogger online at 20161114 12:21:05 in /builds/slave/test 12:21:05 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 12:21:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:21:05 INFO - {'append_to_log': False, 12:21:05 INFO - 'base_work_dir': '/builds/slave/test', 12:21:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:21:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:21:05 INFO - 'branch': 'Mozilla-Beta', 12:21:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:21:05 INFO - 'config_files': ('talos/mac_config.py',), 12:21:05 INFO - 'default_actions': ('clobber', 12:21:05 INFO - 'read-buildbot-config', 12:21:05 INFO - 'download-and-extract', 12:21:05 INFO - 'populate-webroot', 12:21:05 INFO - 'create-virtualenv', 12:21:05 INFO - 'install', 12:21:05 INFO - 'run-tests'), 12:21:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:21:05 INFO - 'download_minidump_stackwalk': True, 12:21:05 INFO - 'download_symbols': 'ondemand', 12:21:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:21:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:21:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:21:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:21:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:21:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:21:05 INFO - 'installer_path': 'installer.exe', 12:21:05 INFO - 'log_level': 'info', 12:21:05 INFO - 'log_name': 'talos', 12:21:05 INFO - 'log_to_console': True, 12:21:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:21:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:21:05 INFO - 'opt_config_files': (), 12:21:05 INFO - 'pip_index': False, 12:21:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:21:05 INFO - 'cmd': ('bash', 12:21:05 INFO - '-c', 12:21:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:21:05 INFO - 'enabled': True, 12:21:05 INFO - 'halt_on_failure': False, 12:21:05 INFO - 'name': 'check_screen_resolution'},), 12:21:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:21:05 INFO - 'cmd': ('bash', 12:21:05 INFO - '-c', 12:21:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:21:05 INFO - 'enabled': True, 12:21:05 INFO - 'halt_on_failure': False, 12:21:05 INFO - 'name': 'check_screen_resolution'},), 12:21:05 INFO - 'run_cmd_checks_enabled': True, 12:21:05 INFO - 'sps_profile': False, 12:21:05 INFO - 'sps_profile_interval': 0, 12:21:05 INFO - 'suite': 'dromaeojs', 12:21:05 INFO - 'system_bits': '32', 12:21:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:21:05 INFO - 'title': 't-yosemite-r7-0337', 12:21:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:21:05 INFO - 'use_talos_json': True, 12:21:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:21:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:21:05 INFO - 'work_dir': 'build'} 12:21:05 INFO - [mozharness: 2016-11-14 20:21:05.844795Z] Running clobber step. 12:21:05 INFO - Running pre-action listener: _resource_record_pre_action 12:21:05 INFO - Running main action method: clobber 12:21:05 INFO - rmtree: /builds/slave/test/build 12:21:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:21:07 INFO - Running post-action listener: _resource_record_post_action 12:21:07 INFO - [mozharness: 2016-11-14 20:21:07.456137Z] Finished clobber step (success) 12:21:07 INFO - [mozharness: 2016-11-14 20:21:07.456281Z] Running read-buildbot-config step. 12:21:07 INFO - Running pre-action listener: _resource_record_pre_action 12:21:07 INFO - Running main action method: read_buildbot_config 12:21:07 INFO - Using buildbot properties: 12:21:07 INFO - { 12:21:07 INFO - "project": "", 12:21:07 INFO - "product": "firefox", 12:21:07 INFO - "script_repo_revision": "production", 12:21:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:21:07 INFO - "repository": "", 12:21:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:21:07 INFO - "buildid": "20161114091743", 12:21:07 INFO - "pgo_build": "False", 12:21:07 INFO - "basedir": "/builds/slave/test", 12:21:07 INFO - "buildnumber": 11, 12:21:07 INFO - "slavename": "t-yosemite-r7-0337", 12:21:07 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:21:07 INFO - "platform": "yosemite_r7", 12:21:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:21:07 INFO - "branch": "mozilla-beta", 12:21:07 INFO - "repo_path": "releases/mozilla-beta", 12:21:07 INFO - "revision": "fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1", 12:21:07 INFO - "stage_platform": "macosx64", 12:21:07 INFO - "builduid": "42ed84f7fcb64e2fb957c8f0e52037f0", 12:21:07 INFO - "slavebuilddir": "test" 12:21:07 INFO - } 12:21:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:21:07 INFO - Running post-action listener: _resource_record_post_action 12:21:07 INFO - [mozharness: 2016-11-14 20:21:07.459543Z] Finished read-buildbot-config step (success) 12:21:07 INFO - [mozharness: 2016-11-14 20:21:07.459717Z] Running download-and-extract step. 12:21:07 INFO - Running pre-action listener: _resource_record_pre_action 12:21:07 INFO - Running main action method: download_and_extract 12:21:07 INFO - mkdir: /builds/slave/test/build/tests 12:21:07 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')]} 12:21:07 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:21:07 INFO - Downloading https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 12:21:08 INFO - Downloaded 1165 bytes. 12:21:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:21:08 INFO - Using the following test package requirements: 12:21:08 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:21:08 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:08 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:21:08 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:08 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:21:08 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:21:08 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:08 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:21:08 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:21:08 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:08 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:21:08 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:08 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:21:08 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:08 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:21:08 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:21:08 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:21:08 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:21:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:21:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:21:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:21:09 INFO - Expected file size: 16231342 12:21:16 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:21:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:21:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:21:16 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:21:16 INFO - Expected file size: 16231342 12:21:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:21:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:21:23 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:21:24 INFO - Expected file size: 14414089 12:21:25 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')]} 12:21:25 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:25 INFO - Downloading https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 12:21:27 INFO - Downloaded 86010818 bytes. 12:21:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:27 INFO - mkdir: /builds/slave/test/properties 12:21:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:21:27 INFO - Writing to file /builds/slave/test/properties/build_url 12:21:27 INFO - Contents: 12:21:27 INFO - build_url:https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:28 INFO - Running post-action listener: _resource_record_post_action 12:21:28 INFO - Running post-action listener: set_extra_try_arguments 12:21:28 INFO - [mozharness: 2016-11-14 20:21:28.000969Z] Finished download-and-extract step (success) 12:21:28 INFO - [mozharness: 2016-11-14 20:21:28.001119Z] Running populate-webroot step. 12:21:28 INFO - Running pre-action listener: _resource_record_pre_action 12:21:28 INFO - Running main action method: populate_webroot 12:21:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:21:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:21:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:21:28 INFO - '--tppagecycles', 12:21:28 INFO - '7'], 12:21:28 INFO - 'tests': ['tsvgm']}}, 12:21:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:21:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:21:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:21:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:21:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['damp', 'tps']}, 12:21:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'tests': ['damp', 'tps']}, 12:21:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['dromaeo_dom']}, 12:21:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:21:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['basic_compositor_video']}, 12:21:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:21:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['a11yr', 12:21:28 INFO - 'ts_paint', 12:21:28 INFO - 'tpaint', 12:21:28 INFO - 'sessionrestore', 12:21:28 INFO - 'sessionrestore_no_auto_restore', 12:21:28 INFO - 'tabpaint']}, 12:21:28 INFO - 'other-e10s': {'tests': ['a11yr', 12:21:28 INFO - 'ts_paint', 12:21:28 INFO - 'tpaint', 12:21:28 INFO - 'sessionrestore', 12:21:28 INFO - 'sessionrestore_no_auto_restore', 12:21:28 INFO - 'tabpaint']}, 12:21:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:21:28 INFO - 'ts_paint', 12:21:28 INFO - 'tpaint', 12:21:28 INFO - 'sessionrestore', 12:21:28 INFO - 'sessionrestore_no_auto_restore', 12:21:28 INFO - 'tabpaint']}, 12:21:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:21:28 INFO - 'ts_paint', 12:21:28 INFO - 'tpaint', 12:21:28 INFO - 'sessionrestore', 12:21:28 INFO - 'sessionrestore_no_auto_restore', 12:21:28 INFO - 'tabpaint']}, 12:21:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['a11yr', 12:21:28 INFO - 'ts_paint', 12:21:28 INFO - 'tpaint', 12:21:28 INFO - 'sessionrestore', 12:21:28 INFO - 'sessionrestore_no_auto_restore', 12:21:28 INFO - 'tabpaint']}, 12:21:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['a11yr', 12:21:28 INFO - 'ts_paint', 12:21:28 INFO - 'tpaint', 12:21:28 INFO - 'sessionrestore', 12:21:28 INFO - 'sessionrestore_no_auto_restore', 12:21:28 INFO - 'tabpaint']}, 12:21:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['tsvgx', 12:21:28 INFO - 'tsvgr_opacity', 12:21:28 INFO - 'tart', 12:21:28 INFO - 'tscrollx', 12:21:28 INFO - 'cart']}, 12:21:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:21:28 INFO - 'tsvgr_opacity', 12:21:28 INFO - 'tart', 12:21:28 INFO - 'tscrollx', 12:21:28 INFO - 'cart']}, 12:21:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'talos_options': ['--disable-e10s'], 12:21:28 INFO - 'tests': ['tp5o']}, 12:21:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'tests': ['tp5o']}, 12:21:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'talos_options': ['--disable-e10s', 12:21:28 INFO - '--xperf_path', 12:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:28 INFO - 'tests': ['tp5n']}, 12:21:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:28 INFO - 'talos_options': ['--xperf_path', 12:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:28 INFO - 'tests': ['tp5n']}}, 12:21:28 INFO - 'talos.zip': {'path': '', 12:21:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:21:28 INFO - Running post-action listener: _resource_record_post_action 12:21:28 INFO - [mozharness: 2016-11-14 20:21:28.019888Z] Finished populate-webroot step (success) 12:21:28 INFO - [mozharness: 2016-11-14 20:21:28.020019Z] Running create-virtualenv step. 12:21:28 INFO - Running pre-action listener: _resource_record_pre_action 12:21:28 INFO - Running main action method: create_virtualenv 12:21:28 INFO - Creating virtualenv /builds/slave/test/build/venv 12:21:28 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 12:21:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:21:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:21:28 INFO - Using real prefix '/tools/python27' 12:21:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:21:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:21:31 INFO - Installing pip.................done. 12:21:31 INFO - Return code: 0 12:21:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:21:31 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')]} 12:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:31 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')]} 12:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:31 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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:31 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 12:21:31 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 12:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:31 INFO - 'HOME': '/Users/cltbld', 12:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:31 INFO - 'LOGNAME': 'cltbld', 12:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:31 INFO - 'MOZ_NO_REMOTE': '1', 12:21:31 INFO - 'NO_EM_RESTART': '1', 12:21:31 INFO - 'PAGER': '/bin/cat', 12:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:31 INFO - 'PWD': '/builds/slave/test', 12:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:31 INFO - 'SHELL': '/bin/bash', 12:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:31 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:31 INFO - 'USER': 'cltbld', 12:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:31 INFO - 'XPC_FLAGS': '0x0', 12:21:31 INFO - 'XPC_SERVICE_NAME': '0', 12:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:31 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 12:21:31 INFO - Cleaning up... 12:21:32 INFO - Return code: 0 12:21:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:32 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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:32 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 12:21:32 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 12:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:32 INFO - 'HOME': '/Users/cltbld', 12:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:32 INFO - 'LOGNAME': 'cltbld', 12:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:32 INFO - 'MOZ_NO_REMOTE': '1', 12:21:32 INFO - 'NO_EM_RESTART': '1', 12:21:32 INFO - 'PAGER': '/bin/cat', 12:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:32 INFO - 'PWD': '/builds/slave/test', 12:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:32 INFO - 'SHELL': '/bin/bash', 12:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:32 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:32 INFO - 'USER': 'cltbld', 12:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:32 INFO - 'XPC_FLAGS': '0x0', 12:21:32 INFO - 'XPC_SERVICE_NAME': '0', 12:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:32 INFO - Downloading/unpacking psutil>=3.1.1 12:21:32 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 12:21:32 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 12:21:32 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 12:21:32 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 12:21:32 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 12:21:32 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 12:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:35 INFO - Installing collected packages: psutil 12:21:35 INFO - Running setup.py install for psutil 12:21:35 INFO - building 'psutil._psutil_osx' extension 12:21:35 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 12:21:35 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 12:21:36 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 12:21:36 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 12:21:36 INFO - building 'psutil._psutil_posix' extension 12:21:36 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 12:21:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:21:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:21:36 INFO - ^ 12:21:36 INFO - 1 warning generated. 12:21:36 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 12:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:36 INFO - Successfully installed psutil 12:21:36 INFO - Cleaning up... 12:21:36 INFO - Return code: 0 12:21:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:21:36 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')]} 12:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:36 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')]} 12:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:36 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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:36 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 12:21:36 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 12:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:36 INFO - 'HOME': '/Users/cltbld', 12:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:36 INFO - 'LOGNAME': 'cltbld', 12:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:36 INFO - 'MOZ_NO_REMOTE': '1', 12:21:36 INFO - 'NO_EM_RESTART': '1', 12:21:36 INFO - 'PAGER': '/bin/cat', 12:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:36 INFO - 'PWD': '/builds/slave/test', 12:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:36 INFO - 'SHELL': '/bin/bash', 12:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:36 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:36 INFO - 'USER': 'cltbld', 12:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:36 INFO - 'XPC_FLAGS': '0x0', 12:21:36 INFO - 'XPC_SERVICE_NAME': '0', 12:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:21:36 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 12:21:36 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 12:21:36 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 12:21:36 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 12:21:36 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 12:21:36 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 12:21:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:21:39 INFO - Installing collected packages: mozsystemmonitor 12:21:39 INFO - Running setup.py install for mozsystemmonitor 12:21:39 INFO - Successfully installed mozsystemmonitor 12:21:39 INFO - Cleaning up... 12:21:39 INFO - Return code: 0 12:21:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', '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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:21: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 jsonschema==2.5.1 12:21:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:39 INFO - 'HOME': '/Users/cltbld', 12:21:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:39 INFO - 'LOGNAME': 'cltbld', 12:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:39 INFO - 'MOZ_NO_REMOTE': '1', 12:21:39 INFO - 'NO_EM_RESTART': '1', 12:21:39 INFO - 'PAGER': '/bin/cat', 12:21:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:39 INFO - 'PWD': '/builds/slave/test', 12:21:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:39 INFO - 'SHELL': '/bin/bash', 12:21:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:39 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:39 INFO - 'USER': 'cltbld', 12:21:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:39 INFO - 'XPC_FLAGS': '0x0', 12:21:39 INFO - 'XPC_SERVICE_NAME': '0', 12:21:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:21:39 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 12:21:39 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 12:21:39 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 12:21:39 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 12:21:39 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 12:21:39 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 12:21:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:21:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:42 INFO - Downloading functools32-3.2.3-2.tar.gz 12:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:21:42 INFO - warning: no files found matching '*.txt' 12:21:42 INFO - no previously-included directories found matching 'build' 12:21:42 INFO - no previously-included directories found matching 'dist' 12:21:42 INFO - no previously-included directories found matching '.git*' 12:21:42 INFO - Installing collected packages: jsonschema, functools32 12:21:42 INFO - Running setup.py install for functools32 12:21:42 INFO - warning: no files found matching '*.txt' 12:21:42 INFO - no previously-included directories found matching 'build' 12:21:42 INFO - no previously-included directories found matching 'dist' 12:21:42 INFO - no previously-included directories found matching '.git*' 12:21:42 INFO - Successfully installed jsonschema functools32 12:21:42 INFO - Cleaning up... 12:21:43 INFO - Return code: 0 12:21:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', '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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:21: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 functools32==3.2.3-2 12:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:43 INFO - 'HOME': '/Users/cltbld', 12:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:43 INFO - 'LOGNAME': 'cltbld', 12:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:43 INFO - 'MOZ_NO_REMOTE': '1', 12:21:43 INFO - 'NO_EM_RESTART': '1', 12:21:43 INFO - 'PAGER': '/bin/cat', 12:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:43 INFO - 'PWD': '/builds/slave/test', 12:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:43 INFO - 'SHELL': '/bin/bash', 12:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:43 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:43 INFO - 'USER': 'cltbld', 12:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:43 INFO - 'XPC_FLAGS': '0x0', 12:21:43 INFO - 'XPC_SERVICE_NAME': '0', 12:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:21:43 INFO - Cleaning up... 12:21:43 INFO - Return code: 0 12:21:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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', '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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:21: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 blobuploader==1.2.4 12:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:43 INFO - 'HOME': '/Users/cltbld', 12:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:43 INFO - 'LOGNAME': 'cltbld', 12:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:43 INFO - 'MOZ_NO_REMOTE': '1', 12:21:43 INFO - 'NO_EM_RESTART': '1', 12:21:43 INFO - 'PAGER': '/bin/cat', 12:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:43 INFO - 'PWD': '/builds/slave/test', 12:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:43 INFO - 'SHELL': '/bin/bash', 12:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:43 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:43 INFO - 'USER': 'cltbld', 12:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:43 INFO - 'XPC_FLAGS': '0x0', 12:21:43 INFO - 'XPC_SERVICE_NAME': '0', 12:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:21:43 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 12:21:43 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 12:21:43 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 12:21:43 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 12:21:43 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 12:21:43 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 12:21:46 INFO - Downloading blobuploader-1.2.4.tar.gz 12:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:21:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:21:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:47 INFO - Downloading docopt-0.6.1.tar.gz 12:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:21:47 INFO - Installing collected packages: blobuploader, requests, docopt 12:21:47 INFO - Running setup.py install for blobuploader 12:21:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:21:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:21:47 INFO - Running setup.py install for requests 12:21:47 INFO - Running setup.py install for docopt 12:21:48 INFO - Successfully installed blobuploader requests docopt 12:21:48 INFO - Cleaning up... 12:21:48 INFO - Return code: 0 12:21:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:48 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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:48 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 12:21:48 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 12:21:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:48 INFO - 'HOME': '/Users/cltbld', 12:21:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:48 INFO - 'LOGNAME': 'cltbld', 12:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:48 INFO - 'MOZ_NO_REMOTE': '1', 12:21:48 INFO - 'NO_EM_RESTART': '1', 12:21:48 INFO - 'PAGER': '/bin/cat', 12:21:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:48 INFO - 'PWD': '/builds/slave/test', 12:21:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:48 INFO - 'SHELL': '/bin/bash', 12:21:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:48 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:48 INFO - 'USER': 'cltbld', 12:21:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:48 INFO - 'XPC_FLAGS': '0x0', 12:21:48 INFO - 'XPC_SERVICE_NAME': '0', 12:21:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-GJNXJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-1k6qpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-qBX2AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-cuunAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-DRzh4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-gCqaV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-xFvtcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-3InlTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-X_4_TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-sKCLnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-kCsuXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-alnqrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-MKJNX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4yxGsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-1dEMHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:50 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-tfrHET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:50 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-azFwpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:21:50 INFO - Running setup.py install for manifestparser 12:21:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:21:50 INFO - Running setup.py install for mozcrash 12:21:50 INFO - Running setup.py install for mozdebug 12:21:50 INFO - Running setup.py install for mozdevice 12:21:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:21:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:21:50 INFO - Running setup.py install for mozfile 12:21:51 INFO - Running setup.py install for mozhttpd 12:21:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Running setup.py install for mozinfo 12:21:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Running setup.py install for mozInstall 12:21:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Running setup.py install for mozleak 12:21:51 INFO - Running setup.py install for mozlog 12:21:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Running setup.py install for moznetwork 12:21:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:21:51 INFO - Running setup.py install for mozprocess 12:21:52 INFO - Running setup.py install for mozprofile 12:21:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:21:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:21:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:21:52 INFO - Running setup.py install for mozrunner 12:21:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:21:52 INFO - Running setup.py install for mozscreenshot 12:21:52 INFO - Running setup.py install for moztest 12:21:52 INFO - Running setup.py install for mozversion 12:21:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:21:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:21:52 INFO - Cleaning up... 12:21:52 INFO - Return code: 0 12:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:52 INFO - 'HOME': '/Users/cltbld', 12:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:52 INFO - 'LOGNAME': 'cltbld', 12:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:52 INFO - 'MOZ_NO_REMOTE': '1', 12:21:52 INFO - 'NO_EM_RESTART': '1', 12:21:52 INFO - 'PAGER': '/bin/cat', 12:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:52 INFO - 'PWD': '/builds/slave/test', 12:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:52 INFO - 'SHELL': '/bin/bash', 12:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:52 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:52 INFO - 'USER': 'cltbld', 12:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:52 INFO - 'XPC_FLAGS': '0x0', 12:21:52 INFO - 'XPC_SERVICE_NAME': '0', 12:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-vqsEdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:53 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)) 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-SZXXxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-EUzVYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:53 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)) 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-MpE7IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ABO9UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:53 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)) 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-30VkOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-VZ6XQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:53 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-_IiTKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:54 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-YA0Zjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:54 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-juUK4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:54 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-JrkYvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:54 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-04l1qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Cmqoor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:54 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-tDWYdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Ix2PDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:54 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-3ZhYeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 12:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:54 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-UlTKz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:55 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)) 12:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:21:55 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)) 12:21:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:21:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:21:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:21:55 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 12:21:55 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 12:21:55 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 12:21:55 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 12:21:55 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 12:21:55 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 12:21:57 INFO - Downloading blessings-1.6.tar.gz 12:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:21:57 INFO - Installing collected packages: blessings 12:21:57 INFO - Running setup.py install for blessings 12:21:57 INFO - Successfully installed blessings 12:21:57 INFO - Cleaning up... 12:21:57 INFO - Return code: 0 12:21:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:21:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:58 INFO - Reading from file tmpfile_stdout 12:21:58 INFO - Current package versions: 12:21:58 INFO - blessings == 1.6 12:21:58 INFO - blobuploader == 1.2.4 12:21:58 INFO - docopt == 0.6.1 12:21:58 INFO - functools32 == 3.2.3-2 12:21:58 INFO - jsonschema == 2.5.1 12:21:58 INFO - manifestparser == 1.1 12:21:58 INFO - mozInstall == 1.12 12:21:58 INFO - mozcrash == 0.17 12:21:58 INFO - mozdebug == 0.1 12:21:58 INFO - mozdevice == 0.48 12:21:58 INFO - mozfile == 1.2 12:21:58 INFO - mozhttpd == 0.7 12:21:58 INFO - mozinfo == 0.9 12:21:58 INFO - mozleak == 0.1 12:21:58 INFO - mozlog == 3.4 12:21:58 INFO - moznetwork == 0.27 12:21:58 INFO - mozprocess == 0.23 12:21:58 INFO - mozprofile == 0.28 12:21:58 INFO - mozrunner == 6.12 12:21:58 INFO - mozscreenshot == 0.1 12:21:58 INFO - mozsystemmonitor == 0.3 12:21:58 INFO - moztest == 0.7 12:21:58 INFO - mozversion == 1.4 12:21:58 INFO - psutil == 3.1.1 12:21:58 INFO - requests == 1.2.3 12:21:58 INFO - wsgiref == 0.1.2 12:21:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:58 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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:58 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 12:21:58 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 12:21:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:58 INFO - 'HOME': '/Users/cltbld', 12:21:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:58 INFO - 'LOGNAME': 'cltbld', 12:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:58 INFO - 'MOZ_NO_REMOTE': '1', 12:21:58 INFO - 'NO_EM_RESTART': '1', 12:21:58 INFO - 'PAGER': '/bin/cat', 12:21:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:58 INFO - 'PWD': '/builds/slave/test', 12:21:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:58 INFO - 'SHELL': '/bin/bash', 12:21:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:58 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:58 INFO - 'USER': 'cltbld', 12:21:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:58 INFO - 'XPC_FLAGS': '0x0', 12:21:58 INFO - 'XPC_SERVICE_NAME': '0', 12:21:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 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)) 12:21:58 INFO - Cleaning up... 12:21:58 INFO - Return code: 0 12:21:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:58 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 0x1102e6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11025c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cbdc68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, '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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 12:21:58 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 12:21:58 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 12:21:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:21:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:58 INFO - 'HOME': '/Users/cltbld', 12:21:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:58 INFO - 'LOGNAME': 'cltbld', 12:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:58 INFO - 'MOZ_NO_REMOTE': '1', 12:21:58 INFO - 'NO_EM_RESTART': '1', 12:21:58 INFO - 'PAGER': '/bin/cat', 12:21:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:58 INFO - 'PWD': '/builds/slave/test', 12:21:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:58 INFO - 'SHELL': '/bin/bash', 12:21:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:21:58 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:21:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:58 INFO - 'USER': 'cltbld', 12:21:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:58 INFO - 'XPC_FLAGS': '0x0', 12:21:58 INFO - 'XPC_SERVICE_NAME': '0', 12:21:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:21:58 INFO - Cleaning up... 12:21:58 INFO - Return code: 0 12:21:58 INFO - Running post-action listener: _resource_record_post_action 12:21:58 INFO - Running post-action listener: _start_resource_monitoring 12:21:58 INFO - Starting resource monitoring. 12:21:58 INFO - [mozharness: 2016-11-14 20:21:58.787009Z] Finished create-virtualenv step (success) 12:21:58 INFO - [mozharness: 2016-11-14 20:21:58.787999Z] Running install step. 12:21:58 INFO - Running pre-action listener: _resource_record_pre_action 12:21:58 INFO - Running main action method: install 12:21:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:59 INFO - Reading from file tmpfile_stdout 12:21:59 INFO - Detecting whether we're running mozinstall >=1.0... 12:21:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:21:59 INFO - Reading from file tmpfile_stdout 12:21:59 INFO - Output received: 12:21:59 INFO - Usage: mozinstall [options] installer 12:21:59 INFO - Options: 12:21:59 INFO - -h, --help show this help message and exit 12:21:59 INFO - -d DEST, --destination=DEST 12:21:59 INFO - Directory to install application into. [default: 12:21:59 INFO - "/builds/slave/test"] 12:21:59 INFO - --app=APP Application being installed. [default: firefox] 12:21:59 INFO - mkdir: /builds/slave/test/build/application 12:21:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:22:21 INFO - Reading from file tmpfile_stdout 12:22:21 INFO - Output received: 12:22:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:22:21 INFO - Running post-action listener: _resource_record_post_action 12:22:21 INFO - [mozharness: 2016-11-14 20:22:21.189775Z] Finished install step (success) 12:22:21 INFO - [mozharness: 2016-11-14 20:22:21.189932Z] Running run-tests step. 12:22:21 INFO - Running pre-action listener: _resource_record_pre_action 12:22:21 INFO - Running main action method: run_tests 12:22:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:22:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:22:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:22:21 INFO - 2016-11-14 12:22:21.204 screenresolution[3111:40157] starting screenresolution argv=screenresolution get 12:22:21 INFO - 2016-11-14 12:22:21.207 screenresolution[3111:40157] Display 0: 1600x1200x32@60 12:22:21 INFO - 2016-11-14 12:22:21.213 screenresolution[3112:40160] starting screenresolution argv=screenresolution list 12:22:21 INFO - Available Modes on Display 0 12:22:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:22:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:22:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:22:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:22:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:22:21 INFO - Intel Iris: 12:22:21 INFO - Chipset Model: Intel Iris 12:22:21 INFO - Type: GPU 12:22:21 INFO - Bus: Built-In 12:22:21 INFO - VRAM (Dynamic, Max): 1536 MB 12:22:21 INFO - Vendor: Intel (0x8086) 12:22:21 INFO - Device ID: 0x0a2e 12:22:21 INFO - Revision ID: 0x0009 12:22:21 INFO - Displays: 12:22:21 INFO - Display: 12:22:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:22:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:22:21 INFO - Display Serial Number: 1600x1200 60 12:22:21 INFO - Main Display: Yes 12:22:21 INFO - Mirror: Off 12:22:21 INFO - Online: Yes 12:22:21 INFO - Rotation: Supported 12:22:21 INFO - Return code: 0 12:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:22:21 INFO - Python 2.7.3 12:22:21 INFO - Return code: 0 12:22:21 INFO - grabbing minidump binary from tooltool 12:22:21 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')]} 12:22:21 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 0x1100fad30>, '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 0x10ff60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100f2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:22:21 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 12:22:21 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 12:22:21 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 12:22:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:22:21 INFO - Return code: 0 12:22:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:22:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:22:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:22:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:22:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:22:21 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/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 12:22:21 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/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0337 --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 12:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6sp5sB5fy/Render', 12:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:22:21 INFO - 'HOME': '/Users/cltbld', 12:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:22:21 INFO - 'LOGNAME': 'cltbld', 12:22:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:22:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:21 INFO - 'MOZ_NO_REMOTE': '1', 12:22:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:22:21 INFO - 'NO_EM_RESTART': '1', 12:22:21 INFO - 'PAGER': '/bin/cat', 12:22:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:21 INFO - 'PWD': '/builds/slave/test', 12:22:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:22:21 INFO - 'SHELL': '/bin/bash', 12:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5TEfkmtQK/Listeners', 12:22:21 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 12:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:22:21 INFO - 'USER': 'cltbld', 12:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:21 INFO - 'XPC_FLAGS': '0x0', 12:22:21 INFO - 'XPC_SERVICE_NAME': '0', 12:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:22:21 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/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 12:22:21 INFO - mozversion application_buildid: 20161114091743 12:22:21 INFO - mozversion application_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:22:21 INFO - mozversion application_display_name: Firefox 12:22:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:22:21 INFO - mozversion application_name: Firefox 12:22:21 INFO - mozversion application_remotingname: firefox 12:22:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:22:21 INFO - mozversion application_vendor: Mozilla 12:22:21 INFO - mozversion application_version: 51.0 12:22:21 INFO - mozversion platform_buildid: 20161114091743 12:22:21 INFO - mozversion platform_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:22:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:22:21 INFO - mozversion platform_version: 51.0 12:22:21 INFO - using testdate: 1479154941 12:22:21 INFO - actual date: 1479154941 12:22:21 INFO - starting webserver on 'localhost:62572' 12:22:21 INFO - SUITE-START | Running 2 tests 12:22:21 INFO - TEST-START | dromaeo_css 12:22:21 INFO - operating with platform_type : mac_ 12:22:21 INFO - Initialising browser for dromaeo_css test... 12:22:21 INFO - TEST-INFO | started process 3122 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmp2JbmCn/profile http://localhost:62572/getInfo.html) 12:22:24 INFO - PROCESS | 3122 | __metrics Screen width/height:1600/1200 12:22:24 INFO - PROCESS | 3122 | colorDepth:24 12:22:24 INFO - PROCESS | 3122 | Browser inner width/height: 1024/689 12:22:24 INFO - PROCESS | 3122 | __metrics 12:22:24 INFO - PROCESS | 3122 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:22:24 INFO - PROCESS | 3122 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:22:24 INFO - TEST-INFO | 3122: exit 0 12:22:24 INFO - Browser initialized. 12:22:24 INFO - Running cycle 1/1 for dromaeo_css test... 12:22:24 INFO - TEST-INFO | started process 3125 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmp2JbmCn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:36 INFO - PROCESS | 3125 | RSS: Main: 168312832 12:22:36 INFO - PROCESS | 3125 | 12:23:28 INFO - PROCESS | 3125 | 1479155008673 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:25:38 INFO - PROCESS | 3125 | Cycle 1(1): loaded http://localhost:62572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62572/tests/dromaeo/cssquery-ext.html) 12:25:39 INFO - PROCESS | 3125 | RSS: Main: 273768448 12:25:39 INFO - PROCESS | 3125 | 12:28:42 INFO - PROCESS | 3125 | Cycle 1(1): loaded http://localhost:62572/tests/dromaeo/cssquery-ext.html (next: http://localhost:62572/tests/dromaeo/cssquery-jquery.html) 12:28:43 INFO - PROCESS | 3125 | RSS: Main: 298512384 12:28:43 INFO - PROCESS | 3125 | 12:31:45 INFO - PROCESS | 3125 | Cycle 1(1): loaded http://localhost:62572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62572/tests/dromaeo/cssquery-mootools.html) 12:31:46 INFO - PROCESS | 3125 | RSS: Main: 270647296 12:31:46 INFO - PROCESS | 3125 | 12:34:48 INFO - PROCESS | 3125 | Cycle 1(1): loaded http://localhost:62572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62572/tests/dromaeo/cssquery-prototype.html) 12:34:49 INFO - PROCESS | 3125 | RSS: Main: 292089856 12:34:49 INFO - PROCESS | 3125 | 12:37:51 INFO - PROCESS | 3125 | Cycle 1(1): loaded http://localhost:62572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62572/tests/dromaeo/cssquery-yui.html) 12:37:52 INFO - PROCESS | 3125 | RSS: Main: 259596288 12:37:52 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | Cycle 1(1): loaded http://localhost:62572/tests/dromaeo/cssquery-yui.html (next: http://localhost:62572/tests/dromaeo/cssquery-dojo.html) 12:40:55 INFO - PROCESS | 3125 | RSS: Main: 386863104 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | __start_tp_report 12:40:55 INFO - PROCESS | 3125 | _x_x_mozilla_page_load 12:40:55 INFO - PROCESS | 3125 | _x_x_mozilla_page_load_details 12:40:55 INFO - PROCESS | 3125 | |i|pagename|runs| 12:40:55 INFO - PROCESS | 3125 | |0;dojo.html;3402.183475965768;3408.8125153116575;3449.62054174041;3453.4474484082552;3502.3870822606036;5816.9709151454235;5856.531477481802;5904.409559044094;5913.438223368778;5935.821925342236;5866.589338746289;5936.88126237475;5951.702414879261;5956;5956.404359564041;5277.102892508273;5313.681179129246;5332.386775520826;5380.596455265852;5418.078926582491;5242.370915490146;5243.239730239113;5258.605604579653;5430.185472179165;5442.809501667442;5095.949040509603;5245.527902488775;5249.580033597303;5277.683338999673;5281.260623512692;5243.921341179866;5272.762725677354;5328.6269961102735;5335.706536140511;5339.492748188916;5169.302144210521;5189.870253243661;5251.369835619712;5264.868378290574;5273.156294992821;5743.5118014968775;5778.624389414675;5786;5796.768129274824;5834.533237341003;6193.659348735818;6215.906761398583;6260.436560709558;6268.49852011838;6286;5568.192612071268;6171.722272497748;6297.874042519124;6317.178766760292;6328.272248691414;5747.885042299173;5794.478496935339;5860.912086318709;5869.941300587025;5874.941250587525;6295.779647712399;6318.399752023551;6335.23977122739;6346.492280617632;6347.174867267226;6045.546584006129;6251.78118765841;6265.404786545271;6273.749050037947;6276.46650034743;6196.969015154896;6271.686415679198;6279.434850863444;6288.9056664150075;6352;6218.005119181;6290.937090629035;6298.968505157445;6298.992161254269;6325.936740632626;5212.478752124757;6258.812235632939;6309.242890853127;6321.431071203614;6329.145565348711;4908.9263661045115;4965.081459929925;4973.278874563168;5034.521720436553;5042;4466.9553304466535;4499.032707967803;4528.162289976365;4541.500434952152;4583.083383323348;5931.228940237742;5963.850903727354;5969.79105731306;5979.073243647242;5988.28140623128;6166.013437849922;6296.527760417987;6330.620162790247;6342.5560210785725;6352.205974253218;5785.797497087582;5863.442972917566;5889.617174883619;5935.495482883917;5955.464008239279;5528.778848846082;5536.446355364431;5538.861528461821;5544.861378465571;5545.362283337387;5360.785568577213;6435.388638079375;6436.16329877113;6454.935450645434;6465.191851018622;6182.567220294536;6206.875862482635;6264.718087686157;6312.242530896322;6336.619802811846;6383.744650214126;6399.232092148972;6424.550281480251;6430.389113034442;6433.485321174388;6256.906146407899;6326.8734625306315;6341.921873281461;6342.49260059185;6354.904676429765;6160.476359509313;6235.00239961604;6247.437730604267;6248.656323902047;6335.334789847;5931.466168044724;6237.438630523275;6276.686165691788;6285.842853928689;6292.528060395397;6240.625562466266;6284.245890492987;6297.779577714758;6299.811005669837;6300.621962682254;5954.404559544011;6003.519718422603;6033.396660333931;6085.6348619083;6094.939050609437;6125.509959203342;6139.938600613937;6174.228221472316;6188.257409110935;6207.534434917309;4773.188557945088;5395.649282796606;6084.482818960438;6112.449879510866;6122.816315510542 12:40:55 INFO - PROCESS | 3125 | |1;ext.html;489.93140960265566;531.7235037780354;542.4629616679489;548.3365128194883;553.8449234214421;32993.67006329939;36295.637043629526;42805.57194428055;44248.11503769923;46547.76726116373;37822.8108859456;46982;47002;47067.293990590166;47100.293495597594;10024.448655323973;10198.796024079515;10207.030332118436;10211.183105351554;10217;9403.247740180803;9617.903820961807;12401.503939842396;12649.177803442793;12689.746205075893;12598.307093109875;12692.873071269307;12711;12724.491020359175;12741.872581274207;12605.180663256859;12660.430280637393;12666.49334026638;12676.683082922955;12677.302748348837;12398.938005309916;12478.937605311916;12480.687982800502;12483;12514.436850341757;43347.783261083496;43678.563214367765;43737.56262437398;43746.34380484295;43837;3554.608993010767;3673.2837096766143;3686.64976827201;3754.4743735877;4466.754328511931;32868.178295542566;32952;34109.6589034109;34356.48465273023;34731.4790278146;3384.644612315696;3422.8973130806116;3423.7432192585406;3447.276072024878;3469.132716820795;556950;563096;563286;563672;564808;35473.82263088668;68656;69213.65393173102;69289;69379.65310173416;36263.637363626025;37791.24417511634;37881.24237515289;37890;37980.43029354562;16390.180490975643;16574.08842513673;16580.336786528405;16591.25339359732;16626.25181866819;12725.300108493937;12885.742285154245;13776.793348099787;13970.441182352592;13985.86014139866;7316.122065352191;8170.7957301067945;8186.672533098728;8194.754157375288;8236.8352632947;3305.735541156702;3334.899953001414;3341.732661387083;3354.3123659649714;3365.2932884094616;971.3589031239349;1015.4567306490992;1028.100412139378;1077.8544896439037;1154.3016475032653;30281.545776813364;32732;32749.181270468427;33170.50244246338;33178.838740643965;996.8785116743663;1033.3851358441716;1102.3385968419045;1103.885076073156;1184.159246934686;14162.291885405688;14247.287635618384;15852;16152.030878147349;16605.50183494497;740758;746905;747583;747765;748745;60181;61080.69459652673;65690.67154664196;65837;66149.33850661432;1320.5576131995888;1362.5367375092517;1450.0864455393246;1469.9853001469849;1513.3492598182668;31994.840025799724;33756.83121584376;33919.66080339165;35376.29247415089;35509.934701958984;59396.10905836502;60901;61152;62142.89285535615;62146.68926655338;685833;689438;690083.5495822489;692110;693107.5344623245;34428;38647.42028869513;42197.578024220595;47177.764111179225;48033;49792;50864;51529.742351288005;51558.74220628873;52052;34629;41257.58742412538;41264.587354127274;41403;43774.56225437705;42024.94937626584;42225.78887105545;42488.57511424846;42742.5725742751;43824;40980;41752.58247417609;41908.58091419047;42100;42142.946426339586;34582.654173457944;35688.28623427465;35959.46060809142;36592.63407365892;36671.449928250564;25487.490250195264;27121.72878271192;27278.590821138096;27335.223210491255;27730.168094957182 12:40:55 INFO - PROCESS | 3125 | |2;jquery.html;373.587186159294;376.617733001004;386.5168539325842;398.3844959537514;402.6859049941047;20083;22418.663720044173;22448.9897954592;22623.321300360996;22888.427789305253;20623.484412889684;21057.368278951617;21114.683279750778;21248.57502849942;21264.681029784526;5787.131930210481;6255.562110652256;6307.621542707429;6338.778142765004;6346.016367463028;4491.393661855656;4539.9546004540025;4544.568266014723;6200.937990620081;6330.430261276484;4567.63458923287;6995.615241161734;7049.753258635923;7056.08270924779;7056.682449289794;5829.504492118175;6118.510519158456;6184.87630247397;7030.507864449491;7054.753083642074;6045.425684559959;6056.091586262096;6066.817995460143;6067.24159480065;6080.574359794816;23114.884425577933;25809.61285580718;26683.73316266851;26831.195064147912;27086.78109485078;2334.4163959010248;2357.3399448154373;2390.521895620883;2556.2586849813533;2711.8237314574685;10159.33964292326;10183.89816101837;10350.534225959775;10465.110465610433;10615.256932014761;1912.837408820252;1919.5297152197802;1987.1058023889307;2034.2269937423832;2037.8064083912004;124643.75356246412;127523;132844.99999999904;140675.59324406728;144515;11201.319802029599;11319;11405.714857128638;11410.087193024538;11668.591599294154;14926.179060151795;14926.328315225624;14951.1776852272;14954.327055282538;14956.551303460914;8861;8934.329925255632;8986.101389861093;9036.367454278268;9095.090490950852;9030.413023153475;9035.096490350912;9073.274138068939;9167.862482062774;9225.72322830316;4467.329900514884;4527.026689261825;4545.068261006486;4554.886127846764;4638.721676699409;1927.1905799564217;1939.4375631066832;1948.3473036532637;1969.3304276545757;1991.32295019694;646.9094326794252;822.5311572403792;856.528909100005;940.9837375634298;1014.8376259798397;20979.685304720442;22423.77576224217;22443.76559289222;22507.662385064235;22628.547429051327;951.9714408567754;955.9484566976271;959.7504648791225;976.9364991275544;1037.232447988483;9277.721668349961;10405.335146376543;11301.830472542919;11816.179534496074;11840.407979600985;553041;555437;556236;575821;673599;100802.4959875196;128581;141303;142723;143561;883.6377085394957;1017.898210178991;1039.2050081687514;1041.8437234414746;1044.2794471814423;18908.810911890705;19041.904790475957;19894.70157947661;20008.59982800307;20014.099365528295;40610.39084413677;54926.45073549373;55049.72475137599;55313.7234313842;58657.4134258669;79073.20926790658;80528;80699;80975.78536322078;84666;7818.452708310364;7830.8825367620675;7979.9601001994615;8071.757847264592;8108.986376702912;10660.84008739885;11904.821427678766;12788.104832661997;12791;13144.934275328562;10989.285696430026;11080.778384432106;11180.869356580171;11317.868213178946;11415.429228538706;10837.187210959051;10838.783224335311;10935.945320273348;11182;11303.43482825839;8429.283510901641;11043.944780276048;11286.322820630789;11382.260153090023;11458.713532161762;6778.762743304158;7943.126256111938;7945.8808117879435;7953.204679532;8019.5990200490905;9626.759331016781;11071.778564428505;11206.719832004264;11506.07951363872;11591.188616796744 12:40:55 INFO - PROCESS | 3125 | |3;mootools.html;1615.749558818383;1634.9673006539867;1896.146733969713;1957.4519134642305;2018.1725492548057;8855.734327970164;9416.52917354133;9420.576074076665;9437.905620943788;9493.762655933606;8251.216134467217;8560.957195214016;8924.955375223131;9144.542772861363;9202.861957070649;2419.286310538391;2475.2945410557995;2479.5412848622973;2480.06997375984;2480.1567467061195;2402.699662542182;2465.5192237513693;2467.111839737693;2468.419921318489;2470.1601455505124;2428.18655750323;2442.6702395176603;2458.6189140683223;2460.6063029915217;2461.729209786922;2413.8431001984814;2423.285130886393;2439.4633180700307;2444.7310795812446;2448.791852692523;2408.8554686718853;2418.2019933422102;2425.6967879015124;2429.4047958250167;2430.1980346485616;9232.169104780534;9278.443293402417;9323.487208203545;9342;9352.298577606707;5448.182772584144;5618.634788738719;5622.128570071645;5626.915596266059;5634.7182640867795;3553.786772793615;3702.833372498244;3773.000154958938;3818.8472461101524;3824.3307421201457;1101.262154356583;1108.7449886526063;1112.165875593305;1145.5475087340453;1151.2401814802274;12288.139830211889;12310.569130080494;12346.259224446561;12354.826291502293;12406.193597416139;4764.404449443819;4793.23308270682;4833.4441539222735;4945.208766597327;4973.52751488608;10429.165666746641;10458.26792124544;10460.424676642706;10473.738156546147;10510.947445262726;5558.221848941152;5558.777648893999;5559.138333558305;5567.749451274703;5569.55443564522;4612.423447069116;4736.928946065812;4986.376702912136;5066;5094.847154585368;4059.2287465381482;4121.29937910556;4186.644135248477;4201.411802347674;4229.873103806891;1137.7440075983004;1313.4483516922724;1318.854925958144;1326.423005992377;1334.5662659635657;803.6825453945776;846.3187134356901;897.8473659477904;939.9613427162886;948.8576713493031;5895.145203945404;6030.939690603038;6087.512998960073;6142.692865356804;6351.6768942510325;906.4063038709655;983.5672304186136;984.6209209454412;1027.4143738069229;1048.6696690542456;3447.9482807757904;3899.5515515715488;3970.1265721541213;4066.674666026711;4140.855070072594;9731.951340243253;11014.118870490342;11201.551937922555;11219.1585631078;11353.034992025605;11312.377819219857;11337.943310283561;11346.886531134583;11393.25943813666;11393.943030284796;8232.547209903392;8567.74296771098;8584.785380365542;8601.741947741577;8722.30221582272;6025.367336429612;6106.969465152646;6205.968970155121;6223.408776166257;6293.96853015732;10387.480625968823;10422.478876056319;10748.731281718019;10762.784744305227;10783.299085559414;10496.212784041074;10535.736606584896;10807.405592692478;10837.403942783223;10855.728606784893;7335.486515944046;7559.1684914660445;7619.809504762204;7981.241782030698;8161.877571836546;8721;8940.46357218569;8955.373123881265;8959.148880856308;9004.459732416077;7771.494852834548;7852.725154619561;7880;7968.800779980547;8193.385496087936;7030.472714546532;7444.330010299099;7540.849183016199;7812.453128281193;7935.6032198391;7382.852342953003;7496.137944136494;7499.212582678741;7511.9624401877645;7513.248675132443;4335.523092459764;5184.377874654915;5260.44765299638;5407.405185429679;5467.5625949923115;5238.345206849144;5325.09473389517;5378.435264297349;5391;5426.945730542644 12:40:55 INFO - PROCESS | 3125 | |4;prototype.html;294.7317940673987;298.828173800065;308.28016581282714;311.8191448959604;314.7057501236343;4623.953760462403;4826.589739872115;5474.616776825619;5586.91619625706;5651.208830763697;5280.683159010462;5430.266913966613;5556.472135147164;5559.805406810762;5608.551315894729;3369.9831500842524;4206.831726730942;4217.936730949038;4259.318509038554;4276.422682937795;3449.913752156191;3478.130467383154;4197.048372506783;4205.432266643995;4249.87250382489;3347.163209197701;4138.317177665682;4171.666266698657;4177.036792707423;4185.97907010466;4135.8966025849295;4146.9792651036705;4147.751134931914;4167.312393455091;4167.91664166715;3563.127033876691;3572.7141828653644;3573.3746594345885;3578.3022310649435;3585.1933315004176;4721;5361.086406922968;5372;5386.703731294777;5401.5948803839865;4764.952350476486;4769.880752981168;4770.379850619432;4784.258439941815;4791.784369703371;5483.711327837955;5840.941590584082;5859.707014649293;5883.911476376884;5915.958994147012;3773.07573137699;3899;3914.178022615254;3937.5471820740695;3953.6557570426194;5738.942610573882;5828.591998560102;5951.821445356646;6073.757049718006;6133.202683651141;3850.7111966602615;3941.3693808990997;3954.367301231789;3955.7428767130045;3957.742746721454;3385.6445073267446;4006.3790112532606;4031.778252196157;4043.575424580377;4045.211183819127;3995.5604883462797;4596.475640456107;4618.861434156981;4730.5032971538185;4760.857174284777;5662.631928924607;5728.169415434739;5828.009238429478;5859.326177489558;5882.23530940975;1078.6817888722846;1364.4883168811696;1369.5891232630172;1372.0121512510975;1386.9722605547834;691.2154704410531;829.8589439520659;832.379876991633;835.3734698975768;845.3870943565988;4125.814338354781;4348.521502689101;4569.748663823521;4607.811289637462;4617.561331673485;4367.781610919441;4434.711743736647;4508.301213311942;4813.95186048142;4986.90026199474;3860.9806950965067;4155.4182414462;4246.851360202378;4615.538446155425;4620.561046700558;2405.7353691093967;2485.3041148478455;2497.4505608766044;2594.0803805184028;2633.8814753336146;4423.496011356155;4552.544745525421;4645.5354464553275;4700.576948074689;4933.510505440104;4399.472063352418;4705.729453047658;4810.037992401463;4854.951450485521;5078.943028073636;4242.745435273831;4365.66847111634;5218.4259731430275;5222.7910883565755;5271.812197937889;4128.442660240949;4215.768132752728;4266.360045993002;4469.776511174363;4555.769942115677;4000.7599544027453;4798.344571122957;4918.901621967469;4968.4286307075145;4999.850004499871;4295.341199367474;4965.162889730823;5157.871053223699;5180.766865490987;5187.714675692873;3190.6809319068834;3455.671711187433;3487.877924272638;3496.8776092837647;3508.947365789464;5045.772940217773;5062.265971434195;5064.240363945438;5082.458770614693;5097.7706003229205;4655.953440465552;4918.901621967612;4940.802367905244;4948.529889660476;4999.90008193278;4146.771927544014;4842.6368022397755;4844.95155048445;4853.369062021915;4862.571886819855;4421.557844215553;4477.79099643088;4694.671373003857;4831.130396528518;4880.217831180721;4866.610671146371;4906.559563594952;5196.272521846869;5280;5924.186011644434;5247.16045432729;5613.691246981291;5822.563307752021;5829.59192856496;5830.76676932918 12:40:55 INFO - PROCESS | 3125 | |5;yui.html;668.5721138471379;737.494816051005;758.4690716498451;791.1887188599735;847.3560094328309;16447.2598733057;17074.573135671613;17152.656946861072;17197.398091066814;17225.655486890253;15215.92392038041;15338.386464541405;15341.156236406992;15341.539753807376;15355.539333820003;712.5404114346244;741.7329761285932;746.4177941205868;747.8429529798749;882.0650110882485;739.7965559471162;812.4718932693767;878.8769572259889;913.7030465098836;918.4535201555065;806.2421323955463;977.7408986618552;978.7602037500823;979.990200097997;980.2843923935532;972.5817898303727;972.6741541583579;973.5618971462835;973.6543527047867;977.4819345746765;714.9785506434815;718.9245129261457;719.1657677094597;719.2879049740719;720.2329519062182;13057.54298599554;15702.921485392615;15731.292091855894;15750.212489375486;15775.211239438097;13870.930645346809;14838.629034274121;15245.313960871787;15330.310136043905;15336.463223787114;13450.461981520728;13457.192568445924;13650.795238071438;13704.177749335071;13820.585382438543;4669.579737823612;4760.547747963972;4791.065742180276;4796.064767370364;4918.385201849769;127066.36466817699;130004.04993925098;130867.34566327203;133758;134321;11119.555217791198;11206.327620342805;11228.382438965771;11451.713707157387;11754.94122529399;18361.81638183601;22195.66706499404;22246.88876555607;22252;22252;7934.127246002935;7955.323797477279;8168.346532277404;8209.302209312156;8589.570521474026;3881.301365754135;4674.205385084544;4680.7191568506;4875.756212189376;4976.850694479172;3388.3562123196516;3804.4673745675627;3948.190620922704;4043.272211001989;4218.725782824106;753.2091304130751;755.8110472381904;775.8913752074714;779.719301051621;787.1616728184465;663.6482664187988;665.733706517397;679.7315060551055;696.8223103108675;709.202147583968;8701.30389568833;8704.086070962585;9828.950855245677;10156.542955567018;10405.84391234117;628.7642134199675;670.7819958513503;671.5366397185926;711.5623891306809;712.0849708125035;4571;4963.726995015237;4981.701097934136;4983.426905905867;4988.476209997971;106981.4650926756;138466;141912;149234;151912;124456;128361;130037;133102;133653.33173334072;107632;108083.91916080896;111579;115152.42423787828;117095;9777.951110244689;9956.352837065568;10061.153895711368;10182.847257291294;10689.251752377259;55716.885662287335;58297;58870.70564647149;65560;68184;68107;71943;86816;88263;98271.52592710972;11287.548498060314;11761.235519691192;13027.739445211233;13844.169349839041;13901.443942242196;14722.484713034992;14977.625559361104;16219.18904054816;16239;16667.41279055296;13959.930200348934;14209.289535522976;14693.191874447008;14851.628709281922;14992.625184370478;13775.242361670204;14705.044172128777;14784.704305914036;15140;15390.230488475756;14149.717005660035;14346.856531434552;14476.638084047983;14931.92534037323;14955.850441495446;11379.54481820718;11544.59593914209;11557.13321500874;12038.75922481528;12044.698882528008;9963.302568820112;11352.489137988976;11978.10164237703;12188.268703877795;12206.694832629255 12:40:55 INFO - PROCESS | 3125 | __end_tp_report 12:40:55 INFO - PROCESS | 3125 | __start_cc_report 12:40:55 INFO - PROCESS | 3125 | _x_x_mozilla_cycle_collect,1030 12:40:55 INFO - PROCESS | 3125 | __end_cc_report 12:40:55 INFO - PROCESS | 3125 | __startTimestamp1479156055727__endTimestamp 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | ------- Summary: start ------- 12:40:55 INFO - PROCESS | 3125 | Number of tests: 6 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | [#0] dojo.html Cycles:165 Average:5816.85 Median:6003.52 stddev:642.68 (10.7%) stddev-sans-first:616.10 12:40:55 INFO - PROCESS | 3125 | Values: 3402.2 3408.8 3449.6 3453.4 3502.4 5817.0 5856.5 5904.4 5913.4 5935.8 5866.6 5936.9 5951.7 5956.0 5956.4 5277.1 5313.7 5332.4 5380.6 5418.1 5242.4 5243.2 5258.6 5430.2 5442.8 5095.9 5245.5 5249.6 5277.7 5281.3 5243.9 5272.8 5328.6 5335.7 5339.5 5169.3 5189.9 5251.4 5264.9 5273.2 5743.5 5778.6 5786.0 5796.8 5834.5 6193.7 6215.9 6260.4 6268.5 6286.0 5568.2 6171.7 6297.9 6317.2 6328.3 5747.9 5794.5 5860.9 5869.9 5874.9 6295.8 6318.4 6335.2 6346.5 6347.2 6045.5 6251.8 6265.4 6273.7 6276.5 6197.0 6271.7 6279.4 6288.9 6352.0 6218.0 6290.9 6299.0 6299.0 6325.9 5212.5 6258.8 6309.2 6321.4 6329.1 4908.9 4965.1 4973.3 5034.5 5042.0 4467.0 4499.0 4528.2 4541.5 4583.1 5931.2 5963.9 5969.8 5979.1 5988.3 6166.0 6296.5 6330.6 6342.6 6352.2 5785.8 5863.4 5889.6 5935.5 5955.5 5528.8 5536.4 5538.9 5544.9 5545.4 5360.8 6435.4 6436.2 6454.9 6465.2 6182.6 6206.9 6264.7 6312.2 6336.6 6383.7 6399.2 6424.6 6430.4 6433.5 6256.9 6326.9 6341.9 6342.5 6354.9 6160.5 6235.0 6247.4 6248.7 6335.3 5931.5 6237.4 6276.7 6285.8 6292.5 6240.6 6284.2 6297.8 6299.8 6300.6 5954.4 6003.5 6033.4 6085.6 6094.9 6125.5 6139.9 6174.2 6188.3 6207.5 4773.2 5395.6 6084.5 6112.4 6122.8 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | [#1] ext.html Cycles:180 Average:79501.00 Median:36444.14 stddev:179811.80 (493.4%) stddev-sans-first:180218.36 12:40:55 INFO - PROCESS | 3125 | Values: 489.9 531.7 542.5 548.3 553.8 32993.7 36295.6 42805.6 44248.1 46547.8 37822.8 46982.0 47002.0 47067.3 47100.3 10024.4 10198.8 10207.0 10211.2 10217.0 9403.2 9617.9 12401.5 12649.2 12689.7 12598.3 12692.9 12711.0 12724.5 12741.9 12605.2 12660.4 12666.5 12676.7 12677.3 12398.9 12478.9 12480.7 12483.0 12514.4 43347.8 43678.6 43737.6 43746.3 43837.0 3554.6 3673.3 3686.6 3754.5 4466.8 32868.2 32952.0 34109.7 34356.5 34731.5 3384.6 3422.9 3423.7 3447.3 3469.1 556950.0 563096.0 563286.0 563672.0 564808.0 35473.8 68656.0 69213.7 69289.0 69379.7 36263.6 37791.2 37881.2 37890.0 37980.4 16390.2 16574.1 16580.3 16591.3 16626.3 12725.3 12885.7 13776.8 13970.4 13985.9 7316.1 8170.8 8186.7 8194.8 8236.8 3305.7 3334.9 3341.7 3354.3 3365.3 971.4 1015.5 1028.1 1077.9 1154.3 30281.5 32732.0 32749.2 33170.5 33178.8 996.9 1033.4 1102.3 1103.9 1184.2 14162.3 14247.3 15852.0 16152.0 16605.5 740758.0 746905.0 747583.0 747765.0 748745.0 60181.0 61080.7 65690.7 65837.0 66149.3 1320.6 1362.5 1450.1 1470.0 1513.3 31994.8 33756.8 33919.7 35376.3 35509.9 59396.1 60901.0 61152.0 62142.9 62146.7 685833.0 689438.0 690083.5 692110.0 693107.5 34428.0 38647.4 42197.6 47177.8 48033.0 49792.0 50864.0 51529.7 51558.7 52052.0 34629.0 41257.6 41264.6 41403.0 43774.6 42024.9 42225.8 42488.6 42742.6 43824.0 40980.0 41752.6 41908.6 42100.0 42142.9 34582.7 35688.3 35959.5 36592.6 36671.4 25487.5 27121.7 27278.6 27335.2 27730.2 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | [#2] jquery.html Cycles:180 Average:35429.12 Median:2373.93 stddev:98284.81 (4140.2%) stddev-sans-first:98525.28 12:40:55 INFO - PROCESS | 3125 | Values: 373.6 376.6 386.5 398.4 402.7 20083.0 22418.7 22449.0 22623.3 22888.4 20623.5 21057.4 21114.7 21248.6 21264.7 5787.1 6255.6 6307.6 6338.8 6346.0 4491.4 4540.0 4544.6 6200.9 6330.4 4567.6 6995.6 7049.8 7056.1 7056.7 5829.5 6118.5 6184.9 7030.5 7054.8 6045.4 6056.1 6066.8 6067.2 6080.6 23114.9 25809.6 26683.7 26831.2 27086.8 2334.4 2357.3 2390.5 2556.3 2711.8 10159.3 10183.9 10350.5 10465.1 10615.3 1912.8 1919.5 1987.1 2034.2 2037.8 124643.8 127523.0 132845.0 140675.6 144515.0 11201.3 11319.0 11405.7 11410.1 11668.6 14926.2 14926.3 14951.2 14954.3 14956.6 8861.0 8934.3 8986.1 9036.4 9095.1 9030.4 9035.1 9073.3 9167.9 9225.7 4467.3 4527.0 4545.1 4554.9 4638.7 1927.2 1939.4 1948.3 1969.3 1991.3 646.9 822.5 856.5 941.0 1014.8 20979.7 22423.8 22443.8 22507.7 22628.5 952.0 955.9 959.8 976.9 1037.2 9277.7 10405.3 11301.8 11816.2 11840.4 553041.0 555437.0 556236.0 575821.0 673599.0 100802.5 128581.0 141303.0 142723.0 143561.0 883.6 1017.9 1039.2 1041.8 1044.3 18908.8 19041.9 19894.7 20008.6 20014.1 40610.4 54926.5 55049.7 55313.7 58657.4 79073.2 80528.0 80699.0 80975.8 84666.0 7818.5 7830.9 7980.0 8071.8 8109.0 10660.8 11904.8 12788.1 12791.0 13144.9 10989.3 11080.8 11180.9 11317.9 11415.4 10837.2 10838.8 10935.9 11182.0 11303.4 8429.3 11043.9 11286.3 11382.3 11458.7 6778.8 7943.1 7945.9 7953.2 8019.6 9626.8 11071.8 11206.7 11506.1 11591.2 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | [#3] mootools.html Cycles:180 Average:5994.70 Median:4813.34 stddev:3378.68 (70.2%) stddev-sans-first:3372.13 12:40:55 INFO - PROCESS | 3125 | Values: 1615.7 1635.0 1896.1 1957.5 2018.2 8855.7 9416.5 9420.6 9437.9 9493.8 8251.2 8561.0 8925.0 9144.5 9202.9 2419.3 2475.3 2479.5 2480.1 2480.2 2402.7 2465.5 2467.1 2468.4 2470.2 2428.2 2442.7 2458.6 2460.6 2461.7 2413.8 2423.3 2439.5 2444.7 2448.8 2408.9 2418.2 2425.7 2429.4 2430.2 9232.2 9278.4 9323.5 9342.0 9352.3 5448.2 5618.6 5622.1 5626.9 5634.7 3553.8 3702.8 3773.0 3818.8 3824.3 1101.3 1108.7 1112.2 1145.5 1151.2 12288.1 12310.6 12346.3 12354.8 12406.2 4764.4 4793.2 4833.4 4945.2 4973.5 10429.2 10458.3 10460.4 10473.7 10510.9 5558.2 5558.8 5559.1 5567.7 5569.6 4612.4 4736.9 4986.4 5066.0 5094.8 4059.2 4121.3 4186.6 4201.4 4229.9 1137.7 1313.4 1318.9 1326.4 1334.6 803.7 846.3 897.8 940.0 948.9 5895.1 6030.9 6087.5 6142.7 6351.7 906.4 983.6 984.6 1027.4 1048.7 3447.9 3899.6 3970.1 4066.7 4140.9 9732.0 11014.1 11201.6 11219.2 11353.0 11312.4 11337.9 11346.9 11393.3 11393.9 8232.5 8567.7 8584.8 8601.7 8722.3 6025.4 6107.0 6206.0 6223.4 6294.0 10387.5 10422.5 10748.7 10762.8 10783.3 10496.2 10535.7 10807.4 10837.4 10855.7 7335.5 7559.2 7619.8 7981.2 8161.9 8721.0 8940.5 8955.4 8959.1 9004.5 7771.5 7852.7 7880.0 7968.8 8193.4 7030.5 7444.3 7540.8 7812.5 7935.6 7382.9 7496.1 7499.2 7512.0 7513.2 4335.5 5184.4 5260.4 5407.4 5467.6 5238.3 5325.1 5378.4 5391.0 5426.9 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | [#4] prototype.html Cycles:180 Average:4293.40 Median:4622.26 stddev:1297.48 (28.1%) stddev-sans-first:1265.93 12:40:55 INFO - PROCESS | 3125 | Values: 294.7 298.8 308.3 311.8 314.7 4624.0 4826.6 5474.6 5586.9 5651.2 5280.7 5430.3 5556.5 5559.8 5608.6 3370.0 4206.8 4217.9 4259.3 4276.4 3449.9 3478.1 4197.0 4205.4 4249.9 3347.2 4138.3 4171.7 4177.0 4186.0 4135.9 4147.0 4147.8 4167.3 4167.9 3563.1 3572.7 3573.4 3578.3 3585.2 4721.0 5361.1 5372.0 5386.7 5401.6 4765.0 4769.9 4770.4 4784.3 4791.8 5483.7 5840.9 5859.7 5883.9 5916.0 3773.1 3899.0 3914.2 3937.5 3953.7 5738.9 5828.6 5951.8 6073.8 6133.2 3850.7 3941.4 3954.4 3955.7 3957.7 3385.6 4006.4 4031.8 4043.6 4045.2 3995.6 4596.5 4618.9 4730.5 4760.9 5662.6 5728.2 5828.0 5859.3 5882.2 1078.7 1364.5 1369.6 1372.0 1387.0 691.2 829.9 832.4 835.4 845.4 4125.8 4348.5 4569.7 4607.8 4617.6 4367.8 4434.7 4508.3 4814.0 4986.9 3861.0 4155.4 4246.9 4615.5 4620.6 2405.7 2485.3 2497.5 2594.1 2633.9 4423.5 4552.5 4645.5 4700.6 4933.5 4399.5 4705.7 4810.0 4855.0 5078.9 4242.7 4365.7 5218.4 5222.8 5271.8 4128.4 4215.8 4266.4 4469.8 4555.8 4000.8 4798.3 4918.9 4968.4 4999.9 4295.3 4965.2 5157.9 5180.8 5187.7 3190.7 3455.7 3487.9 3496.9 3508.9 5045.8 5062.3 5064.2 5082.5 5097.8 4656.0 4918.9 4940.8 4948.5 4999.9 4146.8 4842.6 4845.0 4853.4 4862.6 4421.6 4477.8 4694.7 4831.1 4880.2 4866.6 4906.6 5196.3 5280.0 5924.2 5247.2 5613.7 5822.6 5829.6 5830.8 12:40:55 INFO - PROCESS | 3125 | 12:40:55 INFO - PROCESS | 3125 | [#5] yui.html Cycles:180 Average:25346.83 Median:22221.28 stddev:39873.98 (179.4%) stddev-sans-first:39942.79 12:40:55 INFO - PROCESS | 3125 | Values: 668.6 737.5 758.5 791.2 847.4 16447.3 17074.6 17152.7 17197.4 17225.7 15215.9 15338.4 15341.2 15341.5 15355.5 712.5 741.7 746.4 747.8 882.1 739.8 812.5 878.9 913.7 918.5 806.2 977.7 978.8 980.0 980.3 972.6 972.7 973.6 973.7 977.5 715.0 718.9 719.2 719.3 720.2 13057.5 15702.9 15731.3 15750.2 15775.2 13870.9 14838.6 15245.3 15330.3 15336.5 13450.5 13457.2 13650.8 13704.2 13820.6 4669.6 4760.5 4791.1 4796.1 4918.4 127066.4 130004.0 130867.3 133758.0 134321.0 11119.6 11206.3 11228.4 11451.7 11754.9 18361.8 22195.7 22246.9 22252.0 22252.0 7934.1 7955.3 8168.3 8209.3 8589.6 3881.3 4674.2 4680.7 4875.8 4976.9 3388.4 3804.5 3948.2 4043.3 4218.7 753.2 755.8 775.9 779.7 787.2 663.6 665.7 679.7 696.8 709.2 8701.3 8704.1 9829.0 10156.5 10405.8 628.8 670.8 671.5 711.6 712.1 4571.0 4963.7 4981.7 4983.4 4988.5 106981.5 138466.0 141912.0 149234.0 151912.0 124456.0 128361.0 130037.0 133102.0 133653.3 107632.0 108083.9 111579.0 115152.4 117095.0 9778.0 9956.4 10061.2 10182.8 10689.3 55716.9 58297.0 58870.7 65560.0 68184.0 68107.0 71943.0 86816.0 88263.0 98271.5 11287.5 11761.2 13027.7 13844.2 13901.4 14722.5 14977.6 16219.2 16239.0 16667.4 13959.9 14209.3 14693.2 14851.6 14992.6 13775.2 14705.0 14784.7 15140.0 15390.2 14149.7 14346.9 14476.6 14931.9 14955.9 11379.5 11544.6 11557.1 12038.8 12044.7 9963.3 11352.5 11978.1 12188.3 12206.7 12:40:55 INFO - PROCESS | 3125 | -------- Summary: end -------- 12:40:55 INFO - PROCESS | 3125 | 12:40:56 INFO - TEST-INFO | 3125: exit 0 12:40:56 INFO - TEST-OK | dromaeo_css | took 1114616ms 12:40:56 INFO - TEST-START | kraken 12:40:56 INFO - operating with platform_type : mac_ 12:40:56 INFO - Initialising browser for kraken test... 12:40:56 INFO - TEST-INFO | started process 3128 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpKXDJdH/profile http://localhost:62572/getInfo.html) 12:40:58 INFO - PROCESS | 3128 | __metrics Screen width/height:1600/1200 12:40:58 INFO - PROCESS | 3128 | colorDepth:24 12:40:58 INFO - PROCESS | 3128 | Browser inner width/height: 1024/689 12:40:58 INFO - PROCESS | 3128 | __metrics 12:40:58 INFO - PROCESS | 3128 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:40:58 INFO - PROCESS | 3128 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:40:59 INFO - TEST-INFO | 3128: exit 0 12:40:59 INFO - Browser initialized. 12:40:59 INFO - Running cycle 1/1 for kraken test... 12:40:59 INFO - TEST-INFO | started process 3130 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpKXDJdH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:11 INFO - PROCESS | 3130 | RSS: Main: 164278272 12:41:11 INFO - PROCESS | 3130 | 12:41:13 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62572/tests/kraken/driver.html?testName=audio-beat-detection) 12:41:14 INFO - PROCESS | 3130 | RSS: Main: 216240128 12:41:14 INFO - PROCESS | 3130 | 12:41:17 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62572/tests/kraken/driver.html?testName=audio-dft) 12:41:17 INFO - PROCESS | 3130 | RSS: Main: 230031360 12:41:17 INFO - PROCESS | 3130 | 12:41:20 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62572/tests/kraken/driver.html?testName=audio-fft) 12:41:21 INFO - PROCESS | 3130 | RSS: Main: 327892992 12:41:21 INFO - PROCESS | 3130 | 12:41:23 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62572/tests/kraken/driver.html?testName=audio-oscillator) 12:41:24 INFO - PROCESS | 3130 | RSS: Main: 226344960 12:41:24 INFO - PROCESS | 3130 | 12:41:26 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:41:26 INFO - PROCESS | 3130 | RSS: Main: 228003840 12:41:26 INFO - PROCESS | 3130 | 12:41:29 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62572/tests/kraken/driver.html?testName=imaging-darkroom) 12:41:30 INFO - PROCESS | 3130 | RSS: Main: 265093120 12:41:30 INFO - PROCESS | 3130 | 12:41:32 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62572/tests/kraken/driver.html?testName=imaging-desaturate) 12:41:33 INFO - PROCESS | 3130 | RSS: Main: 266735616 12:41:33 INFO - PROCESS | 3130 | 12:41:36 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62572/tests/kraken/driver.html?testName=json-parse-financial) 12:41:37 INFO - PROCESS | 3130 | RSS: Main: 266760192 12:41:37 INFO - PROCESS | 3130 | 12:41:38 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:41:39 INFO - PROCESS | 3130 | RSS: Main: 242774016 12:41:39 INFO - PROCESS | 3130 | 12:41:41 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:41:41 INFO - PROCESS | 3130 | RSS: Main: 243716096 12:41:41 INFO - PROCESS | 3130 | 12:41:43 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:41:44 INFO - PROCESS | 3130 | RSS: Main: 251355136 12:41:44 INFO - PROCESS | 3130 | 12:41:47 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:41:48 INFO - PROCESS | 3130 | RSS: Main: 255361024 12:41:48 INFO - PROCESS | 3130 | 12:41:50 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:41:51 INFO - PROCESS | 3130 | RSS: Main: 256380928 12:41:51 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | Cycle 1(1): loaded http://localhost:62572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62572/tests/kraken/driver.html?testName=ai-astar) 12:41:53 INFO - PROCESS | 3130 | RSS: Main: 300584960 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | __start_tp_report 12:41:53 INFO - PROCESS | 3130 | _x_x_mozilla_page_load 12:41:53 INFO - PROCESS | 3130 | _x_x_mozilla_page_load_details 12:41:53 INFO - PROCESS | 3130 | |i|pagename|runs| 12:41:53 INFO - PROCESS | 3130 | |0;ai-astar;104;112;111;113;113;113;113;114;112;112 12:41:53 INFO - PROCESS | 3130 | |1;audio-beat-detection;142;104;104;138;107;107;106;104;141;108 12:41:53 INFO - PROCESS | 3130 | |2;audio-dft;186;181;182;180;183;183;185;185;182;180 12:41:53 INFO - PROCESS | 3130 | |3;audio-fft;82;59;75;111;64;58;59;57;80;55 12:41:53 INFO - PROCESS | 3130 | |4;audio-oscillator;90;69;94;69;67;68;91;68;70;109 12:41:53 INFO - PROCESS | 3130 | |5;imaging-gaussian-blur;89;86;90;87;90;86;91;87;88;86 12:41:53 INFO - PROCESS | 3130 | |6;imaging-darkroom;94;93;102;147;135;94;101;95;94;94 12:41:53 INFO - PROCESS | 3130 | |7;imaging-desaturate;86;85;91;130;127;139;105;84;86;87 12:41:53 INFO - PROCESS | 3130 | |8;json-parse-financial;54;52;50;52;54;52;59;67;81;81 12:41:53 INFO - PROCESS | 3130 | |9;json-stringify-tinderbox;63;63;76;76;73;71;69;69;69;72 12:41:53 INFO - PROCESS | 3130 | |10;stanford-crypto-aes;77;83;83;83;80;81;84;88;83;99 12:41:53 INFO - PROCESS | 3130 | |11;stanford-crypto-ccm;143;144;152;136;131;135;132;138;158;154 12:41:53 INFO - PROCESS | 3130 | |12;stanford-crypto-pbkdf2;159;161;163;210;215;164;159;158;158;159 12:41:53 INFO - PROCESS | 3130 | |13;stanford-crypto-sha256-iterative;64;65;65;67;66;64;64;64;64;64 12:41:53 INFO - PROCESS | 3130 | __end_tp_report 12:41:53 INFO - PROCESS | 3130 | __start_cc_report 12:41:53 INFO - PROCESS | 3130 | _x_x_mozilla_cycle_collect,1878 12:41:53 INFO - PROCESS | 3130 | __end_cc_report 12:41:53 INFO - PROCESS | 3130 | __startTimestamp1479156113525__endTimestamp 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | ------- Summary: start ------- 12:41:53 INFO - PROCESS | 3130 | Number of tests: 14 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 12:41:53 INFO - PROCESS | 3130 | Values: 104.0 112.0 111.0 113.0 113.0 113.0 113.0 114.0 112.0 112.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#1] audio-beat-detection Cycles:10 Average:116.10 Median:107.50 stddev:16.81 (15.6%) stddev-sans-first:14.99 12:41:53 INFO - PROCESS | 3130 | Values: 142.0 104.0 104.0 138.0 107.0 107.0 106.0 104.0 141.0 108.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:2.11 (1.2%) stddev-sans-first:1.87 12:41:53 INFO - PROCESS | 3130 | Values: 186.0 181.0 182.0 180.0 183.0 183.0 185.0 185.0 182.0 180.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#3] audio-fft Cycles:10 Average:70.00 Median:61.50 stddev:17.53 (28.5%) stddev-sans-first:18.05 12:41:53 INFO - PROCESS | 3130 | Values: 82.0 59.0 75.0 111.0 64.0 58.0 59.0 57.0 80.0 55.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:69.50 stddev:15.11 (21.7%) stddev-sans-first:15.54 12:41:53 INFO - PROCESS | 3130 | Values: 90.0 69.0 94.0 69.0 67.0 68.0 91.0 68.0 70.0 109.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.50 stddev:1.89 (2.1%) stddev-sans-first:1.96 12:41:53 INFO - PROCESS | 3130 | Values: 89.0 86.0 90.0 87.0 90.0 86.0 91.0 87.0 88.0 86.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:94.00 stddev:19.48 (20.7%) stddev-sans-first:20.26 12:41:53 INFO - PROCESS | 3130 | Values: 94.0 93.0 102.0 147.0 135.0 94.0 101.0 95.0 94.0 94.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:85.50 stddev:21.75 (25.4%) stddev-sans-first:22.29 12:41:53 INFO - PROCESS | 3130 | Values: 86.0 85.0 91.0 130.0 127.0 139.0 105.0 84.0 86.0 87.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:56.50 stddev:12.00 (21.2%) stddev-sans-first:12.51 12:41:53 INFO - PROCESS | 3130 | Values: 54.0 52.0 50.0 52.0 54.0 52.0 59.0 67.0 81.0 81.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.50 stddev:4.56 (6.4%) stddev-sans-first:4.04 12:41:53 INFO - PROCESS | 3130 | Values: 63.0 63.0 76.0 76.0 73.0 71.0 69.0 69.0 69.0 72.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:5.95 (7.2%) stddev-sans-first:5.73 12:41:53 INFO - PROCESS | 3130 | Values: 77.0 83.0 83.0 83.0 80.0 81.0 84.0 88.0 83.0 99.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:143.50 stddev:9.58 (6.7%) stddev-sans-first:10.16 12:41:53 INFO - PROCESS | 3130 | Values: 143.0 144.0 152.0 136.0 131.0 135.0 132.0 138.0 158.0 154.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:162.00 stddev:22.21 (13.7%) stddev-sans-first:23.15 12:41:53 INFO - PROCESS | 3130 | Values: 159.0 161.0 163.0 210.0 215.0 164.0 159.0 158.0 158.0 159.0 12:41:53 INFO - PROCESS | 3130 | 12:41:53 INFO - PROCESS | 3130 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 12:41:53 INFO - PROCESS | 3130 | Values: 64.0 65.0 65.0 67.0 66.0 64.0 64.0 64.0 64.0 64.0 12:41:53 INFO - PROCESS | 3130 | -------- Summary: end -------- 12:41:53 INFO - PROCESS | 3130 | 12:41:54 INFO - TEST-INFO | 3130: exit 0 12:41:54 INFO - TEST-OK | kraken | took 57917ms 12:41:54 INFO - SUITE-END | took 1172s 12:41:54 INFO - Completed test suite (00:19:32) 12:41:54 INFO - javascript benchmark 12:41:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3402.183475965768, 3408.8125153116575, 3449.62054174041, 3453.4474484082552, 3502.3870822606036, 5816.9709151454235, 5856.531477481802, 5904.409559044094, 5913.438223368778, 5935.821925342236, 5866.589338746289, 5936.88126237475, 5951.702414879261, 5956.0, 5956.404359564041, 5277.102892508273, 5313.681179129246, 5332.386775520826, 5380.596455265852, 5418.078926582491, 5242.370915490146, 5243.239730239113, 5258.605604579653, 5430.185472179165, 5442.809501667442, 5095.949040509603, 5245.527902488775, 5249.580033597303, 5277.683338999673, 5281.260623512692, 5243.921341179866, 5272.762725677354, 5328.6269961102735, 5335.706536140511, 5339.492748188916, 5169.302144210521, 5189.870253243661, 5251.369835619712, 5264.868378290574, 5273.156294992821, 5743.5118014968775, 5778.624389414675, 5786.0, 5796.768129274824, 5834.533237341003, 6193.659348735818, 6215.906761398583, 6260.436560709558, 6268.49852011838, 6286.0, 5568.192612071268, 6171.722272497748, 6297.874042519124, 6317.178766760292, 6328.272248691414, 5747.885042299173, 5794.478496935339, 5860.912086318709, 5869.941300587025, 5874.941250587525, 6295.779647712399, 6318.399752023551, 6335.23977122739, 6346.492280617632, 6347.174867267226, 6045.546584006129, 6251.78118765841, 6265.404786545271, 6273.749050037947, 6276.46650034743, 6196.969015154896, 6271.686415679198, 6279.434850863444, 6288.9056664150075, 6352.0, 6218.005119181, 6290.937090629035, 6298.968505157445, 6298.992161254269, 6325.936740632626, 5212.478752124757, 6258.812235632939, 6309.242890853127, 6321.431071203614, 6329.145565348711, 4908.9263661045115, 4965.081459929925, 4973.278874563168, 5034.521720436553, 5042.0, 4466.9553304466535, 4499.032707967803, 4528.162289976365, 4541.500434952152, 4583.083383323348, 5931.228940237742, 5963.850903727354, 5969.79105731306, 5979.073243647242, 5988.28140623128, 6166.013437849922, 6296.527760417987, 6330.620162790247, 6342.5560210785725, 6352.205974253218, 5785.797497087582, 5863.442972917566, 5889.617174883619, 5935.495482883917, 5955.464008239279, 5528.778848846082, 5536.446355364431, 5538.861528461821, 5544.861378465571, 5545.362283337387, 5360.785568577213, 6435.388638079375, 6436.16329877113, 6454.935450645434, 6465.191851018622, 6182.567220294536, 6206.875862482635, 6264.718087686157, 6312.242530896322, 6336.619802811846, 6383.744650214126, 6399.232092148972, 6424.550281480251, 6430.389113034442, 6433.485321174388, 6256.906146407899, 6326.8734625306315, 6341.921873281461, 6342.49260059185, 6354.904676429765, 6160.476359509313, 6235.00239961604, 6247.437730604267, 6248.656323902047, 6335.334789847, 5931.466168044724, 6237.438630523275, 6276.686165691788, 6285.842853928689, 6292.528060395397, 6240.625562466266, 6284.245890492987, 6297.779577714758, 6299.811005669837, 6300.621962682254, 5954.404559544011, 6003.519718422603, 6033.396660333931, 6085.6348619083, 6094.939050609437, 6125.509959203342, 6139.938600613937, 6174.228221472316, 6188.257409110935, 6207.534434917309, 4773.188557945088, 5395.649282796606, 6084.482818960438, 6112.449879510866, 6122.816315510542], "value": 5777.25182893198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.93140960265566, 531.7235037780354, 542.4629616679489, 548.3365128194883, 553.8449234214421, 32993.67006329939, 36295.637043629526, 42805.57194428055, 44248.11503769923, 46547.76726116373, 37822.8108859456, 46982.0, 47002.0, 47067.293990590166, 47100.293495597594, 10024.448655323973, 10198.796024079515, 10207.030332118436, 10211.183105351554, 10217.0, 9403.247740180803, 9617.903820961807, 12401.503939842396, 12649.177803442793, 12689.746205075893, 12598.307093109875, 12692.873071269307, 12711.0, 12724.491020359175, 12741.872581274207, 12605.180663256859, 12660.430280637393, 12666.49334026638, 12676.683082922955, 12677.302748348837, 12398.938005309916, 12478.937605311916, 12480.687982800502, 12483.0, 12514.436850341757, 43347.783261083496, 43678.563214367765, 43737.56262437398, 43746.34380484295, 43837.0, 3554.608993010767, 3673.2837096766143, 3686.64976827201, 3754.4743735877, 4466.754328511931, 32868.178295542566, 32952.0, 34109.6589034109, 34356.48465273023, 34731.4790278146, 3384.644612315696, 3422.8973130806116, 3423.7432192585406, 3447.276072024878, 3469.132716820795, 556950.0, 563096.0, 563286.0, 563672.0, 564808.0, 35473.82263088668, 68656.0, 69213.65393173102, 69289.0, 69379.65310173416, 36263.637363626025, 37791.24417511634, 37881.24237515289, 37890.0, 37980.43029354562, 16390.180490975643, 16574.08842513673, 16580.336786528405, 16591.25339359732, 16626.25181866819, 12725.300108493937, 12885.742285154245, 13776.793348099787, 13970.441182352592, 13985.86014139866, 7316.122065352191, 8170.7957301067945, 8186.672533098728, 8194.754157375288, 8236.8352632947, 3305.735541156702, 3334.899953001414, 3341.732661387083, 3354.3123659649714, 3365.2932884094616, 971.3589031239349, 1015.4567306490992, 1028.100412139378, 1077.8544896439037, 1154.3016475032653, 30281.545776813364, 32732.0, 32749.181270468427, 33170.50244246338, 33178.838740643965, 996.8785116743663, 1033.3851358441716, 1102.3385968419045, 1103.885076073156, 1184.159246934686, 14162.291885405688, 14247.287635618384, 15852.0, 16152.030878147349, 16605.50183494497, 740758.0, 746905.0, 747583.0, 747765.0, 748745.0, 60181.0, 61080.69459652673, 65690.67154664196, 65837.0, 66149.33850661432, 1320.5576131995888, 1362.5367375092517, 1450.0864455393246, 1469.9853001469849, 1513.3492598182668, 31994.840025799724, 33756.83121584376, 33919.66080339165, 35376.29247415089, 35509.934701958984, 59396.10905836502, 60901.0, 61152.0, 62142.89285535615, 62146.68926655338, 685833.0, 689438.0, 690083.5495822489, 692110.0, 693107.5344623245, 34428.0, 38647.42028869513, 42197.578024220595, 47177.764111179225, 48033.0, 49792.0, 50864.0, 51529.742351288005, 51558.74220628873, 52052.0, 34629.0, 41257.58742412538, 41264.587354127274, 41403.0, 43774.56225437705, 42024.94937626584, 42225.78887105545, 42488.57511424846, 42742.5725742751, 43824.0, 40980.0, 41752.58247417609, 41908.58091419047, 42100.0, 42142.946426339586, 34582.654173457944, 35688.28623427465, 35959.46060809142, 36592.63407365892, 36671.449928250564, 25487.490250195264, 27121.72878271192, 27278.590821138096, 27335.223210491255, 27730.168094957182], "value": 20814.702257181463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.587186159294, 376.617733001004, 386.5168539325842, 398.3844959537514, 402.6859049941047, 20083.0, 22418.663720044173, 22448.9897954592, 22623.321300360996, 22888.427789305253, 20623.484412889684, 21057.368278951617, 21114.683279750778, 21248.57502849942, 21264.681029784526, 5787.131930210481, 6255.562110652256, 6307.621542707429, 6338.778142765004, 6346.016367463028, 4491.393661855656, 4539.9546004540025, 4544.568266014723, 6200.937990620081, 6330.430261276484, 4567.63458923287, 6995.615241161734, 7049.753258635923, 7056.08270924779, 7056.682449289794, 5829.504492118175, 6118.510519158456, 6184.87630247397, 7030.507864449491, 7054.753083642074, 6045.425684559959, 6056.091586262096, 6066.817995460143, 6067.24159480065, 6080.574359794816, 23114.884425577933, 25809.61285580718, 26683.73316266851, 26831.195064147912, 27086.78109485078, 2334.4163959010248, 2357.3399448154373, 2390.521895620883, 2556.2586849813533, 2711.8237314574685, 10159.33964292326, 10183.89816101837, 10350.534225959775, 10465.110465610433, 10615.256932014761, 1912.837408820252, 1919.5297152197802, 1987.1058023889307, 2034.2269937423832, 2037.8064083912004, 124643.75356246412, 127523.0, 132844.99999999904, 140675.59324406728, 144515.0, 11201.319802029599, 11319.0, 11405.714857128638, 11410.087193024538, 11668.591599294154, 14926.179060151795, 14926.328315225624, 14951.1776852272, 14954.327055282538, 14956.551303460914, 8861.0, 8934.329925255632, 8986.101389861093, 9036.367454278268, 9095.090490950852, 9030.413023153475, 9035.096490350912, 9073.274138068939, 9167.862482062774, 9225.72322830316, 4467.329900514884, 4527.026689261825, 4545.068261006486, 4554.886127846764, 4638.721676699409, 1927.1905799564217, 1939.4375631066832, 1948.3473036532637, 1969.3304276545757, 1991.32295019694, 646.9094326794252, 822.5311572403792, 856.528909100005, 940.9837375634298, 1014.8376259798397, 20979.685304720442, 22423.77576224217, 22443.76559289222, 22507.662385064235, 22628.547429051327, 951.9714408567754, 955.9484566976271, 959.7504648791225, 976.9364991275544, 1037.232447988483, 9277.721668349961, 10405.335146376543, 11301.830472542919, 11816.179534496074, 11840.407979600985, 553041.0, 555437.0, 556236.0, 575821.0, 673599.0, 100802.4959875196, 128581.0, 141303.0, 142723.0, 143561.0, 883.6377085394957, 1017.898210178991, 1039.2050081687514, 1041.8437234414746, 1044.2794471814423, 18908.810911890705, 19041.904790475957, 19894.70157947661, 20008.59982800307, 20014.099365528295, 40610.39084413677, 54926.45073549373, 55049.72475137599, 55313.7234313842, 58657.4134258669, 79073.20926790658, 80528.0, 80699.0, 80975.78536322078, 84666.0, 7818.452708310364, 7830.8825367620675, 7979.9601001994615, 8071.757847264592, 8108.986376702912, 10660.84008739885, 11904.821427678766, 12788.104832661997, 12791.0, 13144.934275328562, 10989.285696430026, 11080.778384432106, 11180.869356580171, 11317.868213178946, 11415.429228538706, 10837.187210959051, 10838.783224335311, 10935.945320273348, 11182.0, 11303.43482825839, 8429.283510901641, 11043.944780276048, 11286.322820630789, 11382.260153090023, 11458.713532161762, 6778.762743304158, 7943.126256111938, 7945.8808117879435, 7953.204679532, 8019.5990200490905, 9626.759331016781, 11071.778564428505, 11206.719832004264, 11506.07951363872, 11591.188616796744], "value": 9793.370844424973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1615.749558818383, 1634.9673006539867, 1896.146733969713, 1957.4519134642305, 2018.1725492548057, 8855.734327970164, 9416.52917354133, 9420.576074076665, 9437.905620943788, 9493.762655933606, 8251.216134467217, 8560.957195214016, 8924.955375223131, 9144.542772861363, 9202.861957070649, 2419.286310538391, 2475.2945410557995, 2479.5412848622973, 2480.06997375984, 2480.1567467061195, 2402.699662542182, 2465.5192237513693, 2467.111839737693, 2468.419921318489, 2470.1601455505124, 2428.18655750323, 2442.6702395176603, 2458.6189140683223, 2460.6063029915217, 2461.729209786922, 2413.8431001984814, 2423.285130886393, 2439.4633180700307, 2444.7310795812446, 2448.791852692523, 2408.8554686718853, 2418.2019933422102, 2425.6967879015124, 2429.4047958250167, 2430.1980346485616, 9232.169104780534, 9278.443293402417, 9323.487208203545, 9342.0, 9352.298577606707, 5448.182772584144, 5618.634788738719, 5622.128570071645, 5626.915596266059, 5634.7182640867795, 3553.786772793615, 3702.833372498244, 3773.000154958938, 3818.8472461101524, 3824.3307421201457, 1101.262154356583, 1108.7449886526063, 1112.165875593305, 1145.5475087340453, 1151.2401814802274, 12288.139830211889, 12310.569130080494, 12346.259224446561, 12354.826291502293, 12406.193597416139, 4764.404449443819, 4793.23308270682, 4833.4441539222735, 4945.208766597327, 4973.52751488608, 10429.165666746641, 10458.26792124544, 10460.424676642706, 10473.738156546147, 10510.947445262726, 5558.221848941152, 5558.777648893999, 5559.138333558305, 5567.749451274703, 5569.55443564522, 4612.423447069116, 4736.928946065812, 4986.376702912136, 5066.0, 5094.847154585368, 4059.2287465381482, 4121.29937910556, 4186.644135248477, 4201.411802347674, 4229.873103806891, 1137.7440075983004, 1313.4483516922724, 1318.854925958144, 1326.423005992377, 1334.5662659635657, 803.6825453945776, 846.3187134356901, 897.8473659477904, 939.9613427162886, 948.8576713493031, 5895.145203945404, 6030.939690603038, 6087.512998960073, 6142.692865356804, 6351.6768942510325, 906.4063038709655, 983.5672304186136, 984.6209209454412, 1027.4143738069229, 1048.6696690542456, 3447.9482807757904, 3899.5515515715488, 3970.1265721541213, 4066.674666026711, 4140.855070072594, 9731.951340243253, 11014.118870490342, 11201.551937922555, 11219.1585631078, 11353.034992025605, 11312.377819219857, 11337.943310283561, 11346.886531134583, 11393.25943813666, 11393.943030284796, 8232.547209903392, 8567.74296771098, 8584.785380365542, 8601.741947741577, 8722.30221582272, 6025.367336429612, 6106.969465152646, 6205.968970155121, 6223.408776166257, 6293.96853015732, 10387.480625968823, 10422.478876056319, 10748.731281718019, 10762.784744305227, 10783.299085559414, 10496.212784041074, 10535.736606584896, 10807.405592692478, 10837.403942783223, 10855.728606784893, 7335.486515944046, 7559.1684914660445, 7619.809504762204, 7981.241782030698, 8161.877571836546, 8721.0, 8940.46357218569, 8955.373123881265, 8959.148880856308, 9004.459732416077, 7771.494852834548, 7852.725154619561, 7880.0, 7968.800779980547, 8193.385496087936, 7030.472714546532, 7444.330010299099, 7540.849183016199, 7812.453128281193, 7935.6032198391, 7382.852342953003, 7496.137944136494, 7499.212582678741, 7511.9624401877645, 7513.248675132443, 4335.523092459764, 5184.377874654915, 5260.44765299638, 5407.405185429679, 5467.5625949923115, 5238.345206849144, 5325.09473389517, 5378.435264297349, 5391.0, 5426.945730542644], "value": 4804.769779583781, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.7317940673987, 298.828173800065, 308.28016581282714, 311.8191448959604, 314.7057501236343, 4623.953760462403, 4826.589739872115, 5474.616776825619, 5586.91619625706, 5651.208830763697, 5280.683159010462, 5430.266913966613, 5556.472135147164, 5559.805406810762, 5608.551315894729, 3369.9831500842524, 4206.831726730942, 4217.936730949038, 4259.318509038554, 4276.422682937795, 3449.913752156191, 3478.130467383154, 4197.048372506783, 4205.432266643995, 4249.87250382489, 3347.163209197701, 4138.317177665682, 4171.666266698657, 4177.036792707423, 4185.97907010466, 4135.8966025849295, 4146.9792651036705, 4147.751134931914, 4167.312393455091, 4167.91664166715, 3563.127033876691, 3572.7141828653644, 3573.3746594345885, 3578.3022310649435, 3585.1933315004176, 4721.0, 5361.086406922968, 5372.0, 5386.703731294777, 5401.5948803839865, 4764.952350476486, 4769.880752981168, 4770.379850619432, 4784.258439941815, 4791.784369703371, 5483.711327837955, 5840.941590584082, 5859.707014649293, 5883.911476376884, 5915.958994147012, 3773.07573137699, 3899.0, 3914.178022615254, 3937.5471820740695, 3953.6557570426194, 5738.942610573882, 5828.591998560102, 5951.821445356646, 6073.757049718006, 6133.202683651141, 3850.7111966602615, 3941.3693808990997, 3954.367301231789, 3955.7428767130045, 3957.742746721454, 3385.6445073267446, 4006.3790112532606, 4031.778252196157, 4043.575424580377, 4045.211183819127, 3995.5604883462797, 4596.475640456107, 4618.861434156981, 4730.5032971538185, 4760.857174284777, 5662.631928924607, 5728.169415434739, 5828.009238429478, 5859.326177489558, 5882.23530940975, 1078.6817888722846, 1364.4883168811696, 1369.5891232630172, 1372.0121512510975, 1386.9722605547834, 691.2154704410531, 829.8589439520659, 832.379876991633, 835.3734698975768, 845.3870943565988, 4125.814338354781, 4348.521502689101, 4569.748663823521, 4607.811289637462, 4617.561331673485, 4367.781610919441, 4434.711743736647, 4508.301213311942, 4813.95186048142, 4986.90026199474, 3860.9806950965067, 4155.4182414462, 4246.851360202378, 4615.538446155425, 4620.561046700558, 2405.7353691093967, 2485.3041148478455, 2497.4505608766044, 2594.0803805184028, 2633.8814753336146, 4423.496011356155, 4552.544745525421, 4645.5354464553275, 4700.576948074689, 4933.510505440104, 4399.472063352418, 4705.729453047658, 4810.037992401463, 4854.951450485521, 5078.943028073636, 4242.745435273831, 4365.66847111634, 5218.4259731430275, 5222.7910883565755, 5271.812197937889, 4128.442660240949, 4215.768132752728, 4266.360045993002, 4469.776511174363, 4555.769942115677, 4000.7599544027453, 4798.344571122957, 4918.901621967469, 4968.4286307075145, 4999.850004499871, 4295.341199367474, 4965.162889730823, 5157.871053223699, 5180.766865490987, 5187.714675692873, 3190.6809319068834, 3455.671711187433, 3487.877924272638, 3496.8776092837647, 3508.947365789464, 5045.772940217773, 5062.265971434195, 5064.240363945438, 5082.458770614693, 5097.7706003229205, 4655.953440465552, 4918.901621967612, 4940.802367905244, 4948.529889660476, 4999.90008193278, 4146.771927544014, 4842.6368022397755, 4844.95155048445, 4853.369062021915, 4862.571886819855, 4421.557844215553, 4477.79099643088, 4694.671373003857, 4831.130396528518, 4880.217831180721, 4866.610671146371, 4906.559563594952, 5196.272521846869, 5280.0, 5924.186011644434, 5247.16045432729, 5613.691246981291, 5822.563307752021, 5829.59192856496, 5830.76676932918], "value": 3883.4882055152157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5721138471379, 737.494816051005, 758.4690716498451, 791.1887188599735, 847.3560094328309, 16447.2598733057, 17074.573135671613, 17152.656946861072, 17197.398091066814, 17225.655486890253, 15215.92392038041, 15338.386464541405, 15341.156236406992, 15341.539753807376, 15355.539333820003, 712.5404114346244, 741.7329761285932, 746.4177941205868, 747.8429529798749, 882.0650110882485, 739.7965559471162, 812.4718932693767, 878.8769572259889, 913.7030465098836, 918.4535201555065, 806.2421323955463, 977.7408986618552, 978.7602037500823, 979.990200097997, 980.2843923935532, 972.5817898303727, 972.6741541583579, 973.5618971462835, 973.6543527047867, 977.4819345746765, 714.9785506434815, 718.9245129261457, 719.1657677094597, 719.2879049740719, 720.2329519062182, 13057.54298599554, 15702.921485392615, 15731.292091855894, 15750.212489375486, 15775.211239438097, 13870.930645346809, 14838.629034274121, 15245.313960871787, 15330.310136043905, 15336.463223787114, 13450.461981520728, 13457.192568445924, 13650.795238071438, 13704.177749335071, 13820.585382438543, 4669.579737823612, 4760.547747963972, 4791.065742180276, 4796.064767370364, 4918.385201849769, 127066.36466817699, 130004.04993925098, 130867.34566327203, 133758.0, 134321.0, 11119.555217791198, 11206.327620342805, 11228.382438965771, 11451.713707157387, 11754.94122529399, 18361.81638183601, 22195.66706499404, 22246.88876555607, 22252.0, 22252.0, 7934.127246002935, 7955.323797477279, 8168.346532277404, 8209.302209312156, 8589.570521474026, 3881.301365754135, 4674.205385084544, 4680.7191568506, 4875.756212189376, 4976.850694479172, 3388.3562123196516, 3804.4673745675627, 3948.190620922704, 4043.272211001989, 4218.725782824106, 753.2091304130751, 755.8110472381904, 775.8913752074714, 779.719301051621, 787.1616728184465, 663.6482664187988, 665.733706517397, 679.7315060551055, 696.8223103108675, 709.202147583968, 8701.30389568833, 8704.086070962585, 9828.950855245677, 10156.542955567018, 10405.84391234117, 628.7642134199675, 670.7819958513503, 671.5366397185926, 711.5623891306809, 712.0849708125035, 4571.0, 4963.726995015237, 4981.701097934136, 4983.426905905867, 4988.476209997971, 106981.4650926756, 138466.0, 141912.0, 149234.0, 151912.0, 124456.0, 128361.0, 130037.0, 133102.0, 133653.33173334072, 107632.0, 108083.91916080896, 111579.0, 115152.42423787828, 117095.0, 9777.951110244689, 9956.352837065568, 10061.153895711368, 10182.847257291294, 10689.251752377259, 55716.885662287335, 58297.0, 58870.70564647149, 65560.0, 68184.0, 68107.0, 71943.0, 86816.0, 88263.0, 98271.52592710972, 11287.548498060314, 11761.235519691192, 13027.739445211233, 13844.169349839041, 13901.443942242196, 14722.484713034992, 14977.625559361104, 16219.18904054816, 16239.0, 16667.41279055296, 13959.930200348934, 14209.289535522976, 14693.191874447008, 14851.628709281922, 14992.625184370478, 13775.242361670204, 14705.044172128777, 14784.704305914036, 15140.0, 15390.230488475756, 14149.717005660035, 14346.856531434552, 14476.638084047983, 14931.92534037323, 14955.850441495446, 11379.54481820718, 11544.59593914209, 11557.13321500874, 12038.75922481528, 12044.698882528008, 9963.302568820112, 11352.489137988976, 11978.10164237703, 12188.268703877795, 12206.694832629255], "value": 8223.664984385721, "unit": "score"}], "name": "dromaeo_css", "value": 7519.207842584833, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 113.0, 113.0, 113.0, 113.0, 114.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 104.0, 104.0, 138.0, 107.0, 107.0, 106.0, 104.0, 141.0, 108.0], "value": 116.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 182.0, 180.0, 183.0, 183.0, 185.0, 185.0, 182.0, 180.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 75.0, 111.0, 64.0, 58.0, 59.0, 57.0, 80.0, 55.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 94.0, 69.0, 67.0, 68.0, 91.0, 68.0, 70.0, 109.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 90.0, 86.0, 91.0, 87.0, 88.0, 86.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 102.0, 147.0, 135.0, 94.0, 101.0, 95.0, 94.0, 94.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 91.0, 130.0, 127.0, 139.0, 105.0, 84.0, 86.0, 87.0], "value": 102.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 50.0, 52.0, 54.0, 52.0, 59.0, 67.0, 81.0, 81.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 76.0, 76.0, 73.0, 71.0, 69.0, 69.0, 69.0, 72.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 83.0, 83.0, 80.0, 81.0, 84.0, 88.0, 83.0, 99.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 152.0, 136.0, 131.0, 135.0, 132.0, 138.0, 158.0, 154.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 163.0, 210.0, 215.0, 164.0, 159.0, 158.0, 158.0, 159.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 67.0, 66.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1446.8999999999999, "alertThreshold": 2.0}]} 12:41:54 INFO - Return code: 0 12:41:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:41:54 INFO - # TBPL SUCCESS # 12:41:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:41:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:41:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:41:54 INFO - 2016-11-14 12:41:54.873 screenresolution[3134:42187] starting screenresolution argv=screenresolution get 12:41:54 INFO - 2016-11-14 12:41:54.875 screenresolution[3134:42187] Display 0: 1600x1200x32@60 12:41:54 INFO - 2016-11-14 12:41:54.881 screenresolution[3135:42190] starting screenresolution argv=screenresolution list 12:41:54 INFO - Available Modes on Display 0 12:41:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:41:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:41:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:41:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:41:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:41:55 INFO - Intel Iris: 12:41:55 INFO - Chipset Model: Intel Iris 12:41:55 INFO - Type: GPU 12:41:55 INFO - Bus: Built-In 12:41:55 INFO - VRAM (Dynamic, Max): 1536 MB 12:41:55 INFO - Vendor: Intel (0x8086) 12:41:55 INFO - Device ID: 0x0a2e 12:41:55 INFO - Revision ID: 0x0009 12:41:55 INFO - Displays: 12:41:55 INFO - Display: 12:41:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:41:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:41:55 INFO - Display Serial Number: 1600x1200 60 12:41:55 INFO - Main Display: Yes 12:41:55 INFO - Mirror: Off 12:41:55 INFO - Online: Yes 12:41:55 INFO - Rotation: Supported 12:41:55 INFO - Return code: 0 12:41:55 INFO - Running post-action listener: _resource_record_post_action 12:41:55 INFO - [mozharness: 2016-11-14 20:41:55.121672Z] Finished run-tests step (success) 12:41:55 INFO - Running post-run listener: _resource_record_post_run 12:41:55 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 102400; Write bytes: 492723200; Read time: 2; Write time: 1523 12:41:55 INFO - TinderboxPrint: CPU usage
53.6% 12:41:55 INFO - TinderboxPrint: I/O read bytes / time
102,400 / 2 12:41:55 INFO - TinderboxPrint: I/O write bytes / time
492,723,200 / 1,523 12:41:55 INFO - TinderboxPrint: CPU idle
2,217.1 (46.4%) 12:41:55 INFO - TinderboxPrint: CPU system
964.8 (20.2%) 12:41:55 INFO - TinderboxPrint: CPU user
1,599.7 (33.5%) 12:41:55 INFO - TinderboxPrint: Swap in / out
194,580,480 / 0 12:41:55 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192107008; Write bytes: 186828800; Read time: 17949; Write time: 393 12:41:55 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 102400; Write bytes: 294646784; Read time: 2; Write time: 1087 12:41:55 INFO - Running post-run listener: _upload_blobber_files 12:41:55 INFO - Blob upload gear active. 12:41:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:41:55 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 12:41:55 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'] 12:41:55 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 12:41:55 INFO - (blobuploader) - INFO - Open directory for files ... 12:41:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:41:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:41:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:57 INFO - (blobuploader) - INFO - Done attempting. 12:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:58 INFO - (blobuploader) - INFO - Done attempting. 12:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:00 INFO - (blobuploader) - INFO - Done attempting. 12:42:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:42:00 INFO - Return code: 0 12:42:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:42:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:42:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3e642da0d482e43660443be2e62250ed6a97c58e543e70bbe2c32aacae80a97cee044b9da2eeb4f43a6485bcb789f72209df886de55dff7475b5813da1f4287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c90cb34c53ba7757861eb1a81e05a38c0a35ef0bda5e6ca1bc160d9239eb265233b2fd8e4f441497223aa2b2905babf048030a1323801b09ded96a91095ebe6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e8821d7480361e6c17c1a455e8740dbf17acaca17ab15ca62791318444dc4ab4af414f4ef54eeeed6b5afa7e56ff90d2a6e3318881d143f105014567dc81bd2"} 12:42:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:42:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:42:00 INFO - Contents: 12:42:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3e642da0d482e43660443be2e62250ed6a97c58e543e70bbe2c32aacae80a97cee044b9da2eeb4f43a6485bcb789f72209df886de55dff7475b5813da1f4287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c90cb34c53ba7757861eb1a81e05a38c0a35ef0bda5e6ca1bc160d9239eb265233b2fd8e4f441497223aa2b2905babf048030a1323801b09ded96a91095ebe6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e8821d7480361e6c17c1a455e8740dbf17acaca17ab15ca62791318444dc4ab4af414f4ef54eeeed6b5afa7e56ff90d2a6e3318881d143f105014567dc81bd2"} 12:42:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:42:00 INFO - Copying logs to upload dir... 12:42:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:42:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.007174 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-14 12:42:00.906278) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-11-14 12:42:00.913553) ========= 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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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/c3e642da0d482e43660443be2e62250ed6a97c58e543e70bbe2c32aacae80a97cee044b9da2eeb4f43a6485bcb789f72209df886de55dff7475b5813da1f4287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c90cb34c53ba7757861eb1a81e05a38c0a35ef0bda5e6ca1bc160d9239eb265233b2fd8e4f441497223aa2b2905babf048030a1323801b09ded96a91095ebe6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e8821d7480361e6c17c1a455e8740dbf17acaca17ab15ca62791318444dc4ab4af414f4ef54eeeed6b5afa7e56ff90d2a6e3318881d143f105014567dc81bd2"} build_url:https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010655 build_url: 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c3e642da0d482e43660443be2e62250ed6a97c58e543e70bbe2c32aacae80a97cee044b9da2eeb4f43a6485bcb789f72209df886de55dff7475b5813da1f4287", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c90cb34c53ba7757861eb1a81e05a38c0a35ef0bda5e6ca1bc160d9239eb265233b2fd8e4f441497223aa2b2905babf048030a1323801b09ded96a91095ebe6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e8821d7480361e6c17c1a455e8740dbf17acaca17ab15ca62791318444dc4ab4af414f4ef54eeeed6b5afa7e56ff90d2a6e3318881d143f105014567dc81bd2"}' ========= master_lag: 5.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-11-14 12:42:06.400843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:42:06.403191) ========= 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.G6sp5sB5fy/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.U5TEfkmtQK/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.005710 ========= master_lag: 0.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:42:06.844831) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-11-14 12:42:06.849183) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-11-14 12:42:08.621365) ========= ========= Total master_lag: 7.49 =========