builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1493994835.37 results: success (0) buildid: 20170505054525 builduid: e4c79c7dbfe74047b1476565fdcd92d4 revision: 3e76a9b4f4fd14595a4919b6b839549911efdc3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.367848) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.368371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.368746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.401146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.401579) ========= 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.nLN21NtOPd/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.xyChCc95X3/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-05 07:33:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.8M=0.001s 2017-05-05 07:33:55 (13.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135318 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.561925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.562315) ========= 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.nLN21NtOPd/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.xyChCc95X3/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.021595 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:55.614372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 07:33:55.617823) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e76a9b4f4fd14595a4919b6b839549911efdc3d --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 3e76a9b4f4fd14595a4919b6b839549911efdc3d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nLN21NtOPd/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.xyChCc95X3/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-05 07:33:55,695 truncating revision to first 12 chars 2017-05-05 07:33:55,695 Setting DEBUG logging. 2017-05-05 07:33:55,695 attempt 1/10 2017-05-05 07:33:55,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3e76a9b4f4fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 07:33:57,134 unpacking tar archive at: mozilla-beta-3e76a9b4f4fd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.687510 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 07:33:57.330458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:57.330887) ========= script_repo_revision: 3e76a9b4f4fd14595a4919b6b839549911efdc3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:57.331310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:57.331698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:57.352525) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-05-05 07:33:57.352832) ========= /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.nLN21NtOPd/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.xyChCc95X3/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:33:57 INFO - MultiFileLogger online at 20170505 07:33:57 in /builds/slave/test 07:33:57 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 07:33:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:57 INFO - {'append_to_log': False, 07:33:57 INFO - 'base_work_dir': '/builds/slave/test', 07:33:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:33:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:57 INFO - 'branch': 'Mozilla-Beta', 07:33:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:57 INFO - 'config_files': ('talos/mac_config.py',), 07:33:57 INFO - 'default_actions': ('clobber', 07:33:57 INFO - 'read-buildbot-config', 07:33:57 INFO - 'download-and-extract', 07:33:57 INFO - 'populate-webroot', 07:33:57 INFO - 'create-virtualenv', 07:33:57 INFO - 'install', 07:33:57 INFO - 'run-tests'), 07:33:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:57 INFO - 'download_minidump_stackwalk': True, 07:33:57 INFO - 'download_symbols': 'ondemand', 07:33:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:57 INFO - 'gecko_profile': False, 07:33:57 INFO - 'gecko_profile_interval': 0, 07:33:57 INFO - 'installer_path': 'installer.exe', 07:33:57 INFO - 'log_level': 'info', 07:33:57 INFO - 'log_name': 'talos', 07:33:57 INFO - 'log_to_console': True, 07:33:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:33:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:33:57 INFO - 'opt_config_files': (), 07:33:57 INFO - 'pip_index': False, 07:33:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:57 INFO - 'cmd': ('bash', 07:33:57 INFO - '-c', 07:33:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:57 INFO - 'enabled': True, 07:33:57 INFO - 'halt_on_failure': False, 07:33:57 INFO - 'name': 'check_screen_resolution'},), 07:33:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:57 INFO - 'cmd': ('bash', 07:33:57 INFO - '-c', 07:33:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:57 INFO - 'enabled': True, 07:33:57 INFO - 'halt_on_failure': False, 07:33:57 INFO - 'name': 'check_screen_resolution'},), 07:33:57 INFO - 'run_cmd_checks_enabled': True, 07:33:57 INFO - 'suite': 'dromaeojs', 07:33:57 INFO - 'system_bits': '32', 07:33:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:57 INFO - 'title': 't-yosemite-r7-0137', 07:33:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:57 INFO - 'use_talos_json': True, 07:33:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:57 INFO - 'work_dir': 'build'} 07:33:57 INFO - [mozharness: 2017-05-05 14:33:57.556982Z] Running clobber step. 07:33:57 INFO - Running pre-action listener: _resource_record_pre_action 07:33:57 INFO - Running main action method: clobber 07:33:57 INFO - rmtree: /builds/slave/test/build 07:33:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:00 INFO - Running post-action listener: _resource_record_post_action 07:34:00 INFO - [mozharness: 2017-05-05 14:34:00.759434Z] Finished clobber step (success) 07:34:00 INFO - [mozharness: 2017-05-05 14:34:00.759569Z] Running read-buildbot-config step. 07:34:00 INFO - Running pre-action listener: _resource_record_pre_action 07:34:00 INFO - Running main action method: read_buildbot_config 07:34:00 INFO - Using buildbot properties: 07:34:00 INFO - { 07:34:00 INFO - "project": "", 07:34:00 INFO - "product": "firefox", 07:34:00 INFO - "script_repo_revision": "production", 07:34:00 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:34:00 INFO - "repository": "", 07:34:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:34:00 INFO - "buildid": "20170505054525", 07:34:00 INFO - "pgo_build": "False", 07:34:00 INFO - "basedir": "/builds/slave/test", 07:34:00 INFO - "buildnumber": 24, 07:34:00 INFO - "slavename": "t-yosemite-r7-0137", 07:34:00 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:34:00 INFO - "platform": "yosemite_r7", 07:34:00 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:34:00 INFO - "branch": "mozilla-beta", 07:34:00 INFO - "repo_path": "releases/mozilla-beta", 07:34:00 INFO - "revision": "3e76a9b4f4fd14595a4919b6b839549911efdc3d", 07:34:00 INFO - "stage_platform": "macosx64", 07:34:00 INFO - "builduid": "e4c79c7dbfe74047b1476565fdcd92d4", 07:34:00 INFO - "slavebuilddir": "test" 07:34:00 INFO - } 07:34:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 07:34:00 INFO - Running post-action listener: _resource_record_post_action 07:34:00 INFO - [mozharness: 2017-05-05 14:34:00.762934Z] Finished read-buildbot-config step (success) 07:34:00 INFO - [mozharness: 2017-05-05 14:34:00.763069Z] Running download-and-extract step. 07:34:00 INFO - Running pre-action listener: _resource_record_pre_action 07:34:00 INFO - Running main action method: download_and_extract 07:34:00 INFO - mkdir: /builds/slave/test/build/tests 07:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:00 INFO - trying https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 07:34:00 INFO - Downloading https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 07:34:01 INFO - Downloaded 1287 bytes. 07:34:01 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:34:01 INFO - Using the following test package requirements: 07:34:01 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 07:34:01 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:34:01 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 07:34:01 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 07:34:01 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:34:01 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 07:34:01 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:34:01 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 07:34:01 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 07:34:01 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 07:34:01 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:34:01 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 07:34:01 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 07:34:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:34:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:34:01 INFO - Fetch https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:34:03 INFO - Expected file size: 51223907 07:34:03 INFO - Obtained file size: 51223907 07:34:19 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:34:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:34:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:34:19 INFO - Fetch https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:34:20 INFO - Expected file size: 51223907 07:34:20 INFO - Obtained file size: 51223907 07:34:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 07:34:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 07:34:36 INFO - Fetch https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 07:34:37 INFO - Expected file size: 14404449 07:34:37 INFO - Obtained file size: 14404449 07:34:38 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')]} 07:34:38 INFO - trying https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:34:38 INFO - Downloading https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 07:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 07:34:39 INFO - Downloaded 59558233 bytes. 07:34:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:34:39 INFO - mkdir: /builds/slave/test/properties 07:34:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:39 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:39 INFO - Contents: 07:34:39 INFO - build_url:https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:34:40 INFO - Running post-action listener: _resource_record_post_action 07:34:40 INFO - Running post-action listener: set_extra_try_arguments 07:34:40 INFO - [mozharness: 2017-05-05 14:34:40.511258Z] Finished download-and-extract step (success) 07:34:40 INFO - [mozharness: 2017-05-05 14:34:40.511375Z] Running populate-webroot step. 07:34:40 INFO - Running pre-action listener: _resource_record_pre_action 07:34:40 INFO - Running main action method: populate_webroot 07:34:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:40 INFO - '--tppagecycles', 07:34:40 INFO - '7'], 07:34:40 INFO - 'tests': ['tsvgm']}}, 07:34:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:34:40 INFO - 'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:34:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:34:40 INFO - 'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['damp', 'tps']}, 07:34:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:34:40 INFO - 'tests': ['damp', 'tps']}, 07:34:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['dromaeo_dom']}, 07:34:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['basic_compositor_video']}, 07:34:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['a11yr', 07:34:40 INFO - 'ts_paint', 07:34:40 INFO - 'tpaint', 07:34:40 INFO - 'sessionrestore', 07:34:40 INFO - 'sessionrestore_no_auto_restore', 07:34:40 INFO - 'tabpaint']}, 07:34:40 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:40 INFO - 'ts_paint', 07:34:40 INFO - 'tpaint', 07:34:40 INFO - 'sessionrestore', 07:34:40 INFO - 'sessionrestore_no_auto_restore', 07:34:40 INFO - 'tabpaint']}, 07:34:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:40 INFO - 'ts_paint', 07:34:40 INFO - 'tpaint', 07:34:40 INFO - 'sessionrestore', 07:34:40 INFO - 'sessionrestore_no_auto_restore', 07:34:40 INFO - 'tabpaint']}, 07:34:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:40 INFO - 'ts_paint', 07:34:40 INFO - 'tpaint', 07:34:40 INFO - 'sessionrestore', 07:34:40 INFO - 'sessionrestore_no_auto_restore', 07:34:40 INFO - 'tabpaint']}, 07:34:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['a11yr', 07:34:40 INFO - 'ts_paint', 07:34:40 INFO - 'tpaint', 07:34:40 INFO - 'sessionrestore', 07:34:40 INFO - 'sessionrestore_no_auto_restore', 07:34:40 INFO - 'tabpaint']}, 07:34:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['a11yr', 07:34:40 INFO - 'ts_paint', 07:34:40 INFO - 'tpaint', 07:34:40 INFO - 'sessionrestore', 07:34:40 INFO - 'sessionrestore_no_auto_restore', 07:34:40 INFO - 'tabpaint']}, 07:34:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['tsvgx', 07:34:40 INFO - 'tsvgr_opacity', 07:34:40 INFO - 'tart', 07:34:40 INFO - 'tscrollx', 07:34:40 INFO - 'cart', 07:34:40 INFO - 'tsvg_static']}, 07:34:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:40 INFO - 'tsvgr_opacity', 07:34:40 INFO - 'tart', 07:34:40 INFO - 'tscrollx', 07:34:40 INFO - 'cart', 07:34:40 INFO - 'tsvg_static']}, 07:34:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:34:40 INFO - 'talos_options': ['--disable-e10s'], 07:34:40 INFO - 'tests': ['tp5o']}, 07:34:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:34:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:34:40 INFO - 'talos_options': ['--disable-e10s', 07:34:40 INFO - '--xperf_path', 07:34:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:40 INFO - 'tests': ['tp5n']}, 07:34:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:34:40 INFO - 'talos_options': ['--xperf_path', 07:34:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:40 INFO - 'tests': ['tp5n']}}, 07:34:40 INFO - 'talos.zip': {'path': '', 07:34:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:40 INFO - Running post-action listener: _resource_record_post_action 07:34:40 INFO - [mozharness: 2017-05-05 14:34:40.529975Z] Finished populate-webroot step (success) 07:34:40 INFO - [mozharness: 2017-05-05 14:34:40.530086Z] Running create-virtualenv step. 07:34:40 INFO - Running pre-action listener: _resource_record_pre_action 07:34:40 INFO - Running main action method: create_virtualenv 07:34:40 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:40 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 07:34:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:40 INFO - Using real prefix '/tools/python27' 07:34:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:44 INFO - Installing pip.................done. 07:34:44 INFO - Return code: 0 07:34:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:34:44 INFO - Reading from file tmpfile_stdout 07:34:44 INFO - Output received: 07:34:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:34:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:44 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:44 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 07:34:44 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 07:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:44 INFO - 'HOME': '/Users/cltbld', 07:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:44 INFO - 'LOGNAME': 'cltbld', 07:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:44 INFO - 'MOZ_NO_REMOTE': '1', 07:34:44 INFO - 'NO_EM_RESTART': '1', 07:34:44 INFO - 'PAGER': '/bin/cat', 07:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:44 INFO - 'PWD': '/builds/slave/test', 07:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:44 INFO - 'SHELL': '/bin/bash', 07:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:34:44 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:44 INFO - 'USER': 'cltbld', 07:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:44 INFO - 'XPC_FLAGS': '0x0', 07:34:44 INFO - 'XPC_SERVICE_NAME': '0', 07:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:44 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 07:34:44 INFO - Cleaning up... 07:34:44 INFO - Return code: 0 07:34:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:44 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:44 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 07:34:44 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 07:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:44 INFO - 'HOME': '/Users/cltbld', 07:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:44 INFO - 'LOGNAME': 'cltbld', 07:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:44 INFO - 'MOZ_NO_REMOTE': '1', 07:34:44 INFO - 'NO_EM_RESTART': '1', 07:34:44 INFO - 'PAGER': '/bin/cat', 07:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:44 INFO - 'PWD': '/builds/slave/test', 07:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:44 INFO - 'SHELL': '/bin/bash', 07:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:34:44 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:44 INFO - 'USER': 'cltbld', 07:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:44 INFO - 'XPC_FLAGS': '0x0', 07:34:44 INFO - 'XPC_SERVICE_NAME': '0', 07:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:44 INFO - Downloading/unpacking psutil>=3.1.1 07:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:47 INFO - Installing collected packages: psutil 07:34:47 INFO - Running setup.py install for psutil 07:34:47 INFO - building 'psutil._psutil_osx' extension 07:34:47 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 07:34:47 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 07:34:47 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 07:34:47 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 07:34:47 INFO - building 'psutil._psutil_posix' extension 07:34:47 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 07:34:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:34:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:34:47 INFO - ^ 07:34:47 INFO - 1 warning generated. 07:34:47 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 07:34:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:47 INFO - Successfully installed psutil 07:34:47 INFO - Cleaning up... 07:34:48 INFO - Return code: 0 07:34:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:48 INFO - 'HOME': '/Users/cltbld', 07:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:48 INFO - 'LOGNAME': 'cltbld', 07:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:48 INFO - 'MOZ_NO_REMOTE': '1', 07:34:48 INFO - 'NO_EM_RESTART': '1', 07:34:48 INFO - 'PAGER': '/bin/cat', 07:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:48 INFO - 'PWD': '/builds/slave/test', 07:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:48 INFO - 'SHELL': '/bin/bash', 07:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:34:48 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:48 INFO - 'USER': 'cltbld', 07:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:48 INFO - 'XPC_FLAGS': '0x0', 07:34:48 INFO - 'XPC_SERVICE_NAME': '0', 07:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:34:49 INFO - Installing collected packages: mozsystemmonitor 07:34:49 INFO - Running setup.py install for mozsystemmonitor 07:34:49 INFO - Successfully installed mozsystemmonitor 07:34:49 INFO - Cleaning up... 07:34:49 INFO - Return code: 0 07:34:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:50 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:50 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 07:34:50 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 07:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:50 INFO - 'HOME': '/Users/cltbld', 07:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:50 INFO - 'LOGNAME': 'cltbld', 07:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:50 INFO - 'MOZ_NO_REMOTE': '1', 07:34:50 INFO - 'NO_EM_RESTART': '1', 07:34:50 INFO - 'PAGER': '/bin/cat', 07:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:50 INFO - 'PWD': '/builds/slave/test', 07:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:50 INFO - 'SHELL': '/bin/bash', 07:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:34:50 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:50 INFO - 'USER': 'cltbld', 07:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:50 INFO - 'XPC_FLAGS': '0x0', 07:34:50 INFO - 'XPC_SERVICE_NAME': '0', 07:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:50 INFO - Downloading/unpacking jsonschema==2.5.1 07:34:50 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 07:34:50 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 07:34:50 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 07:34:50 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 07:34:50 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 07:34:50 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 07:34:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:34:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:52 INFO - Downloading functools32-3.2.3-2.tar.gz 07:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:34:52 INFO - warning: no files found matching '*.txt' 07:34:52 INFO - no previously-included directories found matching 'build' 07:34:52 INFO - no previously-included directories found matching 'dist' 07:34:52 INFO - no previously-included directories found matching '.git*' 07:34:52 INFO - Installing collected packages: jsonschema, functools32 07:34:52 INFO - Running setup.py install for functools32 07:34:52 INFO - warning: no files found matching '*.txt' 07:34:52 INFO - no previously-included directories found matching 'build' 07:34:52 INFO - no previously-included directories found matching 'dist' 07:34:52 INFO - no previously-included directories found matching '.git*' 07:34:52 INFO - Successfully installed jsonschema functools32 07:34:52 INFO - Cleaning up... 07:34:52 INFO - Return code: 0 07:34:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:52 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:52 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 07:34:52 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 07:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:52 INFO - 'HOME': '/Users/cltbld', 07:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:52 INFO - 'LOGNAME': 'cltbld', 07:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:52 INFO - 'MOZ_NO_REMOTE': '1', 07:34:52 INFO - 'NO_EM_RESTART': '1', 07:34:52 INFO - 'PAGER': '/bin/cat', 07:34:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:52 INFO - 'PWD': '/builds/slave/test', 07:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:52 INFO - 'SHELL': '/bin/bash', 07:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:34:52 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:52 INFO - 'USER': 'cltbld', 07:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:52 INFO - 'XPC_FLAGS': '0x0', 07:34:52 INFO - 'XPC_SERVICE_NAME': '0', 07:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:34:52 INFO - Cleaning up... 07:34:52 INFO - Return code: 0 07:34:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:52 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:52 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 07:34:52 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 07:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:52 INFO - 'HOME': '/Users/cltbld', 07:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:52 INFO - 'LOGNAME': 'cltbld', 07:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:52 INFO - 'MOZ_NO_REMOTE': '1', 07:34:52 INFO - 'NO_EM_RESTART': '1', 07:34:52 INFO - 'PAGER': '/bin/cat', 07:34:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:52 INFO - 'PWD': '/builds/slave/test', 07:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:52 INFO - 'SHELL': '/bin/bash', 07:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:34:52 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:52 INFO - 'USER': 'cltbld', 07:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:52 INFO - 'XPC_FLAGS': '0x0', 07:34:52 INFO - 'XPC_SERVICE_NAME': '0', 07:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:54 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:54 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 07:34:54 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 07:34:54 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 07:34:54 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 07:34:54 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 07:34:54 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 07:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:54 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 07:34:54 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 07:34:54 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 07:34:54 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 07:34:54 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 07:34:54 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 07:34:55 INFO - Downloading docopt-0.6.1.tar.gz 07:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:55 INFO - Running setup.py install for blobuploader 07:34:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:55 INFO - Running setup.py install for requests 07:34:55 INFO - Running setup.py install for docopt 07:34:56 INFO - Successfully installed blobuploader requests docopt 07:34:56 INFO - Cleaning up... 07:34:56 INFO - Return code: 0 07:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:34:56 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 07:34:56 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 07:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:56 INFO - 'HOME': '/Users/cltbld', 07:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:56 INFO - 'LOGNAME': 'cltbld', 07:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:56 INFO - 'MOZ_NO_REMOTE': '1', 07:34:56 INFO - 'NO_EM_RESTART': '1', 07:34:56 INFO - 'PAGER': '/bin/cat', 07:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:56 INFO - 'PWD': '/builds/slave/test', 07:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:56 INFO - 'SHELL': '/bin/bash', 07:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:34:56 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:56 INFO - 'USER': 'cltbld', 07:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:56 INFO - 'XPC_FLAGS': '0x0', 07:34:56 INFO - 'XPC_SERVICE_NAME': '0', 07:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-OCk3VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Ny6v4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-w7l59Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-PLajg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-A53QiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-bz59yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-q_uPjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-7ifxYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-E_TaGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-MJxfG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-BTdpC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-uQnNH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-l979kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ru11Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JvyZnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ibx7hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-3SaJym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:58 INFO - Running setup.py install for manifestparser 07:34:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:58 INFO - Running setup.py install for mozcrash 07:34:58 INFO - Running setup.py install for mozdebug 07:34:58 INFO - Running setup.py install for mozdevice 07:34:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:58 INFO - Running setup.py install for mozfile 07:34:58 INFO - Running setup.py install for mozhttpd 07:34:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Running setup.py install for mozinfo 07:34:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Running setup.py install for mozInstall 07:34:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Running setup.py install for mozleak 07:34:59 INFO - Running setup.py install for mozlog 07:34:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Running setup.py install for moznetwork 07:34:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:59 INFO - Running setup.py install for mozprocess 07:35:00 INFO - Running setup.py install for mozprofile 07:35:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:00 INFO - Running setup.py install for mozrunner 07:35:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:00 INFO - Running setup.py install for mozscreenshot 07:35:00 INFO - Running setup.py install for moztest 07:35:00 INFO - Running setup.py install for mozversion 07:35:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:00 INFO - Cleaning up... 07:35:00 INFO - Return code: 0 07:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:00 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:35:00 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 07:35:00 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 07:35:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:35:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:00 INFO - 'HOME': '/Users/cltbld', 07:35:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:00 INFO - 'LOGNAME': 'cltbld', 07:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:00 INFO - 'MOZ_NO_REMOTE': '1', 07:35:00 INFO - 'NO_EM_RESTART': '1', 07:35:00 INFO - 'PAGER': '/bin/cat', 07:35:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:00 INFO - 'PWD': '/builds/slave/test', 07:35:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:00 INFO - 'SHELL': '/bin/bash', 07:35:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:35:00 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:35:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:00 INFO - 'USER': 'cltbld', 07:35:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:00 INFO - 'XPC_FLAGS': '0x0', 07:35:00 INFO - 'XPC_SERVICE_NAME': '0', 07:35:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-LObr4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:01 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)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-J5o6Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ANaZYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:01 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)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-_vNGm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pvZE1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:01 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)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-bB2pLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:01 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)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-UyVbhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:01 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)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-608P_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:01 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)) 07:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:01 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-OQZXhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:02 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)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IcDYTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:02 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)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-SX0ep_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:02 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)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-01DG0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-iFLzA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:02 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)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Zociyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-i3m39O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:02 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)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-vGH0w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-jdqbEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:02 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)) 07:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:02 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)) 07:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:35:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:04 INFO - Downloading blessings-1.6.tar.gz 07:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:04 INFO - Installing collected packages: blessings 07:35:04 INFO - Running setup.py install for blessings 07:35:04 INFO - Successfully installed blessings 07:35:04 INFO - Cleaning up... 07:35:04 INFO - Return code: 0 07:35:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:04 INFO - Reading from file tmpfile_stdout 07:35:04 INFO - Current package versions: 07:35:04 INFO - blessings == 1.6 07:35:04 INFO - blobuploader == 1.2.4 07:35:04 INFO - docopt == 0.6.1 07:35:04 INFO - functools32 == 3.2.3-2 07:35:04 INFO - jsonschema == 2.5.1 07:35:04 INFO - manifestparser == 1.1 07:35:04 INFO - mozInstall == 1.12 07:35:04 INFO - mozcrash == 1.0 07:35:04 INFO - mozdebug == 0.1 07:35:04 INFO - mozdevice == 0.49 07:35:04 INFO - mozfile == 1.2 07:35:04 INFO - mozhttpd == 0.7 07:35:04 INFO - mozinfo == 0.9 07:35:04 INFO - mozleak == 0.1 07:35:04 INFO - mozlog == 3.4 07:35:04 INFO - moznetwork == 0.27 07:35:04 INFO - mozprocess == 0.25 07:35:04 INFO - mozprofile == 0.28 07:35:04 INFO - mozrunner == 6.13 07:35:04 INFO - mozscreenshot == 0.1 07:35:04 INFO - mozsystemmonitor == 0.3 07:35:04 INFO - moztest == 0.8 07:35:04 INFO - mozversion == 1.4 07:35:04 INFO - psutil == 3.1.1 07:35:04 INFO - requests == 1.2.3 07:35:04 INFO - wsgiref == 0.1.2 07:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:04 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')]} 07:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:04 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')]} 07:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:04 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 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:35:04 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 07:35:04 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 07:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:04 INFO - 'HOME': '/Users/cltbld', 07:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:04 INFO - 'LOGNAME': 'cltbld', 07:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:04 INFO - 'MOZ_NO_REMOTE': '1', 07:35:04 INFO - 'NO_EM_RESTART': '1', 07:35:04 INFO - 'PAGER': '/bin/cat', 07:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:04 INFO - 'PWD': '/builds/slave/test', 07:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:04 INFO - 'SHELL': '/bin/bash', 07:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:35:05 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:05 INFO - 'USER': 'cltbld', 07:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:05 INFO - 'XPC_FLAGS': '0x0', 07:35:05 INFO - 'XPC_SERVICE_NAME': '0', 07:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 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)) 07:35:05 INFO - Cleaning up... 07:35:05 INFO - Return code: 0 07:35:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf0db0e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, '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.nLN21NtOPd/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.xyChCc95X3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 07:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:05 INFO - 'HOME': '/Users/cltbld', 07:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:05 INFO - 'LOGNAME': 'cltbld', 07:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:05 INFO - 'MOZ_NO_REMOTE': '1', 07:35:05 INFO - 'NO_EM_RESTART': '1', 07:35:05 INFO - 'PAGER': '/bin/cat', 07:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:05 INFO - 'PWD': '/builds/slave/test', 07:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:05 INFO - 'SHELL': '/bin/bash', 07:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:35:05 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:05 INFO - 'USER': 'cltbld', 07:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:05 INFO - 'XPC_FLAGS': '0x0', 07:35:05 INFO - 'XPC_SERVICE_NAME': '0', 07:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:05 INFO - Cleaning up... 07:35:05 INFO - Return code: 0 07:35:05 INFO - Running post-action listener: _resource_record_post_action 07:35:05 INFO - Running post-action listener: _start_resource_monitoring 07:35:05 INFO - Starting resource monitoring. 07:35:05 INFO - [mozharness: 2017-05-05 14:35:05.564180Z] Finished create-virtualenv step (success) 07:35:05 INFO - [mozharness: 2017-05-05 14:35:05.565196Z] Running install step. 07:35:05 INFO - Running pre-action listener: _resource_record_pre_action 07:35:05 INFO - Running main action method: install 07:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:05 INFO - Reading from file tmpfile_stdout 07:35:05 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:05 INFO - Reading from file tmpfile_stdout 07:35:05 INFO - Output received: 07:35:05 INFO - Usage: mozinstall [options] installer 07:35:05 INFO - Options: 07:35:05 INFO - -h, --help show this help message and exit 07:35:05 INFO - -d DEST, --destination=DEST 07:35:05 INFO - Directory to install application into. [default: 07:35:05 INFO - "/builds/slave/test"] 07:35:05 INFO - --app=APP Application being installed. [default: firefox] 07:35:05 INFO - mkdir: /builds/slave/test/build/application 07:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:35:20 INFO - Reading from file tmpfile_stdout 07:35:20 INFO - Output received: 07:35:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:35:20 INFO - Running post-action listener: _resource_record_post_action 07:35:20 INFO - [mozharness: 2017-05-05 14:35:20.593107Z] Finished install step (success) 07:35:20 INFO - [mozharness: 2017-05-05 14:35:20.593236Z] Running run-tests step. 07:35:20 INFO - Running pre-action listener: _resource_record_pre_action 07:35:20 INFO - Running main action method: run_tests 07:35:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:20 INFO - 2017-05-05 07:35:20.607 screenresolution[1963:10508] starting screenresolution argv=screenresolution get 07:35:20 INFO - 2017-05-05 07:35:20.610 screenresolution[1963:10508] Display 0: 1600x1200x32@60 07:35:20 INFO - 2017-05-05 07:35:20.615 screenresolution[1964:10510] starting screenresolution argv=screenresolution list 07:35:20 INFO - Available Modes on Display 0 07:35:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:20 INFO - Intel Iris: 07:35:20 INFO - Chipset Model: Intel Iris 07:35:20 INFO - Type: GPU 07:35:20 INFO - Bus: Built-In 07:35:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:35:20 INFO - Vendor: Intel (0x8086) 07:35:20 INFO - Device ID: 0x0a2e 07:35:20 INFO - Revision ID: 0x0009 07:35:20 INFO - Displays: 07:35:20 INFO - Display: 07:35:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:20 INFO - Display Serial Number: 1600x1200 60 07:35:20 INFO - Main Display: Yes 07:35:20 INFO - Mirror: Off 07:35:20 INFO - Online: Yes 07:35:20 INFO - Rotation: Supported 07:35:20 INFO - Return code: 0 07:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:20 INFO - Python 2.7.3 07:35:20 INFO - Return code: 0 07:35:20 INFO - grabbing minidump binary from tooltool 07:35:20 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')]} 07:35:20 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 0x101694d30>, '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 0x1015bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101689be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:20 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 07:35:20 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 07:35:20 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 07:35:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:20 INFO - Return code: 0 07:35:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:35:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:20 INFO - ENV: RUST_BACKTRACE is now 1 07:35:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:35:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:20 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/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 07:35:20 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/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --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 07:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nLN21NtOPd/Render', 07:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:20 INFO - 'HOME': '/Users/cltbld', 07:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:20 INFO - 'LOGNAME': 'cltbld', 07:35:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:20 INFO - 'MOZ_NO_REMOTE': '1', 07:35:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:20 INFO - 'NO_EM_RESTART': '1', 07:35:20 INFO - 'PAGER': '/bin/cat', 07:35:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:20 INFO - 'PWD': '/builds/slave/test', 07:35:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:20 INFO - 'RUST_BACKTRACE': '1', 07:35:20 INFO - 'SHELL': '/bin/bash', 07:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyChCc95X3/Listeners', 07:35:20 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 07:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:20 INFO - 'USER': 'cltbld', 07:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:20 INFO - 'XPC_FLAGS': '0x0', 07:35:20 INFO - 'XPC_SERVICE_NAME': '0', 07:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:20 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/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 07:35:21 INFO - mozversion application_buildid: 20170505054525 07:35:21 INFO - mozversion application_changeset: 3e76a9b4f4fd14595a4919b6b839549911efdc3d 07:35:21 INFO - mozversion application_display_name: Firefox 07:35:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:21 INFO - mozversion application_name: Firefox 07:35:21 INFO - mozversion application_remotingname: firefox 07:35:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:35:21 INFO - mozversion application_vendor: Mozilla 07:35:21 INFO - mozversion application_version: 54.0 07:35:21 INFO - mozversion platform_buildid: 20170505054525 07:35:21 INFO - mozversion platform_changeset: 3e76a9b4f4fd14595a4919b6b839549911efdc3d 07:35:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:35:21 INFO - mozversion platform_version: 54.0 07:35:21 INFO - using testdate: 1493994921 07:35:21 INFO - actual date: 1493994921 07:35:21 INFO - starting webserver on 'localhost:49361' 07:35:21 INFO - SUITE-START | Running 2 tests 07:35:21 INFO - TEST-START | dromaeo_css 07:35:21 INFO - operating with platform_type : mac_ 07:35:21 INFO - Initialising browser for dromaeo_css test... 07:35:21 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpyGpuUI/profile http://localhost:49361/getInfo.html) 07:35:23 INFO - PROCESS | 1974 | __metrics Screen width/height:1600/1200 07:35:23 INFO - PROCESS | 1974 | colorDepth:24 07:35:23 INFO - PROCESS | 1974 | Browser inner width/height: 1024/689 07:35:23 INFO - PROCESS | 1974 | __metrics 07:35:23 INFO - PROCESS | 1974 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:35:23 INFO - PROCESS | 1974 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:24 INFO - TEST-INFO | 1974: exit 0 07:35:24 INFO - Browser initialized. 07:35:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:35:24 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpyGpuUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:36 INFO - PROCESS | 1977 | RSS: Main: 165187584 07:35:36 INFO - PROCESS | 1977 | 07:38:39 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49361/tests/dromaeo/cssquery-ext.html) 07:38:42 INFO - PROCESS | 1977 | RSS: Main: 374468608 07:38:42 INFO - PROCESS | 1977 | 07:41:45 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-ext.html (next: http://localhost:49361/tests/dromaeo/cssquery-jquery.html) 07:41:46 INFO - PROCESS | 1977 | RSS: Main: 301518848 07:41:46 INFO - PROCESS | 1977 | 07:44:48 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49361/tests/dromaeo/cssquery-mootools.html) 07:44:49 INFO - PROCESS | 1977 | RSS: Main: 282529792 07:44:49 INFO - PROCESS | 1977 | 07:47:51 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49361/tests/dromaeo/cssquery-prototype.html) 07:47:52 INFO - PROCESS | 1977 | RSS: Main: 270495744 07:47:52 INFO - PROCESS | 1977 | 07:50:55 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49361/tests/dromaeo/cssquery-yui.html) 07:50:56 INFO - PROCESS | 1977 | RSS: Main: 269279232 07:50:56 INFO - PROCESS | 1977 | 07:53:59 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-yui.html (next: http://localhost:49361/tests/dromaeo/cssquery-dojo.html) 07:54:00 INFO - PROCESS | 1977 | RSS: Main: 305250304 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | __start_tp_report 07:54:00 INFO - PROCESS | 1977 | _x_x_mozilla_page_load 07:54:00 INFO - PROCESS | 1977 | _x_x_mozilla_page_load_details 07:54:00 INFO - PROCESS | 1977 | |i|pagename|runs| 07:54:00 INFO - PROCESS | 1977 | |0;dojo.html;3470.4620783778514;3500.2649443616847;3519.9648003519956;3565.500829883815;3578.7852728836274;4995.2257400103;5270;5887.969605319068;6175.228096487939;6218.347073557279;6154.138420621117;6184.752609895599;6206.1931948846695;6221.688915554216;6229.159063526423;5383.084875571143;5385.838424847261;5409.24270602116;5428.83713488596;5586.022446071942;5306.044911915854;5343.919841202385;5381.842903775688;5537.307836520435;5550;4617.515160908107;5453.836384908459;5506.64206826555;5507.834764957058;5534.252875861747;5493.148561972901;5516.255305533782;5525.944740552583;5528.253685752412;5538.224648549206;5376.892462150774;5422;5431.728413579344;5449.455054494519;5484.451554844523;5955.315138759055;5980.282366116094;6008.429199226067;6050.878982420327;6064.878702425926;6366.172397588284;6405.167328247345;6423.710933007979;6425.678716064178;6461.12774775404;6443.806685799434;6447.613143211375;6461.289258181596;6484.967575162141;6495.6752162391695;6089.330173680892;6129.817282374534;6131.315499378962;6131.478824299985;6191.164192834;6610.933890661128;6623.205215374186;6623.503237257225;6630.336966303331;6666.166729158856;5429.701366424805;6453.354664533603;6459.967700161469;6463.256725476536;6467.579607325509;6545.967270163619;6617;6617.139771829631;6624.105745724266;6626.105475760807;5476.315460567429;6517.51118666102;6526.053722210253;6536.117624120778;6541.443977261891;6218.533609979269;6262.780802671885;6275.560710750204;6335.1447554579545;6431.967840160863;5241.50205730455;5268.578513718893;5282.630215884851;5301.973490132525;5318.9202161967605;4665.86002419928;4687.718736875799;4694.976525117352;4702.059588082398;4753.405824271966;6137.355577664371;6144.218176728788;6148.770245950827;6245.656488893063;6262.467690246289;6439.871202575922;6469.644169570624;6559.376859198369;6581.2760596334365;6583.506237032242;6228.159198508234;6247;6248.968755156286;6264.718087685974;6269.62382257066;5402.648827826258;5801.564882633819;5850;5865.384134665798;5865.5285790318885;6541.018847172867;6563.868722625616;6776.457883369417;6809.38715515606;6903.206131294965;6603.042558829039;6612.40488356031;6629.602223866584;6638.269790323157;6639.3692599203;6773.119494465688;6869.553479023847;6887;6904.965475172592;6913.446924246149;6273.811785646438;6338.619682819046;6380.074889140956;6480.578762380619;6503.674816259263;5547.33431988164;6587.440067594116;6589.0775291460195;6601.306862779339;6610.768623098168;6335.936640633719;6406.775762848464;6421.165248517663;6438.806835794933;6442.8389290268115;6209.285932117864;6239.220097487814;6372.713227904663;6402.839929001812;6403.359664033559;6217.440430361289;6337.397947195009;6357.777477788255;6359.713812878339;6364.172657554488;6347.333529979285;6350.523710721622;6350.968245158745;6354.046892966092;6365.458935990493;6116.8227554565365;6144.1567529740005;6152.938470615237;6161.106639537153;6211.3478084802255 07:54:00 INFO - PROCESS | 1977 | |1;ext.html;818.2308629887906;827.6523859978809;897.138746803069;902.3728508686462;994.1847684898377;39289.803550982244;39471.40792888105;39494.60505394945;41312.38031429523;41556.961075973115;39383.409248861215;39725.80137099318;39745.60254397455;39808;39811.80094099533;8030.7590772276635;8190.50856948582;8232.629531671075;8360.45657032294;11854.407279636027;11909.940450297736;12049.03607711381;12053.63839084829;12060.819087713691;12065.276083434977;12038.759224815498;12060.698482537919;12063;12076.275423474575;12090.093243006766;12028.27830330183;12028.939855300667;12031.699207519794;12057;12061.819072713917;11604.361760103191;11674.416279186007;11681.007114395286;11685.123615728855;11697.298162110215;40912.59087409118;41148.588514114774;41171;41185;41198.38202426966;3969.384745364473;4018.839246430139;4040.878773636796;4046.7167298289132;4066.4713587233764;28287.009954651694;28894.566581501294;30037.399252015057;30879.691203088132;30910.53634195489;3184.9363012739846;3248.7888287261253;3312.751543634237;3322.3753234944365;3421.4354631485776;347747;351968;352125.99999999744;352743;353603;44567.55432445634;45461.54538454639;54029;54121.72939135279;54653.45346546563;54899;57534.13698794522;57664;57671.71164144152;57714.8457030857;15993.040417574983;16105.677886442205;16107.758383624256;16113.27490262941;16131.274092665859;13592.252426116658;13632.863671363159;13659.521916732867;13671.931640341934;13855.584332470042;13426.194428334331;13432.529861454997;13453.596392108253;13554.728905421836;13571.796423053662;5033.5469807716745;5924.822255332347;5989.371116032841;6022.97609406402;6098.390160983866;1137.7724455109012;1149.9885001150049;1159.171192597297;1170.145793570698;1235.8146278058184;21328.78671213268;25886.48227035449;27814.820351821236;28208;28370.43259134847;1055.4036969112426;1128.0848399312165;1289.1749280460513;1310.6919873829643;1338.7188690374935;10942.835857462145;14417.711645767025;14419.711605767827;14687.090678211978;14851.331690073972;509806;513363;513721;513959;514807;58922.70538647365;59471.70264148652;59473.702631486565;59735;59747.701261493414;1463.75116230239;1483.243545791654;1494.1558019718825;1505.7515509940956;1508.2232650184944;27681;27850;28339.71660283371;28755.856220718764;28857.56713649255;42360.78819605882;42691.78654106834;42701.35947960721;42716.57283427126;42723.7863810679;446050;449011;449563;449717;543351;28548.858045677942;28819.855900720362;28940;33637.49543756895;34781;31906.883259085822;33400;38386.232275354894;40921.57026457522;42561.93595160146;19868.90065549663;28089.297767555974;28192.872285108366;29152.708472915;29941;25349.493010140064;29168.416631666823;29893.551596725632;30000;30179.245518862204;34388;35154.82422587871;35174.472382913766;35203.64796352004;35227.47158792569;29542;29682;29749.10752677423;30365.089047328616;30440.84779576088;24132.87933560321;24226.273211803673;24317.39206519851;24482.51034979255;24676.876615616806 07:54:00 INFO - PROCESS | 1977 | |2;jquery.html;434.2032370599949;438.56801050964793;440.9492908315545;440.95149533551324;441.93370994350846;20341.389758307258;21560.13759449622;22689.886550567226;22939.42651433715;22989.08043678253;23145.652815207744;23748;24178.87910560449;24446.266612001626;24661.0135594576;6674.466042716595;6772.288909664476;6956.4087052600335;7018;7081.327273908971;6779.62712050837;6897.448204143657;6900.965495172542;6918.619475928822;6983.68573414195;6618.007298905179;6857.417119544844;6973.476989225803;6975.581465112109;6990.755323563676;6907.896381554281;6960.686769095378;6970.30296970304;7431.739889103856;7739.61301934901;7551.622418879034;7620.352270057052;7621.237876212334;7648;7657;26991.73008269912;27492.762825672693;27550.724492755016;27781.305467363276;27871.86064069667;3020.8312528710458;3026.273694313349;3074.064268623459;3156.463401221798;3233.0462513558555;16429.507114786575;16632.002079875245;16698.58253543659;16896.239669214792;17383.30466781327;2054.866433681821;2058.0018690934885;2060.64968955278;2066.1941842681367;2127.98936005319;137883.31058344644;143676;155199;156205;157569.21215393848;19431.611367772566;19729.210831566576;20060.69908951367;20083.297084601967;20429;31676.89130880454;32059.51910721341;32067.839660802012;32186;32192;10490.318129321722;10586.89413105859;10820.593322868133;10840.5121769519;10974.615888443866;7416.666250018654;8724.912750872538;9048.638054477879;9067.914379692707;9173.03683113277;9247;9439;9462.57418416173;9468.810623787485;9479.24166066713;3107.735842453417;3137.952930706041;3476.947845782315;3874.360730479439;3977.3636218204947;1029.1869423155624;1035.9896401035894;1054.3130990415427;1055.667464748617;1068.9091427228773;21244;21383.67924481134;21500.892495537733;21509.892450537962;21521.569568608542;1030.5002073994108;1033.720895358249;1068.930519516229;1074.2265568790458;1079.0989523747758;10751.301165424222;11352.148588855704;11505.986452370802;11522.481488333045;11542.018928391013;661236;750409;767944;781655.0917245378;791043;102302.48848755857;147934.90488213426;165875;168418;172582;1186.8635106962638;1317.611304665107;1337.0840973932693;1368.2953279061292;1368.438940034601;20420;20571.8971405142;21030.57938841245;21041.368758937257;21058.2629607963;59102;62380;62639.06041409474;62866.68566657137;63127.0530942027;88004.55997719971;88224;88791.55604221938;90294;90428;9575.664851730156;11485.712857178638;11571.6528504145;11904.523819047488;12317.507299707911;13040.282784446947;13545.796813047615;13766.793498097337;14008.719825603226;14148.009639325148;11540.422978851191;11631.941840290745;11742.471588778697;11990.220635658654;12115.151939364512;10146.543405546916;10281.53733082028;10898.836517452086;10982.670519884416;11225.438728063727;11751.236169648946;11811.350375729417;11958.402079896145;12126.393680316125;12158.513659453523;11804.527818887149;11950.46222919988;11989.220700654778;12150.75698486043;12262.754744904874;10457.529411176667;11122.221444498808;11636.650900473;11760.764784704086;11805.173637845612 07:54:00 INFO - PROCESS | 1977 | |3;mootools.html;1227;1459.9270036498176;1584.1208129488136;1609.8551130398262;1622.367276762063;10510.632127875526;11510.769784604303;11528.193026488148;11532.308061516314;11542.65372038838;10957.890421095786;11231.831522527149;11258.268212566178;11408.771824563504;11491.770164596724;2493.6259561065804;2542.1102614085016;2545.6690630218045;2547.541442540342;2547.7070136934212;2469.962950555743;2480.8635525046116;2521.2940376694555;2522.066835270952;2523.911663091792;2451.632255161731;2492.3270716906422;2497.7876880465183;2513.49730053989;2519.722830488645;2423.8545687258643;2471.7775400213977;2487.788537974265;2506.035176457059;2522.5585522533665;2093.9371818845457;2231.252530402317;2330.0563271874917;2491.8380305280098;2504.6994360676654;11173.664790056311;11365.147613928906;11389.145814063979;11397.974182323547;11400.372979486125;5996.940030599681;6158.969205153946;6192.504599632019;6203.689815509251;6205.875882482325;3701.8889433316776;3784.129650180474;3860.498135242429;3871.612838716134;3938.8424463021443;1256.0265794009715;1919.673655478558;1923.4998900285887;1978.6735188693992;1999.5700924301345;14144.504942327072;14285;14800.963932524835;15822.287997040161;16026.439074632448;4765.451973023078;4939.777710003059;4946.1344264753525;4967.155583550805;4969.602431805447;11919.88080119205;12037.518499259932;12046.759064818654;12059;12065.758684826254;4928.802847886044;5165.380154381498;5317.096093664087;6064.393560643988;6068.666223357669;5410.972945135328;5525.060739674184;5597.776088956478;5605.691686957257;5626.2967129108865;3360.8487618057247;3506.1760486285702;3926.332523471017;4055.270051390778;4145.647619952338;955.5222388805597;1047.6490375724218;1074.4573990135088;1078.1698092468755;1080.9675709728722;895.7312806158127;913.5340976102236;917.8118485710413;929.5741184390288;955.6416343871049;5757.913631295534;6679.165104361955;6704.966475167593;6710.228323742735;6777.898331525031;886.8072442564741;952.661805059194;988.9406635601887;1001.0940099210227;1004.5630150884242;4110.835566577363;4146.896327591834;4297.162053399557;4300.247456695066;4407.294832826732;12158.392080395945;12611.243325400323;12617.684557886127;12623;12637.684057898627;11631.76736465283;12340.382980850922;12394.442250098768;12471.5011399543;12497.812532812015;9968;10315.535800888827;10322;10522.789544209227;10532.789344213073;6335.968320158369;6572.8356791080605;6745.763898263537;6959.26927672587;7052.858942821217;12117.75764484723;12584.993200544117;12594.937025314815;12632;12854.357282136043;11711.590094346657;12086.335251560897;12206.75586488283;12481.188722732993;12571.931385832308;9276.582553784961;9542.761430964003;9555.474448905377;9559.522023898917;9585.233181345615;10098.949505252427;10274.486275686335;10411;10436.843447348449;10438.21713371485;8754.25588824957;8778.122187781171;8863.157999989991;9066.682666106655;9138.588763505792;8762.07998160184;8805.471671699463;8806.559672016245;8863.556822158736;8883.42257753244;7946.364290856834;8133.593320333841;8144.470609410369;8170.101288858102;8183.590820459072;5989.131575921554;6012.969935150296;6028.90956635642;6194.535409844189;6204.534659900435;5218;6017.398260173947;6156.1381406604005;6306.653134077486;6329.335419780857 07:54:00 INFO - PROCESS | 1977 | |4;prototype.html;284.9586809912563;382.45691118611603;383.4612369620683;389.58703773999565;392.242971065843;4249.625561657517;4565.543445655441;4655.860324190276;4881.804727810888;4914.336564563783;4534.682572219937;4601.838935637254;4841.322214889909;5073.670211436254;5237.633365664405;4164.541900390955;4249.19265339586;4295.7852107394665;4350.695451318409;4519.548045195487;3436.299031979174;3579.9642003579893;4279.33670281107;4337.1325734853;4370.4318438603095;3464.4882460216395;4186.958130418688;4255.872063968016;4336;4356.607905288523;3687.3178461984485;3693.765272010449;3748.4939533163083;3848.5574158971795;4337.8481753138485;3434.742394320436;3781.6596506314563;3941.369380899071;3983.7609743415487;4013.97993010036;3964.147708242742;4279.935800962988;4669.824519326857;4761.857144285677;5092.949070509285;4319.509769129645;5061.696298222082;5064.468230835783;5078.847634570969;5086.516780905808;4655.930161047587;4952.405711314629;5005.0990821652085;5547.195656629807;5592.273004509429;4432.401625780542;4487.083395792728;4518.299663552122;4528.818847246106;4529.614982726473;4917.72952487613;4992.375953005874;5340.07757207405;5488.859344855509;5801.361850196475;3767.7927713975446;3770.6606405423645;4355.80398882051;4577.992841574915;4631.861044168613;4134.64855487287;4193.685473589493;4374.78126093694;4700.824793801549;4776.307435421844;4079.3676980068135;4863.781129849165;4866.902661946741;5063.518965698253;5072.6195535335;5607.532685618315;5609.046462101371;5610.607257492018;5625.690587017753;5696.974544582015;1478;1566.686662667471;1586.5319730679478;1597.9840201597835;1609.1954022988505;1081.5727787523883;1089.9536445012718;1109.7626146846208;1158.009901534193;1230.944607492665;4453.465584129925;4515.751633660115;4716.575508204278;4755.38180036593;4966.826161084345;5095.668781529189;5366.731663416814;5501.614886957875;5840.795572154954;5855.619384739978;4530.977345113253;4668.5760842942545;4936.802527898915;4967.776450059756;5162.767675454538;2805.9859700701772;2874.6837847836723;2996.7374632152587;2998.580198772174;3015.9246018849703;4953.058918805487;5145.845624631267;5181.948180518147;5875.265591801025;5905.40554050404;5447.612666758614;5517.503424691797;5705.147426286857;5719.656820590778;5764.279465066867;4752.619790416758;5146.794128234828;5193.091209038404;5437.075697131497;6031.8237943602335;5429.782808687608;5519.089350257163;5659;5701.315842098975;5812.587776073052;5144.636671282188;5628.409017053151;5692.686902220252;5703.258576385043;5718.571107166896;5362.793371491383;5428.45715428454;5612.719364031864;5788.913166302593;5846.707664616837;3784.5836957934052;4125.628693417607;4303.246931786862;4354.956450435455;4616.399208617284;4550.294704320836;5410.675359478444;5586.994341018656;5838.5621078418435;5878.794242201502;5021.430498246578;5119;5309.946900531099;5368.557306425645;5406.026915155153;4810.374651295309;4878.756062196947;4972.801087956441;4985.930838701898;5558.972205138948;4834.380482538389;5175.792968281226;5379.73101344939;5430.565554755689;5480.861949228307;4713.835015774432;5019.422766381913;5423.430539793423;5628.409017053151;5639;4621.445426548836;4725.535084123932;4914.557689807934;5477.643953143033;5527.336719593674 07:54:00 INFO - PROCESS | 1977 | |5;yui.html;703.0719450325566;708.7731925783748;761.653447681305;821.8972628421446;833.766545367297;14998.325075371607;16409.671806563892;16472.752908706378;16540.669186616262;16541.75187372189;14547.854521454783;15549.84450155498;15720.37118515258;15796.210189490508;15822;982.2731178927596;984.3109823123806;986.1075726467558;986.6743974488437;991.0188912976138;975.3367709957226;981.3277904635312;1004.2769206171545;1026.794641071785;1034.8551202831609;1075.451519724942;1076.6608518316743;1078.557791305565;1080.573173596429;1082.4317233452462;1072.222638587026;1073.3452593917705;1073.3828048871892;1074.4359211413991;1080.76763495848;796.0487217774704;796.0725754496005;796.7330944133722;797.2067792546453;799.2806474173233;15968.361265549363;16287;16331.938424002401;16644.001359918442;16881.83118168815;14144;14257;14298.499552515716;14330;14348.28258587077;11509.539618415254;11688.474018669096;11794.764104717944;11822.586209482626;11848.585299514561;3636.890893273206;3673.540807399075;3696.981515092434;3812.046988252937;3879.7478163919254;110899;118776;123629;124835;126990;10617.362958222531;10904.727381815517;11075.944620276847;11150.940660637227;11432.971032607105;22536.211232607107;22792.658110128363;22919.083236670678;22970.08119675228;23003.88498057499;7682.193369696213;7877.448578599558;7950.4832185907735;8055.355571554262;8203.548804815793;4471.217536931024;4552.704074235164;4572.497025327211;4613.653975951817;4785.210440277316;3527;3640.8543658253375;3645.1251699591908;3649.7225970909967;3662.5421822272215;633.1484153813115;645.1967300710645;670.792054463118;679.1544527063837;679.5582871133803;712.2058904321748;714.1109318898006;718.4432065149551;719.0257201492008;725.372552741885;9992.25058120644;10222.948885255526;10358.466380372418;10584.841227381596;10704.250702450909;671.3286713286714;693.9930600693929;699.989500157498;708.7377670262036;714.1965289049818;3972.880813575597;4345.3699213613845;5045.7981680732355;5098.4646612105935;5102.3877134743325;104363.47818261012;108055;108058.91941080645;108881.45559272153;109920.35119473214;60890.39053960122;62852.685736571024;94501;97559;98621.50689246508;64208.67895660492;65438.345616544175;65716.67141664357;80037.19962800297;80418.19581804224;11012.614558490415;11016.394098324668;11422.771544569228;11459.942700286445;11475.770484590095;47080.52919470761;49000.52998410053;49751.25373119478;50242.24636630526;50639;50022.74943126305;65562;65851.68296633945;66265.33734662592;72618.18454538679;12971.610851674464;13335;13604;13916.095453795471;13986.580402587939;15069.47256846005;15106;15153.202788579174;15313.081215127128;15435.691286174439;14144;14222.35999380051;14462.783058254345;14674.192919389536;14892.180930048951;12383.504659813507;13136.27750473733;14047.227402492961;14108.36512356926;14240.35918383696;13872.203164712073;14044.438222470986;14118.50585229512;14383;14545.054571452822;8136.22705842944;9508.809823803347;9600.519974001132;9876.50617469138;9980.301378903407;11132.276402033842;11228.214025018171;11456.140789440658;11589.536418543164;11633.767324653629 07:54:00 INFO - PROCESS | 1977 | __end_tp_report 07:54:00 INFO - PROCESS | 1977 | __start_cc_report 07:54:00 INFO - PROCESS | 1977 | _x_x_mozilla_cycle_collect,2514 07:54:00 INFO - PROCESS | 1977 | __end_cc_report 07:54:00 INFO - PROCESS | 1977 | __startTimestamp1493996040216__endTimestamp 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | ------- Summary: start ------- 07:54:00 INFO - PROCESS | 1977 | Number of tests: 6 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | [#0] dojo.html Cycles:165 Average:6030.18 Median:6247.00 stddev:686.17 (11.0%) stddev-sans-first:658.23 07:54:00 INFO - PROCESS | 1977 | Values: 3470.5 3500.3 3520.0 3565.5 3578.8 4995.2 5270.0 5888.0 6175.2 6218.3 6154.1 6184.8 6206.2 6221.7 6229.2 5383.1 5385.8 5409.2 5428.8 5586.0 5306.0 5343.9 5381.8 5537.3 5550.0 4617.5 5453.8 5506.6 5507.8 5534.3 5493.1 5516.3 5525.9 5528.3 5538.2 5376.9 5422.0 5431.7 5449.5 5484.5 5955.3 5980.3 6008.4 6050.9 6064.9 6366.2 6405.2 6423.7 6425.7 6461.1 6443.8 6447.6 6461.3 6485.0 6495.7 6089.3 6129.8 6131.3 6131.5 6191.2 6610.9 6623.2 6623.5 6630.3 6666.2 5429.7 6453.4 6460.0 6463.3 6467.6 6546.0 6617.0 6617.1 6624.1 6626.1 5476.3 6517.5 6526.1 6536.1 6541.4 6218.5 6262.8 6275.6 6335.1 6432.0 5241.5 5268.6 5282.6 5302.0 5318.9 4665.9 4687.7 4695.0 4702.1 4753.4 6137.4 6144.2 6148.8 6245.7 6262.5 6439.9 6469.6 6559.4 6581.3 6583.5 6228.2 6247.0 6249.0 6264.7 6269.6 5402.6 5801.6 5850.0 5865.4 5865.5 6541.0 6563.9 6776.5 6809.4 6903.2 6603.0 6612.4 6629.6 6638.3 6639.4 6773.1 6869.6 6887.0 6905.0 6913.4 6273.8 6338.6 6380.1 6480.6 6503.7 5547.3 6587.4 6589.1 6601.3 6610.8 6335.9 6406.8 6421.2 6438.8 6442.8 6209.3 6239.2 6372.7 6402.8 6403.4 6217.4 6337.4 6357.8 6359.7 6364.2 6347.3 6350.5 6351.0 6354.0 6365.5 6116.8 6144.2 6152.9 6161.1 6211.3 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | [#1] ext.html Cycles:180 Average:58139.42 Median:30402.97 stddev:119589.90 (393.3%) stddev-sans-first:119847.94 07:54:00 INFO - PROCESS | 1977 | Values: 818.2 827.7 897.1 902.4 994.2 39289.8 39471.4 39494.6 41312.4 41557.0 39383.4 39725.8 39745.6 39808.0 39811.8 8030.8 8190.5 8232.6 8360.5 11854.4 11909.9 12049.0 12053.6 12060.8 12065.3 12038.8 12060.7 12063.0 12076.3 12090.1 12028.3 12028.9 12031.7 12057.0 12061.8 11604.4 11674.4 11681.0 11685.1 11697.3 40912.6 41148.6 41171.0 41185.0 41198.4 3969.4 4018.8 4040.9 4046.7 4066.5 28287.0 28894.6 30037.4 30879.7 30910.5 3184.9 3248.8 3312.8 3322.4 3421.4 347747.0 351968.0 352126.0 352743.0 353603.0 44567.6 45461.5 54029.0 54121.7 54653.5 54899.0 57534.1 57664.0 57671.7 57714.8 15993.0 16105.7 16107.8 16113.3 16131.3 13592.3 13632.9 13659.5 13671.9 13855.6 13426.2 13432.5 13453.6 13554.7 13571.8 5033.5 5924.8 5989.4 6023.0 6098.4 1137.8 1150.0 1159.2 1170.1 1235.8 21328.8 25886.5 27814.8 28208.0 28370.4 1055.4 1128.1 1289.2 1310.7 1338.7 10942.8 14417.7 14419.7 14687.1 14851.3 509806.0 513363.0 513721.0 513959.0 514807.0 58922.7 59471.7 59473.7 59735.0 59747.7 1463.8 1483.2 1494.2 1505.8 1508.2 27681.0 27850.0 28339.7 28755.9 28857.6 42360.8 42691.8 42701.4 42716.6 42723.8 446050.0 449011.0 449563.0 449717.0 543351.0 28548.9 28819.9 28940.0 33637.5 34781.0 31906.9 33400.0 38386.2 40921.6 42561.9 19868.9 28089.3 28192.9 29152.7 29941.0 25349.5 29168.4 29893.6 30000.0 30179.2 34388.0 35154.8 35174.5 35203.6 35227.5 29542.0 29682.0 29749.1 30365.1 30440.8 24132.9 24226.3 24317.4 24482.5 24676.9 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | [#2] jquery.html Cycles:180 Average:43307.00 Median:11755.83 stddev:125287.09 (1065.7%) stddev-sans-first:125597.19 07:54:00 INFO - PROCESS | 1977 | Values: 434.2 438.6 440.9 441.0 441.9 20341.4 21560.1 22689.9 22939.4 22989.1 23145.7 23748.0 24178.9 24446.3 24661.0 6674.5 6772.3 6956.4 7018.0 7081.3 6779.6 6897.4 6901.0 6918.6 6983.7 6618.0 6857.4 6973.5 6975.6 6990.8 6907.9 6960.7 6970.3 7431.7 7739.6 7551.6 7620.4 7621.2 7648.0 7657.0 26991.7 27492.8 27550.7 27781.3 27871.9 3020.8 3026.3 3074.1 3156.5 3233.0 16429.5 16632.0 16698.6 16896.2 17383.3 2054.9 2058.0 2060.6 2066.2 2128.0 137883.3 143676.0 155199.0 156205.0 157569.2 19431.6 19729.2 20060.7 20083.3 20429.0 31676.9 32059.5 32067.8 32186.0 32192.0 10490.3 10586.9 10820.6 10840.5 10974.6 7416.7 8724.9 9048.6 9067.9 9173.0 9247.0 9439.0 9462.6 9468.8 9479.2 3107.7 3138.0 3476.9 3874.4 3977.4 1029.2 1036.0 1054.3 1055.7 1068.9 21244.0 21383.7 21500.9 21509.9 21521.6 1030.5 1033.7 1068.9 1074.2 1079.1 10751.3 11352.1 11506.0 11522.5 11542.0 661236.0 750409.0 767944.0 781655.1 791043.0 102302.5 147934.9 165875.0 168418.0 172582.0 1186.9 1317.6 1337.1 1368.3 1368.4 20420.0 20571.9 21030.6 21041.4 21058.3 59102.0 62380.0 62639.1 62866.7 63127.1 88004.6 88224.0 88791.6 90294.0 90428.0 9575.7 11485.7 11571.7 11904.5 12317.5 13040.3 13545.8 13766.8 14008.7 14148.0 11540.4 11631.9 11742.5 11990.2 12115.2 10146.5 10281.5 10898.8 10982.7 11225.4 11751.2 11811.4 11958.4 12126.4 12158.5 11804.5 11950.5 11989.2 12150.8 12262.8 10457.5 11122.2 11636.7 11760.8 11805.2 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | [#3] mootools.html Cycles:180 Average:6792.75 Median:2533.01 stddev:4117.16 (162.5%) stddev-sans-first:4107.46 07:54:00 INFO - PROCESS | 1977 | Values: 1227.0 1459.9 1584.1 1609.9 1622.4 10510.6 11510.8 11528.2 11532.3 11542.7 10957.9 11231.8 11258.3 11408.8 11491.8 2493.6 2542.1 2545.7 2547.5 2547.7 2470.0 2480.9 2521.3 2522.1 2523.9 2451.6 2492.3 2497.8 2513.5 2519.7 2423.9 2471.8 2487.8 2506.0 2522.6 2093.9 2231.3 2330.1 2491.8 2504.7 11173.7 11365.1 11389.1 11398.0 11400.4 5996.9 6159.0 6192.5 6203.7 6205.9 3701.9 3784.1 3860.5 3871.6 3938.8 1256.0 1919.7 1923.5 1978.7 1999.6 14144.5 14285.0 14801.0 15822.3 16026.4 4765.5 4939.8 4946.1 4967.2 4969.6 11919.9 12037.5 12046.8 12059.0 12065.8 4928.8 5165.4 5317.1 6064.4 6068.7 5411.0 5525.1 5597.8 5605.7 5626.3 3360.8 3506.2 3926.3 4055.3 4145.6 955.5 1047.6 1074.5 1078.2 1081.0 895.7 913.5 917.8 929.6 955.6 5757.9 6679.2 6705.0 6710.2 6777.9 886.8 952.7 988.9 1001.1 1004.6 4110.8 4146.9 4297.2 4300.2 4407.3 12158.4 12611.2 12617.7 12623.0 12637.7 11631.8 12340.4 12394.4 12471.5 12497.8 9968.0 10315.5 10322.0 10522.8 10532.8 6336.0 6572.8 6745.8 6959.3 7052.9 12117.8 12585.0 12594.9 12632.0 12854.4 11711.6 12086.3 12206.8 12481.2 12571.9 9276.6 9542.8 9555.5 9559.5 9585.2 10098.9 10274.5 10411.0 10436.8 10438.2 8754.3 8778.1 8863.2 9066.7 9138.6 8762.1 8805.5 8806.6 8863.6 8883.4 7946.4 8133.6 8144.5 8170.1 8183.6 5989.1 6013.0 6028.9 6194.5 6204.5 5218.0 6017.4 6156.1 6306.7 6329.3 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | [#4] prototype.html Cycles:180 Average:4526.83 Median:4852.55 stddev:1264.66 (26.1%) stddev-sans-first:1227.48 07:54:00 INFO - PROCESS | 1977 | Values: 285.0 382.5 383.5 389.6 392.2 4249.6 4565.5 4655.9 4881.8 4914.3 4534.7 4601.8 4841.3 5073.7 5237.6 4164.5 4249.2 4295.8 4350.7 4519.5 3436.3 3580.0 4279.3 4337.1 4370.4 3464.5 4187.0 4255.9 4336.0 4356.6 3687.3 3693.8 3748.5 3848.6 4337.8 3434.7 3781.7 3941.4 3983.8 4014.0 3964.1 4279.9 4669.8 4761.9 5092.9 4319.5 5061.7 5064.5 5078.8 5086.5 4655.9 4952.4 5005.1 5547.2 5592.3 4432.4 4487.1 4518.3 4528.8 4529.6 4917.7 4992.4 5340.1 5488.9 5801.4 3767.8 3770.7 4355.8 4578.0 4631.9 4134.6 4193.7 4374.8 4700.8 4776.3 4079.4 4863.8 4866.9 5063.5 5072.6 5607.5 5609.0 5610.6 5625.7 5697.0 1478.0 1566.7 1586.5 1598.0 1609.2 1081.6 1090.0 1109.8 1158.0 1230.9 4453.5 4515.8 4716.6 4755.4 4966.8 5095.7 5366.7 5501.6 5840.8 5855.6 4531.0 4668.6 4936.8 4967.8 5162.8 2806.0 2874.7 2996.7 2998.6 3015.9 4953.1 5145.8 5181.9 5875.3 5905.4 5447.6 5517.5 5705.1 5719.7 5764.3 4752.6 5146.8 5193.1 5437.1 6031.8 5429.8 5519.1 5659.0 5701.3 5812.6 5144.6 5628.4 5692.7 5703.3 5718.6 5362.8 5428.5 5612.7 5788.9 5846.7 3784.6 4125.6 4303.2 4355.0 4616.4 4550.3 5410.7 5587.0 5838.6 5878.8 5021.4 5119.0 5309.9 5368.6 5406.0 4810.4 4878.8 4972.8 4985.9 5559.0 4834.4 5175.8 5379.7 5430.6 5480.9 4713.8 5019.4 5423.4 5628.4 5639.0 4621.4 4725.5 4914.6 5477.6 5527.3 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - PROCESS | 1977 | [#5] yui.html Cycles:180 Average:20840.42 Median:16762.92 stddev:30327.87 (180.9%) stddev-sans-first:30375.25 07:54:00 INFO - PROCESS | 1977 | Values: 703.1 708.8 761.7 821.9 833.8 14998.3 16409.7 16472.8 16540.7 16541.8 14547.9 15549.8 15720.4 15796.2 15822.0 982.3 984.3 986.1 986.7 991.0 975.3 981.3 1004.3 1026.8 1034.9 1075.5 1076.7 1078.6 1080.6 1082.4 1072.2 1073.3 1073.4 1074.4 1080.8 796.0 796.1 796.7 797.2 799.3 15968.4 16287.0 16331.9 16644.0 16881.8 14144.0 14257.0 14298.5 14330.0 14348.3 11509.5 11688.5 11794.8 11822.6 11848.6 3636.9 3673.5 3697.0 3812.0 3879.7 110899.0 118776.0 123629.0 124835.0 126990.0 10617.4 10904.7 11075.9 11150.9 11433.0 22536.2 22792.7 22919.1 22970.1 23003.9 7682.2 7877.4 7950.5 8055.4 8203.5 4471.2 4552.7 4572.5 4613.7 4785.2 3527.0 3640.9 3645.1 3649.7 3662.5 633.1 645.2 670.8 679.2 679.6 712.2 714.1 718.4 719.0 725.4 9992.3 10222.9 10358.5 10584.8 10704.3 671.3 694.0 700.0 708.7 714.2 3972.9 4345.4 5045.8 5098.5 5102.4 104363.5 108055.0 108058.9 108881.5 109920.4 60890.4 62852.7 94501.0 97559.0 98621.5 64208.7 65438.3 65716.7 80037.2 80418.2 11012.6 11016.4 11422.8 11459.9 11475.8 47080.5 49000.5 49751.3 50242.2 50639.0 50022.7 65562.0 65851.7 66265.3 72618.2 12971.6 13335.0 13604.0 13916.1 13986.6 15069.5 15106.0 15153.2 15313.1 15435.7 14144.0 14222.4 14462.8 14674.2 14892.2 12383.5 13136.3 14047.2 14108.4 14240.4 13872.2 14044.4 14118.5 14383.0 14545.1 8136.2 9508.8 9600.5 9876.5 9980.3 11132.3 11228.2 11456.1 11589.5 11633.8 07:54:00 INFO - PROCESS | 1977 | -------- Summary: end -------- 07:54:00 INFO - PROCESS | 1977 | 07:54:00 INFO - TEST-INFO | 1977: exit 0 07:54:00 INFO - TEST-OK | dromaeo_css | took 1119614ms 07:54:00 INFO - TEST-START | kraken 07:54:00 INFO - operating with platform_type : mac_ 07:54:00 INFO - Initialising browser for kraken test... 07:54:00 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpez241C/profile http://localhost:49361/getInfo.html) 07:54:03 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 07:54:03 INFO - PROCESS | 1981 | colorDepth:24 07:54:03 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 07:54:03 INFO - PROCESS | 1981 | __metrics 07:54:03 INFO - PROCESS | 1981 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:54:03 INFO - PROCESS | 1981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:03 INFO - TEST-INFO | 1981: exit 0 07:54:03 INFO - Browser initialized. 07:54:03 INFO - Running cycle 1/1 for kraken test... 07:54:03 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpez241C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:16 INFO - PROCESS | 1983 | RSS: Main: 165208064 07:54:16 INFO - PROCESS | 1983 | 07:54:19 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:20 INFO - PROCESS | 1983 | RSS: Main: 216219648 07:54:20 INFO - PROCESS | 1983 | 07:54:22 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-dft) 07:54:23 INFO - PROCESS | 1983 | RSS: Main: 232095744 07:54:23 INFO - PROCESS | 1983 | 07:54:26 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-fft) 07:54:26 INFO - PROCESS | 1983 | RSS: Main: 327950336 07:54:26 INFO - PROCESS | 1983 | 07:54:29 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-oscillator) 07:54:29 INFO - PROCESS | 1983 | RSS: Main: 230612992 07:54:29 INFO - PROCESS | 1983 | 07:54:31 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:32 INFO - PROCESS | 1983 | RSS: Main: 232140800 07:54:32 INFO - PROCESS | 1983 | 07:54:35 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49361/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:36 INFO - PROCESS | 1983 | RSS: Main: 272519168 07:54:36 INFO - PROCESS | 1983 | 07:54:39 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49361/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:39 INFO - PROCESS | 1983 | RSS: Main: 275300352 07:54:39 INFO - PROCESS | 1983 | 07:54:42 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49361/tests/kraken/driver.html?testName=json-parse-financial) 07:54:43 INFO - PROCESS | 1983 | RSS: Main: 269422592 07:54:43 INFO - PROCESS | 1983 | 07:54:44 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:45 INFO - PROCESS | 1983 | RSS: Main: 247689216 07:54:45 INFO - PROCESS | 1983 | 07:54:47 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:48 INFO - PROCESS | 1983 | RSS: Main: 250789888 07:54:48 INFO - PROCESS | 1983 | 07:54:50 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:50 INFO - PROCESS | 1983 | RSS: Main: 261132288 07:54:50 INFO - PROCESS | 1983 | 07:54:53 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:54 INFO - PROCESS | 1983 | RSS: Main: 273494016 07:54:54 INFO - PROCESS | 1983 | 07:54:57 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:57 INFO - PROCESS | 1983 | RSS: Main: 267485184 07:54:57 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49361/tests/kraken/driver.html?testName=ai-astar) 07:54:59 INFO - PROCESS | 1983 | RSS: Main: 312332288 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | __start_tp_report 07:54:59 INFO - PROCESS | 1983 | _x_x_mozilla_page_load 07:54:59 INFO - PROCESS | 1983 | _x_x_mozilla_page_load_details 07:54:59 INFO - PROCESS | 1983 | |i|pagename|runs| 07:54:59 INFO - PROCESS | 1983 | |0;ai-astar;108;118;120;116;120;169;176;177;118;116 07:54:59 INFO - PROCESS | 1983 | |1;audio-beat-detection;129;108;105;138;103;109;107;103;122;105 07:54:59 INFO - PROCESS | 1983 | |2;audio-dft;182;182;186;184;183;185;184;186;184;185 07:54:59 INFO - PROCESS | 1983 | |3;audio-fft;86;62;71;80;67;77;83;83;89;58 07:54:59 INFO - PROCESS | 1983 | |4;audio-oscillator;86;68;86;82;98;99;115;99;76;81 07:54:59 INFO - PROCESS | 1983 | |5;imaging-gaussian-blur;122;115;87;88;88;88;88;87;95;135 07:54:59 INFO - PROCESS | 1983 | |6;imaging-darkroom;94;97;94;95;94;101;107;129;94;93 07:54:59 INFO - PROCESS | 1983 | |7;imaging-desaturate;83;84;98;133;130;84;83;83;86;85 07:54:59 INFO - PROCESS | 1983 | |8;json-parse-financial;61;61;61;62;64;64;62;63;64;64 07:54:59 INFO - PROCESS | 1983 | |9;json-stringify-tinderbox;61;63;70;61;61;60;58;59;58;58 07:54:59 INFO - PROCESS | 1983 | |10;stanford-crypto-aes;83;80;84;84;80;82;82;87;87;82 07:54:59 INFO - PROCESS | 1983 | |11;stanford-crypto-ccm;134;135;132;134;128;121;117;127;195;167 07:54:59 INFO - PROCESS | 1983 | |12;stanford-crypto-pbkdf2;159;162;161;159;160;160;160;160;160;161 07:54:59 INFO - PROCESS | 1983 | |13;stanford-crypto-sha256-iterative;65;63;65;64;62;64;63;63;62;64 07:54:59 INFO - PROCESS | 1983 | __end_tp_report 07:54:59 INFO - PROCESS | 1983 | __start_cc_report 07:54:59 INFO - PROCESS | 1983 | _x_x_mozilla_cycle_collect,2062 07:54:59 INFO - PROCESS | 1983 | __end_cc_report 07:54:59 INFO - PROCESS | 1983 | __startTimestamp1493996099692__endTimestamp 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | ------- Summary: start ------- 07:54:59 INFO - PROCESS | 1983 | Number of tests: 14 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#0] ai-astar Cycles:10 Average:133.80 Median:120.00 stddev:28.02 (23.3%) stddev-sans-first:28.12 07:54:59 INFO - PROCESS | 1983 | Values: 108.0 118.0 120.0 116.0 120.0 169.0 176.0 177.0 118.0 116.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#1] audio-beat-detection Cycles:10 Average:112.90 Median:108.50 stddev:12.32 (11.4%) stddev-sans-first:11.61 07:54:59 INFO - PROCESS | 1983 | Values: 129.0 108.0 105.0 138.0 103.0 109.0 107.0 103.0 122.0 105.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.45 (0.8%) stddev-sans-first:1.32 07:54:59 INFO - PROCESS | 1983 | Values: 182.0 182.0 186.0 184.0 183.0 185.0 184.0 186.0 184.0 185.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#3] audio-fft Cycles:10 Average:75.60 Median:81.50 stddev:10.59 (13.0%) stddev-sans-first:10.54 07:54:59 INFO - PROCESS | 1983 | Values: 86.0 62.0 71.0 80.0 67.0 77.0 83.0 83.0 89.0 58.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:86.00 stddev:13.74 (16.0%) stddev-sans-first:14.53 07:54:59 INFO - PROCESS | 1983 | Values: 86.0 68.0 86.0 82.0 98.0 99.0 115.0 99.0 76.0 81.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#5] imaging-gaussian-blur Cycles:10 Average:99.30 Median:88.00 stddev:17.85 (20.3%) stddev-sans-first:16.94 07:54:59 INFO - PROCESS | 1983 | Values: 122.0 115.0 87.0 88.0 88.0 88.0 88.0 87.0 95.0 135.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:94.00 stddev:11.14 (11.9%) stddev-sans-first:11.62 07:54:59 INFO - PROCESS | 1983 | Values: 94.0 97.0 94.0 95.0 94.0 101.0 107.0 129.0 94.0 93.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:84.00 stddev:19.81 (23.6%) stddev-sans-first:20.54 07:54:59 INFO - PROCESS | 1983 | Values: 83.0 84.0 98.0 133.0 130.0 84.0 83.0 83.0 86.0 85.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.30 07:54:59 INFO - PROCESS | 1983 | Values: 61.0 61.0 61.0 62.0 64.0 64.0 62.0 63.0 64.0 64.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:3.60 (5.9%) stddev-sans-first:3.82 07:54:59 INFO - PROCESS | 1983 | Values: 61.0 63.0 70.0 61.0 61.0 60.0 58.0 59.0 58.0 58.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:2.47 (3.0%) stddev-sans-first:2.62 07:54:59 INFO - PROCESS | 1983 | Values: 83.0 80.0 84.0 84.0 80.0 82.0 82.0 87.0 87.0 82.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:134.00 stddev:23.82 (17.8%) stddev-sans-first:25.20 07:54:59 INFO - PROCESS | 1983 | Values: 134.0 135.0 132.0 134.0 128.0 121.0 117.0 127.0 195.0 167.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 07:54:59 INFO - PROCESS | 1983 | Values: 159.0 162.0 161.0 159.0 160.0 160.0 160.0 160.0 160.0 161.0 07:54:59 INFO - PROCESS | 1983 | 07:54:59 INFO - PROCESS | 1983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 07:54:59 INFO - PROCESS | 1983 | Values: 65.0 63.0 65.0 64.0 62.0 64.0 63.0 63.0 62.0 64.0 07:54:59 INFO - PROCESS | 1983 | -------- Summary: end -------- 07:54:59 INFO - PROCESS | 1983 | 07:55:00 INFO - TEST-INFO | 1983: exit 0 07:55:00 INFO - TEST-OK | kraken | took 59850ms 07:55:00 INFO - SUITE-END | took 1179s 07:55:00 INFO - Completed test suite (00:19:39) 07:55:00 INFO - javascript benchmark 07:55:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.549559098293, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3470.4620783778514, 3500.2649443616847, 3519.9648003519956, 3565.500829883815, 3578.7852728836274, 4995.2257400103, 5270.0, 5887.969605319068, 6175.228096487939, 6218.347073557279, 6154.138420621117, 6184.752609895599, 6206.1931948846695, 6221.688915554216, 6229.159063526423, 5383.084875571143, 5385.838424847261, 5409.24270602116, 5428.83713488596, 5586.022446071942, 5306.044911915854, 5343.919841202385, 5381.842903775688, 5537.307836520435, 5550.0, 4617.515160908107, 5453.836384908459, 5506.64206826555, 5507.834764957058, 5534.252875861747, 5493.148561972901, 5516.255305533782, 5525.944740552583, 5528.253685752412, 5538.224648549206, 5376.892462150774, 5422.0, 5431.728413579344, 5449.455054494519, 5484.451554844523, 5955.315138759055, 5980.282366116094, 6008.429199226067, 6050.878982420327, 6064.878702425926, 6366.172397588284, 6405.167328247345, 6423.710933007979, 6425.678716064178, 6461.12774775404, 6443.806685799434, 6447.613143211375, 6461.289258181596, 6484.967575162141, 6495.6752162391695, 6089.330173680892, 6129.817282374534, 6131.315499378962, 6131.478824299985, 6191.164192834, 6610.933890661128, 6623.205215374186, 6623.503237257225, 6630.336966303331, 6666.166729158856, 5429.701366424805, 6453.354664533603, 6459.967700161469, 6463.256725476536, 6467.579607325509, 6545.967270163619, 6617.0, 6617.139771829631, 6624.105745724266, 6626.105475760807, 5476.315460567429, 6517.51118666102, 6526.053722210253, 6536.117624120778, 6541.443977261891, 6218.533609979269, 6262.780802671885, 6275.560710750204, 6335.1447554579545, 6431.967840160863, 5241.50205730455, 5268.578513718893, 5282.630215884851, 5301.973490132525, 5318.9202161967605, 4665.86002419928, 4687.718736875799, 4694.976525117352, 4702.059588082398, 4753.405824271966, 6137.355577664371, 6144.218176728788, 6148.770245950827, 6245.656488893063, 6262.467690246289, 6439.871202575922, 6469.644169570624, 6559.376859198369, 6581.2760596334365, 6583.506237032242, 6228.159198508234, 6247.0, 6248.968755156286, 6264.718087685974, 6269.62382257066, 5402.648827826258, 5801.564882633819, 5850.0, 5865.384134665798, 5865.5285790318885, 6541.018847172867, 6563.868722625616, 6776.457883369417, 6809.38715515606, 6903.206131294965, 6603.042558829039, 6612.40488356031, 6629.602223866584, 6638.269790323157, 6639.3692599203, 6773.119494465688, 6869.553479023847, 6887.0, 6904.965475172592, 6913.446924246149, 6273.811785646438, 6338.619682819046, 6380.074889140956, 6480.578762380619, 6503.674816259263, 5547.33431988164, 6587.440067594116, 6589.0775291460195, 6601.306862779339, 6610.768623098168, 6335.936640633719, 6406.775762848464, 6421.165248517663, 6438.806835794933, 6442.8389290268115, 6209.285932117864, 6239.220097487814, 6372.713227904663, 6402.839929001812, 6403.359664033559, 6217.440430361289, 6337.397947195009, 6357.777477788255, 6359.713812878339, 6364.172657554488, 6347.333529979285, 6350.523710721622, 6350.968245158745, 6354.046892966092, 6365.458935990493, 6116.8227554565365, 6144.1567529740005, 6152.938470615237, 6161.106639537153, 6211.3478084802255], "value": 5986.93715299032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.2308629887906, 827.6523859978809, 897.138746803069, 902.3728508686462, 994.1847684898377, 39289.803550982244, 39471.40792888105, 39494.60505394945, 41312.38031429523, 41556.961075973115, 39383.409248861215, 39725.80137099318, 39745.60254397455, 39808.0, 39811.80094099533, 8030.7590772276635, 8190.50856948582, 8232.629531671075, 8360.45657032294, 11854.407279636027, 11909.940450297736, 12049.03607711381, 12053.63839084829, 12060.819087713691, 12065.276083434977, 12038.759224815498, 12060.698482537919, 12063.0, 12076.275423474575, 12090.093243006766, 12028.27830330183, 12028.939855300667, 12031.699207519794, 12057.0, 12061.819072713917, 11604.361760103191, 11674.416279186007, 11681.007114395286, 11685.123615728855, 11697.298162110215, 40912.59087409118, 41148.588514114774, 41171.0, 41185.0, 41198.38202426966, 3969.384745364473, 4018.839246430139, 4040.878773636796, 4046.7167298289132, 4066.4713587233764, 28287.009954651694, 28894.566581501294, 30037.399252015057, 30879.691203088132, 30910.53634195489, 3184.9363012739846, 3248.7888287261253, 3312.751543634237, 3322.3753234944365, 3421.4354631485776, 347747.0, 351968.0, 352125.99999999744, 352743.0, 353603.0, 44567.55432445634, 45461.54538454639, 54029.0, 54121.72939135279, 54653.45346546563, 54899.0, 57534.13698794522, 57664.0, 57671.71164144152, 57714.8457030857, 15993.040417574983, 16105.677886442205, 16107.758383624256, 16113.27490262941, 16131.274092665859, 13592.252426116658, 13632.863671363159, 13659.521916732867, 13671.931640341934, 13855.584332470042, 13426.194428334331, 13432.529861454997, 13453.596392108253, 13554.728905421836, 13571.796423053662, 5033.5469807716745, 5924.822255332347, 5989.371116032841, 6022.97609406402, 6098.390160983866, 1137.7724455109012, 1149.9885001150049, 1159.171192597297, 1170.145793570698, 1235.8146278058184, 21328.78671213268, 25886.48227035449, 27814.820351821236, 28208.0, 28370.43259134847, 1055.4036969112426, 1128.0848399312165, 1289.1749280460513, 1310.6919873829643, 1338.7188690374935, 10942.835857462145, 14417.711645767025, 14419.711605767827, 14687.090678211978, 14851.331690073972, 509806.0, 513363.0, 513721.0, 513959.0, 514807.0, 58922.70538647365, 59471.70264148652, 59473.702631486565, 59735.0, 59747.701261493414, 1463.75116230239, 1483.243545791654, 1494.1558019718825, 1505.7515509940956, 1508.2232650184944, 27681.0, 27850.0, 28339.71660283371, 28755.856220718764, 28857.56713649255, 42360.78819605882, 42691.78654106834, 42701.35947960721, 42716.57283427126, 42723.7863810679, 446050.0, 449011.0, 449563.0, 449717.0, 543351.0, 28548.858045677942, 28819.855900720362, 28940.0, 33637.49543756895, 34781.0, 31906.883259085822, 33400.0, 38386.232275354894, 40921.57026457522, 42561.93595160146, 19868.90065549663, 28089.297767555974, 28192.872285108366, 29152.708472915, 29941.0, 25349.493010140064, 29168.416631666823, 29893.551596725632, 30000.0, 30179.245518862204, 34388.0, 35154.82422587871, 35174.472382913766, 35203.64796352004, 35227.47158792569, 29542.0, 29682.0, 29749.10752677423, 30365.089047328616, 30440.84779576088, 24132.87933560321, 24226.273211803673, 24317.39206519851, 24482.51034979255, 24676.876615616806], "value": 19401.237784951314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.2032370599949, 438.56801050964793, 440.9492908315545, 440.95149533551324, 441.93370994350846, 20341.389758307258, 21560.13759449622, 22689.886550567226, 22939.42651433715, 22989.08043678253, 23145.652815207744, 23748.0, 24178.87910560449, 24446.266612001626, 24661.0135594576, 6674.466042716595, 6772.288909664476, 6956.4087052600335, 7018.0, 7081.327273908971, 6779.62712050837, 6897.448204143657, 6900.965495172542, 6918.619475928822, 6983.68573414195, 6618.007298905179, 6857.417119544844, 6973.476989225803, 6975.581465112109, 6990.755323563676, 6907.896381554281, 6960.686769095378, 6970.30296970304, 7431.739889103856, 7739.61301934901, 7551.622418879034, 7620.352270057052, 7621.237876212334, 7648.0, 7657.0, 26991.73008269912, 27492.762825672693, 27550.724492755016, 27781.305467363276, 27871.86064069667, 3020.8312528710458, 3026.273694313349, 3074.064268623459, 3156.463401221798, 3233.0462513558555, 16429.507114786575, 16632.002079875245, 16698.58253543659, 16896.239669214792, 17383.30466781327, 2054.866433681821, 2058.0018690934885, 2060.64968955278, 2066.1941842681367, 2127.98936005319, 137883.31058344644, 143676.0, 155199.0, 156205.0, 157569.21215393848, 19431.611367772566, 19729.210831566576, 20060.69908951367, 20083.297084601967, 20429.0, 31676.89130880454, 32059.51910721341, 32067.839660802012, 32186.0, 32192.0, 10490.318129321722, 10586.89413105859, 10820.593322868133, 10840.5121769519, 10974.615888443866, 7416.666250018654, 8724.912750872538, 9048.638054477879, 9067.914379692707, 9173.03683113277, 9247.0, 9439.0, 9462.57418416173, 9468.810623787485, 9479.24166066713, 3107.735842453417, 3137.952930706041, 3476.947845782315, 3874.360730479439, 3977.3636218204947, 1029.1869423155624, 1035.9896401035894, 1054.3130990415427, 1055.667464748617, 1068.9091427228773, 21244.0, 21383.67924481134, 21500.892495537733, 21509.892450537962, 21521.569568608542, 1030.5002073994108, 1033.720895358249, 1068.930519516229, 1074.2265568790458, 1079.0989523747758, 10751.301165424222, 11352.148588855704, 11505.986452370802, 11522.481488333045, 11542.018928391013, 661236.0, 750409.0, 767944.0, 781655.0917245378, 791043.0, 102302.48848755857, 147934.90488213426, 165875.0, 168418.0, 172582.0, 1186.8635106962638, 1317.611304665107, 1337.0840973932693, 1368.2953279061292, 1368.438940034601, 20420.0, 20571.8971405142, 21030.57938841245, 21041.368758937257, 21058.2629607963, 59102.0, 62380.0, 62639.06041409474, 62866.68566657137, 63127.0530942027, 88004.55997719971, 88224.0, 88791.55604221938, 90294.0, 90428.0, 9575.664851730156, 11485.712857178638, 11571.6528504145, 11904.523819047488, 12317.507299707911, 13040.282784446947, 13545.796813047615, 13766.793498097337, 14008.719825603226, 14148.009639325148, 11540.422978851191, 11631.941840290745, 11742.471588778697, 11990.220635658654, 12115.151939364512, 10146.543405546916, 10281.53733082028, 10898.836517452086, 10982.670519884416, 11225.438728063727, 11751.236169648946, 11811.350375729417, 11958.402079896145, 12126.393680316125, 12158.513659453523, 11804.527818887149, 11950.46222919988, 11989.220700654778, 12150.75698486043, 12262.754744904874, 10457.529411176667, 11122.221444498808, 11636.650900473, 11760.764784704086, 11805.173637845612], "value": 11918.87681307865, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.0, 1459.9270036498176, 1584.1208129488136, 1609.8551130398262, 1622.367276762063, 10510.632127875526, 11510.769784604303, 11528.193026488148, 11532.308061516314, 11542.65372038838, 10957.890421095786, 11231.831522527149, 11258.268212566178, 11408.771824563504, 11491.770164596724, 2493.6259561065804, 2542.1102614085016, 2545.6690630218045, 2547.541442540342, 2547.7070136934212, 2469.962950555743, 2480.8635525046116, 2521.2940376694555, 2522.066835270952, 2523.911663091792, 2451.632255161731, 2492.3270716906422, 2497.7876880465183, 2513.49730053989, 2519.722830488645, 2423.8545687258643, 2471.7775400213977, 2487.788537974265, 2506.035176457059, 2522.5585522533665, 2093.9371818845457, 2231.252530402317, 2330.0563271874917, 2491.8380305280098, 2504.6994360676654, 11173.664790056311, 11365.147613928906, 11389.145814063979, 11397.974182323547, 11400.372979486125, 5996.940030599681, 6158.969205153946, 6192.504599632019, 6203.689815509251, 6205.875882482325, 3701.8889433316776, 3784.129650180474, 3860.498135242429, 3871.612838716134, 3938.8424463021443, 1256.0265794009715, 1919.673655478558, 1923.4998900285887, 1978.6735188693992, 1999.5700924301345, 14144.504942327072, 14285.0, 14800.963932524835, 15822.287997040161, 16026.439074632448, 4765.451973023078, 4939.777710003059, 4946.1344264753525, 4967.155583550805, 4969.602431805447, 11919.88080119205, 12037.518499259932, 12046.759064818654, 12059.0, 12065.758684826254, 4928.802847886044, 5165.380154381498, 5317.096093664087, 6064.393560643988, 6068.666223357669, 5410.972945135328, 5525.060739674184, 5597.776088956478, 5605.691686957257, 5626.2967129108865, 3360.8487618057247, 3506.1760486285702, 3926.332523471017, 4055.270051390778, 4145.647619952338, 955.5222388805597, 1047.6490375724218, 1074.4573990135088, 1078.1698092468755, 1080.9675709728722, 895.7312806158127, 913.5340976102236, 917.8118485710413, 929.5741184390288, 955.6416343871049, 5757.913631295534, 6679.165104361955, 6704.966475167593, 6710.228323742735, 6777.898331525031, 886.8072442564741, 952.661805059194, 988.9406635601887, 1001.0940099210227, 1004.5630150884242, 4110.835566577363, 4146.896327591834, 4297.162053399557, 4300.247456695066, 4407.294832826732, 12158.392080395945, 12611.243325400323, 12617.684557886127, 12623.0, 12637.684057898627, 11631.76736465283, 12340.382980850922, 12394.442250098768, 12471.5011399543, 12497.812532812015, 9968.0, 10315.535800888827, 10322.0, 10522.789544209227, 10532.789344213073, 6335.968320158369, 6572.8356791080605, 6745.763898263537, 6959.26927672587, 7052.858942821217, 12117.75764484723, 12584.993200544117, 12594.937025314815, 12632.0, 12854.357282136043, 11711.590094346657, 12086.335251560897, 12206.75586488283, 12481.188722732993, 12571.931385832308, 9276.582553784961, 9542.761430964003, 9555.474448905377, 9559.522023898917, 9585.233181345615, 10098.949505252427, 10274.486275686335, 10411.0, 10436.843447348449, 10438.21713371485, 8754.25588824957, 8778.122187781171, 8863.157999989991, 9066.682666106655, 9138.588763505792, 8762.07998160184, 8805.471671699463, 8806.559672016245, 8863.556822158736, 8883.42257753244, 7946.364290856834, 8133.593320333841, 8144.470609410369, 8170.101288858102, 8183.590820459072, 5989.131575921554, 6012.969935150296, 6028.90956635642, 6194.535409844189, 6204.534659900435, 5218.0, 6017.398260173947, 6156.1381406604005, 6306.653134077486, 6329.335419780857], "value": 5252.802152150463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.9586809912563, 382.45691118611603, 383.4612369620683, 389.58703773999565, 392.242971065843, 4249.625561657517, 4565.543445655441, 4655.860324190276, 4881.804727810888, 4914.336564563783, 4534.682572219937, 4601.838935637254, 4841.322214889909, 5073.670211436254, 5237.633365664405, 4164.541900390955, 4249.19265339586, 4295.7852107394665, 4350.695451318409, 4519.548045195487, 3436.299031979174, 3579.9642003579893, 4279.33670281107, 4337.1325734853, 4370.4318438603095, 3464.4882460216395, 4186.958130418688, 4255.872063968016, 4336.0, 4356.607905288523, 3687.3178461984485, 3693.765272010449, 3748.4939533163083, 3848.5574158971795, 4337.8481753138485, 3434.742394320436, 3781.6596506314563, 3941.369380899071, 3983.7609743415487, 4013.97993010036, 3964.147708242742, 4279.935800962988, 4669.824519326857, 4761.857144285677, 5092.949070509285, 4319.509769129645, 5061.696298222082, 5064.468230835783, 5078.847634570969, 5086.516780905808, 4655.930161047587, 4952.405711314629, 5005.0990821652085, 5547.195656629807, 5592.273004509429, 4432.401625780542, 4487.083395792728, 4518.299663552122, 4528.818847246106, 4529.614982726473, 4917.72952487613, 4992.375953005874, 5340.07757207405, 5488.859344855509, 5801.361850196475, 3767.7927713975446, 3770.6606405423645, 4355.80398882051, 4577.992841574915, 4631.861044168613, 4134.64855487287, 4193.685473589493, 4374.78126093694, 4700.824793801549, 4776.307435421844, 4079.3676980068135, 4863.781129849165, 4866.902661946741, 5063.518965698253, 5072.6195535335, 5607.532685618315, 5609.046462101371, 5610.607257492018, 5625.690587017753, 5696.974544582015, 1478.0, 1566.686662667471, 1586.5319730679478, 1597.9840201597835, 1609.1954022988505, 1081.5727787523883, 1089.9536445012718, 1109.7626146846208, 1158.009901534193, 1230.944607492665, 4453.465584129925, 4515.751633660115, 4716.575508204278, 4755.38180036593, 4966.826161084345, 5095.668781529189, 5366.731663416814, 5501.614886957875, 5840.795572154954, 5855.619384739978, 4530.977345113253, 4668.5760842942545, 4936.802527898915, 4967.776450059756, 5162.767675454538, 2805.9859700701772, 2874.6837847836723, 2996.7374632152587, 2998.580198772174, 3015.9246018849703, 4953.058918805487, 5145.845624631267, 5181.948180518147, 5875.265591801025, 5905.40554050404, 5447.612666758614, 5517.503424691797, 5705.147426286857, 5719.656820590778, 5764.279465066867, 4752.619790416758, 5146.794128234828, 5193.091209038404, 5437.075697131497, 6031.8237943602335, 5429.782808687608, 5519.089350257163, 5659.0, 5701.315842098975, 5812.587776073052, 5144.636671282188, 5628.409017053151, 5692.686902220252, 5703.258576385043, 5718.571107166896, 5362.793371491383, 5428.45715428454, 5612.719364031864, 5788.913166302593, 5846.707664616837, 3784.5836957934052, 4125.628693417607, 4303.246931786862, 4354.956450435455, 4616.399208617284, 4550.294704320836, 5410.675359478444, 5586.994341018656, 5838.5621078418435, 5878.794242201502, 5021.430498246578, 5119.0, 5309.946900531099, 5368.557306425645, 5406.026915155153, 4810.374651295309, 4878.756062196947, 4972.801087956441, 4985.930838701898, 5558.972205138948, 4834.380482538389, 5175.792968281226, 5379.73101344939, 5430.565554755689, 5480.861949228307, 4713.835015774432, 5019.422766381913, 5423.430539793423, 5628.409017053151, 5639.0, 4621.445426548836, 4725.535084123932, 4914.557689807934, 5477.643953143033, 5527.336719593674], "value": 4160.947822223784, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.0719450325566, 708.7731925783748, 761.653447681305, 821.8972628421446, 833.766545367297, 14998.325075371607, 16409.671806563892, 16472.752908706378, 16540.669186616262, 16541.75187372189, 14547.854521454783, 15549.84450155498, 15720.37118515258, 15796.210189490508, 15822.0, 982.2731178927596, 984.3109823123806, 986.1075726467558, 986.6743974488437, 991.0188912976138, 975.3367709957226, 981.3277904635312, 1004.2769206171545, 1026.794641071785, 1034.8551202831609, 1075.451519724942, 1076.6608518316743, 1078.557791305565, 1080.573173596429, 1082.4317233452462, 1072.222638587026, 1073.3452593917705, 1073.3828048871892, 1074.4359211413991, 1080.76763495848, 796.0487217774704, 796.0725754496005, 796.7330944133722, 797.2067792546453, 799.2806474173233, 15968.361265549363, 16287.0, 16331.938424002401, 16644.001359918442, 16881.83118168815, 14144.0, 14257.0, 14298.499552515716, 14330.0, 14348.28258587077, 11509.539618415254, 11688.474018669096, 11794.764104717944, 11822.586209482626, 11848.585299514561, 3636.890893273206, 3673.540807399075, 3696.981515092434, 3812.046988252937, 3879.7478163919254, 110899.0, 118776.0, 123629.0, 124835.0, 126990.0, 10617.362958222531, 10904.727381815517, 11075.944620276847, 11150.940660637227, 11432.971032607105, 22536.211232607107, 22792.658110128363, 22919.083236670678, 22970.08119675228, 23003.88498057499, 7682.193369696213, 7877.448578599558, 7950.4832185907735, 8055.355571554262, 8203.548804815793, 4471.217536931024, 4552.704074235164, 4572.497025327211, 4613.653975951817, 4785.210440277316, 3527.0, 3640.8543658253375, 3645.1251699591908, 3649.7225970909967, 3662.5421822272215, 633.1484153813115, 645.1967300710645, 670.792054463118, 679.1544527063837, 679.5582871133803, 712.2058904321748, 714.1109318898006, 718.4432065149551, 719.0257201492008, 725.372552741885, 9992.25058120644, 10222.948885255526, 10358.466380372418, 10584.841227381596, 10704.250702450909, 671.3286713286714, 693.9930600693929, 699.989500157498, 708.7377670262036, 714.1965289049818, 3972.880813575597, 4345.3699213613845, 5045.7981680732355, 5098.4646612105935, 5102.3877134743325, 104363.47818261012, 108055.0, 108058.91941080645, 108881.45559272153, 109920.35119473214, 60890.39053960122, 62852.685736571024, 94501.0, 97559.0, 98621.50689246508, 64208.67895660492, 65438.345616544175, 65716.67141664357, 80037.19962800297, 80418.19581804224, 11012.614558490415, 11016.394098324668, 11422.771544569228, 11459.942700286445, 11475.770484590095, 47080.52919470761, 49000.52998410053, 49751.25373119478, 50242.24636630526, 50639.0, 50022.74943126305, 65562.0, 65851.68296633945, 66265.33734662592, 72618.18454538679, 12971.610851674464, 13335.0, 13604.0, 13916.095453795471, 13986.580402587939, 15069.47256846005, 15106.0, 15153.202788579174, 15313.081215127128, 15435.691286174439, 14144.0, 14222.35999380051, 14462.783058254345, 14674.192919389536, 14892.180930048951, 12383.504659813507, 13136.27750473733, 14047.227402492961, 14108.36512356926, 14240.35918383696, 13872.203164712073, 14044.438222470986, 14118.50585229512, 14383.0, 14545.054571452822, 8136.22705842944, 9508.809823803347, 9600.519974001132, 9876.50617469138, 9980.301378903407, 11132.276402033842, 11228.214025018171, 11456.140789440658, 11589.536418543164, 11633.767324653629], "value": 7854.796700063749, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 120.0, 116.0, 120.0, 169.0, 176.0, 177.0, 118.0, 116.0], "value": 133.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 108.0, 105.0, 138.0, 103.0, 109.0, 107.0, 103.0, 122.0, 105.0], "value": 112.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 186.0, 184.0, 183.0, 185.0, 184.0, 186.0, 184.0, 185.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 62.0, 71.0, 80.0, 67.0, 77.0, 83.0, 83.0, 89.0, 58.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 86.0, 82.0, 98.0, 99.0, 115.0, 99.0, 76.0, 81.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 87.0, 88.0, 88.0, 88.0, 88.0, 87.0, 95.0, 135.0], "value": 99.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 95.0, 94.0, 101.0, 107.0, 129.0, 94.0, 93.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 98.0, 133.0, 130.0, 84.0, 83.0, 83.0, 86.0, 85.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 64.0, 64.0, 62.0, 63.0, 64.0, 64.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 70.0, 61.0, 61.0, 60.0, 58.0, 59.0, 58.0, 58.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 84.0, 84.0, 80.0, 82.0, 82.0, 87.0, 87.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 132.0, 134.0, 128.0, 121.0, 117.0, 127.0, 195.0, 167.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 161.0, 159.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 62.0, 64.0, 63.0, 63.0, 62.0, 64.0], "value": 63.5, "unit": "score"}]}]} 07:55:00 INFO - Return code: 0 07:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:01 INFO - # TBPL SUCCESS # 07:55:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:01 INFO - 2017-05-05 07:55:01.055 screenresolution[1987:12586] starting screenresolution argv=screenresolution get 07:55:01 INFO - 2017-05-05 07:55:01.057 screenresolution[1987:12586] Display 0: 1600x1200x32@60 07:55:01 INFO - 2017-05-05 07:55:01.063 screenresolution[1988:12589] starting screenresolution argv=screenresolution list 07:55:01 INFO - Available Modes on Display 0 07:55:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:01 INFO - Intel Iris: 07:55:01 INFO - Chipset Model: Intel Iris 07:55:01 INFO - Type: GPU 07:55:01 INFO - Bus: Built-In 07:55:01 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:01 INFO - Vendor: Intel (0x8086) 07:55:01 INFO - Device ID: 0x0a2e 07:55:01 INFO - Revision ID: 0x0009 07:55:01 INFO - Displays: 07:55:01 INFO - Display: 07:55:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:01 INFO - Display Serial Number: 1600x1200 60 07:55:01 INFO - Main Display: Yes 07:55:01 INFO - Mirror: Off 07:55:01 INFO - Online: Yes 07:55:01 INFO - Rotation: Supported 07:55:01 INFO - Return code: 0 07:55:01 INFO - Running post-action listener: _resource_record_post_action 07:55:01 INFO - [mozharness: 2017-05-05 14:55:01.304374Z] Finished run-tests step (success) 07:55:01 INFO - Running post-run listener: _resource_record_post_run 07:55:01 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 544768; Write bytes: 423296512; Read time: 10; Write time: 1813 07:55:01 INFO - TinderboxPrint: CPU usage
53.6% 07:55:01 INFO - TinderboxPrint: I/O read bytes / time
544,768 / 10 07:55:01 INFO - TinderboxPrint: I/O write bytes / time
423,296,512 / 1,813 07:55:01 INFO - TinderboxPrint: CPU idle
2,218.4 (46.4%) 07:55:01 INFO - TinderboxPrint: CPU system
952.4 (19.9%) 07:55:01 INFO - TinderboxPrint: CPU user
1,610.9 (33.7%) 07:55:01 INFO - TinderboxPrint: Swap in / out
122,580,992 / 0 07:55:01 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 122819072; Write bytes: 122806272; Read time: 11084; Write time: 246 07:55:01 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 348160; Write bytes: 299089408; Read time: 7; Write time: 1561 07:55:01 INFO - Running post-run listener: _upload_blobber_files 07:55:01 INFO - Blob upload gear active. 07:55:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55:01 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 07:55:01 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'] 07:55:01 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 07:55:02 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:03 INFO - (blobuploader) - INFO - Done attempting. 07:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:04 INFO - (blobuploader) - INFO - Done attempting. 07:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:05 INFO - (blobuploader) - INFO - Done attempting. 07:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:07 INFO - (blobuploader) - INFO - Done attempting. 07:55:07 INFO - (blobuploader) - INFO - Iteration through files over. 07:55:07 INFO - Return code: 0 07:55:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:55:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:55:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f76c0a06a9f462055d7076068662e3b224e568d2c99a04b2393b8c9e7ec043c8699ba8d16ac16079ac59accfd45a8a6cd671c4efd4b6ee9388d36e1ef4bc29dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac001b5f55ff2eaa9e72b1881dce9231d50424089a765cde7f37adc9329b39ddc07d044a2cd28c871ceada40ed0ef6ef75707bc40d93f0ae4c5cb6d0ec857a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35b48ba4088711bff0a898be803253f763ff11bebf1a5c3e2ae53ee699e8b2d5b19c8b9fc35defc5f8020b3898ae69f901d0ec7ee8898fd65656c11d751278f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dfcd38990ecc567620e1d779f451f634cdf369cd1034b98ba734ac4da8bd9444fa36167089a77466a19378ee1357b5495d3cb8d2b62e6bb2da095564d4a56fc"} 07:55:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:55:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:55:07 INFO - Contents: 07:55:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f76c0a06a9f462055d7076068662e3b224e568d2c99a04b2393b8c9e7ec043c8699ba8d16ac16079ac59accfd45a8a6cd671c4efd4b6ee9388d36e1ef4bc29dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac001b5f55ff2eaa9e72b1881dce9231d50424089a765cde7f37adc9329b39ddc07d044a2cd28c871ceada40ed0ef6ef75707bc40d93f0ae4c5cb6d0ec857a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35b48ba4088711bff0a898be803253f763ff11bebf1a5c3e2ae53ee699e8b2d5b19c8b9fc35defc5f8020b3898ae69f901d0ec7ee8898fd65656c11d751278f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dfcd38990ecc567620e1d779f451f634cdf369cd1034b98ba734ac4da8bd9444fa36167089a77466a19378ee1357b5495d3cb8d2b62e6bb2da095564d4a56fc"} 07:55:07 INFO - Running post-run listener: copy_logs_to_upload_dir 07:55:07 INFO - Copying logs to upload dir... 07:55:07 INFO - mkdir: /builds/slave/test/build/upload/logs 07:55:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.331316 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-05-05 07:55:07.725214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:55:07.730929) ========= 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.nLN21NtOPd/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.xyChCc95X3/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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/f76c0a06a9f462055d7076068662e3b224e568d2c99a04b2393b8c9e7ec043c8699ba8d16ac16079ac59accfd45a8a6cd671c4efd4b6ee9388d36e1ef4bc29dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac001b5f55ff2eaa9e72b1881dce9231d50424089a765cde7f37adc9329b39ddc07d044a2cd28c871ceada40ed0ef6ef75707bc40d93f0ae4c5cb6d0ec857a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35b48ba4088711bff0a898be803253f763ff11bebf1a5c3e2ae53ee699e8b2d5b19c8b9fc35defc5f8020b3898ae69f901d0ec7ee8898fd65656c11d751278f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dfcd38990ecc567620e1d779f451f634cdf369cd1034b98ba734ac4da8bd9444fa36167089a77466a19378ee1357b5495d3cb8d2b62e6bb2da095564d4a56fc"} build_url:https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f76c0a06a9f462055d7076068662e3b224e568d2c99a04b2393b8c9e7ec043c8699ba8d16ac16079ac59accfd45a8a6cd671c4efd4b6ee9388d36e1ef4bc29dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac001b5f55ff2eaa9e72b1881dce9231d50424089a765cde7f37adc9329b39ddc07d044a2cd28c871ceada40ed0ef6ef75707bc40d93f0ae4c5cb6d0ec857a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35b48ba4088711bff0a898be803253f763ff11bebf1a5c3e2ae53ee699e8b2d5b19c8b9fc35defc5f8020b3898ae69f901d0ec7ee8898fd65656c11d751278f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dfcd38990ecc567620e1d779f451f634cdf369cd1034b98ba734ac4da8bd9444fa36167089a77466a19378ee1357b5495d3cb8d2b62e6bb2da095564d4a56fc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:55:07.767577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:55:07.767941) ========= 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.nLN21NtOPd/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.xyChCc95X3/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005306 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:55:07.816475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:55:07.816786) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:55:07.817161) ========= ========= Total master_lag: 0.19 =========