builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0079 starttime: 1482338684.92 results: success (0) buildid: 20161221065231 builduid: d63bb653407345139c8f75599070f38a revision: 5b0afeaeebdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:44.918526) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:44.918933) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:44.919220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:44.945579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:44.945857) ========= 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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-21 08:44:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-12-21 08:44:45 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.189906 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:45.159761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:45.160063) ========= 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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.027603 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:45.211054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-21 08:44:45.211382) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b0afeaeebdd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5b0afeaeebdd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SQP8DtVIL9/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.rjPcwxlSAY/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-21 08:44:45,371 Setting DEBUG logging. 2016-12-21 08:44:45,371 attempt 1/10 2016-12-21 08:44:45,371 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b0afeaeebdd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 08:44:47,074 unpacking tar archive at: mozilla-central-5b0afeaeebdd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.959302 ========= master_lag: 0.86 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-21 08:44:48.027108) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:48.027400) ========= script_repo_revision: 5b0afeaeebdd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:48.027770) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:48.028044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 08:44:48.761562) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-21 08:44:48.761946) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SQP8DtVIL9/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.rjPcwxlSAY/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:44:49 INFO - MultiFileLogger online at 20161221 08:44:49 in /builds/slave/test 08:44:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:44:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:49 INFO - {'append_to_log': False, 08:44:49 INFO - 'base_work_dir': '/builds/slave/test', 08:44:49 INFO - 'blob_upload_branch': 'Firefox', 08:44:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:49 INFO - 'branch': 'Firefox', 08:44:49 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:49 INFO - 'config_files': ('talos/mac_config.py',), 08:44:49 INFO - 'default_actions': ('clobber', 08:44:49 INFO - 'read-buildbot-config', 08:44:49 INFO - 'download-and-extract', 08:44:49 INFO - 'populate-webroot', 08:44:49 INFO - 'create-virtualenv', 08:44:49 INFO - 'install', 08:44:49 INFO - 'run-tests'), 08:44:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:49 INFO - 'download_minidump_stackwalk': True, 08:44:49 INFO - 'download_symbols': 'ondemand', 08:44:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:49 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:49 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:49 INFO - 'installer_path': 'installer.exe', 08:44:49 INFO - 'log_level': 'info', 08:44:49 INFO - 'log_name': 'talos', 08:44:49 INFO - 'log_to_console': True, 08:44:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:44:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:44:49 INFO - 'opt_config_files': (), 08:44:49 INFO - 'pip_index': False, 08:44:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:44:49 INFO - 'cmd': ('bash', 08:44:49 INFO - '-c', 08:44:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:44:49 INFO - 'enabled': True, 08:44:49 INFO - 'halt_on_failure': False, 08:44:49 INFO - 'name': 'check_screen_resolution'},), 08:44:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:44:49 INFO - 'cmd': ('bash', 08:44:49 INFO - '-c', 08:44:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:44:49 INFO - 'enabled': True, 08:44:49 INFO - 'halt_on_failure': False, 08:44:49 INFO - 'name': 'check_screen_resolution'},), 08:44:49 INFO - 'run_cmd_checks_enabled': True, 08:44:49 INFO - 'sps_profile': False, 08:44:49 INFO - 'sps_profile_interval': 0, 08:44:49 INFO - 'suite': 'dromaeojs', 08:44:49 INFO - 'system_bits': '32', 08:44:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:49 INFO - 'title': 't-yosemite-r7-0079', 08:44:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:49 INFO - 'use_talos_json': True, 08:44:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:49 INFO - 'work_dir': 'build'} 08:44:49 INFO - [mozharness: 2016-12-21 16:44:49.035194Z] Running clobber step. 08:44:49 INFO - Running pre-action listener: _resource_record_pre_action 08:44:49 INFO - Running main action method: clobber 08:44:49 INFO - rmtree: /builds/slave/test/build 08:44:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:51 INFO - Running post-action listener: _resource_record_post_action 08:44:51 INFO - [mozharness: 2016-12-21 16:44:51.339039Z] Finished clobber step (success) 08:44:51 INFO - [mozharness: 2016-12-21 16:44:51.339241Z] Running read-buildbot-config step. 08:44:51 INFO - Running pre-action listener: _resource_record_pre_action 08:44:51 INFO - Running main action method: read_buildbot_config 08:44:51 INFO - Using buildbot properties: 08:44:51 INFO - { 08:44:51 INFO - "project": "", 08:44:51 INFO - "product": "firefox", 08:44:51 INFO - "script_repo_revision": "production", 08:44:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:44:51 INFO - "repository": "", 08:44:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:44:51 INFO - "buildid": "20161221065231", 08:44:51 INFO - "stage_platform": "macosx64", 08:44:51 INFO - "basedir": "/builds/slave/test", 08:44:51 INFO - "nightly_build": "True", 08:44:51 INFO - "buildnumber": 38, 08:44:51 INFO - "slavename": "t-yosemite-r7-0079", 08:44:51 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:44:51 INFO - "platform": "yosemite_r7", 08:44:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:44:51 INFO - "branch": "mozilla-central", 08:44:51 INFO - "repo_path": "mozilla-central", 08:44:51 INFO - "revision": "5b0afeaeebdd", 08:44:51 INFO - "pgo_build": "False", 08:44:51 INFO - "builduid": "d63bb653407345139c8f75599070f38a", 08:44:51 INFO - "slavebuilddir": "test" 08:44:51 INFO - } 08:44:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:44:51 INFO - Running post-action listener: _resource_record_post_action 08:44:51 INFO - [mozharness: 2016-12-21 16:44:51.342669Z] Finished read-buildbot-config step (success) 08:44:51 INFO - [mozharness: 2016-12-21 16:44:51.342784Z] Running download-and-extract step. 08:44:51 INFO - Running pre-action listener: _resource_record_pre_action 08:44:51 INFO - Running main action method: download_and_extract 08:44:51 INFO - mkdir: /builds/slave/test/build/tests 08:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:51 INFO - trying https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:44:51 INFO - Downloading https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:44:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:44:52 INFO - Downloaded 1199 bytes. 08:44:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:44:52 INFO - Using the following test package requirements: 08:44:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:44:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:44:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:44:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'jsshell-mac.zip'], 08:44:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:44:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:44:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:44:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:44:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:44:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:44:52 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:44:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:44:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:44:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:44:52 INFO - Fetch https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:44:53 INFO - Expected file size: 16277835 08:44:53 INFO - Obtained file size: 16277835 08:45:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:45:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:45:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:45:00 INFO - Fetch https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:45:02 INFO - Expected file size: 16277835 08:45:02 INFO - Obtained file size: 16277835 08:45:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:45:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:45:09 INFO - Fetch https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:45:10 INFO - Expected file size: 14409734 08:45:10 INFO - Obtained file size: 14409734 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:10 INFO - trying https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:45:10 INFO - Downloading https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:45:13 INFO - Downloaded 69636622 bytes. 08:45:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:45:13 INFO - mkdir: /builds/slave/test/properties 08:45:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:13 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:13 INFO - Contents: 08:45:13 INFO - build_url:https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:45:14 INFO - Running post-action listener: _resource_record_post_action 08:45:14 INFO - Running post-action listener: set_extra_try_arguments 08:45:14 INFO - [mozharness: 2016-12-21 16:45:14.542458Z] Finished download-and-extract step (success) 08:45:14 INFO - [mozharness: 2016-12-21 16:45:14.542630Z] Running populate-webroot step. 08:45:14 INFO - Running pre-action listener: _resource_record_pre_action 08:45:14 INFO - Running main action method: populate_webroot 08:45:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:14 INFO - '--tppagecycles', 08:45:14 INFO - '7'], 08:45:14 INFO - 'tests': ['tsvgm']}}, 08:45:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:45:14 INFO - 'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:45:14 INFO - 'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['damp', 'tps']}, 08:45:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:45:14 INFO - 'tests': ['damp', 'tps']}, 08:45:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['dromaeo_dom']}, 08:45:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['basic_compositor_video']}, 08:45:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['a11yr', 08:45:14 INFO - 'ts_paint', 08:45:14 INFO - 'tpaint', 08:45:14 INFO - 'sessionrestore', 08:45:14 INFO - 'sessionrestore_no_auto_restore', 08:45:14 INFO - 'tabpaint']}, 08:45:14 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:14 INFO - 'ts_paint', 08:45:14 INFO - 'tpaint', 08:45:14 INFO - 'sessionrestore', 08:45:14 INFO - 'sessionrestore_no_auto_restore', 08:45:14 INFO - 'tabpaint']}, 08:45:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:14 INFO - 'ts_paint', 08:45:14 INFO - 'tpaint', 08:45:14 INFO - 'sessionrestore', 08:45:14 INFO - 'sessionrestore_no_auto_restore', 08:45:14 INFO - 'tabpaint']}, 08:45:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:14 INFO - 'ts_paint', 08:45:14 INFO - 'tpaint', 08:45:14 INFO - 'sessionrestore', 08:45:14 INFO - 'sessionrestore_no_auto_restore', 08:45:14 INFO - 'tabpaint']}, 08:45:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['a11yr', 08:45:14 INFO - 'ts_paint', 08:45:14 INFO - 'tpaint', 08:45:14 INFO - 'sessionrestore', 08:45:14 INFO - 'sessionrestore_no_auto_restore', 08:45:14 INFO - 'tabpaint']}, 08:45:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['a11yr', 08:45:14 INFO - 'ts_paint', 08:45:14 INFO - 'tpaint', 08:45:14 INFO - 'sessionrestore', 08:45:14 INFO - 'sessionrestore_no_auto_restore', 08:45:14 INFO - 'tabpaint']}, 08:45:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['tsvgx', 08:45:14 INFO - 'tsvgr_opacity', 08:45:14 INFO - 'tart', 08:45:14 INFO - 'tscrollx', 08:45:14 INFO - 'cart', 08:45:14 INFO - 'tsvg_static']}, 08:45:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:14 INFO - 'tsvgr_opacity', 08:45:14 INFO - 'tart', 08:45:14 INFO - 'tscrollx', 08:45:14 INFO - 'cart', 08:45:14 INFO - 'tsvg_static']}, 08:45:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:45:14 INFO - 'talos_options': ['--disable-e10s'], 08:45:14 INFO - 'tests': ['tp5o']}, 08:45:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:45:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:45:14 INFO - 'talos_options': ['--disable-e10s', 08:45:14 INFO - '--xperf_path', 08:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:14 INFO - 'tests': ['tp5n']}, 08:45:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:45:14 INFO - 'talos_options': ['--xperf_path', 08:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:14 INFO - 'tests': ['tp5n']}}, 08:45:14 INFO - 'talos.zip': {'path': '', 08:45:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:14 INFO - Running post-action listener: _resource_record_post_action 08:45:14 INFO - [mozharness: 2016-12-21 16:45:14.562886Z] Finished populate-webroot step (success) 08:45:14 INFO - [mozharness: 2016-12-21 16:45:14.563036Z] Running create-virtualenv step. 08:45:14 INFO - Running pre-action listener: _resource_record_pre_action 08:45:14 INFO - Running main action method: create_virtualenv 08:45:14 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:45:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:14 INFO - Using real prefix '/tools/python27' 08:45:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:15 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:18 INFO - Installing pip.................done. 08:45:18 INFO - Return code: 0 08:45:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:45:18 INFO - Reading from file tmpfile_stdout 08:45:18 INFO - Output received: 08:45:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:45:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:18 INFO - 'HOME': '/Users/cltbld', 08:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:18 INFO - 'LOGNAME': 'cltbld', 08:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:18 INFO - 'MOZ_NO_REMOTE': '1', 08:45:18 INFO - 'NO_EM_RESTART': '1', 08:45:18 INFO - 'PAGER': '/bin/cat', 08:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:18 INFO - 'PWD': '/builds/slave/test', 08:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:18 INFO - 'SHELL': '/bin/bash', 08:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:18 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:18 INFO - 'USER': 'cltbld', 08:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:18 INFO - 'XPC_FLAGS': '0x0', 08:45:18 INFO - 'XPC_SERVICE_NAME': '0', 08:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:45:18 INFO - Cleaning up... 08:45:18 INFO - Return code: 0 08:45:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:18 INFO - 'HOME': '/Users/cltbld', 08:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:18 INFO - 'LOGNAME': 'cltbld', 08:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:18 INFO - 'MOZ_NO_REMOTE': '1', 08:45:18 INFO - 'NO_EM_RESTART': '1', 08:45:18 INFO - 'PAGER': '/bin/cat', 08:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:18 INFO - 'PWD': '/builds/slave/test', 08:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:18 INFO - 'SHELL': '/bin/bash', 08:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:18 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:18 INFO - 'USER': 'cltbld', 08:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:18 INFO - 'XPC_FLAGS': '0x0', 08:45:18 INFO - 'XPC_SERVICE_NAME': '0', 08:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:19 INFO - Downloading/unpacking psutil>=3.1.1 08:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:22 INFO - Installing collected packages: psutil 08:45:22 INFO - Running setup.py install for psutil 08:45:22 INFO - building 'psutil._psutil_osx' extension 08:45:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:45:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:45:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:45:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:45:23 INFO - building 'psutil._psutil_posix' extension 08:45:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:45:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:45:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:45:23 INFO - ^ 08:45:23 INFO - 1 warning generated. 08:45:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:45:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:23 INFO - Successfully installed psutil 08:45:23 INFO - Cleaning up... 08:45:23 INFO - Return code: 0 08:45:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:23 INFO - 'HOME': '/Users/cltbld', 08:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:23 INFO - 'LOGNAME': 'cltbld', 08:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:23 INFO - 'MOZ_NO_REMOTE': '1', 08:45:23 INFO - 'NO_EM_RESTART': '1', 08:45:23 INFO - 'PAGER': '/bin/cat', 08:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:23 INFO - 'PWD': '/builds/slave/test', 08:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:23 INFO - 'SHELL': '/bin/bash', 08:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:23 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:23 INFO - 'USER': 'cltbld', 08:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:23 INFO - 'XPC_FLAGS': '0x0', 08:45:23 INFO - 'XPC_SERVICE_NAME': '0', 08:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:26 INFO - Installing collected packages: mozsystemmonitor 08:45:26 INFO - Running setup.py install for mozsystemmonitor 08:45:27 INFO - Successfully installed mozsystemmonitor 08:45:27 INFO - Cleaning up... 08:45:27 INFO - Return code: 0 08:45:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:27 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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:45:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:27 INFO - 'HOME': '/Users/cltbld', 08:45:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:27 INFO - 'LOGNAME': 'cltbld', 08:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:27 INFO - 'MOZ_NO_REMOTE': '1', 08:45:27 INFO - 'NO_EM_RESTART': '1', 08:45:27 INFO - 'PAGER': '/bin/cat', 08:45:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:27 INFO - 'PWD': '/builds/slave/test', 08:45:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:27 INFO - 'SHELL': '/bin/bash', 08:45:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:27 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:27 INFO - 'USER': 'cltbld', 08:45:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:27 INFO - 'XPC_FLAGS': '0x0', 08:45:27 INFO - 'XPC_SERVICE_NAME': '0', 08:45:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:30 INFO - warning: no files found matching '*.txt' 08:45:30 INFO - no previously-included directories found matching 'build' 08:45:30 INFO - no previously-included directories found matching 'dist' 08:45:30 INFO - no previously-included directories found matching '.git*' 08:45:30 INFO - Installing collected packages: jsonschema, functools32 08:45:30 INFO - Running setup.py install for functools32 08:45:30 INFO - warning: no files found matching '*.txt' 08:45:30 INFO - no previously-included directories found matching 'build' 08:45:30 INFO - no previously-included directories found matching 'dist' 08:45:30 INFO - no previously-included directories found matching '.git*' 08:45:30 INFO - Successfully installed jsonschema functools32 08:45:30 INFO - Cleaning up... 08:45:30 INFO - Return code: 0 08:45:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:30 INFO - 'HOME': '/Users/cltbld', 08:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:30 INFO - 'LOGNAME': 'cltbld', 08:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:30 INFO - 'MOZ_NO_REMOTE': '1', 08:45:30 INFO - 'NO_EM_RESTART': '1', 08:45:30 INFO - 'PAGER': '/bin/cat', 08:45:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:30 INFO - 'PWD': '/builds/slave/test', 08:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:30 INFO - 'SHELL': '/bin/bash', 08:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:30 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:30 INFO - 'USER': 'cltbld', 08:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:30 INFO - 'XPC_FLAGS': '0x0', 08:45:30 INFO - 'XPC_SERVICE_NAME': '0', 08:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:30 INFO - Cleaning up... 08:45:30 INFO - Return code: 0 08:45:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:30 INFO - 'HOME': '/Users/cltbld', 08:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:30 INFO - 'LOGNAME': 'cltbld', 08:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:30 INFO - 'MOZ_NO_REMOTE': '1', 08:45:30 INFO - 'NO_EM_RESTART': '1', 08:45:30 INFO - 'PAGER': '/bin/cat', 08:45:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:30 INFO - 'PWD': '/builds/slave/test', 08:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:30 INFO - 'SHELL': '/bin/bash', 08:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:30 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:30 INFO - 'USER': 'cltbld', 08:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:30 INFO - 'XPC_FLAGS': '0x0', 08:45:30 INFO - 'XPC_SERVICE_NAME': '0', 08:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:33 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:35 INFO - Downloading docopt-0.6.1.tar.gz 08:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:35 INFO - Running setup.py install for blobuploader 08:45:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:35 INFO - Running setup.py install for requests 08:45:35 INFO - Running setup.py install for docopt 08:45:35 INFO - Successfully installed blobuploader requests docopt 08:45:35 INFO - Cleaning up... 08:45:36 INFO - Return code: 0 08:45:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:36 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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:36 INFO - 'HOME': '/Users/cltbld', 08:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:36 INFO - 'LOGNAME': 'cltbld', 08:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:36 INFO - 'MOZ_NO_REMOTE': '1', 08:45:36 INFO - 'NO_EM_RESTART': '1', 08:45:36 INFO - 'PAGER': '/bin/cat', 08:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:36 INFO - 'PWD': '/builds/slave/test', 08:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:36 INFO - 'SHELL': '/bin/bash', 08:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:36 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:36 INFO - 'USER': 'cltbld', 08:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:36 INFO - 'XPC_FLAGS': '0x0', 08:45:36 INFO - 'XPC_SERVICE_NAME': '0', 08:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-tpyTuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-nUbMnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-rMppII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BtFooA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-gv_Sga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-F8tVKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-wUW9r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-r0Xw5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-czeo2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-8IDqKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ToNdx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-KgOK_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-sNN6P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-myR2B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-FeMS9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-e8p4Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:37 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-m3t7Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:38 INFO - Running setup.py install for manifestparser 08:45:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:38 INFO - Running setup.py install for mozcrash 08:45:38 INFO - Running setup.py install for mozdebug 08:45:38 INFO - Running setup.py install for mozdevice 08:45:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:38 INFO - Running setup.py install for mozfile 08:45:38 INFO - Running setup.py install for mozhttpd 08:45:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:38 INFO - Running setup.py install for mozinfo 08:45:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:39 INFO - Running setup.py install for mozInstall 08:45:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:39 INFO - Running setup.py install for mozleak 08:45:39 INFO - Running setup.py install for mozlog 08:45:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:39 INFO - Running setup.py install for moznetwork 08:45:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:39 INFO - Running setup.py install for mozprocess 08:45:39 INFO - Running setup.py install for mozprofile 08:45:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:40 INFO - Running setup.py install for mozrunner 08:45:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:40 INFO - Running setup.py install for mozscreenshot 08:45:40 INFO - Running setup.py install for moztest 08:45:40 INFO - Running setup.py install for mozversion 08:45:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:40 INFO - Cleaning up... 08:45:40 INFO - Return code: 0 08:45:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:41 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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:41 INFO - 'HOME': '/Users/cltbld', 08:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:41 INFO - 'LOGNAME': 'cltbld', 08:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:41 INFO - 'MOZ_NO_REMOTE': '1', 08:45:41 INFO - 'NO_EM_RESTART': '1', 08:45:41 INFO - 'PAGER': '/bin/cat', 08:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:41 INFO - 'PWD': '/builds/slave/test', 08:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:41 INFO - 'SHELL': '/bin/bash', 08:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:41 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:41 INFO - 'USER': 'cltbld', 08:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:41 INFO - 'XPC_FLAGS': '0x0', 08:45:41 INFO - 'XPC_SERVICE_NAME': '0', 08:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Xq8pqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-oQJ4E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-QLF94s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-6qGNx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-anrBZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_lR4Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-AQu2Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-VoYUq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Xy8zsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-cLKIdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-uqpJV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:42 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-2UrZTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:43 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-j5zDuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:43 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-t979PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:43 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-l2THsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:43 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-74IEnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:43 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-mD0GsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:46 INFO - Downloading blessings-1.6.tar.gz 08:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:46 INFO - Installing collected packages: blessings 08:45:46 INFO - Running setup.py install for blessings 08:45:46 INFO - Successfully installed blessings 08:45:46 INFO - Cleaning up... 08:45:46 INFO - Return code: 0 08:45:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:47 INFO - Reading from file tmpfile_stdout 08:45:47 INFO - Current package versions: 08:45:47 INFO - blessings == 1.6 08:45:47 INFO - blobuploader == 1.2.4 08:45:47 INFO - docopt == 0.6.1 08:45:47 INFO - functools32 == 3.2.3-2 08:45:47 INFO - jsonschema == 2.5.1 08:45:47 INFO - manifestparser == 1.1 08:45:47 INFO - mozInstall == 1.12 08:45:47 INFO - mozcrash == 1.0 08:45:47 INFO - mozdebug == 0.1 08:45:47 INFO - mozdevice == 0.49 08:45:47 INFO - mozfile == 1.2 08:45:47 INFO - mozhttpd == 0.7 08:45:47 INFO - mozinfo == 0.9 08:45:47 INFO - mozleak == 0.1 08:45:47 INFO - mozlog == 3.4 08:45:47 INFO - moznetwork == 0.27 08:45:47 INFO - mozprocess == 0.23 08:45:47 INFO - mozprofile == 0.28 08:45:47 INFO - mozrunner == 6.13 08:45:47 INFO - mozscreenshot == 0.1 08:45:47 INFO - mozsystemmonitor == 0.3 08:45:47 INFO - moztest == 0.7 08:45:47 INFO - mozversion == 1.4 08:45:47 INFO - psutil == 3.1.1 08:45:47 INFO - requests == 1.2.3 08:45:47 INFO - wsgiref == 0.1.2 08:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:47 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 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:47 INFO - 'HOME': '/Users/cltbld', 08:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:47 INFO - 'LOGNAME': 'cltbld', 08:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:47 INFO - 'MOZ_NO_REMOTE': '1', 08:45:47 INFO - 'NO_EM_RESTART': '1', 08:45:47 INFO - 'PAGER': '/bin/cat', 08:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:47 INFO - 'PWD': '/builds/slave/test', 08:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:47 INFO - 'SHELL': '/bin/bash', 08:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:47 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:47 INFO - 'USER': 'cltbld', 08:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:47 INFO - 'XPC_FLAGS': '0x0', 08:45:47 INFO - 'XPC_SERVICE_NAME': '0', 08:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:45:47 INFO - Cleaning up... 08:45:47 INFO - Return code: 0 08:45:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86305ba460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, '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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:47 INFO - 'HOME': '/Users/cltbld', 08:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:47 INFO - 'LOGNAME': 'cltbld', 08:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:47 INFO - 'MOZ_NO_REMOTE': '1', 08:45:47 INFO - 'NO_EM_RESTART': '1', 08:45:47 INFO - 'PAGER': '/bin/cat', 08:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:47 INFO - 'PWD': '/builds/slave/test', 08:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:47 INFO - 'SHELL': '/bin/bash', 08:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:45:47 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:47 INFO - 'USER': 'cltbld', 08:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:47 INFO - 'XPC_FLAGS': '0x0', 08:45:47 INFO - 'XPC_SERVICE_NAME': '0', 08:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:47 INFO - Cleaning up... 08:45:47 INFO - Return code: 0 08:45:47 INFO - Running post-action listener: _resource_record_post_action 08:45:47 INFO - Running post-action listener: _start_resource_monitoring 08:45:47 INFO - Starting resource monitoring. 08:45:47 INFO - [mozharness: 2016-12-21 16:45:47.663183Z] Finished create-virtualenv step (success) 08:45:47 INFO - [mozharness: 2016-12-21 16:45:47.664199Z] Running install step. 08:45:47 INFO - Running pre-action listener: _resource_record_pre_action 08:45:47 INFO - Running main action method: install 08:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:47 INFO - Reading from file tmpfile_stdout 08:45:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:48 INFO - Reading from file tmpfile_stdout 08:45:48 INFO - Output received: 08:45:48 INFO - Usage: mozinstall [options] installer 08:45:48 INFO - Options: 08:45:48 INFO - -h, --help show this help message and exit 08:45:48 INFO - -d DEST, --destination=DEST 08:45:48 INFO - Directory to install application into. [default: 08:45:48 INFO - "/builds/slave/test"] 08:45:48 INFO - --app=APP Application being installed. [default: firefox] 08:45:48 INFO - mkdir: /builds/slave/test/build/application 08:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:46:09 INFO - Reading from file tmpfile_stdout 08:46:09 INFO - Output received: 08:46:09 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 08:46:09 INFO - Running post-action listener: _resource_record_post_action 08:46:09 INFO - [mozharness: 2016-12-21 16:46:09.917891Z] Finished install step (success) 08:46:09 INFO - [mozharness: 2016-12-21 16:46:09.918046Z] Running run-tests step. 08:46:09 INFO - Running pre-action listener: _resource_record_pre_action 08:46:09 INFO - Running main action method: run_tests 08:46:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:46:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:46:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:46:09 INFO - 2016-12-21 08:46:09.933 screenresolution[1631:7501] starting screenresolution argv=screenresolution get 08:46:09 INFO - 2016-12-21 08:46:09.935 screenresolution[1631:7501] Display 0: 1600x1200x32@60 08:46:09 INFO - 2016-12-21 08:46:09.941 screenresolution[1632:7503] starting screenresolution argv=screenresolution list 08:46:09 INFO - Available Modes on Display 0 08:46:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:46:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:46:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:46:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:10 INFO - Intel Iris: 08:46:10 INFO - Chipset Model: Intel Iris 08:46:10 INFO - Type: GPU 08:46:10 INFO - Bus: Built-In 08:46:10 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:10 INFO - Vendor: Intel (0x8086) 08:46:10 INFO - Device ID: 0x0a2e 08:46:10 INFO - Revision ID: 0x0009 08:46:10 INFO - Displays: 08:46:10 INFO - Display: 08:46:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:10 INFO - Display Serial Number: 1600x1200 60 08:46:10 INFO - Main Display: Yes 08:46:10 INFO - Mirror: Off 08:46:10 INFO - Online: Yes 08:46:10 INFO - Rotation: Supported 08:46:10 INFO - Return code: 0 08:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:10 INFO - Python 2.7.3 08:46:10 INFO - Return code: 0 08:46:10 INFO - grabbing minidump binary from tooltool 08:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:10 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 0x103780d30>, '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 0x1036a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103775be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:46:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:46:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:46:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:10 INFO - Return code: 0 08:46:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:46:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:46:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:46:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SQP8DtVIL9/Render', 08:46:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:10 INFO - 'HOME': '/Users/cltbld', 08:46:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:10 INFO - 'LOGNAME': 'cltbld', 08:46:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:10 INFO - 'MOZ_NO_REMOTE': '1', 08:46:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:10 INFO - 'NO_EM_RESTART': '1', 08:46:10 INFO - 'PAGER': '/bin/cat', 08:46:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:10 INFO - 'PWD': '/builds/slave/test', 08:46:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:10 INFO - 'SHELL': '/bin/bash', 08:46:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjPcwxlSAY/Listeners', 08:46:10 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:46:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:10 INFO - 'USER': 'cltbld', 08:46:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:10 INFO - 'XPC_FLAGS': '0x0', 08:46:10 INFO - 'XPC_SERVICE_NAME': '0', 08:46:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:46:10 INFO - mozversion application_buildid: 20161221065231 08:46:10 INFO - mozversion application_changeset: 5b0afeaeebdd3a60e1885912cda2e48a9233be52 08:46:10 INFO - mozversion application_display_name: Nightly 08:46:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:10 INFO - mozversion application_name: Firefox 08:46:10 INFO - mozversion application_remotingname: firefox 08:46:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:46:10 INFO - mozversion application_vendor: Mozilla 08:46:10 INFO - mozversion application_version: 53.0a1 08:46:10 INFO - mozversion platform_buildid: 20161221065231 08:46:10 INFO - mozversion platform_changeset: 5b0afeaeebdd3a60e1885912cda2e48a9233be52 08:46:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:46:10 INFO - mozversion platform_version: 53.0a1 08:46:10 INFO - using testdate: 1482338770 08:46:10 INFO - actual date: 1482338770 08:46:10 INFO - starting webserver on 'localhost:49243' 08:46:10 INFO - SUITE-START | Running 2 tests 08:46:10 INFO - TEST-START | dromaeo_css 08:46:10 INFO - operating with platform_type : mac_ 08:46:10 INFO - Initialising browser for dromaeo_css test... 08:46:10 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpKwpRfS/profile http://localhost:49243/getInfo.html) 08:46:13 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 08:46:13 INFO - PROCESS | 1642 | colorDepth:24 08:46:13 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 08:46:13 INFO - PROCESS | 1642 | __metrics 08:46:13 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:46:13 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:14 INFO - TEST-INFO | 1642: exit 0 08:46:14 INFO - Browser initialized. 08:46:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:14 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpKwpRfS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:25 INFO - PROCESS | 1648 | RSS: Main: 236912640 08:46:25 INFO - PROCESS | 1648 | 08:47:16 INFO - PROCESS | 1648 | 1482338836783 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:49:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:49:32 INFO - PROCESS | 1648 | RSS: Main: 426594304 08:49:32 INFO - PROCESS | 1648 | 08:52:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:52:36 INFO - PROCESS | 1648 | RSS: Main: 371630080 08:52:36 INFO - PROCESS | 1648 | 08:55:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:55:39 INFO - PROCESS | 1648 | RSS: Main: 346423296 08:55:39 INFO - PROCESS | 1648 | 08:58:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 08:58:42 INFO - PROCESS | 1648 | RSS: Main: 341798912 08:58:42 INFO - PROCESS | 1648 | 09:01:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 09:01:46 INFO - PROCESS | 1648 | RSS: Main: 330420224 09:01:46 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 09:04:50 INFO - PROCESS | 1648 | RSS: Main: 518639616 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | __start_tp_report 09:04:50 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 09:04:50 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 09:04:50 INFO - PROCESS | 1648 | |i|pagename|runs| 09:04:50 INFO - PROCESS | 1648 | |0;dojo.html;3273.9017829465115;3291.8683252669894;3298.9340213195737;3300.306935543536;3352.497125431185;5464.316960379952;5574.414686457924;5635.492805647491;5698.430156984299;5734.483896449318;5586.469285417878;5668.348139963905;5712.9428705713035;5713.514351280146;5746.396628354026;5114.232865070232;5145.176771716508;5167.741612919358;5181.87045323868;5213.661112027725;5182.3262975813095;5209.270702101709;5220.634555581111;5254.316938797951;5259.237410575464;5121.692698438105;5158.458361871987;5183.896322073556;5185.118529849897;5214.739263036833;5195.350581177353;5199.740012999335;5201.635885488017;5209.453007434241;5210.869728256786;5122.846314610568;5181.766820493087;5192.221166825007;5201.531862132389;5203.4796520348045;5692.601517893749;5693.715314234313;5695.77216911323;5702.230198923134;5715.142728590745;6117.593182542191;6128.509719222451;6132.3555089925;6135.630783975068;6148.262208534959;6210.689465526705;6274.309825919146;6311.211098612674;6322.0200868865395;6326.5255105867245;5715.371309155989;5785.479306862402;5786.218860453869;5795.159701843209;5826.388229235911;6194.938050619436;6241.34465881085;6258.655773932477;6347.968260158762;6357.396047375492;6046.909296360558;6107.144999700045;6120.755169793248;6123.770712314271;6124.238830365066;6113.969430152821;6272.435480806749;6279.403456671609;6280.026595877646;6280.528960327993;5448.45515448452;6167.383261673796;6174.783882564088;6179.81460556184;6189.288231853305;5972.940270597325;6059.454649081604;6064.818055458255;6106.15732346443;6215.65813880241;4874.561289483963;4880.145974454456;4906.656534042583;4931.802727890844;4967.726775027409;3945.9013524662114;4166.562859691124;4354.238008348526;4361.890952726208;4373.1472362888935;5662.801801936995;5703.486686198179;5752.561859535116;5798.623089499169;5871.442212989759;6138.664296166128;6167.691615419211;6181.134641150243;6211.59624624407;6240.968795155995;5029.673071250357;5652.830415087554;5754.309482862083;5764.164196191528;5767.538596912237;5359.142537194109;5365.436629153883;5369.328833895763;5379.085555455582;5426.647267927572;6189.6286222826775;6281.685915704288;6298.307186209422;6334.113224148715;6336.556441049082;6185.536084793748;6321.1782468278825;6324.4940404766585;6331;6344;6325.082862984934;6335.619862808247;6339.841503962438;6343.809685709436;6389.456896163878;5952.107183922446;5999.250093738283;6143.907841382294;6212.72042758086;6213.658248796179;6171.907421388593;6171.9691401542705;6221.720022599085;6302.054691796267;6315.179026726496;6141.508679305555;6144.38556144382;6147.047207682816;6147.108669243024;6163.167972323679;5884.823455296348;6068.302145253176;6080.939190608037;6107.511399087974;6162.784302549389;4922.680025798311;5806.303243610625;5896.351401345934;5898.852528686817;5987.131865879336;6143.938560614337;6145.108959200801;6145.508359331332;6152.907706384497;6169.074638804215;5768.913466297925;5802.709864506842;5818.8254352369495;5837.29952405714;5875.618084824473 09:04:50 INFO - PROCESS | 1648 | |1;ext.html;399.3729844144692;438.30528612149743;455.84956964201814;474.59896387552504;491.9754012299384;29951;31182.90859819904;39275.80362098185;39891.40162897559;40105.79682609519;41215;41625.79187104068;41773.58226417735;41853;41919.58080419195;9380.624775009008;9622.855657165148;9623.085806848338;9629.903700963006;9631.229501639888;8485.915140848605;8635.309175265995;11166.720831979224;11454.713632159179;11485.368304743235;11432.085433165326;11509.079273658088;11510.021648159916;11515.596954106608;11539.942300288487;8475.576221188916;11382.772344553145;11406.916342947407;11501.884981150166;11516.942415287953;8351.164883511661;8596.226339629464;8597.441166324168;8598.140185981414;11021.614243501519;37642.81178594117;39398.40902386467;39653.20693586141;39658.60341396578;39658.60341396578;3372.4772660237704;3416.5900091988874;3527.2769082338314;3665.2303016366595;3826.367841761043;29508;29758.256043598867;29943.401131977454;29960.700392996227;30281.545776813364;3153.8580763865452;3175.7300629446527;3190.760692948038;3195.568598239231;3260.9347813043605;403059;479082;483525;485183;485582;57671.42328576744;58003;58032.41967580355;58150.709246454346;58176.418235817946;50001.74999124981;60528.78942421127;60771.392286076574;60827.39172608217;60975;15028.248587570577;15539.5338139856;15541.533753987398;15574.221288935734;15576;10855.565777368975;11149.832752508719;12071.456784444721;12143.817842732366;12172.965297949773;13867.445302188002;15430.38278468871;15798.36806527749;15869.603259918595;16121.919390402973;5288.709120998382;5798.579348059752;6032.440859892685;6413.551051426449;6429.678516074177;889.4307643108416;958.8465845464692;1004.0612027753928;1060.4538662588773;1094.2941802537478;29057.27356816054;29191;29247.755977440756;29252.561211581844;29595.112146635634;1031.6079889641887;1060.5545670818274;1082.6156714366443;1105.4251789069638;1126.3354620773782;11932.940335298441;13657.931710341385;15060.54818355451;15084.019538730166;15176.089434633957;585295.0735246297;588506;588572;590449;591897;56869.14696279559;57262.42737572654;57435;57477.85044299091;57478.425215748146;1255.4036832504487;1291.1284882703949;1295.546558704446;1409.9365528551034;1427.4361627157214;28447;28734.712652873204;29784.255393615334;30506.542401864433;30857.22856928505;52736.20895686491;53310;53388.46611533835;53422.93154136973;53674;526146;530334;530491;530790;532441.3377933085;21718.805465699537;23582.29253122409;24126.914288856693;24272.271831844366;38055.238895222494;33044.669553305124;33712.651493940946;35315.11712207215;41186.588134119476;41261.76214713563;34484.65515344815;34611.82694086513;34756.82621586876;35703.64296357003;35894.28211435809;34393.65606343905;34568;34863.825680871436;35263.11842203863;35873.82063089668;33738.493922591675;33741.493877592344;34268.65731342655;34729.305413891074;34856.47715284323;29359.853200733858;31362.843185783924;31544.2113947144;31573.526397103604;31604.525932110577;20982.580348392643;23456.882715586995;23521.64717529204;24103.638445423683;24163.154289600483 09:04:50 INFO - PROCESS | 1648 | |2;jquery.html;361.9438986957023;372.07353689313607;372.26849241240956;375.5868544600938;395.93269144245477;18950.810491895078;19296.228150873965;19723.901380493076;20278.594428111446;20413.48966275844;12063.336516491589;12210.633680989584;18286.45140645783;18845.58658100641;18963;5311.389190243133;5551.444855514436;5558.6942718150485;5572.804951826687;5578.079616863212;3868.400397938324;4122.361034039714;4147.854825081123;6703.798886033403;6734;6584.275729669733;6670.499712521556;6699.162604674416;6701.631410272433;6710.832229194285;5975.551833612496;6036.15493830864;6043.879122417571;6044.969775151096;6071.1196876453105;5460.972695136538;5833.708314584296;5838.241028666289;5843.561732870052;5857.502112320458;22669.88665056664;23203.187888423825;24007.51984960291;24060.518789624286;24165.033398664207;2228.576570451609;2243.9214627488122;2258.9661155082686;2260.2993072147524;2278.951682226178;9644.614215431375;9970.651027214013;10329.018743219382;10456.47717614124;10461.686149415453;1707.2317457144334;1875.5686192175876;1881.3603374852617;1911.3023746332628;1947.2989723699457;108015.45992270067;112026.43986780096;112959;113389;113633;11362.94318528402;11383.829242561369;11530.365829879269;11543.653690389301;11708.12189085822;14509.201993890438;14561.854381456049;14566.708665826836;14566.708665826836;14596.562103136923;6754.290799466084;8269.875951860728;8412.284955778705;8502.447340922943;8569;8220.301274391744;8221.917780822116;8272.37957153216;8392.412531122764;8426.831463370821;4457.442819647544;4541.455025396974;4550.772461376918;4643.674942754043;4643.767811609406;1690.2562872336132;1898.1932678611536;1907.9713804292946;1927.5181204698824;1931.9806801932082;711.8113699869539;801.9975031210986;810.4974915552277;815.0423252678198;891.4517571693361;19632.312869049514;20915.163393464092;21069.26257581008;21327.46681332979;21701.565968680537;953.7949340891741;955.8279509688323;967.2165545907837;972.4457059476031;993.1707024634367;10386.792264154674;10556.47217639115;11185.66443006711;11221.66335009951;11222.551097956153;413089;463574;466585;472540;474890;85681.57159214164;88434;104180;121448.39275803741;122476.16285755721;967.4485543240286;987.2694206287296;1014.7412409835445;1038;1040.7242080848582;18575.44273671738;19338.90330548338;19366.225350985802;19370.61258774845;19457.832530048243;47274.527254727014;50370.49629503658;51852.74073629608;51951.480485196174;52484.737576311876;75694;75981.62009189918;76610;76659.61670191614;78367.60816195882;7637;7939.801504962422;8020.478668886503;8038.557879316693;8046.83906321882;11713.355765432641;12076.879231207928;12090;12361.752764944831;12501.499940002299;9121;9815.52767084943;10352.844707329245;10816.351018938889;10949.945250273699;9146.039665834991;9900.900990989998;10575.101116405192;10575.307950727847;10633.734156645836;10945.288556243819;11007.779844402907;11018.898110188917;11174.994250517493;11229.66311010671;7877.409194310335;7988.840223195387;8003.239692229462;8024.638891249791;8290.046644635944;8009.239122283374;8225.753227403187;9685.41887486753;10371.636992705218;10661.413622250851 09:04:50 INFO - PROCESS | 1648 | |3;mootools.html;1472.602397352715;1523.0633160606228;1722.982770172298;1854.7310639957198;1909.388995521433;8051.91948080519;8464.449810762297;8472.91527084729;8481.745547633582;8489.448185867923;7410.777676669709;7646.158922518519;7647.885281720779;8029.718959836407;8210.876836847438;2287.485315803943;2330.778576035274;2334.3697201755517;2334.6031174700342;2343.027643527934;2348.213348528245;2367.1833217540006;2367.4081479630095;2389.1279682915783;2389.139909632531;2321.7330007049154;2325.2907863101746;2352.8117750579913;2354.776296251853;2355.998700552267;1948.8928108954;2302.3208153594646;2308.9725072342812;2310.6765052892442;2312.364099872532;2320.3271051395077;2341.379534423379;2347.4718188407473;2348.459854233519;2353.646952957053;8243.8351232975;8296.585170741439;8368.3305335573;8381.28759055481;8395.244428001448;5028.84913452597;5202.401723801736;5205.375354957429;5205.713685747282;5212.869678258074;3090.351026284483;3291.670832916713;3486.4073107571776;3487.7907325560545;3503.754737168399;1039.6984874386494;1061.400308825511;1068.7167900506372;1074.8441475986017;1083.918706097038;10436.947815260952;10796.028357447789;10806.243562950596;10850.891491085067;11022.063124634416;3737.271232109767;4253.680973926967;4369.868903932887;4424.247877860771;4494.662900282492;8618.439801412887;8620.78448038804;8626.654933802703;8632.611532481053;8633.136686331442;5078.796848126108;5082.847514574569;5101.821436249787;5112.130937740593;5115.258287548285;3835.5589107252463;4222.3244280914905;4747.976260118678;4794.304825800309;4801.95198048015;3628.872989445357;3654.3056819204267;3709.276691045274;3740.121071548184;3751.8989365955154;1131.8302254661703;1135.3755434510986;1137.2380505061628;1152.383474840973;1156.2253290295523;634.6445990245385;860.875173099897;880.7621942075732;896.188949001155;941.2799208605422;5418.4039755626845;5472.808451704172;5907.2911250650195;5923.822285331447;6067.271927368744;935.8923723771717;971.484484204643;974.697843668465;979.6669132494986;984.606157536991;3652.8356223969986;3750.3811871041516;3816.191598585802;3865.7680539167177;3926.2932672118723;9817.852732209023;10017.849732254022;10146.797064058677;10160;10184.388936663823;10123.443210623487;10125.088742013255;10127.240456965757;10129;10130.088292053602;7363.779086627303;7727.729529466442;7752.961235193788;7893.17121702213;7922.722704705423;5164.767585458739;5361.571074313967;5848.561357898089;5903.0555111182;5955.851103722442;9110.954445227731;9229.123233292827;9443.622255109993;9577.473238971923;9588.37675551087;9296;9366.67216647414;9380.530973451436;9583.808323833346;9715.125638692552;6586.967065164644;6817.0456136141975;6826.351496607815;7025.192102908231;7325.487215895049;7651.120121186135;7943.086545047162;7943.126256111707;8036.758897233092;8041.396895232764;6979.651017449209;7129.215786263403;7171.641417929187;7236.457265705199;7280.490365674352;6951.548149370275;6977.33715297046;7000.789976300719;7003.159620845531;7120.430365570845;6536.0522724205675;6539.149910511603;6606.537542371988;6617.7683781067435;6635.170603674541;4781.569658730731;4787.784549695341;4839.975800120977;4871.269309603446;4964.602831773522;4770.0936822003705;4842.249451335048;4885.047415753894;4885.95114048855;4898.044881248123 09:04:50 INFO - PROCESS | 1648 | |4;prototype.html;325.95273685315624;344.701832914529;345.4041777933064;347.34872114784775;364.2678216784263;5190;5195.688258704471;5207.609429292799;5238.476152384759;5238.6332956692995;4385.276429389155;4695.460022097452;4874.585660218877;5014.643117734668;5204.453532379102;3879.5538513071074;4034.9193016139807;4101.5488296287385;4116.670666346685;4118.073433477473;3346.498025296201;3568.036630109869;4035.878923632281;4107.137501124767;4132.483439570054;3744.9251014979686;3865.4781604483314;3954.387070004154;4100.753954762708;4103.528094269167;3239.5302681111343;3250.391056427072;3308.4541050726602;3541.8583256669704;3797.6012518685693;3398.9972957977457;3406.42090844557;3414.8463319150696;3417.043227896193;3419.401255046158;4580.839670611513;4648.279516674921;4746.288056791474;4977.875553111165;5021.648484606079;3523.4714792781033;3639.3622869708474;4386.912261754779;4469.173202957463;4469.195544801934;4477.776111194427;4864.805407783684;4879.4388645305535;5049.061731849163;5342.011727830325;3707.94438083429;3717.312297225022;3731.8693845715543;3734.3672710739133;3752.2307926874923;4893.314935908976;5430.294061771984;5577.972110139464;5717.456841600083;5752.252207213078;3669.3945498992903;3776.0937375029794;3778.792166430818;3779.9244015120094;3792.8001758979726;3790.578533050106;3841.5234213037247;3857.691384689218;3872.9279835287984;3874.4382064600477;3751.5873253942045;4098.836046558164;4305.203537345601;4466.977665111719;4467.955320446754;5146.30524879144;5396.730163491809;5469.644473109235;5488.012157811632;5516.420775818561;1110.9612512301023;1166.288563975974;1202.22456515547;1226.9325187114794;1240.621610408834;791.165320586775;803.5500119932856;805.6414895371504;819.3035919468523;848.6944699908029;4593.701409408378;4788.449328327218;4846.684965477232;4858.902821943612;4859.271109333557;4630.490646028934;4894.363732714795;5236.214567814782;5292.576593872481;5346.518813306743;3879.2047630236298;4043.9797801011396;4686.297055441642;4800.879978000508;4863.489333619989;2389.928302150938;2658.986705066501;2690.435008648167;2695.110613497541;2787.567926971323;4577.901303687157;4594.908101837945;4683.625309975194;4685.718856868599;5347.812826551052;4131.97934010328;4397.284294770913;4785.95214047862;5203.479652034766;5210.140326846028;5048.116579598629;5498;5501.889962200814;5504.752286147133;5514.696691681916;4629.768511574341;5134.203028939841;5277.709725965109;5318.627696061239;5345.9465405345445;4558.703684260512;4919.827806026915;5158.807506809516;5202.921956170736;5281.234221037851;4574.062317225027;4671.929921051119;4854.228206704457;4854.563089321978;5442.414852944819;3169.716264912714;3477.4609935460044;3570.821458927095;3574.928501429905;3591.51514545533;4617.284320930261;4681.625469962327;4848.3454733610515;5177.689338639693;5341.946580534145;4467.776611169494;5126.000429916131;5179.782751053424;5180.456052114624;5204.453532379197;4606.078784243232;4694.694844835075;4798.73606951621;5084.9745751271;5178.766955486937;3985.306244845987;4431.423914891044;4519.23173060587;5021.970496048229;5069.391672999263;4520.6383489320115;4879.853604391874;4889.926651100308;5348.5186333230195;5355.732213389237;5341.9198712020125;5350.866228344167;5352.277442545206;5369.301990741179;5422.213779002102 09:04:50 INFO - PROCESS | 1648 | |5;yui.html;725.6879541797027;731.747547096252;737.4727070144845;767.0028962348947;800.4716886854677;15194.92402537987;15397.92301038496;15779.28993195306;15827.129507877062;15890.205489725511;13595.93202033991;13698.726025479484;13722.176669399843;13722.31388430577;13746.931265343685;653.7058323754305;675.1830285354727;675.6317806795308;856.1481326080559;876.8246350729847;874.2350443362059;887.4719541872576;891.857302831547;892.2326798952895;893.0622846011694;936.6347124621369;937.9671711490099;937.9906200937971;938.6949241496541;939.3424602778049;692.394155114275;711.3242419701304;765.7013764631798;889.9822003559957;930.186087173723;679.4530403025562;680.4216416046371;680.9523333366666;681.2370145437093;682.4403988729244;14422;14571.562853114423;14777.965542412036;14826.703465930728;14833.851661483355;13324.267165305904;13341.799873001914;13412.013980336465;13431.798523022162;13577.117487363388;12207.93896030523;12237.571684991071;12323.5070597176;12363.938180309131;12445.377731113407;4242.40606315113;4277.550857159985;4288.185244803477;4295.098029413795;4424.535423780489;113087.99999999917;114480;117226.48320550397;117353.41323293414;119129.80870191274;8894.510801905828;10589.523471443803;10609.15126789855;10849.132069434427;10919.727006824893;20604.38186854397;20730;20906.895465522575;20921.05855236518;20932.058057387454;7607.125180604301;7611.1627720950655;7669.731559395506;7784.143744188134;7816.452848300678;4228.741919443063;4271.081717430705;4272.764997925082;4306.181825453154;4380.036391993756;2772.7781777457753;3378.797272163678;3393.9151521212166;3412.4710669846213;3413.60743514499;636.3064259956669;643.0996604753383;648.9221293444817;664.9335066493312;665.5241502325861;540.8999335123015;543.8450041738085;587.1574290892497;632.784853149922;642.5213216153902;8179.83640327202;8359.623816928253;8502.78743031429;8602.483850968962;8842.967792098932;582.7465052702088;596.3946594206883;628.707650942314;630.9053641953652;635.0569404434411;4186.476690413699;4186.811593478301;4237;4262.211490874198;4292.163028209532;87107;90097.19805603982;98493.5075324633;98593.50703246582;113996.29005564924;86337.56831215804;86683.13316866876;87010.56494717486;87026.824329391;88979.66530502048;64107;75448.73653790505;76702.23297766951;77456.45087098227;78389.82415263775;9434.622615095319;9650.855237171589;9658.227341812779;9755.512224388895;9827.361221520578;42156.94607634834;51426.228606571676;52452.95094098173;52744.472555273955;53264.20103698525;63236.36763632489;69158.65420672865;74580.62709686416;74617.2538274632;76048;9927.950360248153;12237.632871013884;12867.356632168541;12881.935590321988;12915.418806153933;14420.85579144195;14629.561113166623;14697.338619761922;15205.847941520886;15415;11074.723131921444;13439.596812095653;13577.185368877505;13592.524261650795;13658.795118073038;13367.064305498521;13763.931180344034;13948.58154255374;13954.023218375023;14202.431902723776;10498.685039448828;13168.736625267633;13173.736525269633;13255.80116298237;13612.251326177155;11166;11294.023545879274;11342.943285283522;11366.147538934778;11380.772384552429;9295.953520232355;11006.223341025026;11164;11407.429628518375;11437.656870293904 09:04:50 INFO - PROCESS | 1648 | __end_tp_report 09:04:50 INFO - PROCESS | 1648 | __start_cc_report 09:04:50 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2406 09:04:50 INFO - PROCESS | 1648 | __end_cc_report 09:04:50 INFO - PROCESS | 1648 | __startTimestamp1482339890474__endTimestamp 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | ------- Summary: start ------- 09:04:50 INFO - PROCESS | 1648 | Number of tests: 6 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5710.24 Median:5875.62 stddev:660.46 (11.2%) stddev-sans-first:634.22 09:04:50 INFO - PROCESS | 1648 | Values: 3273.9 3291.9 3298.9 3300.3 3352.5 5464.3 5574.4 5635.5 5698.4 5734.5 5586.5 5668.3 5712.9 5713.5 5746.4 5114.2 5145.2 5167.7 5181.9 5213.7 5182.3 5209.3 5220.6 5254.3 5259.2 5121.7 5158.5 5183.9 5185.1 5214.7 5195.4 5199.7 5201.6 5209.5 5210.9 5122.8 5181.8 5192.2 5201.5 5203.5 5692.6 5693.7 5695.8 5702.2 5715.1 6117.6 6128.5 6132.4 6135.6 6148.3 6210.7 6274.3 6311.2 6322.0 6326.5 5715.4 5785.5 5786.2 5795.2 5826.4 6194.9 6241.3 6258.7 6348.0 6357.4 6046.9 6107.1 6120.8 6123.8 6124.2 6114.0 6272.4 6279.4 6280.0 6280.5 5448.5 6167.4 6174.8 6179.8 6189.3 5972.9 6059.5 6064.8 6106.2 6215.7 4874.6 4880.1 4906.7 4931.8 4967.7 3945.9 4166.6 4354.2 4361.9 4373.1 5662.8 5703.5 5752.6 5798.6 5871.4 6138.7 6167.7 6181.1 6211.6 6241.0 5029.7 5652.8 5754.3 5764.2 5767.5 5359.1 5365.4 5369.3 5379.1 5426.6 6189.6 6281.7 6298.3 6334.1 6336.6 6185.5 6321.2 6324.5 6331.0 6344.0 6325.1 6335.6 6339.8 6343.8 6389.5 5952.1 5999.3 6143.9 6212.7 6213.7 6171.9 6172.0 6221.7 6302.1 6315.2 6141.5 6144.4 6147.0 6147.1 6163.2 5884.8 6068.3 6080.9 6107.5 6162.8 4922.7 5806.3 5896.4 5898.9 5987.1 6143.9 6145.1 6145.5 6152.9 6169.1 5768.9 5802.7 5818.8 5837.3 5875.6 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:65716.65 Median:34526.33 stddev:141870.75 (410.9%) stddev-sans-first:142183.98 09:04:50 INFO - PROCESS | 1648 | Values: 399.4 438.3 455.8 474.6 492.0 29951.0 31182.9 39275.8 39891.4 40105.8 41215.0 41625.8 41773.6 41853.0 41919.6 9380.6 9622.9 9623.1 9629.9 9631.2 8485.9 8635.3 11166.7 11454.7 11485.4 11432.1 11509.1 11510.0 11515.6 11539.9 8475.6 11382.8 11406.9 11501.9 11516.9 8351.2 8596.2 8597.4 8598.1 11021.6 37642.8 39398.4 39653.2 39658.6 39658.6 3372.5 3416.6 3527.3 3665.2 3826.4 29508.0 29758.3 29943.4 29960.7 30281.5 3153.9 3175.7 3190.8 3195.6 3260.9 403059.0 479082.0 483525.0 485183.0 485582.0 57671.4 58003.0 58032.4 58150.7 58176.4 50001.7 60528.8 60771.4 60827.4 60975.0 15028.2 15539.5 15541.5 15574.2 15576.0 10855.6 11149.8 12071.5 12143.8 12173.0 13867.4 15430.4 15798.4 15869.6 16121.9 5288.7 5798.6 6032.4 6413.6 6429.7 889.4 958.8 1004.1 1060.5 1094.3 29057.3 29191.0 29247.8 29252.6 29595.1 1031.6 1060.6 1082.6 1105.4 1126.3 11932.9 13657.9 15060.5 15084.0 15176.1 585295.1 588506.0 588572.0 590449.0 591897.0 56869.1 57262.4 57435.0 57477.9 57478.4 1255.4 1291.1 1295.5 1409.9 1427.4 28447.0 28734.7 29784.3 30506.5 30857.2 52736.2 53310.0 53388.5 53422.9 53674.0 526146.0 530334.0 530491.0 530790.0 532441.3 21718.8 23582.3 24126.9 24272.3 38055.2 33044.7 33712.7 35315.1 41186.6 41261.8 34484.7 34611.8 34756.8 35703.6 35894.3 34393.7 34568.0 34863.8 35263.1 35873.8 33738.5 33741.5 34268.7 34729.3 34856.5 29359.9 31362.8 31544.2 31573.5 31604.5 20982.6 23456.9 23521.6 24103.6 24163.2 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:29915.57 Median:2121.99 stddev:77313.21 (3643.4%) stddev-sans-first:77498.25 09:04:50 INFO - PROCESS | 1648 | Values: 361.9 372.1 372.3 375.6 395.9 18950.8 19296.2 19723.9 20278.6 20413.5 12063.3 12210.6 18286.5 18845.6 18963.0 5311.4 5551.4 5558.7 5572.8 5578.1 3868.4 4122.4 4147.9 6703.8 6734.0 6584.3 6670.5 6699.2 6701.6 6710.8 5975.6 6036.2 6043.9 6045.0 6071.1 5461.0 5833.7 5838.2 5843.6 5857.5 22669.9 23203.2 24007.5 24060.5 24165.0 2228.6 2243.9 2259.0 2260.3 2279.0 9644.6 9970.7 10329.0 10456.5 10461.7 1707.2 1875.6 1881.4 1911.3 1947.3 108015.5 112026.4 112959.0 113389.0 113633.0 11362.9 11383.8 11530.4 11543.7 11708.1 14509.2 14561.9 14566.7 14566.7 14596.6 6754.3 8269.9 8412.3 8502.4 8569.0 8220.3 8221.9 8272.4 8392.4 8426.8 4457.4 4541.5 4550.8 4643.7 4643.8 1690.3 1898.2 1908.0 1927.5 1932.0 711.8 802.0 810.5 815.0 891.5 19632.3 20915.2 21069.3 21327.5 21701.6 953.8 955.8 967.2 972.4 993.2 10386.8 10556.5 11185.7 11221.7 11222.6 413089.0 463574.0 466585.0 472540.0 474890.0 85681.6 88434.0 104180.0 121448.4 122476.2 967.4 987.3 1014.7 1038.0 1040.7 18575.4 19338.9 19366.2 19370.6 19457.8 47274.5 50370.5 51852.7 51951.5 52484.7 75694.0 75981.6 76610.0 76659.6 78367.6 7637.0 7939.8 8020.5 8038.6 8046.8 11713.4 12076.9 12090.0 12361.8 12501.5 9121.0 9815.5 10352.8 10816.4 10949.9 9146.0 9900.9 10575.1 10575.3 10633.7 10945.3 11007.8 11018.9 11175.0 11229.7 7877.4 7988.8 8003.2 8024.6 8290.0 8009.2 8225.8 9685.4 10371.6 10661.4 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5406.36 Median:5080.82 stddev:2953.69 (58.1%) stddev-sans-first:2947.18 09:04:50 INFO - PROCESS | 1648 | Values: 1472.6 1523.1 1723.0 1854.7 1909.4 8051.9 8464.4 8472.9 8481.7 8489.4 7410.8 7646.2 7647.9 8029.7 8210.9 2287.5 2330.8 2334.4 2334.6 2343.0 2348.2 2367.2 2367.4 2389.1 2389.1 2321.7 2325.3 2352.8 2354.8 2356.0 1948.9 2302.3 2309.0 2310.7 2312.4 2320.3 2341.4 2347.5 2348.5 2353.6 8243.8 8296.6 8368.3 8381.3 8395.2 5028.8 5202.4 5205.4 5205.7 5212.9 3090.4 3291.7 3486.4 3487.8 3503.8 1039.7 1061.4 1068.7 1074.8 1083.9 10436.9 10796.0 10806.2 10850.9 11022.1 3737.3 4253.7 4369.9 4424.2 4494.7 8618.4 8620.8 8626.7 8632.6 8633.1 5078.8 5082.8 5101.8 5112.1 5115.3 3835.6 4222.3 4748.0 4794.3 4802.0 3628.9 3654.3 3709.3 3740.1 3751.9 1131.8 1135.4 1137.2 1152.4 1156.2 634.6 860.9 880.8 896.2 941.3 5418.4 5472.8 5907.3 5923.8 6067.3 935.9 971.5 974.7 979.7 984.6 3652.8 3750.4 3816.2 3865.8 3926.3 9817.9 10017.8 10146.8 10160.0 10184.4 10123.4 10125.1 10127.2 10129.0 10130.1 7363.8 7727.7 7753.0 7893.2 7922.7 5164.8 5361.6 5848.6 5903.1 5955.9 9111.0 9229.1 9443.6 9577.5 9588.4 9296.0 9366.7 9380.5 9583.8 9715.1 6587.0 6817.0 6826.4 7025.2 7325.5 7651.1 7943.1 7943.1 8036.8 8041.4 6979.7 7129.2 7171.6 7236.5 7280.5 6951.5 6977.3 7000.8 7003.2 7120.4 6536.1 6539.1 6606.5 6617.8 6635.2 4781.6 4787.8 4840.0 4871.3 4964.6 4770.1 4842.2 4885.0 4886.0 4898.0 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4210.06 Median:4639.39 stddev:1260.67 (27.2%) stddev-sans-first:1230.04 09:04:50 INFO - PROCESS | 1648 | Values: 326.0 344.7 345.4 347.3 364.3 5190.0 5195.7 5207.6 5238.5 5238.6 4385.3 4695.5 4874.6 5014.6 5204.5 3879.6 4034.9 4101.5 4116.7 4118.1 3346.5 3568.0 4035.9 4107.1 4132.5 3744.9 3865.5 3954.4 4100.8 4103.5 3239.5 3250.4 3308.5 3541.9 3797.6 3399.0 3406.4 3414.8 3417.0 3419.4 4580.8 4648.3 4746.3 4977.9 5021.6 3523.5 3639.4 4386.9 4469.2 4469.2 4477.8 4864.8 4879.4 5049.1 5342.0 3707.9 3717.3 3731.9 3734.4 3752.2 4893.3 5430.3 5578.0 5717.5 5752.3 3669.4 3776.1 3778.8 3779.9 3792.8 3790.6 3841.5 3857.7 3872.9 3874.4 3751.6 4098.8 4305.2 4467.0 4468.0 5146.3 5396.7 5469.6 5488.0 5516.4 1111.0 1166.3 1202.2 1226.9 1240.6 791.2 803.6 805.6 819.3 848.7 4593.7 4788.4 4846.7 4858.9 4859.3 4630.5 4894.4 5236.2 5292.6 5346.5 3879.2 4044.0 4686.3 4800.9 4863.5 2389.9 2659.0 2690.4 2695.1 2787.6 4577.9 4594.9 4683.6 4685.7 5347.8 4132.0 4397.3 4786.0 5203.5 5210.1 5048.1 5498.0 5501.9 5504.8 5514.7 4629.8 5134.2 5277.7 5318.6 5345.9 4558.7 4919.8 5158.8 5202.9 5281.2 4574.1 4671.9 4854.2 4854.6 5442.4 3169.7 3477.5 3570.8 3574.9 3591.5 4617.3 4681.6 4848.3 5177.7 5341.9 4467.8 5126.0 5179.8 5180.5 5204.5 4606.1 4694.7 4798.7 5085.0 5178.8 3985.3 4431.4 4519.2 5022.0 5069.4 4520.6 4879.9 4889.9 5348.5 5355.7 5341.9 5350.9 5352.3 5369.3 5422.2 09:04:50 INFO - PROCESS | 1648 | 09:04:50 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20441.66 Median:4300.64 stddev:29865.48 (694.4%) stddev-sans-first:29912.57 09:04:50 INFO - PROCESS | 1648 | Values: 725.7 731.7 737.5 767.0 800.5 15194.9 15397.9 15779.3 15827.1 15890.2 13595.9 13698.7 13722.2 13722.3 13746.9 653.7 675.2 675.6 856.1 876.8 874.2 887.5 891.9 892.2 893.1 936.6 938.0 938.0 938.7 939.3 692.4 711.3 765.7 890.0 930.2 679.5 680.4 681.0 681.2 682.4 14422.0 14571.6 14778.0 14826.7 14833.9 13324.3 13341.8 13412.0 13431.8 13577.1 12207.9 12237.6 12323.5 12363.9 12445.4 4242.4 4277.6 4288.2 4295.1 4424.5 113088.0 114480.0 117226.5 117353.4 119129.8 8894.5 10589.5 10609.2 10849.1 10919.7 20604.4 20730.0 20906.9 20921.1 20932.1 7607.1 7611.2 7669.7 7784.1 7816.5 4228.7 4271.1 4272.8 4306.2 4380.0 2772.8 3378.8 3393.9 3412.5 3413.6 636.3 643.1 648.9 664.9 665.5 540.9 543.8 587.2 632.8 642.5 8179.8 8359.6 8502.8 8602.5 8843.0 582.7 596.4 628.7 630.9 635.1 4186.5 4186.8 4237.0 4262.2 4292.2 87107.0 90097.2 98493.5 98593.5 113996.3 86337.6 86683.1 87010.6 87026.8 88979.7 64107.0 75448.7 76702.2 77456.5 78389.8 9434.6 9650.9 9658.2 9755.5 9827.4 42156.9 51426.2 52453.0 52744.5 53264.2 63236.4 69158.7 74580.6 74617.3 76048.0 9928.0 12237.6 12867.4 12881.9 12915.4 14420.9 14629.6 14697.3 15205.8 15415.0 11074.7 13439.6 13577.2 13592.5 13658.8 13367.1 13763.9 13948.6 13954.0 14202.4 10498.7 13168.7 13173.7 13255.8 13612.3 11166.0 11294.0 11342.9 11366.1 11380.8 9296.0 11006.2 11164.0 11407.4 11437.7 09:04:50 INFO - PROCESS | 1648 | -------- Summary: end -------- 09:04:50 INFO - PROCESS | 1648 | 09:04:51 INFO - TEST-INFO | 1648: exit 0 09:04:51 INFO - TEST-OK | dromaeo_css | took 1120584ms 09:04:51 INFO - TEST-START | kraken 09:04:51 INFO - operating with platform_type : mac_ 09:04:51 INFO - Initialising browser for kraken test... 09:04:51 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp88TS7m/profile http://localhost:49243/getInfo.html) 09:04:53 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 09:04:53 INFO - PROCESS | 1654 | colorDepth:24 09:04:53 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 09:04:53 INFO - PROCESS | 1654 | __metrics 09:04:53 INFO - PROCESS | 1654 | 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" 09:04:53 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:54 INFO - TEST-INFO | 1654: exit 0 09:04:54 INFO - Browser initialized. 09:04:54 INFO - Running cycle 1/1 for kraken test... 09:04:54 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp88TS7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:06 INFO - PROCESS | 1656 | RSS: Main: 228548608 09:05:06 INFO - PROCESS | 1656 | 09:05:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 09:05:10 INFO - PROCESS | 1656 | RSS: Main: 288407552 09:05:10 INFO - PROCESS | 1656 | 09:05:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 09:05:13 INFO - PROCESS | 1656 | RSS: Main: 289439744 09:05:13 INFO - PROCESS | 1656 | 09:05:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 09:05:17 INFO - PROCESS | 1656 | RSS: Main: 382201856 09:05:17 INFO - PROCESS | 1656 | 09:05:19 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 09:05:20 INFO - PROCESS | 1656 | RSS: Main: 284581888 09:05:20 INFO - PROCESS | 1656 | 09:05:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:22 INFO - PROCESS | 1656 | RSS: Main: 288030720 09:05:22 INFO - PROCESS | 1656 | 09:05:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:26 INFO - PROCESS | 1656 | RSS: Main: 330280960 09:05:26 INFO - PROCESS | 1656 | 09:05:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:29 INFO - PROCESS | 1656 | RSS: Main: 331591680 09:05:29 INFO - PROCESS | 1656 | 09:05:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 09:05:33 INFO - PROCESS | 1656 | RSS: Main: 329519104 09:05:33 INFO - PROCESS | 1656 | 09:05:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:35 INFO - PROCESS | 1656 | RSS: Main: 303861760 09:05:35 INFO - PROCESS | 1656 | 09:05:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:38 INFO - PROCESS | 1656 | RSS: Main: 308293632 09:05:38 INFO - PROCESS | 1656 | 09:05:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:41 INFO - PROCESS | 1656 | RSS: Main: 310947840 09:05:41 INFO - PROCESS | 1656 | 09:05:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:44 INFO - PROCESS | 1656 | RSS: Main: 323596288 09:05:44 INFO - PROCESS | 1656 | 09:05:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:48 INFO - PROCESS | 1656 | RSS: Main: 322424832 09:05:48 INFO - PROCESS | 1656 | 09:05:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 09:05:50 INFO - PROCESS | 1656 | RSS: Main: 366817280 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | __start_tp_report 09:05:50 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:05:50 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:05:50 INFO - PROCESS | 1656 | |i|pagename|runs| 09:05:50 INFO - PROCESS | 1656 | |0;ai-astar;104;117;169;148;114;114;113;113;113;111 09:05:50 INFO - PROCESS | 1656 | |1;audio-beat-detection;169;147;138;144;112;108;110;111;130;111 09:05:50 INFO - PROCESS | 1656 | |2;audio-dft;184;183;182;187;183;178;180;186;182;181 09:05:50 INFO - PROCESS | 1656 | |3;audio-fft;80;60;61;106;84;83;60;59;73;58 09:05:50 INFO - PROCESS | 1656 | |4;audio-oscillator;90;71;86;68;69;69;81;69;69;83 09:05:50 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;88;87;89;86;89;88;90;86;88;87 09:05:50 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;94;98;98;93;149;126;97;94;94 09:05:50 INFO - PROCESS | 1656 | |7;imaging-desaturate;125;133;85;87;85;89;85;84;85;84 09:05:50 INFO - PROCESS | 1656 | |8;json-parse-financial;58;55;56;55;55;56;56;55;55;55 09:05:50 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;73;69;74;70;72;71;78;80;106;82 09:05:50 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;87;90;86;88;85;82;85;87;86;85 09:05:50 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;140;139;138;138;138;139;137;140;221;177 09:05:50 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;171;173;172;172;171;172;171;171;172;172 09:05:50 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;66;68;69;68;68;67;68;67;66;65 09:05:50 INFO - PROCESS | 1656 | __end_tp_report 09:05:50 INFO - PROCESS | 1656 | __start_cc_report 09:05:50 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1994 09:05:50 INFO - PROCESS | 1656 | __end_cc_report 09:05:50 INFO - PROCESS | 1656 | __startTimestamp1482339950227__endTimestamp 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:05:50 INFO - PROCESS | 1656 | Number of tests: 14 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:121.60 Median:114.00 stddev:20.34 (17.8%) stddev-sans-first:20.56 09:05:50 INFO - PROCESS | 1656 | Values: 104.0 117.0 169.0 148.0 114.0 114.0 113.0 113.0 113.0 111.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:134.00 stddev:20.98 (15.7%) stddev-sans-first:16.17 09:05:50 INFO - PROCESS | 1656 | Values: 169.0 147.0 138.0 144.0 112.0 108.0 110.0 111.0 130.0 111.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:2.67 (1.5%) stddev-sans-first:2.79 09:05:50 INFO - PROCESS | 1656 | Values: 184.0 183.0 182.0 187.0 183.0 178.0 180.0 186.0 182.0 181.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:72.40 Median:67.00 stddev:15.84 (23.6%) stddev-sans-first:16.56 09:05:50 INFO - PROCESS | 1656 | Values: 80.0 60.0 61.0 106.0 84.0 83.0 60.0 59.0 73.0 58.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:8.51 (11.2%) stddev-sans-first:7.24 09:05:50 INFO - PROCESS | 1656 | Values: 90.0 71.0 86.0 68.0 69.0 69.0 81.0 69.0 69.0 83.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:1.32 (1.5%) stddev-sans-first:1.39 09:05:50 INFO - PROCESS | 1656 | Values: 88.0 87.0 89.0 86.0 89.0 88.0 90.0 86.0 88.0 87.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:94.00 stddev:18.71 (19.9%) stddev-sans-first:19.51 09:05:50 INFO - PROCESS | 1656 | Values: 94.0 94.0 98.0 98.0 93.0 149.0 126.0 97.0 94.0 94.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:85.00 stddev:18.50 (21.8%) stddev-sans-first:15.91 09:05:50 INFO - PROCESS | 1656 | Values: 125.0 133.0 85.0 87.0 85.0 89.0 85.0 84.0 85.0 84.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:0.97 (1.7%) stddev-sans-first:0.50 09:05:50 INFO - PROCESS | 1656 | Values: 58.0 55.0 56.0 55.0 55.0 56.0 56.0 55.0 55.0 55.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:73.50 stddev:10.92 (14.9%) stddev-sans-first:11.46 09:05:50 INFO - PROCESS | 1656 | Values: 73.0 69.0 74.0 70.0 72.0 71.0 78.0 80.0 106.0 82.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.50 stddev:2.13 (2.5%) stddev-sans-first:2.24 09:05:50 INFO - PROCESS | 1656 | Values: 87.0 90.0 86.0 88.0 85.0 82.0 85.0 87.0 86.0 85.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:139.50 stddev:27.50 (19.7%) stddev-sans-first:28.90 09:05:50 INFO - PROCESS | 1656 | Values: 140.0 139.0 138.0 138.0 138.0 139.0 137.0 140.0 221.0 177.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 09:05:50 INFO - PROCESS | 1656 | Values: 171.0 173.0 172.0 172.0 171.0 172.0 171.0 171.0 172.0 172.0 09:05:50 INFO - PROCESS | 1656 | 09:05:50 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 09:05:50 INFO - PROCESS | 1656 | Values: 66.0 68.0 69.0 68.0 68.0 67.0 68.0 67.0 66.0 65.0 09:05:50 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:05:50 INFO - PROCESS | 1656 | 09:05:51 INFO - TEST-INFO | 1656: exit 0 09:05:51 INFO - TEST-OK | kraken | took 60040ms 09:05:51 INFO - SUITE-END | took 1180s 09:05:51 INFO - Completed test suite (00:19:40) 09:05:51 INFO - javascript benchmark 09:05:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.9017829465115, 3291.8683252669894, 3298.9340213195737, 3300.306935543536, 3352.497125431185, 5464.316960379952, 5574.414686457924, 5635.492805647491, 5698.430156984299, 5734.483896449318, 5586.469285417878, 5668.348139963905, 5712.9428705713035, 5713.514351280146, 5746.396628354026, 5114.232865070232, 5145.176771716508, 5167.741612919358, 5181.87045323868, 5213.661112027725, 5182.3262975813095, 5209.270702101709, 5220.634555581111, 5254.316938797951, 5259.237410575464, 5121.692698438105, 5158.458361871987, 5183.896322073556, 5185.118529849897, 5214.739263036833, 5195.350581177353, 5199.740012999335, 5201.635885488017, 5209.453007434241, 5210.869728256786, 5122.846314610568, 5181.766820493087, 5192.221166825007, 5201.531862132389, 5203.4796520348045, 5692.601517893749, 5693.715314234313, 5695.77216911323, 5702.230198923134, 5715.142728590745, 6117.593182542191, 6128.509719222451, 6132.3555089925, 6135.630783975068, 6148.262208534959, 6210.689465526705, 6274.309825919146, 6311.211098612674, 6322.0200868865395, 6326.5255105867245, 5715.371309155989, 5785.479306862402, 5786.218860453869, 5795.159701843209, 5826.388229235911, 6194.938050619436, 6241.34465881085, 6258.655773932477, 6347.968260158762, 6357.396047375492, 6046.909296360558, 6107.144999700045, 6120.755169793248, 6123.770712314271, 6124.238830365066, 6113.969430152821, 6272.435480806749, 6279.403456671609, 6280.026595877646, 6280.528960327993, 5448.45515448452, 6167.383261673796, 6174.783882564088, 6179.81460556184, 6189.288231853305, 5972.940270597325, 6059.454649081604, 6064.818055458255, 6106.15732346443, 6215.65813880241, 4874.561289483963, 4880.145974454456, 4906.656534042583, 4931.802727890844, 4967.726775027409, 3945.9013524662114, 4166.562859691124, 4354.238008348526, 4361.890952726208, 4373.1472362888935, 5662.801801936995, 5703.486686198179, 5752.561859535116, 5798.623089499169, 5871.442212989759, 6138.664296166128, 6167.691615419211, 6181.134641150243, 6211.59624624407, 6240.968795155995, 5029.673071250357, 5652.830415087554, 5754.309482862083, 5764.164196191528, 5767.538596912237, 5359.142537194109, 5365.436629153883, 5369.328833895763, 5379.085555455582, 5426.647267927572, 6189.6286222826775, 6281.685915704288, 6298.307186209422, 6334.113224148715, 6336.556441049082, 6185.536084793748, 6321.1782468278825, 6324.4940404766585, 6331.0, 6344.0, 6325.082862984934, 6335.619862808247, 6339.841503962438, 6343.809685709436, 6389.456896163878, 5952.107183922446, 5999.250093738283, 6143.907841382294, 6212.72042758086, 6213.658248796179, 6171.907421388593, 6171.9691401542705, 6221.720022599085, 6302.054691796267, 6315.179026726496, 6141.508679305555, 6144.38556144382, 6147.047207682816, 6147.108669243024, 6163.167972323679, 5884.823455296348, 6068.302145253176, 6080.939190608037, 6107.511399087974, 6162.784302549389, 4922.680025798311, 5806.303243610625, 5896.351401345934, 5898.852528686817, 5987.131865879336, 6143.938560614337, 6145.108959200801, 6145.508359331332, 6152.907706384497, 6169.074638804215, 5768.913466297925, 5802.709864506842, 5818.8254352369495, 5837.29952405714, 5875.618084824473], "value": 5666.107692049851, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.3729844144692, 438.30528612149743, 455.84956964201814, 474.59896387552504, 491.9754012299384, 29951.0, 31182.90859819904, 39275.80362098185, 39891.40162897559, 40105.79682609519, 41215.0, 41625.79187104068, 41773.58226417735, 41853.0, 41919.58080419195, 9380.624775009008, 9622.855657165148, 9623.085806848338, 9629.903700963006, 9631.229501639888, 8485.915140848605, 8635.309175265995, 11166.720831979224, 11454.713632159179, 11485.368304743235, 11432.085433165326, 11509.079273658088, 11510.021648159916, 11515.596954106608, 11539.942300288487, 8475.576221188916, 11382.772344553145, 11406.916342947407, 11501.884981150166, 11516.942415287953, 8351.164883511661, 8596.226339629464, 8597.441166324168, 8598.140185981414, 11021.614243501519, 37642.81178594117, 39398.40902386467, 39653.20693586141, 39658.60341396578, 39658.60341396578, 3372.4772660237704, 3416.5900091988874, 3527.2769082338314, 3665.2303016366595, 3826.367841761043, 29508.0, 29758.256043598867, 29943.401131977454, 29960.700392996227, 30281.545776813364, 3153.8580763865452, 3175.7300629446527, 3190.760692948038, 3195.568598239231, 3260.9347813043605, 403059.0, 479082.0, 483525.0, 485183.0, 485582.0, 57671.42328576744, 58003.0, 58032.41967580355, 58150.709246454346, 58176.418235817946, 50001.74999124981, 60528.78942421127, 60771.392286076574, 60827.39172608217, 60975.0, 15028.248587570577, 15539.5338139856, 15541.533753987398, 15574.221288935734, 15576.0, 10855.565777368975, 11149.832752508719, 12071.456784444721, 12143.817842732366, 12172.965297949773, 13867.445302188002, 15430.38278468871, 15798.36806527749, 15869.603259918595, 16121.919390402973, 5288.709120998382, 5798.579348059752, 6032.440859892685, 6413.551051426449, 6429.678516074177, 889.4307643108416, 958.8465845464692, 1004.0612027753928, 1060.4538662588773, 1094.2941802537478, 29057.27356816054, 29191.0, 29247.755977440756, 29252.561211581844, 29595.112146635634, 1031.6079889641887, 1060.5545670818274, 1082.6156714366443, 1105.4251789069638, 1126.3354620773782, 11932.940335298441, 13657.931710341385, 15060.54818355451, 15084.019538730166, 15176.089434633957, 585295.0735246297, 588506.0, 588572.0, 590449.0, 591897.0, 56869.14696279559, 57262.42737572654, 57435.0, 57477.85044299091, 57478.425215748146, 1255.4036832504487, 1291.1284882703949, 1295.546558704446, 1409.9365528551034, 1427.4361627157214, 28447.0, 28734.712652873204, 29784.255393615334, 30506.542401864433, 30857.22856928505, 52736.20895686491, 53310.0, 53388.46611533835, 53422.93154136973, 53674.0, 526146.0, 530334.0, 530491.0, 530790.0, 532441.3377933085, 21718.805465699537, 23582.29253122409, 24126.914288856693, 24272.271831844366, 38055.238895222494, 33044.669553305124, 33712.651493940946, 35315.11712207215, 41186.588134119476, 41261.76214713563, 34484.65515344815, 34611.82694086513, 34756.82621586876, 35703.64296357003, 35894.28211435809, 34393.65606343905, 34568.0, 34863.825680871436, 35263.11842203863, 35873.82063089668, 33738.493922591675, 33741.493877592344, 34268.65731342655, 34729.305413891074, 34856.47715284323, 29359.853200733858, 31362.843185783924, 31544.2113947144, 31573.526397103604, 31604.525932110577, 20982.580348392643, 23456.882715586995, 23521.64717529204, 24103.638445423683, 24163.154289600483], "value": 19112.797298561192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9438986957023, 372.07353689313607, 372.26849241240956, 375.5868544600938, 395.93269144245477, 18950.810491895078, 19296.228150873965, 19723.901380493076, 20278.594428111446, 20413.48966275844, 12063.336516491589, 12210.633680989584, 18286.45140645783, 18845.58658100641, 18963.0, 5311.389190243133, 5551.444855514436, 5558.6942718150485, 5572.804951826687, 5578.079616863212, 3868.400397938324, 4122.361034039714, 4147.854825081123, 6703.798886033403, 6734.0, 6584.275729669733, 6670.499712521556, 6699.162604674416, 6701.631410272433, 6710.832229194285, 5975.551833612496, 6036.15493830864, 6043.879122417571, 6044.969775151096, 6071.1196876453105, 5460.972695136538, 5833.708314584296, 5838.241028666289, 5843.561732870052, 5857.502112320458, 22669.88665056664, 23203.187888423825, 24007.51984960291, 24060.518789624286, 24165.033398664207, 2228.576570451609, 2243.9214627488122, 2258.9661155082686, 2260.2993072147524, 2278.951682226178, 9644.614215431375, 9970.651027214013, 10329.018743219382, 10456.47717614124, 10461.686149415453, 1707.2317457144334, 1875.5686192175876, 1881.3603374852617, 1911.3023746332628, 1947.2989723699457, 108015.45992270067, 112026.43986780096, 112959.0, 113389.0, 113633.0, 11362.94318528402, 11383.829242561369, 11530.365829879269, 11543.653690389301, 11708.12189085822, 14509.201993890438, 14561.854381456049, 14566.708665826836, 14566.708665826836, 14596.562103136923, 6754.290799466084, 8269.875951860728, 8412.284955778705, 8502.447340922943, 8569.0, 8220.301274391744, 8221.917780822116, 8272.37957153216, 8392.412531122764, 8426.831463370821, 4457.442819647544, 4541.455025396974, 4550.772461376918, 4643.674942754043, 4643.767811609406, 1690.2562872336132, 1898.1932678611536, 1907.9713804292946, 1927.5181204698824, 1931.9806801932082, 711.8113699869539, 801.9975031210986, 810.4974915552277, 815.0423252678198, 891.4517571693361, 19632.312869049514, 20915.163393464092, 21069.26257581008, 21327.46681332979, 21701.565968680537, 953.7949340891741, 955.8279509688323, 967.2165545907837, 972.4457059476031, 993.1707024634367, 10386.792264154674, 10556.47217639115, 11185.66443006711, 11221.66335009951, 11222.551097956153, 413089.0, 463574.0, 466585.0, 472540.0, 474890.0, 85681.57159214164, 88434.0, 104180.0, 121448.39275803741, 122476.16285755721, 967.4485543240286, 987.2694206287296, 1014.7412409835445, 1038.0, 1040.7242080848582, 18575.44273671738, 19338.90330548338, 19366.225350985802, 19370.61258774845, 19457.832530048243, 47274.527254727014, 50370.49629503658, 51852.74073629608, 51951.480485196174, 52484.737576311876, 75694.0, 75981.62009189918, 76610.0, 76659.61670191614, 78367.60816195882, 7637.0, 7939.801504962422, 8020.478668886503, 8038.557879316693, 8046.83906321882, 11713.355765432641, 12076.879231207928, 12090.0, 12361.752764944831, 12501.499940002299, 9121.0, 9815.52767084943, 10352.844707329245, 10816.351018938889, 10949.945250273699, 9146.039665834991, 9900.900990989998, 10575.101116405192, 10575.307950727847, 10633.734156645836, 10945.288556243819, 11007.779844402907, 11018.898110188917, 11174.994250517493, 11229.66311010671, 7877.409194310335, 7988.840223195387, 8003.239692229462, 8024.638891249791, 8290.046644635944, 8009.239122283374, 8225.753227403187, 9685.41887486753, 10371.636992705218, 10661.413622250851], "value": 9181.176666215664, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.602397352715, 1523.0633160606228, 1722.982770172298, 1854.7310639957198, 1909.388995521433, 8051.91948080519, 8464.449810762297, 8472.91527084729, 8481.745547633582, 8489.448185867923, 7410.777676669709, 7646.158922518519, 7647.885281720779, 8029.718959836407, 8210.876836847438, 2287.485315803943, 2330.778576035274, 2334.3697201755517, 2334.6031174700342, 2343.027643527934, 2348.213348528245, 2367.1833217540006, 2367.4081479630095, 2389.1279682915783, 2389.139909632531, 2321.7330007049154, 2325.2907863101746, 2352.8117750579913, 2354.776296251853, 2355.998700552267, 1948.8928108954, 2302.3208153594646, 2308.9725072342812, 2310.6765052892442, 2312.364099872532, 2320.3271051395077, 2341.379534423379, 2347.4718188407473, 2348.459854233519, 2353.646952957053, 8243.8351232975, 8296.585170741439, 8368.3305335573, 8381.28759055481, 8395.244428001448, 5028.84913452597, 5202.401723801736, 5205.375354957429, 5205.713685747282, 5212.869678258074, 3090.351026284483, 3291.670832916713, 3486.4073107571776, 3487.7907325560545, 3503.754737168399, 1039.6984874386494, 1061.400308825511, 1068.7167900506372, 1074.8441475986017, 1083.918706097038, 10436.947815260952, 10796.028357447789, 10806.243562950596, 10850.891491085067, 11022.063124634416, 3737.271232109767, 4253.680973926967, 4369.868903932887, 4424.247877860771, 4494.662900282492, 8618.439801412887, 8620.78448038804, 8626.654933802703, 8632.611532481053, 8633.136686331442, 5078.796848126108, 5082.847514574569, 5101.821436249787, 5112.130937740593, 5115.258287548285, 3835.5589107252463, 4222.3244280914905, 4747.976260118678, 4794.304825800309, 4801.95198048015, 3628.872989445357, 3654.3056819204267, 3709.276691045274, 3740.121071548184, 3751.8989365955154, 1131.8302254661703, 1135.3755434510986, 1137.2380505061628, 1152.383474840973, 1156.2253290295523, 634.6445990245385, 860.875173099897, 880.7621942075732, 896.188949001155, 941.2799208605422, 5418.4039755626845, 5472.808451704172, 5907.2911250650195, 5923.822285331447, 6067.271927368744, 935.8923723771717, 971.484484204643, 974.697843668465, 979.6669132494986, 984.606157536991, 3652.8356223969986, 3750.3811871041516, 3816.191598585802, 3865.7680539167177, 3926.2932672118723, 9817.852732209023, 10017.849732254022, 10146.797064058677, 10160.0, 10184.388936663823, 10123.443210623487, 10125.088742013255, 10127.240456965757, 10129.0, 10130.088292053602, 7363.779086627303, 7727.729529466442, 7752.961235193788, 7893.17121702213, 7922.722704705423, 5164.767585458739, 5361.571074313967, 5848.561357898089, 5903.0555111182, 5955.851103722442, 9110.954445227731, 9229.123233292827, 9443.622255109993, 9577.473238971923, 9588.37675551087, 9296.0, 9366.67216647414, 9380.530973451436, 9583.808323833346, 9715.125638692552, 6586.967065164644, 6817.0456136141975, 6826.351496607815, 7025.192102908231, 7325.487215895049, 7651.120121186135, 7943.086545047162, 7943.126256111707, 8036.758897233092, 8041.396895232764, 6979.651017449209, 7129.215786263403, 7171.641417929187, 7236.457265705199, 7280.490365674352, 6951.548149370275, 6977.33715297046, 7000.789976300719, 7003.159620845531, 7120.430365570845, 6536.0522724205675, 6539.149910511603, 6606.537542371988, 6617.7683781067435, 6635.170603674541, 4781.569658730731, 4787.784549695341, 4839.975800120977, 4871.269309603446, 4964.602831773522, 4770.0936822003705, 4842.249451335048, 4885.047415753894, 4885.95114048855, 4898.044881248123], "value": 4390.005254409973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.95273685315624, 344.701832914529, 345.4041777933064, 347.34872114784775, 364.2678216784263, 5190.0, 5195.688258704471, 5207.609429292799, 5238.476152384759, 5238.6332956692995, 4385.276429389155, 4695.460022097452, 4874.585660218877, 5014.643117734668, 5204.453532379102, 3879.5538513071074, 4034.9193016139807, 4101.5488296287385, 4116.670666346685, 4118.073433477473, 3346.498025296201, 3568.036630109869, 4035.878923632281, 4107.137501124767, 4132.483439570054, 3744.9251014979686, 3865.4781604483314, 3954.387070004154, 4100.753954762708, 4103.528094269167, 3239.5302681111343, 3250.391056427072, 3308.4541050726602, 3541.8583256669704, 3797.6012518685693, 3398.9972957977457, 3406.42090844557, 3414.8463319150696, 3417.043227896193, 3419.401255046158, 4580.839670611513, 4648.279516674921, 4746.288056791474, 4977.875553111165, 5021.648484606079, 3523.4714792781033, 3639.3622869708474, 4386.912261754779, 4469.173202957463, 4469.195544801934, 4477.776111194427, 4864.805407783684, 4879.4388645305535, 5049.061731849163, 5342.011727830325, 3707.94438083429, 3717.312297225022, 3731.8693845715543, 3734.3672710739133, 3752.2307926874923, 4893.314935908976, 5430.294061771984, 5577.972110139464, 5717.456841600083, 5752.252207213078, 3669.3945498992903, 3776.0937375029794, 3778.792166430818, 3779.9244015120094, 3792.8001758979726, 3790.578533050106, 3841.5234213037247, 3857.691384689218, 3872.9279835287984, 3874.4382064600477, 3751.5873253942045, 4098.836046558164, 4305.203537345601, 4466.977665111719, 4467.955320446754, 5146.30524879144, 5396.730163491809, 5469.644473109235, 5488.012157811632, 5516.420775818561, 1110.9612512301023, 1166.288563975974, 1202.22456515547, 1226.9325187114794, 1240.621610408834, 791.165320586775, 803.5500119932856, 805.6414895371504, 819.3035919468523, 848.6944699908029, 4593.701409408378, 4788.449328327218, 4846.684965477232, 4858.902821943612, 4859.271109333557, 4630.490646028934, 4894.363732714795, 5236.214567814782, 5292.576593872481, 5346.518813306743, 3879.2047630236298, 4043.9797801011396, 4686.297055441642, 4800.879978000508, 4863.489333619989, 2389.928302150938, 2658.986705066501, 2690.435008648167, 2695.110613497541, 2787.567926971323, 4577.901303687157, 4594.908101837945, 4683.625309975194, 4685.718856868599, 5347.812826551052, 4131.97934010328, 4397.284294770913, 4785.95214047862, 5203.479652034766, 5210.140326846028, 5048.116579598629, 5498.0, 5501.889962200814, 5504.752286147133, 5514.696691681916, 4629.768511574341, 5134.203028939841, 5277.709725965109, 5318.627696061239, 5345.9465405345445, 4558.703684260512, 4919.827806026915, 5158.807506809516, 5202.921956170736, 5281.234221037851, 4574.062317225027, 4671.929921051119, 4854.228206704457, 4854.563089321978, 5442.414852944819, 3169.716264912714, 3477.4609935460044, 3570.821458927095, 3574.928501429905, 3591.51514545533, 4617.284320930261, 4681.625469962327, 4848.3454733610515, 5177.689338639693, 5341.946580534145, 4467.776611169494, 5126.000429916131, 5179.782751053424, 5180.456052114624, 5204.453532379197, 4606.078784243232, 4694.694844835075, 4798.73606951621, 5084.9745751271, 5178.766955486937, 3985.306244845987, 4431.423914891044, 4519.23173060587, 5021.970496048229, 5069.391672999263, 4520.6383489320115, 4879.853604391874, 4889.926651100308, 5348.5186333230195, 5355.732213389237, 5341.9198712020125, 5350.866228344167, 5352.277442545206, 5369.301990741179, 5422.213779002102], "value": 3821.3266535160355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.6879541797027, 731.747547096252, 737.4727070144845, 767.0028962348947, 800.4716886854677, 15194.92402537987, 15397.92301038496, 15779.28993195306, 15827.129507877062, 15890.205489725511, 13595.93202033991, 13698.726025479484, 13722.176669399843, 13722.31388430577, 13746.931265343685, 653.7058323754305, 675.1830285354727, 675.6317806795308, 856.1481326080559, 876.8246350729847, 874.2350443362059, 887.4719541872576, 891.857302831547, 892.2326798952895, 893.0622846011694, 936.6347124621369, 937.9671711490099, 937.9906200937971, 938.6949241496541, 939.3424602778049, 692.394155114275, 711.3242419701304, 765.7013764631798, 889.9822003559957, 930.186087173723, 679.4530403025562, 680.4216416046371, 680.9523333366666, 681.2370145437093, 682.4403988729244, 14422.0, 14571.562853114423, 14777.965542412036, 14826.703465930728, 14833.851661483355, 13324.267165305904, 13341.799873001914, 13412.013980336465, 13431.798523022162, 13577.117487363388, 12207.93896030523, 12237.571684991071, 12323.5070597176, 12363.938180309131, 12445.377731113407, 4242.40606315113, 4277.550857159985, 4288.185244803477, 4295.098029413795, 4424.535423780489, 113087.99999999917, 114480.0, 117226.48320550397, 117353.41323293414, 119129.80870191274, 8894.510801905828, 10589.523471443803, 10609.15126789855, 10849.132069434427, 10919.727006824893, 20604.38186854397, 20730.0, 20906.895465522575, 20921.05855236518, 20932.058057387454, 7607.125180604301, 7611.1627720950655, 7669.731559395506, 7784.143744188134, 7816.452848300678, 4228.741919443063, 4271.081717430705, 4272.764997925082, 4306.181825453154, 4380.036391993756, 2772.7781777457753, 3378.797272163678, 3393.9151521212166, 3412.4710669846213, 3413.60743514499, 636.3064259956669, 643.0996604753383, 648.9221293444817, 664.9335066493312, 665.5241502325861, 540.8999335123015, 543.8450041738085, 587.1574290892497, 632.784853149922, 642.5213216153902, 8179.83640327202, 8359.623816928253, 8502.78743031429, 8602.483850968962, 8842.967792098932, 582.7465052702088, 596.3946594206883, 628.707650942314, 630.9053641953652, 635.0569404434411, 4186.476690413699, 4186.811593478301, 4237.0, 4262.211490874198, 4292.163028209532, 87107.0, 90097.19805603982, 98493.5075324633, 98593.50703246582, 113996.29005564924, 86337.56831215804, 86683.13316866876, 87010.56494717486, 87026.824329391, 88979.66530502048, 64107.0, 75448.73653790505, 76702.23297766951, 77456.45087098227, 78389.82415263775, 9434.622615095319, 9650.855237171589, 9658.227341812779, 9755.512224388895, 9827.361221520578, 42156.94607634834, 51426.228606571676, 52452.95094098173, 52744.472555273955, 53264.20103698525, 63236.36763632489, 69158.65420672865, 74580.62709686416, 74617.2538274632, 76048.0, 9927.950360248153, 12237.632871013884, 12867.356632168541, 12881.935590321988, 12915.418806153933, 14420.85579144195, 14629.561113166623, 14697.338619761922, 15205.847941520886, 15415.0, 11074.723131921444, 13439.596812095653, 13577.185368877505, 13592.524261650795, 13658.795118073038, 13367.064305498521, 13763.931180344034, 13948.58154255374, 13954.023218375023, 14202.431902723776, 10498.685039448828, 13168.736625267633, 13173.736525269633, 13255.80116298237, 13612.251326177155, 11166.0, 11294.023545879274, 11342.943285283522, 11366.147538934778, 11380.772384552429, 9295.953520232355, 11006.223341025026, 11164.0, 11407.429628518375, 11437.656870293904], "value": 7345.305199709357, "unit": "score"}], "name": "dromaeo_css", "value": 7047.593549472895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 169.0, 148.0, 114.0, 114.0, 113.0, 113.0, 113.0, 111.0], "value": 121.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 147.0, 138.0, 144.0, 112.0, 108.0, 110.0, 111.0, 130.0, 111.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 182.0, 187.0, 183.0, 178.0, 180.0, 186.0, 182.0, 181.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 61.0, 106.0, 84.0, 83.0, 60.0, 59.0, 73.0, 58.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 86.0, 68.0, 69.0, 69.0, 81.0, 69.0, 69.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 86.0, 89.0, 88.0, 90.0, 86.0, 88.0, 87.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 98.0, 98.0, 93.0, 149.0, 126.0, 97.0, 94.0, 94.0], "value": 103.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 133.0, 85.0, 87.0, 85.0, 89.0, 85.0, 84.0, 85.0, 84.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 74.0, 70.0, 72.0, 71.0, 78.0, 80.0, 106.0, 82.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 86.0, 88.0, 85.0, 82.0, 85.0, 87.0, 86.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 138.0, 138.0, 138.0, 139.0, 137.0, 140.0, 221.0, 177.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 172.0, 172.0, 171.0, 172.0, 171.0, 171.0, 172.0, 172.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 66.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1474.6000000000001, "alertThreshold": 2.0}]} 09:05:51 INFO - Return code: 0 09:05:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:51 INFO - # TBPL SUCCESS # 09:05:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:05:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:05:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:05:51 INFO - 2016-12-21 09:05:51.577 screenresolution[1660:9891] starting screenresolution argv=screenresolution get 09:05:51 INFO - 2016-12-21 09:05:51.580 screenresolution[1660:9891] Display 0: 1600x1200x32@60 09:05:51 INFO - 2016-12-21 09:05:51.586 screenresolution[1661:9894] starting screenresolution argv=screenresolution list 09:05:51 INFO - Available Modes on Display 0 09:05:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:05:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:05:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:05:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:05:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:05:51 INFO - Intel Iris: 09:05:51 INFO - Chipset Model: Intel Iris 09:05:51 INFO - Type: GPU 09:05:51 INFO - Bus: Built-In 09:05:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:05:51 INFO - Vendor: Intel (0x8086) 09:05:51 INFO - Device ID: 0x0a2e 09:05:51 INFO - Revision ID: 0x0009 09:05:51 INFO - Displays: 09:05:51 INFO - Display: 09:05:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:05:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:05:51 INFO - Display Serial Number: 1600x1200 60 09:05:51 INFO - Main Display: Yes 09:05:51 INFO - Mirror: Off 09:05:51 INFO - Online: Yes 09:05:51 INFO - Rotation: Supported 09:05:51 INFO - Return code: 0 09:05:51 INFO - Running post-action listener: _resource_record_post_action 09:05:51 INFO - [mozharness: 2016-12-21 17:05:51.819390Z] Finished run-tests step (success) 09:05:51 INFO - Running post-run listener: _resource_record_post_run 09:05:51 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 38761472; Write bytes: 550868992; Read time: 379; Write time: 1641 09:05:51 INFO - TinderboxPrint: CPU usage
53.7% 09:05:51 INFO - TinderboxPrint: I/O read bytes / time
38,761,472 / 379 09:05:51 INFO - TinderboxPrint: I/O write bytes / time
550,868,992 / 1,641 09:05:51 INFO - TinderboxPrint: CPU idle
2,229.0 (46.3%) 09:05:51 INFO - TinderboxPrint: CPU system
961.8 (20.0%) 09:05:51 INFO - TinderboxPrint: CPU user
1,622.9 (33.7%) 09:05:51 INFO - TinderboxPrint: Swap in / out
288,047,104 / 0 09:05:51 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247611904; Write bytes: 241354752; Read time: 18052; Write time: 474 09:05:51 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 36635648; Write bytes: 297996288; Read time: 351; Write time: 1134 09:05:52 INFO - Running post-run listener: _upload_blobber_files 09:05:52 INFO - Blob upload gear active. 09:05:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:52 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 09:05:52 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:52 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:53 INFO - (blobuploader) - INFO - Done attempting. 09:05:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:05:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:05:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:54 INFO - (blobuploader) - INFO - Done attempting. 09:05:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:05:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:05:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:55 INFO - (blobuploader) - INFO - Done attempting. 09:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:58 INFO - (blobuploader) - INFO - Done attempting. 09:05:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:58 INFO - Return code: 0 09:05:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db49d735abee6350166bb9fba0489cd0eab87a2eb2043c6e744fd4187c997c5a59c3bfa6360d0bd320ab6a638ace39e322885fe8049bd2fea0be6c5efe864032", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd770f73676d00bd75ccbce76957db413f2becf79b07fc37a440353fb2fde48960d0ac6e4eb01f05260958ea26dc79958379c107667c7c8109daede91af096b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ad118349b959cf86eb5f7265d318a65b5ec72fd6b37bde07551bd0378f1ce77324d91f4d13848b45e61ab5f2a18bc541ff1af920cf9762f43e905b5cc57c5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a562d64ff3204f39f2816e2e967fb1b499699d382bd3bd9bf468cd2a6f93a1f8947f038fb0b9676de6c43cdd83adedc16f1286b911b8853d712d97c86629694"} 09:05:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:58 INFO - Contents: 09:05:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db49d735abee6350166bb9fba0489cd0eab87a2eb2043c6e744fd4187c997c5a59c3bfa6360d0bd320ab6a638ace39e322885fe8049bd2fea0be6c5efe864032", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd770f73676d00bd75ccbce76957db413f2becf79b07fc37a440353fb2fde48960d0ac6e4eb01f05260958ea26dc79958379c107667c7c8109daede91af096b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ad118349b959cf86eb5f7265d318a65b5ec72fd6b37bde07551bd0378f1ce77324d91f4d13848b45e61ab5f2a18bc541ff1af920cf9762f43e905b5cc57c5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a562d64ff3204f39f2816e2e967fb1b499699d382bd3bd9bf468cd2a6f93a1f8947f038fb0b9676de6c43cdd83adedc16f1286b911b8853d712d97c86629694"} 09:05:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:58 INFO - Copying logs to upload dir... 09:05:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.024389 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-21 09:05:58.853733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 09:05:58.861619) ========= 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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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/Firefox/sha512/db49d735abee6350166bb9fba0489cd0eab87a2eb2043c6e744fd4187c997c5a59c3bfa6360d0bd320ab6a638ace39e322885fe8049bd2fea0be6c5efe864032", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd770f73676d00bd75ccbce76957db413f2becf79b07fc37a440353fb2fde48960d0ac6e4eb01f05260958ea26dc79958379c107667c7c8109daede91af096b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ad118349b959cf86eb5f7265d318a65b5ec72fd6b37bde07551bd0378f1ce77324d91f4d13848b45e61ab5f2a18bc541ff1af920cf9762f43e905b5cc57c5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a562d64ff3204f39f2816e2e967fb1b499699d382bd3bd9bf468cd2a6f93a1f8947f038fb0b9676de6c43cdd83adedc16f1286b911b8853d712d97c86629694"} build_url:https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/NzEG5QE0Tc-XNifLpaBD5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db49d735abee6350166bb9fba0489cd0eab87a2eb2043c6e744fd4187c997c5a59c3bfa6360d0bd320ab6a638ace39e322885fe8049bd2fea0be6c5efe864032", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd770f73676d00bd75ccbce76957db413f2becf79b07fc37a440353fb2fde48960d0ac6e4eb01f05260958ea26dc79958379c107667c7c8109daede91af096b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ad118349b959cf86eb5f7265d318a65b5ec72fd6b37bde07551bd0378f1ce77324d91f4d13848b45e61ab5f2a18bc541ff1af920cf9762f43e905b5cc57c5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a562d64ff3204f39f2816e2e967fb1b499699d382bd3bd9bf468cd2a6f93a1f8947f038fb0b9676de6c43cdd83adedc16f1286b911b8853d712d97c86629694"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 09:05:59.048151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:05:59.048516) ========= 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.SQP8DtVIL9/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.rjPcwxlSAY/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005339 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:05:59.076110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 09:05:59.076444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 09:05:59.076764) ========= ========= Total master_lag: 1.17 =========