builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0060 starttime: 1490691629.55 results: success (0) buildid: 20170328004003 builduid: a93bd0709e6f4eaa8ac19c1f076cdd14 revision: db2babffcafbd6b5b47a8c5813005838eb171a90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.553187) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.553642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.553983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.578738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.579096) ========= 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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-28 02:00:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-03-28 02:00:29 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117098 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.719830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.720167) ========= 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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.021243 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.768736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:29.769080) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev db2babffcafbd6b5b47a8c5813005838eb171a90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev db2babffcafbd6b5b47a8c5813005838eb171a90 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0VMVrWf0XM/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.YjIGNKBMXi/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-28 02:00:29,860 truncating revision to first 12 chars 2017-03-28 02:00:29,860 Setting DEBUG logging. 2017-03-28 02:00:29,860 attempt 1/10 2017-03-28 02:00:29,860 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/db2babffcafb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 02:00:30,532 unpacking tar archive at: mozilla-aurora-db2babffcafb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929079 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:30.742222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:30.742549) ========= script_repo_revision: db2babffcafbd6b5b47a8c5813005838eb171a90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:30.742957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:30.743219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 02:00:30.770668) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-28 02:00:30.771054) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0VMVrWf0XM/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.YjIGNKBMXi/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:00:30 INFO - MultiFileLogger online at 20170328 02:00:30 in /builds/slave/test 02:00:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:00:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:00:30 INFO - {'append_to_log': False, 02:00:30 INFO - 'base_work_dir': '/builds/slave/test', 02:00:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:00:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:00:30 INFO - 'branch': 'Mozilla-Aurora', 02:00:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:00:30 INFO - 'config_files': ('talos/mac_config.py',), 02:00:30 INFO - 'default_actions': ('clobber', 02:00:30 INFO - 'read-buildbot-config', 02:00:30 INFO - 'download-and-extract', 02:00:30 INFO - 'populate-webroot', 02:00:30 INFO - 'create-virtualenv', 02:00:30 INFO - 'install', 02:00:30 INFO - 'run-tests'), 02:00:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:00:30 INFO - 'download_minidump_stackwalk': True, 02:00:30 INFO - 'download_symbols': 'ondemand', 02:00:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:00:30 INFO - 'tooltool.py': '/tools/tooltool.py', 02:00:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:00:30 INFO - '/tools/misc-python/virtualenv.py')}, 02:00:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:00:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:00:30 INFO - 'gecko_profile': False, 02:00:30 INFO - 'gecko_profile_interval': 0, 02:00:30 INFO - 'installer_path': 'installer.exe', 02:00:30 INFO - 'log_level': 'info', 02:00:30 INFO - 'log_name': 'talos', 02:00:30 INFO - 'log_to_console': True, 02:00:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:00:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:00:30 INFO - 'opt_config_files': (), 02:00:30 INFO - 'pip_index': False, 02:00:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:00:30 INFO - 'cmd': ('bash', 02:00:30 INFO - '-c', 02:00:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:00:30 INFO - 'enabled': True, 02:00:30 INFO - 'halt_on_failure': False, 02:00:30 INFO - 'name': 'check_screen_resolution'},), 02:00:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:00:30 INFO - 'cmd': ('bash', 02:00:30 INFO - '-c', 02:00:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:00:30 INFO - 'enabled': True, 02:00:30 INFO - 'halt_on_failure': False, 02:00:30 INFO - 'name': 'check_screen_resolution'},), 02:00:30 INFO - 'run_cmd_checks_enabled': True, 02:00:30 INFO - 'suite': 'dromaeojs-e10s', 02:00:30 INFO - 'system_bits': '32', 02:00:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:00:30 INFO - 'title': 't-yosemite-r7-0060', 02:00:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:00:30 INFO - 'use_talos_json': True, 02:00:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:00:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:00:30 INFO - 'work_dir': 'build'} 02:00:30 INFO - [mozharness: 2017-03-28 09:00:30.983681Z] Running clobber step. 02:00:30 INFO - Running pre-action listener: _resource_record_pre_action 02:00:30 INFO - Running main action method: clobber 02:00:30 INFO - rmtree: /builds/slave/test/build 02:00:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:00:32 INFO - Running post-action listener: _resource_record_post_action 02:00:32 INFO - [mozharness: 2017-03-28 09:00:32.716326Z] Finished clobber step (success) 02:00:32 INFO - [mozharness: 2017-03-28 09:00:32.716451Z] Running read-buildbot-config step. 02:00:32 INFO - Running pre-action listener: _resource_record_pre_action 02:00:32 INFO - Running main action method: read_buildbot_config 02:00:32 INFO - Using buildbot properties: 02:00:32 INFO - { 02:00:32 INFO - "project": "", 02:00:32 INFO - "product": "firefox", 02:00:32 INFO - "script_repo_revision": "production", 02:00:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:00:32 INFO - "repository": "", 02:00:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:00:32 INFO - "buildid": "20170328004003", 02:00:32 INFO - "stage_platform": "macosx64", 02:00:32 INFO - "basedir": "/builds/slave/test", 02:00:32 INFO - "nightly_build": "True", 02:00:32 INFO - "buildnumber": 91, 02:00:32 INFO - "slavename": "t-yosemite-r7-0060", 02:00:32 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:00:32 INFO - "platform": "yosemite_r7", 02:00:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:00:32 INFO - "branch": "mozilla-aurora", 02:00:32 INFO - "repo_path": "releases/mozilla-aurora", 02:00:32 INFO - "revision": "db2babffcafbd6b5b47a8c5813005838eb171a90", 02:00:32 INFO - "pgo_build": "False", 02:00:32 INFO - "builduid": "a93bd0709e6f4eaa8ac19c1f076cdd14", 02:00:32 INFO - "slavebuilddir": "test" 02:00:32 INFO - } 02:00:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:00:32 INFO - Running post-action listener: _resource_record_post_action 02:00:32 INFO - [mozharness: 2017-03-28 09:00:32.719836Z] Finished read-buildbot-config step (success) 02:00:32 INFO - [mozharness: 2017-03-28 09:00:32.719948Z] Running download-and-extract step. 02:00:32 INFO - Running pre-action listener: _resource_record_pre_action 02:00:32 INFO - Running main action method: download_and_extract 02:00:32 INFO - mkdir: /builds/slave/test/build/tests 02:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:32 INFO - trying https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:00:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:00:33 INFO - Downloaded 1199 bytes. 02:00:33 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:00:33 INFO - Using the following test package requirements: 02:00:33 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:00:33 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:00:33 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:00:33 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'jsshell-mac.zip'], 02:00:33 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:00:33 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:00:33 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:00:33 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:00:33 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:00:33 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:00:33 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:00:33 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:00:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:00:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:00:33 INFO - Fetch https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:00:35 INFO - Expected file size: 51789064 02:00:35 INFO - Obtained file size: 51789064 02:00:51 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:00:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:00:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:00:51 INFO - Fetch https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:00:53 INFO - Expected file size: 51789064 02:00:53 INFO - Obtained file size: 51789064 02:01:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:01:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:01:08 INFO - Fetch https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:01:09 INFO - Expected file size: 14404438 02:01:09 INFO - Obtained file size: 14404438 02:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:09 INFO - trying https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:01:09 INFO - Downloading https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:01:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:01:11 INFO - Downloaded 74737487 bytes. 02:01:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:01:11 INFO - mkdir: /builds/slave/test/properties 02:01:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:01:11 INFO - Writing to file /builds/slave/test/properties/build_url 02:01:11 INFO - Contents: 02:01:11 INFO - build_url:https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:01:12 INFO - Running post-action listener: _resource_record_post_action 02:01:12 INFO - Running post-action listener: set_extra_try_arguments 02:01:12 INFO - [mozharness: 2017-03-28 09:01:12.298535Z] Finished download-and-extract step (success) 02:01:12 INFO - [mozharness: 2017-03-28 09:01:12.298660Z] Running populate-webroot step. 02:01:12 INFO - Running pre-action listener: _resource_record_pre_action 02:01:12 INFO - Running main action method: populate_webroot 02:01:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:01:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:01:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:01:12 INFO - '--tppagecycles', 02:01:12 INFO - '7'], 02:01:12 INFO - 'tests': ['tsvgm']}}, 02:01:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:01:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:01:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:01:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:01:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:01:12 INFO - 'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:01:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:01:12 INFO - 'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['damp', 'tps']}, 02:01:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:01:12 INFO - 'tests': ['damp', 'tps']}, 02:01:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['dromaeo_dom']}, 02:01:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:01:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['basic_compositor_video']}, 02:01:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:01:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['a11yr', 02:01:12 INFO - 'ts_paint', 02:01:12 INFO - 'tpaint', 02:01:12 INFO - 'sessionrestore', 02:01:12 INFO - 'sessionrestore_no_auto_restore', 02:01:12 INFO - 'tabpaint']}, 02:01:12 INFO - 'other-e10s': {'tests': ['a11yr', 02:01:12 INFO - 'ts_paint', 02:01:12 INFO - 'tpaint', 02:01:12 INFO - 'sessionrestore', 02:01:12 INFO - 'sessionrestore_no_auto_restore', 02:01:12 INFO - 'tabpaint']}, 02:01:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:01:12 INFO - 'ts_paint', 02:01:12 INFO - 'tpaint', 02:01:12 INFO - 'sessionrestore', 02:01:12 INFO - 'sessionrestore_no_auto_restore', 02:01:12 INFO - 'tabpaint']}, 02:01:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:01:12 INFO - 'ts_paint', 02:01:12 INFO - 'tpaint', 02:01:12 INFO - 'sessionrestore', 02:01:12 INFO - 'sessionrestore_no_auto_restore', 02:01:12 INFO - 'tabpaint']}, 02:01:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['a11yr', 02:01:12 INFO - 'ts_paint', 02:01:12 INFO - 'tpaint', 02:01:12 INFO - 'sessionrestore', 02:01:12 INFO - 'sessionrestore_no_auto_restore', 02:01:12 INFO - 'tabpaint']}, 02:01:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['a11yr', 02:01:12 INFO - 'ts_paint', 02:01:12 INFO - 'tpaint', 02:01:12 INFO - 'sessionrestore', 02:01:12 INFO - 'sessionrestore_no_auto_restore', 02:01:12 INFO - 'tabpaint']}, 02:01:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['tsvgx', 02:01:12 INFO - 'tsvgr_opacity', 02:01:12 INFO - 'tart', 02:01:12 INFO - 'tscrollx', 02:01:12 INFO - 'cart', 02:01:12 INFO - 'tsvg_static']}, 02:01:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:01:12 INFO - 'tsvgr_opacity', 02:01:12 INFO - 'tart', 02:01:12 INFO - 'tscrollx', 02:01:12 INFO - 'cart', 02:01:12 INFO - 'tsvg_static']}, 02:01:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:01:12 INFO - 'talos_options': ['--disable-e10s'], 02:01:12 INFO - 'tests': ['tp5o']}, 02:01:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:01:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:01:12 INFO - 'talos_options': ['--disable-e10s', 02:01:12 INFO - '--xperf_path', 02:01:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:12 INFO - 'tests': ['tp5n']}, 02:01:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:01:12 INFO - 'talos_options': ['--xperf_path', 02:01:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:12 INFO - 'tests': ['tp5n']}}, 02:01:12 INFO - 'talos.zip': {'path': '', 02:01:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:01:12 INFO - Running post-action listener: _resource_record_post_action 02:01:12 INFO - [mozharness: 2017-03-28 09:01:12.317636Z] Finished populate-webroot step (success) 02:01:12 INFO - [mozharness: 2017-03-28 09:01:12.317776Z] Running create-virtualenv step. 02:01:12 INFO - Running pre-action listener: _resource_record_pre_action 02:01:12 INFO - Running main action method: create_virtualenv 02:01:12 INFO - Creating virtualenv /builds/slave/test/build/venv 02:01:12 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 02:01:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:01:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:01:12 INFO - Using real prefix '/tools/python27' 02:01:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:01:13 INFO - Installing distribute.............................................................................................................................................................................................done. 02:01:16 INFO - Installing pip.................done. 02:01:16 INFO - Return code: 0 02:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:01:16 INFO - Reading from file tmpfile_stdout 02:01:16 INFO - Output received: 02:01:16 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) 02:01:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:01:16 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')]} 02:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:16 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')]} 02:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:16 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:16 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 02:01:16 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 02:01:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:16 INFO - 'HOME': '/Users/cltbld', 02:01:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:16 INFO - 'LOGNAME': 'cltbld', 02:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:16 INFO - 'MOZ_NO_REMOTE': '1', 02:01:16 INFO - 'NO_EM_RESTART': '1', 02:01:16 INFO - 'PAGER': '/bin/cat', 02:01:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:16 INFO - 'PWD': '/builds/slave/test', 02:01:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:16 INFO - 'SHELL': '/bin/bash', 02:01:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:16 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:16 INFO - 'USER': 'cltbld', 02:01:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:16 INFO - 'XPC_FLAGS': '0x0', 02:01:16 INFO - 'XPC_SERVICE_NAME': '0', 02:01:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:16 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 02:01:16 INFO - Cleaning up... 02:01:16 INFO - Return code: 0 02:01:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:01:16 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')]} 02:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:16 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')]} 02:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:16 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:16 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 02:01:16 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 02:01:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:16 INFO - 'HOME': '/Users/cltbld', 02:01:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:16 INFO - 'LOGNAME': 'cltbld', 02:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:16 INFO - 'MOZ_NO_REMOTE': '1', 02:01:16 INFO - 'NO_EM_RESTART': '1', 02:01:16 INFO - 'PAGER': '/bin/cat', 02:01:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:16 INFO - 'PWD': '/builds/slave/test', 02:01:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:16 INFO - 'SHELL': '/bin/bash', 02:01:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:16 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:16 INFO - 'USER': 'cltbld', 02:01:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:16 INFO - 'XPC_FLAGS': '0x0', 02:01:16 INFO - 'XPC_SERVICE_NAME': '0', 02:01:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:16 INFO - Downloading/unpacking psutil>=3.1.1 02:01:16 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 02:01:16 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 02:01:16 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 02:01:16 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 02:01:16 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 02:01:16 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 02:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:20 INFO - Installing collected packages: psutil 02:01:20 INFO - Running setup.py install for psutil 02:01:20 INFO - building 'psutil._psutil_osx' extension 02:01:20 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 02:01:20 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 02:01:20 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 02:01:20 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 02:01:21 INFO - building 'psutil._psutil_posix' extension 02:01:21 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 02:01:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:01:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:01:21 INFO - ^ 02:01:21 INFO - 1 warning generated. 02:01:21 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 02:01:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:21 INFO - Successfully installed psutil 02:01:21 INFO - Cleaning up... 02:01:21 INFO - Return code: 0 02:01:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:21 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:21 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 02:01:21 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 02:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:21 INFO - 'HOME': '/Users/cltbld', 02:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:21 INFO - 'LOGNAME': 'cltbld', 02:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:21 INFO - 'MOZ_NO_REMOTE': '1', 02:01:21 INFO - 'NO_EM_RESTART': '1', 02:01:21 INFO - 'PAGER': '/bin/cat', 02:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:21 INFO - 'PWD': '/builds/slave/test', 02:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:21 INFO - 'SHELL': '/bin/bash', 02:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:21 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:21 INFO - 'USER': 'cltbld', 02:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:21 INFO - 'XPC_FLAGS': '0x0', 02:01:21 INFO - 'XPC_SERVICE_NAME': '0', 02:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:01:21 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 02:01:21 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 02:01:21 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 02:01:21 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 02:01:21 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 02:01:21 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 02:01:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:01:24 INFO - Installing collected packages: mozsystemmonitor 02:01:24 INFO - Running setup.py install for mozsystemmonitor 02:01:24 INFO - Successfully installed mozsystemmonitor 02:01:24 INFO - Cleaning up... 02:01:24 INFO - Return code: 0 02:01:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:01:24 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')]} 02:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:24 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')]} 02:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:24 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:24 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 02:01:24 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 02:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:24 INFO - 'HOME': '/Users/cltbld', 02:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:24 INFO - 'LOGNAME': 'cltbld', 02:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:24 INFO - 'MOZ_NO_REMOTE': '1', 02:01:24 INFO - 'NO_EM_RESTART': '1', 02:01:24 INFO - 'PAGER': '/bin/cat', 02:01:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:24 INFO - 'PWD': '/builds/slave/test', 02:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:24 INFO - 'SHELL': '/bin/bash', 02:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:24 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:24 INFO - 'USER': 'cltbld', 02:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:24 INFO - 'XPC_FLAGS': '0x0', 02:01:24 INFO - 'XPC_SERVICE_NAME': '0', 02:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:24 INFO - Downloading/unpacking jsonschema==2.5.1 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:01:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:01:27 INFO - warning: no files found matching '*.txt' 02:01:27 INFO - no previously-included directories found matching 'build' 02:01:27 INFO - no previously-included directories found matching 'dist' 02:01:27 INFO - no previously-included directories found matching '.git*' 02:01:27 INFO - Installing collected packages: jsonschema, functools32 02:01:27 INFO - Running setup.py install for functools32 02:01:28 INFO - warning: no files found matching '*.txt' 02:01:28 INFO - no previously-included directories found matching 'build' 02:01:28 INFO - no previously-included directories found matching 'dist' 02:01:28 INFO - no previously-included directories found matching '.git*' 02:01:28 INFO - Successfully installed jsonschema functools32 02:01:28 INFO - Cleaning up... 02:01:28 INFO - Return code: 0 02:01:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:29 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:29 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 02:01:29 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 02:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:29 INFO - 'HOME': '/Users/cltbld', 02:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:29 INFO - 'LOGNAME': 'cltbld', 02:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:29 INFO - 'MOZ_NO_REMOTE': '1', 02:01:29 INFO - 'NO_EM_RESTART': '1', 02:01:29 INFO - 'PAGER': '/bin/cat', 02:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:29 INFO - 'PWD': '/builds/slave/test', 02:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:29 INFO - 'SHELL': '/bin/bash', 02:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:29 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:29 INFO - 'USER': 'cltbld', 02:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:29 INFO - 'XPC_FLAGS': '0x0', 02:01:29 INFO - 'XPC_SERVICE_NAME': '0', 02:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:01:29 INFO - Cleaning up... 02:01:29 INFO - Return code: 0 02:01:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:29 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')]} 02:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:29 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')]} 02:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:29 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:29 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 02:01:29 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 02:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:29 INFO - 'HOME': '/Users/cltbld', 02:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:29 INFO - 'LOGNAME': 'cltbld', 02:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:29 INFO - 'MOZ_NO_REMOTE': '1', 02:01:29 INFO - 'NO_EM_RESTART': '1', 02:01:29 INFO - 'PAGER': '/bin/cat', 02:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:29 INFO - 'PWD': '/builds/slave/test', 02:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:29 INFO - 'SHELL': '/bin/bash', 02:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:29 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:29 INFO - 'USER': 'cltbld', 02:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:29 INFO - 'XPC_FLAGS': '0x0', 02:01:29 INFO - 'XPC_SERVICE_NAME': '0', 02:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:01:30 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 02:01:30 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 02:01:30 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 02:01:30 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 02:01:30 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 02:01:30 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 02:01:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:01:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:01:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:34 INFO - Downloading docopt-0.6.1.tar.gz 02:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:01:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:01:34 INFO - Running setup.py install for blobuploader 02:01:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:01:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:01:34 INFO - Running setup.py install for requests 02:01:35 INFO - Running setup.py install for docopt 02:01:35 INFO - Successfully installed blobuploader requests docopt 02:01:35 INFO - Cleaning up... 02:01:35 INFO - Return code: 0 02:01:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:35 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')]} 02:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:35 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')]} 02:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:35 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:35 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 02:01:35 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 02:01:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:35 INFO - 'HOME': '/Users/cltbld', 02:01:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:35 INFO - 'LOGNAME': 'cltbld', 02:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:35 INFO - 'MOZ_NO_REMOTE': '1', 02:01:35 INFO - 'NO_EM_RESTART': '1', 02:01:35 INFO - 'PAGER': '/bin/cat', 02:01:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:35 INFO - 'PWD': '/builds/slave/test', 02:01:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:35 INFO - 'SHELL': '/bin/bash', 02:01:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:35 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:35 INFO - 'USER': 'cltbld', 02:01:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:35 INFO - 'XPC_FLAGS': '0x0', 02:01:35 INFO - 'XPC_SERVICE_NAME': '0', 02:01:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:35 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Dlst2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:35 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-9_pwwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:35 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-PHnqhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:35 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-jItK42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:35 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-f3ks7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-CWdi2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-52ow1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-1qWnLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-QijTIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-kT6mYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-RxrRMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-faQppk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-yd7GUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:36 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-RwIEAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-SubKGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-PcwPso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:37 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-KuyuR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:01:37 INFO - Running setup.py install for manifestparser 02:01:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:01:37 INFO - Running setup.py install for mozcrash 02:01:37 INFO - Running setup.py install for mozdebug 02:01:37 INFO - Running setup.py install for mozdevice 02:01:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:01:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:01:37 INFO - Running setup.py install for mozfile 02:01:38 INFO - Running setup.py install for mozhttpd 02:01:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Running setup.py install for mozinfo 02:01:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Running setup.py install for mozInstall 02:01:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Running setup.py install for mozleak 02:01:38 INFO - Running setup.py install for mozlog 02:01:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Running setup.py install for moznetwork 02:01:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:01:38 INFO - Running setup.py install for mozprocess 02:01:39 INFO - Running setup.py install for mozprofile 02:01:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:01:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:01:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:01:39 INFO - Running setup.py install for mozrunner 02:01:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:01:39 INFO - Running setup.py install for mozscreenshot 02:01:39 INFO - Running setup.py install for moztest 02:01:39 INFO - Running setup.py install for mozversion 02:01:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:01:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:01:39 INFO - Cleaning up... 02:01:39 INFO - Return code: 0 02:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:39 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:39 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 02:01:39 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 02:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:39 INFO - 'HOME': '/Users/cltbld', 02:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:39 INFO - 'LOGNAME': 'cltbld', 02:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:39 INFO - 'MOZ_NO_REMOTE': '1', 02:01:39 INFO - 'NO_EM_RESTART': '1', 02:01:39 INFO - 'PAGER': '/bin/cat', 02:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:39 INFO - 'PWD': '/builds/slave/test', 02:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:39 INFO - 'SHELL': '/bin/bash', 02:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:39 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:39 INFO - 'USER': 'cltbld', 02:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:39 INFO - 'XPC_FLAGS': '0x0', 02:01:39 INFO - 'XPC_SERVICE_NAME': '0', 02:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-c_9lhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:40 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)) 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-0xf5WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:40 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)) 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-uvILVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:40 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)) 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-c97XxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:40 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)) 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-22GN9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:40 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)) 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-L4WHmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:40 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)) 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-48q2TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:40 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)) 02:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:40 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-rI57yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:41 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)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-CqG2mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:41 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)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-FiicHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:41 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)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-rVyvvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:41 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)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-JAdDVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-2rlxBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:41 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)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-zfNUnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:41 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)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-mZLEAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:41 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)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-lGHxCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-3m5O0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:42 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)) 02:01:42 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)) 02:01:42 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)) 02:01:42 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)) 02:01:42 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)) 02:01:42 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)) 02:01:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:44 INFO - Downloading blessings-1.6.tar.gz 02:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:01:44 INFO - Installing collected packages: blessings 02:01:44 INFO - Running setup.py install for blessings 02:01:44 INFO - Successfully installed blessings 02:01:44 INFO - Cleaning up... 02:01:45 INFO - Return code: 0 02:01:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:01:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:45 INFO - Reading from file tmpfile_stdout 02:01:45 INFO - Current package versions: 02:01:45 INFO - blessings == 1.6 02:01:45 INFO - blobuploader == 1.2.4 02:01:45 INFO - docopt == 0.6.1 02:01:45 INFO - functools32 == 3.2.3-2 02:01:45 INFO - jsonschema == 2.5.1 02:01:45 INFO - manifestparser == 1.1 02:01:45 INFO - mozInstall == 1.12 02:01:45 INFO - mozcrash == 1.0 02:01:45 INFO - mozdebug == 0.1 02:01:45 INFO - mozdevice == 0.49 02:01:45 INFO - mozfile == 1.2 02:01:45 INFO - mozhttpd == 0.7 02:01:45 INFO - mozinfo == 0.9 02:01:45 INFO - mozleak == 0.1 02:01:45 INFO - mozlog == 3.4 02:01:45 INFO - moznetwork == 0.27 02:01:45 INFO - mozprocess == 0.25 02:01:45 INFO - mozprofile == 0.28 02:01:45 INFO - mozrunner == 6.13 02:01:45 INFO - mozscreenshot == 0.1 02:01:45 INFO - mozsystemmonitor == 0.3 02:01:45 INFO - moztest == 0.8 02:01:45 INFO - mozversion == 1.4 02:01:45 INFO - psutil == 3.1.1 02:01:45 INFO - requests == 1.2.3 02:01:45 INFO - wsgiref == 0.1.2 02:01:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:45 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')]} 02:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:45 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')]} 02:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:45 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:45 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 02:01:45 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 02:01:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:45 INFO - 'HOME': '/Users/cltbld', 02:01:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:45 INFO - 'LOGNAME': 'cltbld', 02:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:45 INFO - 'MOZ_NO_REMOTE': '1', 02:01:45 INFO - 'NO_EM_RESTART': '1', 02:01:45 INFO - 'PAGER': '/bin/cat', 02:01:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:45 INFO - 'PWD': '/builds/slave/test', 02:01:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:45 INFO - 'SHELL': '/bin/bash', 02:01:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:45 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:45 INFO - 'USER': 'cltbld', 02:01:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:45 INFO - 'XPC_FLAGS': '0x0', 02:01:45 INFO - 'XPC_SERVICE_NAME': '0', 02:01:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 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)) 02:01:45 INFO - Cleaning up... 02:01:45 INFO - Return code: 0 02:01:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:01:45 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')]} 02:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:45 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')]} 02:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:45 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 0x1006ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512d76a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, '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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 02:01:45 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 02:01:45 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 02:01:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:01:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:45 INFO - 'HOME': '/Users/cltbld', 02:01:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:45 INFO - 'LOGNAME': 'cltbld', 02:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:45 INFO - 'MOZ_NO_REMOTE': '1', 02:01:45 INFO - 'NO_EM_RESTART': '1', 02:01:45 INFO - 'PAGER': '/bin/cat', 02:01:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:45 INFO - 'PWD': '/builds/slave/test', 02:01:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:45 INFO - 'SHELL': '/bin/bash', 02:01:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:01:45 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:01:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:45 INFO - 'USER': 'cltbld', 02:01:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:45 INFO - 'XPC_FLAGS': '0x0', 02:01:45 INFO - 'XPC_SERVICE_NAME': '0', 02:01:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:01:45 INFO - Cleaning up... 02:01:45 INFO - Return code: 0 02:01:45 INFO - Running post-action listener: _resource_record_post_action 02:01:45 INFO - Running post-action listener: _start_resource_monitoring 02:01:45 INFO - Starting resource monitoring. 02:01:45 INFO - [mozharness: 2017-03-28 09:01:45.890560Z] Finished create-virtualenv step (success) 02:01:45 INFO - [mozharness: 2017-03-28 09:01:45.891562Z] Running install step. 02:01:45 INFO - Running pre-action listener: _resource_record_pre_action 02:01:45 INFO - Running main action method: install 02:01:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:46 INFO - Reading from file tmpfile_stdout 02:01:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:01:46 INFO - Reading from file tmpfile_stdout 02:01:46 INFO - Output received: 02:01:46 INFO - Usage: mozinstall [options] installer 02:01:46 INFO - Options: 02:01:46 INFO - -h, --help show this help message and exit 02:01:46 INFO - -d DEST, --destination=DEST 02:01:46 INFO - Directory to install application into. [default: 02:01:46 INFO - "/builds/slave/test"] 02:01:46 INFO - --app=APP Application being installed. [default: firefox] 02:01:46 INFO - mkdir: /builds/slave/test/build/application 02:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:02:06 INFO - Reading from file tmpfile_stdout 02:02:06 INFO - Output received: 02:02:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:02:06 INFO - Running post-action listener: _resource_record_post_action 02:02:06 INFO - [mozharness: 2017-03-28 09:02:06.394681Z] Finished install step (success) 02:02:06 INFO - [mozharness: 2017-03-28 09:02:06.394824Z] Running run-tests step. 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: run_tests 02:02:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:02:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:02:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:02:06 INFO - 2017-03-28 02:02:06.409 screenresolution[1903:17683] starting screenresolution argv=screenresolution get 02:02:06 INFO - 2017-03-28 02:02:06.412 screenresolution[1903:17683] Display 0: 1600x1200x32@60 02:02:06 INFO - 2017-03-28 02:02:06.417 screenresolution[1904:17686] starting screenresolution argv=screenresolution list 02:02:06 INFO - Available Modes on Display 0 02:02:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:02:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:02:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:02:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:02:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:02:06 INFO - Intel Iris: 02:02:06 INFO - Chipset Model: Intel Iris 02:02:06 INFO - Type: GPU 02:02:06 INFO - Bus: Built-In 02:02:06 INFO - VRAM (Dynamic, Max): 1536 MB 02:02:06 INFO - Vendor: Intel (0x8086) 02:02:06 INFO - Device ID: 0x0a2e 02:02:06 INFO - Revision ID: 0x0009 02:02:06 INFO - Displays: 02:02:06 INFO - Display: 02:02:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:02:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:02:06 INFO - Display Serial Number: 1600x1200 60 02:02:06 INFO - Main Display: Yes 02:02:06 INFO - Mirror: Off 02:02:06 INFO - Online: Yes 02:02:06 INFO - Rotation: Supported 02:02:06 INFO - Return code: 0 02:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:06 INFO - Python 2.7.3 02:02:06 INFO - Return code: 0 02:02:06 INFO - grabbing minidump binary from tooltool 02:02:06 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')]} 02:02:06 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 0x1004ddd30>, '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 0x100404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004d2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:06 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 02:02:06 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 02:02:06 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 02:02:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:06 INFO - Return code: 0 02:02:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:02:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:06 INFO - ENV: RUST_BACKTRACE is now 1 02:02:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:02:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:02:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0VMVrWf0XM/Render', 02:02:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:06 INFO - 'HOME': '/Users/cltbld', 02:02:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:06 INFO - 'LOGNAME': 'cltbld', 02:02:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:06 INFO - 'MOZ_NO_REMOTE': '1', 02:02:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:06 INFO - 'NO_EM_RESTART': '1', 02:02:06 INFO - 'PAGER': '/bin/cat', 02:02:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:06 INFO - 'PWD': '/builds/slave/test', 02:02:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:06 INFO - 'RUST_BACKTRACE': '1', 02:02:06 INFO - 'SHELL': '/bin/bash', 02:02:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YjIGNKBMXi/Listeners', 02:02:06 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:02:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:06 INFO - 'USER': 'cltbld', 02:02:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:06 INFO - 'XPC_FLAGS': '0x0', 02:02:06 INFO - 'XPC_SERVICE_NAME': '0', 02:02:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:02:07 INFO - mozversion application_buildid: 20170328004003 02:02:07 INFO - mozversion application_changeset: db2babffcafbd6b5b47a8c5813005838eb171a90 02:02:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:02:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:07 INFO - mozversion application_name: Firefox 02:02:07 INFO - mozversion application_remotingname: firefox-dev 02:02:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:02:07 INFO - mozversion application_vendor: Mozilla 02:02:07 INFO - mozversion application_version: 54.0a2 02:02:07 INFO - mozversion platform_buildid: 20170328004003 02:02:07 INFO - mozversion platform_changeset: db2babffcafbd6b5b47a8c5813005838eb171a90 02:02:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:02:07 INFO - mozversion platform_version: 54.0a2 02:02:07 INFO - using testdate: 1490691727 02:02:07 INFO - actual date: 1490691727 02:02:07 INFO - starting webserver on 'localhost:54249' 02:02:07 INFO - SUITE-START | Running 2 tests 02:02:07 INFO - TEST-START | dromaeo_css 02:02:07 INFO - operating with platform_type : mac_ 02:02:07 INFO - Initialising browser for dromaeo_css test... 02:02:07 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmplfXIwl/profile http://localhost:54249/getInfo.html) 02:02:09 INFO - PROCESS | 1914 | 2017-03-28 02:02:09.881 plugin-container[1917:17853] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 02:02:09 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:09 INFO - PROCESS | 1914 | 2017-03-28 02:02:09.881 plugin-container[1917:17853] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 02:02:09 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:09 INFO - PROCESS | 1914 | 2017-03-28 02:02:09.881 plugin-container[1917:17853] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:02:09 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 02:02:09 INFO - PROCESS | 1914 | colorDepth:24 02:02:09 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 02:02:09 INFO - PROCESS | 1914 | __metrics 02:02:10 ERROR - PROCESS | 1914 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:02:10 INFO - TEST-INFO | 1914: exit 0 02:02:10 INFO - Browser initialized. 02:02:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:02:10 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmplfXIwl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:02:13 INFO - PROCESS | 1918 | 2017-03-28 02:02:13.407 plugin-container[1919:17986] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 02:02:13 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:13 INFO - PROCESS | 1918 | 2017-03-28 02:02:13.408 plugin-container[1919:17986] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:02:13 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:13 INFO - PROCESS | 1918 | 2017-03-28 02:02:13.408 plugin-container[1919:17986] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:02:22 INFO - PROCESS | 1918 | RSS: Main: 220696576 02:02:22 INFO - PROCESS | 1918 | 02:05:25 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:54249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54249/tests/dromaeo/cssquery-ext.html) 02:05:28 INFO - PROCESS | 1918 | RSS: Main: 238751744 02:05:28 INFO - PROCESS | 1918 | 02:07:11 INFO - PROCESS | 1918 | ************************* 02:07:11 INFO - PROCESS | 1918 | A coding exception was thrown and uncaught in a Task. 02:07:11 INFO - PROCESS | 1918 | 02:07:11 ERROR - PROCESS | 1918 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:07:11 INFO - PROCESS | 1918 | Full stack: 02:07:11 INFO - PROCESS | 1918 | ************************* 02:08:30 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:54249/tests/dromaeo/cssquery-ext.html (next: http://localhost:54249/tests/dromaeo/cssquery-jquery.html) 02:08:31 INFO - PROCESS | 1918 | RSS: Main: 249671680 02:08:31 INFO - PROCESS | 1918 | 02:11:33 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:54249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54249/tests/dromaeo/cssquery-mootools.html) 02:11:34 INFO - PROCESS | 1918 | RSS: Main: 259129344 02:11:34 INFO - PROCESS | 1918 | 02:14:36 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:54249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54249/tests/dromaeo/cssquery-prototype.html) 02:14:36 INFO - PROCESS | 1918 | RSS: Main: 255238144 02:14:36 INFO - PROCESS | 1918 | 02:17:39 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:54249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54249/tests/dromaeo/cssquery-yui.html) 02:17:40 INFO - PROCESS | 1918 | RSS: Main: 260411392 02:17:40 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:54249/tests/dromaeo/cssquery-yui.html (next: http://localhost:54249/tests/dromaeo/cssquery-dojo.html) 02:20:43 INFO - PROCESS | 1918 | RSS: Main: 256708608 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | __start_tp_report 02:20:43 INFO - PROCESS | 1918 | _x_x_mozilla_page_load 02:20:43 INFO - PROCESS | 1918 | _x_x_mozilla_page_load_details 02:20:43 INFO - PROCESS | 1918 | |i|pagename|runs| 02:20:43 INFO - PROCESS | 1918 | |0;dojo.html;2886.89895853645;3000.309928716395;3468.1329667583104;3498.3702933471964;3537.5931767846696;4934.3585333906585;5156.561692256163;6056.333803281641;6125.908111378321;6136.723847426865;5905.704714764266;6100.176476175715;6140.232470941132;6163.167972323735;6179.938200617992;5435.537979271757;5494.560435165177;5518.255035570187;5571.220029195895;5590.273264475612;4535.274356103024;5553.028220061493;5554.86112847178;5563.499285064343;5579.776808927638;5357.651752636086;5382.865428364303;5591.30108736408;5594.832155035356;5621.269234999444;5457.372402173761;5464.043792336345;5467.5625949923915;5481.287432633772;5496.285482887199;5409.594280428983;5423.511883930465;5470.261514695505;5521.641093328921;5580.469855363734;6160.229971253593;6200.658963756991;6203;6222.968885155546;6238.750449981995;6196.070589411579;6265.530085243579;6454.515911306624;6489.740410383579;6500.804975850732;6342.365763423621;6415.1981002374705;6445.709943052574;6569.704363303663;6600.372964568358;6237.345078766755;6270.874582508415;6274.623522588659;6283.277423096311;6283.3088360280335;6641.269460359356;6658.167729033871;6683.331666833375;6684.598924064571;6706.798796036127;6208.161898143783;6248.718807653667;6255.74977000924;6283.3402492737605;6286.245650521967;5416.972915135478;5486.231927530149;6456.709448074848;6529.053287273318;6533.803985880431;6352.333005034405;6391.265004524446;6403.96798016007;6422.967885160544;6446.613203207822;6201.317855035943;6243.843903902439;6256.906146407808;6450.612963222222;6470.2559205691;4339.305711086211;5057.165567681292;5158.509941555546;5212.270282160501;5241.266222728821;4507.098580283956;4569.725816451024;4571.017231295287;4590.724556526552;4593.954060459419;4740.28895665646;6120.296165940974;6127.969360153171;6178.258608966953;6195.039768835838;6259.217597800275;6561.179852518435;6563.540552161398;6574.868502629921;6589.209294884548;5981.431763982415;6088.330283668793;6127.234095738033;6170.444659980623;6206.162168107338;5789.131630255495;5790.623609465371;5791.160281759121;5797.304323481209;5809;6734.865302693918;6757.256701762803;6758.8648227036165;6780.593164410151;6788.830279243059;5888.646681199141;6240.7503699851495;6355.110284560258;6448.967755161382;6471.094046833541;6624.6025238485845;6659.866802664016;6679.866402672016;6724.260331363644;6741.089952856301;6411.3909178627955;6438.774642887476;6442.194725659293;6451.2903580607035;6463.289038205888;6240.968795155995;6304.936950630618;6419.197600299963;6435.356464353715;6490.8052758417325;6219.564630475823;6342.460890824332;6376.202974628171;6382.968085159545;6388.936110638834;6339.397757213057;6370.980643097082;6386.074019267273;6399.136116624196;6400.423961843457;5333.8265581571995;5379.735762095983;6053.152558641706;6185;6216.53375996793;6268.843278918063;6286.27707813589;6315.210598675166;6344.841378965562;6347.5239357047485;5226.477352264743;6249.218847644044;6260.248770147611;6277.466415354746;6293.465055470153 02:20:43 INFO - PROCESS | 1918 | |1;ext.html;793.3494534481728;811.2414892075909;813.4265342933231;867.7873920889383;940.2571968145165;38061.61938380615;38908.02729931753;39199.648021118715;40477;40635.59364406355;38855.80572097136;39005.41491877617;39081.02297442565;39134.825955221386;39147.21705565887;7500.662470188828;7588.241175882423;7841.294283514469;7955.960220198891;11117.499712512956;11317.773644527104;11413.942930285379;11437.142214333917;11441.199116061878;11448.542058317656;9678.419294842297;11447.02700270478;11463;11466.312021278709;11508.71228219297;11352;11400.315981041082;11401.828972565418;11402.31586104828;11404;11055.170862185289;11109.111271098292;11120.165987550967;11122.944385278102;11133.72165695856;39450.80274598609;39581.812545623674;39643.00892477683;39663.60336396628;39717;3802.7718336899875;3813.8474461021524;3838.9040273993096;3892.338302488584;3911.178652482982;28119.156425307272;29652.8517357414;30143.09570712882;30262.84868575643;30297.091087267196;3005.7144571265694;3136.905892823219;3151.495760678303;3288.3423315337027;3290.1610089427045;357334;359537;363090;363094;364567;44307.11385772267;44853.10293794106;53366;54319.45680543223;54377.72811135919;55388;56392.15411768827;56529.15206271827;56754.716226418604;56914.86170276571;14868.330925108396;14949.925250373679;14999.17504537239;15041.924790375979;15062.246887655574;10998.395088270061;11205;12851.614451566467;12861;12923;13501.324933753272;13507.459701612022;13541;13604.04771665974;13632.727345453035;6095.323785958897;6097.939020609826;6123.84690382744;6127.938720612826;6147.170132032208;948.7343543807744;1071.8959471744115;1089.8147314956318;1111.1166622535104;1126.695792136135;26962.115512061155;27177.45645087127;27310.5903411449;27400.177994660193;27597;941.9105185007413;998.9500524973722;1006.7181189267017;1040.422565476168;1222.5904322052033;13593.660158496117;13676.726465470634;13781.966352523601;13801.723965520634;13948.930255348861;496411;500730;502347;502860;502923;47563.28655070177;48008.27987580189;48087.519124809005;48122;48221.758891206024;1293.8318018657515;1328.156620545941;1328.4686125549665;1338.0767270583267;1345.9259740714158;20070.09684564169;25056.62415063739;25898.870505648105;26302.736972630795;26406.867965660047;41993;42236.78881605572;42317.78841105775;42412.575874242095;42415.5758442424;485927;486041;486111;486124;487521;24104.75895241025;30230.54654180145;31005.534916976714;32039;32053.67946320507;39099.631512896915;39345.80327098346;40067.59932400638;40151;40188.1962360757;28191;28244.576331355456;28754.568681470213;28922.42155156843;29458.705412945597;24985.625215621418;26177.560234187302;28414.715852841207;28561.000364987125;29026.564601531416;32307.51538726874;33272.00183994484;33349.499757503174;33522.32955340928;33545;22972.77027229773;26545.60181597316;27117;28827.71172288334;29403.705962940952;22441.551168976857;23133.421664458525;23216.767832322137;23622.88188559046;23695.881520592287 02:20:43 INFO - PROCESS | 1918 | |2;jquery.html;402.11334008511216;405.8396933211383;410.2390066426779;418.20332267031307;439.93096774837153;19443.319483818068;19647.60704785905;20038.59922801543;20425.080871360788;20653.586928261444;21160.365189044314;21222.57554848902;21514.784852151475;21974;22255.888720556413;5779.479846813786;7044.753433629824;7052.188998265188;7055.259197784236;7061.046758687588;6529.510286728514;6825.044493770876;6856.074429951967;6880.518363714517;6880.759173428931;5463.836084917439;6098.658295175054;6545.214574251097;6876.724931002754;6883.827904302382;5942.673152976585;6904.965475172592;6923.653817309114;6927.618980956071;6934.965325173393;6393.520485963525;6645.900311495331;6673.699683514254;6684.665766711693;6754.2907994660345;20588.86761228132;26062;26101.73898261012;26321;26597.335066623295;2704.837709737422;2755.9586606200924;2796.4826507096254;2806.649168853893;2812.6343575335077;7541.944127822109;7642.694292228304;16620.750688739678;16629.91685041567;16689;1783.2777725021388;1810.63787242552;2035.5827055453597;2110.0504772852123;2112.207922029239;117066;118652.40673796662;120294.39852800767;122251;122321.16518252234;16332;21706.240281590068;21805.345839624835;21920;21986;34911.07989060575;34982.30035399328;35514.644853551654;35743.28513429717;35801.8209908954;10656;10818.29681070728;10920.071793897609;11009.064229540418;11018.063464605599;7320.524165929304;8850.644132430229;8908.06465321145;8964.462132272085;9030.683926062557;9495.38280011797;10188.9811018899;10499.527521261562;10923.508442120125;10961;3586.497890295361;3915.4909861717792;4262.744235345889;4318.740875547477;4345.327049086125;764.3846703403702;885.4421714319938;885.6191837509932;888.853339199025;905.3798148268457;20902.477438063866;21762;21802.672959905613;21937.890310548344;21971.121155153614;842.5113434208145;931.1970967388211;932.6875496708678;935.6818681648273;947.280067148958;7913.061299981541;11382.317060976367;11792.764144717057;11799.941000294944;11814.88185118155;623788;730522;753104;764026;765312;94658;114781;159931;165864.17067914826;167749;1274.49020391844;1274.8916342111024;1325.0327261099258;1327.8605746396684;1336.1181620130667;19036.714449282994;19500.414987550397;19803.306884258982;20249.69625455649;20275;56855;65955.01067484087;65990;66226.66886665729;66821.32946676372;86193.7070943949;92164.53917730368;93533;93695;95247;8657.047724750399;10152.64465743725;11094.223404361617;11225.49485273181;11816.46825892854;12689.302088385228;12846.357682116044;12947.741045179233;13139.54011609589;13243.20540767557;10893.237473376788;10904.672859814218;10911.2362134653;11118.833217501582;11283.266587671775;8088;9085.727998080141;9873.210143188384;10371.222158338003;10682.198835087554;9885.357451765612;10247.7438064049;10965.725856853642;11534;11643.359615221245;9669.854952175583;11336.886631133582;11406.201565890307;11454.854514548479;11567.595134170264;7779.611019448892;11017.779644407226;11224.831627525431;11442.713932151762;11468.31190128595 02:20:43 INFO - PROCESS | 1918 | |3;mootools.html;1454.803601513796;1516.9469068582603;1581.6757564699235;1586.9526112765577;1588.6902054099448;10686.305390149635;11116.444177791098;11240.606578769744;11315.886841131587;11324.150688698339;9051.502167380808;9211.539423028855;11274.323540587571;11280.871912808736;11307.208495405324;2306.2043594959714;2360.4216966843146;2363.948043120812;2364.988175059122;2371.9644205336936;2263.151318255654;2343.297010896733;2345.9882700586472;2360.8819559022068;2363.161077817376;2257.6613507973852;2306.8961896714686;2342.625179971205;2355.0815182079004;2358.9056437742556;2286.9771302287095;2299;2316.976830231693;2326.813854891613;2335.2177020698086;2298.988505057481;2308.4344335637707;2315.3169814904477;2315.3979965209;2321.5472982768365;11053.778924421547;11054.281471704395;11091.55633774648;11136.498857551349;11175;4628.6991345562765;5504.91742623861;5683;5684.488396044376;5705.515031222351;3199.856006479714;3247.7564182686156;3344.966550334514;3372.426687463137;3383.6954674079207;1158.2645020412015;1170.3153655111769;1602.767598698194;1748.6360638701833;1757.0072908806483;12165.270083795001;14062.578122656336;14232.928835355757;15373.538793836204;15928.681426371408;4629.981404091094;4630.814767409333;4730.2431610942085;4740.620750340034;4762.618990480753;9841;12939.741205175844;12950.481980720853;12984.935075324753;13001.349932503337;5664.49019588239;5680.318361796528;5701.971490142606;5703.714814259353;5713.628614140151;4907.754612269372;5099.6685215460875;5106.259592359087;5160.148575485003;5192.402873669501;3836.3861782114727;3887.814216663888;3935.193285376491;4010.298197815429;4064.5732198119363;1017.9871028326714;1048.8688913885765;1065.6909496246;1072.8658917635296;1081.6268387406333;917.4632839788665;931.0921851195166;946.4794363100267;950.6007476859736;1011.110223003752;6468.8059358219325;6488.448481879093;6634;6750.7299708012115;6754.493412994045;967.2020583019038;970.5438443931341;992.9851052234222;1003.7691330993912;1023.5701005577675;3582.283543291352;3741.401375779862;3956.1296514766705;4163.625273725379;4203.432536607519;11353.60262390829;13253.536126235536;13875.58373248784;13902.860971390359;13907.374168162458;11609.767804644029;13280;13540.052196346162;13665.111767735065;13847.376868040963;10017.899821001842;10274.383536987805;10310.639127630648;10344.844827327595;10485.108765754843;6504.707288171949;6748.628825414649;6903.309669033057;6913.274106218976;7037.894431583428;11870;12138.817917731418;12153.270803751802;12174.208676436003;12361.320127393079;11097.611583594535;12217.755644887231;12449.564265251034;12564.434600442819;12755.48978040868;8885.777855553662;9159.725208243763;9166.862497062417;9301.488418136796;9313.534323283673;10218.489075546044;10330.225233107396;10347.017033381817;10434.791304173723;10495.265331426726;7378.704851805867;8794.824103518022;8795.604197810986;8822.955885220534;8901.376903616685;8533.615987280711;8614.3108551317;8662.177093176138;8663;8729.869051964099;7742.806429839074;7752.341051010727;7787.338076263581;7863.449558530848;7873.606319684108;5675.205471233948;5808.593398462067;5858.355580886185;5877.23595932526;5985.88563876216;5862.12068189775;5880.206172166702;5919.437653422918;5963.2844058713235;6046.30467496226 02:20:43 INFO - PROCESS | 1918 | |4;prototype.html;347.1529468097843;349.18465383329925;369.7686703278086;381.71943621438237;389.581921804631;5179.81870634527;5203.4796520347945;5229.450907654698;5267.420583735786;5278.392984806748;4425.77871106445;4484.461864576256;4792.880177995552;5203.933193695293;5213.817516386927;3365.4951757236486;4000.4796977904025;4014.808227459177;4188.602082802144;4328.653707703376;3556.590992035923;3725.962740372602;4069.006186968379;4366.463164836477;4384.298512238042;4148.274052040896;4224.704270701052;4378.737275763448;4400.889977750549;4413.470383553978;3583.3191693578137;4004.9599504004877;4259.595338442843;4410.360497727827;4415.624671902892;3977.3835055566433;3994.7603143811466;4005.517958355398;4050.6354428101317;4067.51189857219;4405.22908491016;4892.584130348924;5182.248573956793;5195.19474481456;5210.921836172422;4443.777811109431;4921.704697718113;5065.189569668835;5091.0581542414775;5110.616703747234;5603.159526071081;5670;5699.549193846644;5751.447109280471;5780.913286300709;4316.395704601358;4516.696484792747;4528.128450175086;4558.521355257683;4569.109023740372;4840.273958906157;4918.778654960535;5334.119870221409;5469.699166545838;5805.53555715546;3993.2845664947536;4301.494476933049;4403.603675669206;4617.538246175355;4623.398958135488;4019.789115986196;4521.321801729701;4569.634429245652;4663.370444989883;4765.285207218945;4350.912981740347;4649.325847752057;4744.695208817603;4839.564439200489;4888.682235654671;5224.268602395668;5515.896820635889;5599.244102046253;5627.296587926509;5707.828765137053;1339.6115126613367;1592;1593.8406159384201;1594.5136733296224;1602.1748799368336;955.1308309438377;1085.3270971997413;1104.812181929074;1197.963761346429;1214.9514019439123;4793.664443488922;5070.518300761421;5270.393904701008;5322.760475778599;5345.893082138336;5794.652320860761;5875.29496460419;5881.00068964831;5926.362768567946;5969.343372229051;4080.2346448488443;4732.6687131900435;4760.547747963938;5231.3199284092825;5273.630845840754;2715.932101697473;3035.1653295343517;3065.601471808651;3067.708567686066;3102.1314032071054;5682.77268909239;6069.998450255746;6074.514038876968;6093.786717464867;6106.358832322631;5345.1447768356875;5472.005436031719;5539.972300138474;5684.54523638108;5966.181643748005;5506.394296627368;5801.82594522165;5932.644041357532;6026;6050.848728781815;4993.551869957817;5032.986805277918;5425.755840987086;5783.710814459176;5875.914050512178;4640.429177260463;4716.806684891542;5037.140088937413;5299.887023724907;5769.336526299529;5046.873828154178;5096.598435430286;5248.24183898383;5995.970020149872;6027.46846324536;3916.686665066845;4027.0536423940935;4526.117407105715;4559.202139625486;4586.945002649342;4710.845842768544;4892.602624713936;5444.686008446473;5537.311120108245;5777.8555536111935;5223.895522089613;5603.691796951207;5658.840752047325;5678.176664383724;5684.971575142098;5187.714675692722;5240.34495688039;5450.150756273237;5555.638883472561;5664.801731939362;4393.62654174386;4816.686915350631;5208.947910520847;5463.207834864002;5583.832485025456;4938.629602779878;4978.726170060681;5419.187121931742;5656.830295091154;5663.263775709132;4667.989147000234;4681.976590117028;5183.663061900965;5485.698286594116;5547.750351234124 02:20:43 INFO - PROCESS | 1918 | |5;yui.html;683.8085336105889;689.3657834791991;744.2111361956327;805.5368163306099;829.4981536170617;15349;15432.459863904765;16021.59946001349;16071.919640401811;16159.030458172503;12947.48210071596;15348.61628459289;15533.301001454962;15605.297761600727;16226.756598651029;913.7213149989267;918.2332752151962;928.7770934975625;929.9349045566813;931.7903471718843;888.6667499687617;923.5520772425368;925.0656836595053;925.5742358515091;926.0045451140018;1001.7695929936083;1002.413588050991;1004.1063453526367;1005.8038682456923;1006.4112494190907;992.7865508915581;993.88073431188;997.306871724152;998.4907697074472;999.6601155607092;624.2010226909563;734.4711807498646;740.0896896816945;740.5371642723298;741.4624397311906;16257.024578525326;16677.833221667748;16805.495835124966;16881.40915067979;16898.662026759517;12570.120091593591;12861.16402433848;13521.188728676212;13860.168389896638;14106.435742570286;11109;12320.199187052813;12404.441800119017;12840.165389249669;12924;4308.116836048603;4320.179165958458;4390.692651514395;4411.6250118739945;4489.573490518395;70408.6479567604;96875;102493.4875325626;102728.48635756773;103837.96162038359;8752.431091979;10369.222308326905;10441.791164176673;10451.02919245674;10723.981221783917;19552.413427597196;20669.89665051665;20793.792062079487;20887.68668469974;20941.790582094287;7463.8507229855095;7560.621968901533;7576.659050342748;7665.808354791175;7702.845943081107;4251.638610718123;4278.871633850989;4312.37470566766;4331.7834108294455;4431.8670439886855;3178.3166619176986;3259.071164718044;3260.1849537615594;3261.2662151015834;3271.0677456925137;596.4214711729616;613.2365205319317;625.4964753373487;635.86964672243;637.5186734015789;540.4325458268802;556.8751122732059;572.1275055540334;580.7676929228343;586.7447660267798;9360.531973401303;9829.655962041294;9835.704928852147;10058.396496210251;10142.695719128438;616.636184651058;640.3692363022419;653.6862306093102;657.4083325007532;663.575311800448;4249.936250956238;4290.485141783006;4741.336212930192;4752.738599377068;4818.204996175662;79761.60119199484;97115.54326685105;99235;100034;100330;75505.24494754981;78534;78573.60713196397;87471.56264218639;88564.6715299271;72124.91812622815;76122.4775504498;76569.85145222826;78345;79522.20477795148;10572.947135264274;11146.119151934488;11182.496787644739;11401.771964560829;11404.201705880509;45899;51155;51712.74143629258;52034.21948670697;52721.20918186154;62818;64877.02684459831;66401;68297;69886.65056674684;12676.04929630263;13201.933990329986;13216.140950838164;13285.66785830362;13464.730705386033;12341.50633974631;14475.565733028026;14697.632559186106;14748.33632486562;14880.466588371259;13528.86471135276;13734.244616546186;13747.587572372844;14365.712685746435;14647.26763661834;11106.833397498882;12517.624471265877;12528.874711253135;13696;13839.723205536035;10024.147947424259;12434.813477798021;13570.253636050113;13713.382897769823;13990.930045349709;9008.819823603622;9108;9402.95298523503;9529;9776.120149186607;9609.327347085637;10958.28771129874;11106.555737770723;11169.553217871518;11284 02:20:43 INFO - PROCESS | 1918 | __end_tp_report 02:20:43 INFO - PROCESS | 1918 | __start_cc_report 02:20:43 INFO - PROCESS | 1918 | _x_x_mozilla_cycle_collect,416 02:20:43 INFO - PROCESS | 1918 | __end_cc_report 02:20:43 INFO - PROCESS | 1918 | __startTimestamp1490692843529__endTimestamp 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | ------- Summary: start ------- 02:20:43 INFO - PROCESS | 1918 | Number of tests: 6 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | [#0] dojo.html Cycles:165 Average:5964.12 Median:6237.35 stddev:722.88 (11.6%) stddev-sans-first:683.60 02:20:43 INFO - PROCESS | 1918 | Values: 2886.9 3000.3 3468.1 3498.4 3537.6 4934.4 5156.6 6056.3 6125.9 6136.7 5905.7 6100.2 6140.2 6163.2 6179.9 5435.5 5494.6 5518.3 5571.2 5590.3 4535.3 5553.0 5554.9 5563.5 5579.8 5357.7 5382.9 5591.3 5594.8 5621.3 5457.4 5464.0 5467.6 5481.3 5496.3 5409.6 5423.5 5470.3 5521.6 5580.5 6160.2 6200.7 6203.0 6223.0 6238.8 6196.1 6265.5 6454.5 6489.7 6500.8 6342.4 6415.2 6445.7 6569.7 6600.4 6237.3 6270.9 6274.6 6283.3 6283.3 6641.3 6658.2 6683.3 6684.6 6706.8 6208.2 6248.7 6255.7 6283.3 6286.2 5417.0 5486.2 6456.7 6529.1 6533.8 6352.3 6391.3 6404.0 6423.0 6446.6 6201.3 6243.8 6256.9 6450.6 6470.3 4339.3 5057.2 5158.5 5212.3 5241.3 4507.1 4569.7 4571.0 4590.7 4594.0 4740.3 6120.3 6128.0 6178.3 6195.0 6259.2 6561.2 6563.5 6574.9 6589.2 5981.4 6088.3 6127.2 6170.4 6206.2 5789.1 5790.6 5791.2 5797.3 5809.0 6734.9 6757.3 6758.9 6780.6 6788.8 5888.6 6240.8 6355.1 6449.0 6471.1 6624.6 6659.9 6679.9 6724.3 6741.1 6411.4 6438.8 6442.2 6451.3 6463.3 6241.0 6304.9 6419.2 6435.4 6490.8 6219.6 6342.5 6376.2 6383.0 6388.9 6339.4 6371.0 6386.1 6399.1 6400.4 5333.8 5379.7 6053.2 6185.0 6216.5 6268.8 6286.3 6315.2 6344.8 6347.5 5226.5 6249.2 6260.2 6277.5 6293.5 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | [#1] ext.html Cycles:180 Average:57783.53 Median:17071.22 stddev:120826.39 (707.8%) stddev-sans-first:121089.58 02:20:43 INFO - PROCESS | 1918 | Values: 793.3 811.2 813.4 867.8 940.3 38061.6 38908.0 39199.6 40477.0 40635.6 38855.8 39005.4 39081.0 39134.8 39147.2 7500.7 7588.2 7841.3 7956.0 11117.5 11317.8 11413.9 11437.1 11441.2 11448.5 9678.4 11447.0 11463.0 11466.3 11508.7 11352.0 11400.3 11401.8 11402.3 11404.0 11055.2 11109.1 11120.2 11122.9 11133.7 39450.8 39581.8 39643.0 39663.6 39717.0 3802.8 3813.8 3838.9 3892.3 3911.2 28119.2 29652.9 30143.1 30262.8 30297.1 3005.7 3136.9 3151.5 3288.3 3290.2 357334.0 359537.0 363090.0 363094.0 364567.0 44307.1 44853.1 53366.0 54319.5 54377.7 55388.0 56392.2 56529.2 56754.7 56914.9 14868.3 14949.9 14999.2 15041.9 15062.2 10998.4 11205.0 12851.6 12861.0 12923.0 13501.3 13507.5 13541.0 13604.0 13632.7 6095.3 6097.9 6123.8 6127.9 6147.2 948.7 1071.9 1089.8 1111.1 1126.7 26962.1 27177.5 27310.6 27400.2 27597.0 941.9 999.0 1006.7 1040.4 1222.6 13593.7 13676.7 13782.0 13801.7 13948.9 496411.0 500730.0 502347.0 502860.0 502923.0 47563.3 48008.3 48087.5 48122.0 48221.8 1293.8 1328.2 1328.5 1338.1 1345.9 20070.1 25056.6 25898.9 26302.7 26406.9 41993.0 42236.8 42317.8 42412.6 42415.6 485927.0 486041.0 486111.0 486124.0 487521.0 24104.8 30230.5 31005.5 32039.0 32053.7 39099.6 39345.8 40067.6 40151.0 40188.2 28191.0 28244.6 28754.6 28922.4 29458.7 24985.6 26177.6 28414.7 28561.0 29026.6 32307.5 33272.0 33349.5 33522.3 33545.0 22972.8 26545.6 27117.0 28827.7 29403.7 22441.6 23133.4 23216.8 23622.9 23695.9 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | [#2] jquery.html Cycles:180 Average:41257.34 Median:26211.37 stddev:120999.22 (461.6%) stddev-sans-first:121299.76 02:20:43 INFO - PROCESS | 1918 | Values: 402.1 405.8 410.2 418.2 439.9 19443.3 19647.6 20038.6 20425.1 20653.6 21160.4 21222.6 21514.8 21974.0 22255.9 5779.5 7044.8 7052.2 7055.3 7061.0 6529.5 6825.0 6856.1 6880.5 6880.8 5463.8 6098.7 6545.2 6876.7 6883.8 5942.7 6905.0 6923.7 6927.6 6935.0 6393.5 6645.9 6673.7 6684.7 6754.3 20588.9 26062.0 26101.7 26321.0 26597.3 2704.8 2756.0 2796.5 2806.6 2812.6 7541.9 7642.7 16620.8 16629.9 16689.0 1783.3 1810.6 2035.6 2110.1 2112.2 117066.0 118652.4 120294.4 122251.0 122321.2 16332.0 21706.2 21805.3 21920.0 21986.0 34911.1 34982.3 35514.6 35743.3 35801.8 10656.0 10818.3 10920.1 11009.1 11018.1 7320.5 8850.6 8908.1 8964.5 9030.7 9495.4 10189.0 10499.5 10923.5 10961.0 3586.5 3915.5 4262.7 4318.7 4345.3 764.4 885.4 885.6 888.9 905.4 20902.5 21762.0 21802.7 21937.9 21971.1 842.5 931.2 932.7 935.7 947.3 7913.1 11382.3 11792.8 11799.9 11814.9 623788.0 730522.0 753104.0 764026.0 765312.0 94658.0 114781.0 159931.0 165864.2 167749.0 1274.5 1274.9 1325.0 1327.9 1336.1 19036.7 19500.4 19803.3 20249.7 20275.0 56855.0 65955.0 65990.0 66226.7 66821.3 86193.7 92164.5 93533.0 93695.0 95247.0 8657.0 10152.6 11094.2 11225.5 11816.5 12689.3 12846.4 12947.7 13139.5 13243.2 10893.2 10904.7 10911.2 11118.8 11283.3 8088.0 9085.7 9873.2 10371.2 10682.2 9885.4 10247.7 10965.7 11534.0 11643.4 9669.9 11336.9 11406.2 11454.9 11567.6 7779.6 11017.8 11224.8 11442.7 11468.3 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | [#3] mootools.html Cycles:180 Average:6665.67 Median:2362.02 stddev:4163.18 (176.3%) stddev-sans-first:4156.44 02:20:43 INFO - PROCESS | 1918 | Values: 1454.8 1516.9 1581.7 1587.0 1588.7 10686.3 11116.4 11240.6 11315.9 11324.2 9051.5 9211.5 11274.3 11280.9 11307.2 2306.2 2360.4 2363.9 2365.0 2372.0 2263.2 2343.3 2346.0 2360.9 2363.2 2257.7 2306.9 2342.6 2355.1 2358.9 2287.0 2299.0 2317.0 2326.8 2335.2 2299.0 2308.4 2315.3 2315.4 2321.5 11053.8 11054.3 11091.6 11136.5 11175.0 4628.7 5504.9 5683.0 5684.5 5705.5 3199.9 3247.8 3345.0 3372.4 3383.7 1158.3 1170.3 1602.8 1748.6 1757.0 12165.3 14062.6 14232.9 15373.5 15928.7 4630.0 4630.8 4730.2 4740.6 4762.6 9841.0 12939.7 12950.5 12984.9 13001.3 5664.5 5680.3 5702.0 5703.7 5713.6 4907.8 5099.7 5106.3 5160.1 5192.4 3836.4 3887.8 3935.2 4010.3 4064.6 1018.0 1048.9 1065.7 1072.9 1081.6 917.5 931.1 946.5 950.6 1011.1 6468.8 6488.4 6634.0 6750.7 6754.5 967.2 970.5 993.0 1003.8 1023.6 3582.3 3741.4 3956.1 4163.6 4203.4 11353.6 13253.5 13875.6 13902.9 13907.4 11609.8 13280.0 13540.1 13665.1 13847.4 10017.9 10274.4 10310.6 10344.8 10485.1 6504.7 6748.6 6903.3 6913.3 7037.9 11870.0 12138.8 12153.3 12174.2 12361.3 11097.6 12217.8 12449.6 12564.4 12755.5 8885.8 9159.7 9166.9 9301.5 9313.5 10218.5 10330.2 10347.0 10434.8 10495.3 7378.7 8794.8 8795.6 8823.0 8901.4 8533.6 8614.3 8662.2 8663.0 8729.9 7742.8 7752.3 7787.3 7863.4 7873.6 5675.2 5808.6 5858.4 5877.2 5985.9 5862.1 5880.2 5919.4 5963.3 6046.3 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | [#4] prototype.html Cycles:180 Average:4625.09 Median:4958.68 stddev:1301.79 (26.3%) stddev-sans-first:1265.23 02:20:43 INFO - PROCESS | 1918 | Values: 347.2 349.2 369.8 381.7 389.6 5179.8 5203.5 5229.5 5267.4 5278.4 4425.8 4484.5 4792.9 5203.9 5213.8 3365.5 4000.5 4014.8 4188.6 4328.7 3556.6 3726.0 4069.0 4366.5 4384.3 4148.3 4224.7 4378.7 4400.9 4413.5 3583.3 4005.0 4259.6 4410.4 4415.6 3977.4 3994.8 4005.5 4050.6 4067.5 4405.2 4892.6 5182.2 5195.2 5210.9 4443.8 4921.7 5065.2 5091.1 5110.6 5603.2 5670.0 5699.5 5751.4 5780.9 4316.4 4516.7 4528.1 4558.5 4569.1 4840.3 4918.8 5334.1 5469.7 5805.5 3993.3 4301.5 4403.6 4617.5 4623.4 4019.8 4521.3 4569.6 4663.4 4765.3 4350.9 4649.3 4744.7 4839.6 4888.7 5224.3 5515.9 5599.2 5627.3 5707.8 1339.6 1592.0 1593.8 1594.5 1602.2 955.1 1085.3 1104.8 1198.0 1215.0 4793.7 5070.5 5270.4 5322.8 5345.9 5794.7 5875.3 5881.0 5926.4 5969.3 4080.2 4732.7 4760.5 5231.3 5273.6 2715.9 3035.2 3065.6 3067.7 3102.1 5682.8 6070.0 6074.5 6093.8 6106.4 5345.1 5472.0 5540.0 5684.5 5966.2 5506.4 5801.8 5932.6 6026.0 6050.8 4993.6 5033.0 5425.8 5783.7 5875.9 4640.4 4716.8 5037.1 5299.9 5769.3 5046.9 5096.6 5248.2 5996.0 6027.5 3916.7 4027.1 4526.1 4559.2 4586.9 4710.8 4892.6 5444.7 5537.3 5777.9 5223.9 5603.7 5658.8 5678.2 5685.0 5187.7 5240.3 5450.2 5555.6 5664.8 4393.6 4816.7 5208.9 5463.2 5583.8 4938.6 4978.7 5419.2 5656.8 5663.3 4668.0 4682.0 5183.7 5485.7 5547.8 02:20:43 INFO - PROCESS | 1918 | 02:20:43 INFO - PROCESS | 1918 | [#5] yui.html Cycles:180 Average:19704.98 Median:4316.28 stddev:27488.25 (636.9%) stddev-sans-first:27528.26 02:20:43 INFO - PROCESS | 1918 | Values: 683.8 689.4 744.2 805.5 829.5 15349.0 15432.5 16021.6 16071.9 16159.0 12947.5 15348.6 15533.3 15605.3 16226.8 913.7 918.2 928.8 929.9 931.8 888.7 923.6 925.1 925.6 926.0 1001.8 1002.4 1004.1 1005.8 1006.4 992.8 993.9 997.3 998.5 999.7 624.2 734.5 740.1 740.5 741.5 16257.0 16677.8 16805.5 16881.4 16898.7 12570.1 12861.2 13521.2 13860.2 14106.4 11109.0 12320.2 12404.4 12840.2 12924.0 4308.1 4320.2 4390.7 4411.6 4489.6 70408.6 96875.0 102493.5 102728.5 103838.0 8752.4 10369.2 10441.8 10451.0 10724.0 19552.4 20669.9 20793.8 20887.7 20941.8 7463.9 7560.6 7576.7 7665.8 7702.8 4251.6 4278.9 4312.4 4331.8 4431.9 3178.3 3259.1 3260.2 3261.3 3271.1 596.4 613.2 625.5 635.9 637.5 540.4 556.9 572.1 580.8 586.7 9360.5 9829.7 9835.7 10058.4 10142.7 616.6 640.4 653.7 657.4 663.6 4249.9 4290.5 4741.3 4752.7 4818.2 79761.6 97115.5 99235.0 100034.0 100330.0 75505.2 78534.0 78573.6 87471.6 88564.7 72124.9 76122.5 76569.9 78345.0 79522.2 10572.9 11146.1 11182.5 11401.8 11404.2 45899.0 51155.0 51712.7 52034.2 52721.2 62818.0 64877.0 66401.0 68297.0 69886.7 12676.0 13201.9 13216.1 13285.7 13464.7 12341.5 14475.6 14697.6 14748.3 14880.5 13528.9 13734.2 13747.6 14365.7 14647.3 11106.8 12517.6 12528.9 13696.0 13839.7 10024.1 12434.8 13570.3 13713.4 13990.9 9008.8 9108.0 9403.0 9529.0 9776.1 9609.3 10958.3 11106.6 11169.6 11284.0 02:20:43 INFO - PROCESS | 1918 | -------- Summary: end -------- 02:20:43 INFO - PROCESS | 1918 | 02:20:44 INFO - TEST-INFO | 1918: exit 0 02:20:44 INFO - TEST-OK | dromaeo_css | took 1117181ms 02:20:44 INFO - TEST-START | kraken 02:20:44 INFO - operating with platform_type : mac_ 02:20:44 INFO - Initialising browser for kraken test... 02:20:44 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmp7mcWIp/profile http://localhost:54249/getInfo.html) 02:20:47 INFO - PROCESS | 1924 | 2017-03-28 02:20:47.122 plugin-container[1926:20170] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a37, name = 'com.apple.tsm.portname' 02:20:47 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:20:47 INFO - PROCESS | 1924 | 2017-03-28 02:20:47.123 plugin-container[1926:20170] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 02:20:47 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:20:47 INFO - PROCESS | 1924 | 2017-03-28 02:20:47.123 plugin-container[1926:20170] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:20:47 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 02:20:47 INFO - PROCESS | 1924 | colorDepth:24 02:20:47 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 02:20:47 INFO - PROCESS | 1924 | __metrics 02:20:47 ERROR - PROCESS | 1924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:20:47 INFO - TEST-INFO | 1924: exit 0 02:20:47 INFO - Browser initialized. 02:20:47 INFO - Running cycle 1/1 for kraken test... 02:20:47 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmp7mcWIp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:50 INFO - PROCESS | 1927 | 2017-03-28 02:20:50.597 plugin-container[1928:20294] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 02:20:50 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:20:50 INFO - PROCESS | 1927 | 2017-03-28 02:20:50.598 plugin-container[1928:20294] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 02:20:50 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:20:50 INFO - PROCESS | 1927 | 2017-03-28 02:20:50.598 plugin-container[1928:20294] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:21:00 INFO - PROCESS | 1927 | RSS: Main: 220594176 02:21:00 INFO - PROCESS | 1927 | 02:21:03 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54249/tests/kraken/driver.html?testName=audio-beat-detection) 02:21:04 INFO - PROCESS | 1927 | RSS: Main: 235360256 02:21:04 INFO - PROCESS | 1927 | 02:21:07 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54249/tests/kraken/driver.html?testName=audio-dft) 02:21:07 INFO - PROCESS | 1927 | RSS: Main: 243265536 02:21:07 INFO - PROCESS | 1927 | 02:21:11 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54249/tests/kraken/driver.html?testName=audio-fft) 02:21:11 INFO - PROCESS | 1927 | RSS: Main: 244871168 02:21:11 INFO - PROCESS | 1927 | 02:21:13 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54249/tests/kraken/driver.html?testName=audio-oscillator) 02:21:14 INFO - PROCESS | 1927 | RSS: Main: 247623680 02:21:14 INFO - PROCESS | 1927 | 02:21:16 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:21:16 INFO - PROCESS | 1927 | RSS: Main: 248008704 02:21:16 INFO - PROCESS | 1927 | 02:21:20 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54249/tests/kraken/driver.html?testName=imaging-darkroom) 02:21:20 INFO - PROCESS | 1927 | RSS: Main: 252039168 02:21:20 INFO - PROCESS | 1927 | 02:21:23 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54249/tests/kraken/driver.html?testName=imaging-desaturate) 02:21:24 INFO - PROCESS | 1927 | RSS: Main: 251801600 02:21:24 INFO - PROCESS | 1927 | 02:21:27 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54249/tests/kraken/driver.html?testName=json-parse-financial) 02:21:27 INFO - PROCESS | 1927 | RSS: Main: 251514880 02:21:27 INFO - PROCESS | 1927 | 02:21:29 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:21:30 INFO - PROCESS | 1927 | RSS: Main: 251510784 02:21:30 INFO - PROCESS | 1927 | 02:21:32 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:21:32 INFO - PROCESS | 1927 | RSS: Main: 251457536 02:21:32 INFO - PROCESS | 1927 | 02:21:34 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:21:35 INFO - PROCESS | 1927 | RSS: Main: 251547648 02:21:35 INFO - PROCESS | 1927 | 02:21:38 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:21:39 INFO - PROCESS | 1927 | RSS: Main: 251809792 02:21:39 INFO - PROCESS | 1927 | 02:21:42 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:42 INFO - PROCESS | 1927 | RSS: Main: 251527168 02:21:42 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:54249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54249/tests/kraken/driver.html?testName=ai-astar) 02:21:44 INFO - PROCESS | 1927 | RSS: Main: 253575168 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | __start_tp_report 02:21:44 INFO - PROCESS | 1927 | _x_x_mozilla_page_load 02:21:44 INFO - PROCESS | 1927 | _x_x_mozilla_page_load_details 02:21:44 INFO - PROCESS | 1927 | |i|pagename|runs| 02:21:44 INFO - PROCESS | 1927 | |0;ai-astar;107;118;135;177;159;119;119;119;119;118 02:21:44 INFO - PROCESS | 1927 | |1;audio-beat-detection;131;111;113;145;111;114;112;119;155;126 02:21:44 INFO - PROCESS | 1927 | |2;audio-dft;196;199;199;203;198;207;263;282;196;236 02:21:44 INFO - PROCESS | 1927 | |3;audio-fft;82;59;62;87;63;63;65;62;100;87 02:21:44 INFO - PROCESS | 1927 | |4;audio-oscillator;89;72;86;73;73;70;82;71;73;108 02:21:44 INFO - PROCESS | 1927 | |5;imaging-gaussian-blur;87;90;128;121;138;136;88;88;88;88 02:21:44 INFO - PROCESS | 1927 | |6;imaging-darkroom;96;97;98;130;96;95;97;97;97;102 02:21:44 INFO - PROCESS | 1927 | |7;imaging-desaturate;118;90;91;91;92;85;91;91;91;92 02:21:44 INFO - PROCESS | 1927 | |8;json-parse-financial;66;67;64;68;70;71;69;68;68;70 02:21:44 INFO - PROCESS | 1927 | |9;json-stringify-tinderbox;63;55;58;64;58;58;56;56;56;59 02:21:44 INFO - PROCESS | 1927 | |10;stanford-crypto-aes;87;86;89;87;86;84;86;89;90;102 02:21:44 INFO - PROCESS | 1927 | |11;stanford-crypto-ccm;136;142;138;137;139;138;138;147;178;158 02:21:44 INFO - PROCESS | 1927 | |12;stanford-crypto-pbkdf2;173;170;163;164;178;222;227;193;174;168 02:21:44 INFO - PROCESS | 1927 | |13;stanford-crypto-sha256-iterative;60;74;70;65;91;87;84;86;65;65 02:21:44 INFO - PROCESS | 1927 | __end_tp_report 02:21:44 INFO - PROCESS | 1927 | __start_cc_report 02:21:44 INFO - PROCESS | 1927 | _x_x_mozilla_cycle_collect,1015 02:21:44 INFO - PROCESS | 1927 | __end_cc_report 02:21:44 INFO - PROCESS | 1927 | __startTimestamp1490692904781__endTimestamp 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | ------- Summary: start ------- 02:21:44 INFO - PROCESS | 1927 | Number of tests: 14 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#0] ai-astar Cycles:10 Average:129.00 Median:119.00 stddev:22.03 (18.5%) stddev-sans-first:21.88 02:21:44 INFO - PROCESS | 1927 | Values: 107.0 118.0 135.0 177.0 159.0 119.0 119.0 119.0 119.0 118.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:122.50 stddev:15.57 (12.7%) stddev-sans-first:16.29 02:21:44 INFO - PROCESS | 1927 | Values: 131.0 111.0 113.0 145.0 111.0 114.0 112.0 119.0 155.0 126.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#2] audio-dft Cycles:10 Average:217.90 Median:205.00 stddev:31.41 (15.3%) stddev-sans-first:32.30 02:21:44 INFO - PROCESS | 1927 | Values: 196.0 199.0 199.0 203.0 198.0 207.0 263.0 282.0 196.0 236.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#3] audio-fft Cycles:10 Average:73.00 Median:64.00 stddev:14.54 (22.7%) stddev-sans-first:15.06 02:21:44 INFO - PROCESS | 1927 | Values: 82.0 59.0 62.0 87.0 63.0 63.0 65.0 62.0 100.0 87.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:73.00 stddev:12.00 (16.4%) stddev-sans-first:12.25 02:21:44 INFO - PROCESS | 1927 | Values: 89.0 72.0 86.0 73.0 73.0 70.0 82.0 71.0 73.0 108.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#5] imaging-gaussian-blur Cycles:10 Average:105.20 Median:88.00 stddev:22.46 (25.5%) stddev-sans-first:22.84 02:21:44 INFO - PROCESS | 1927 | Values: 87.0 90.0 128.0 121.0 138.0 136.0 88.0 88.0 88.0 88.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:97.00 stddev:10.53 (10.9%) stddev-sans-first:11.05 02:21:44 INFO - PROCESS | 1927 | Values: 96.0 97.0 98.0 130.0 96.0 95.0 97.0 97.0 97.0 102.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:91.00 stddev:8.94 (9.8%) stddev-sans-first:2.13 02:21:44 INFO - PROCESS | 1927 | Values: 118.0 90.0 91.0 91.0 92.0 85.0 91.0 91.0 91.0 92.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:68.50 stddev:2.08 (3.0%) stddev-sans-first:2.06 02:21:44 INFO - PROCESS | 1927 | Values: 66.0 67.0 64.0 68.0 70.0 71.0 69.0 68.0 68.0 70.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:3.02 (5.2%) stddev-sans-first:2.68 02:21:44 INFO - PROCESS | 1927 | Values: 63.0 55.0 58.0 64.0 58.0 58.0 56.0 56.0 56.0 59.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:87.00 stddev:5.04 (5.8%) stddev-sans-first:5.31 02:21:44 INFO - PROCESS | 1927 | Values: 87.0 86.0 89.0 87.0 86.0 84.0 86.0 89.0 90.0 102.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:140.50 stddev:13.33 (9.5%) stddev-sans-first:13.72 02:21:44 INFO - PROCESS | 1927 | Values: 136.0 142.0 138.0 137.0 139.0 138.0 138.0 147.0 178.0 158.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:176.00 stddev:23.38 (13.3%) stddev-sans-first:24.50 02:21:44 INFO - PROCESS | 1927 | Values: 173.0 170.0 163.0 164.0 178.0 222.0 227.0 193.0 174.0 168.0 02:21:44 INFO - PROCESS | 1927 | 02:21:44 INFO - PROCESS | 1927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:79.00 stddev:11.31 (14.3%) stddev-sans-first:10.68 02:21:44 INFO - PROCESS | 1927 | Values: 60.0 74.0 70.0 65.0 91.0 87.0 84.0 86.0 65.0 65.0 02:21:44 INFO - PROCESS | 1927 | -------- Summary: end -------- 02:21:44 INFO - PROCESS | 1927 | 02:21:45 INFO - TEST-INFO | 1927: exit 0 02:21:45 INFO - TEST-OK | kraken | took 61586ms 02:21:45 INFO - SUITE-END | took 1178s 02:21:45 INFO - Completed test suite (00:19:38) 02:21:45 INFO - javascript benchmark 02:21:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7656.982265086147, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2886.89895853645, 3000.309928716395, 3468.1329667583104, 3498.3702933471964, 3537.5931767846696, 4934.3585333906585, 5156.561692256163, 6056.333803281641, 6125.908111378321, 6136.723847426865, 5905.704714764266, 6100.176476175715, 6140.232470941132, 6163.167972323735, 6179.938200617992, 5435.537979271757, 5494.560435165177, 5518.255035570187, 5571.220029195895, 5590.273264475612, 4535.274356103024, 5553.028220061493, 5554.86112847178, 5563.499285064343, 5579.776808927638, 5357.651752636086, 5382.865428364303, 5591.30108736408, 5594.832155035356, 5621.269234999444, 5457.372402173761, 5464.043792336345, 5467.5625949923915, 5481.287432633772, 5496.285482887199, 5409.594280428983, 5423.511883930465, 5470.261514695505, 5521.641093328921, 5580.469855363734, 6160.229971253593, 6200.658963756991, 6203.0, 6222.968885155546, 6238.750449981995, 6196.070589411579, 6265.530085243579, 6454.515911306624, 6489.740410383579, 6500.804975850732, 6342.365763423621, 6415.1981002374705, 6445.709943052574, 6569.704363303663, 6600.372964568358, 6237.345078766755, 6270.874582508415, 6274.623522588659, 6283.277423096311, 6283.3088360280335, 6641.269460359356, 6658.167729033871, 6683.331666833375, 6684.598924064571, 6706.798796036127, 6208.161898143783, 6248.718807653667, 6255.74977000924, 6283.3402492737605, 6286.245650521967, 5416.972915135478, 5486.231927530149, 6456.709448074848, 6529.053287273318, 6533.803985880431, 6352.333005034405, 6391.265004524446, 6403.96798016007, 6422.967885160544, 6446.613203207822, 6201.317855035943, 6243.843903902439, 6256.906146407808, 6450.612963222222, 6470.2559205691, 4339.305711086211, 5057.165567681292, 5158.509941555546, 5212.270282160501, 5241.266222728821, 4507.098580283956, 4569.725816451024, 4571.017231295287, 4590.724556526552, 4593.954060459419, 4740.28895665646, 6120.296165940974, 6127.969360153171, 6178.258608966953, 6195.039768835838, 6259.217597800275, 6561.179852518435, 6563.540552161398, 6574.868502629921, 6589.209294884548, 5981.431763982415, 6088.330283668793, 6127.234095738033, 6170.444659980623, 6206.162168107338, 5789.131630255495, 5790.623609465371, 5791.160281759121, 5797.304323481209, 5809.0, 6734.865302693918, 6757.256701762803, 6758.8648227036165, 6780.593164410151, 6788.830279243059, 5888.646681199141, 6240.7503699851495, 6355.110284560258, 6448.967755161382, 6471.094046833541, 6624.6025238485845, 6659.866802664016, 6679.866402672016, 6724.260331363644, 6741.089952856301, 6411.3909178627955, 6438.774642887476, 6442.194725659293, 6451.2903580607035, 6463.289038205888, 6240.968795155995, 6304.936950630618, 6419.197600299963, 6435.356464353715, 6490.8052758417325, 6219.564630475823, 6342.460890824332, 6376.202974628171, 6382.968085159545, 6388.936110638834, 6339.397757213057, 6370.980643097082, 6386.074019267273, 6399.136116624196, 6400.423961843457, 5333.8265581571995, 5379.735762095983, 6053.152558641706, 6185.0, 6216.53375996793, 6268.843278918063, 6286.27707813589, 6315.210598675166, 6344.841378965562, 6347.5239357047485, 5226.477352264743, 6249.218847644044, 6260.248770147611, 6277.466415354746, 6293.465055470153], "value": 5915.830414387801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.3494534481728, 811.2414892075909, 813.4265342933231, 867.7873920889383, 940.2571968145165, 38061.61938380615, 38908.02729931753, 39199.648021118715, 40477.0, 40635.59364406355, 38855.80572097136, 39005.41491877617, 39081.02297442565, 39134.825955221386, 39147.21705565887, 7500.662470188828, 7588.241175882423, 7841.294283514469, 7955.960220198891, 11117.499712512956, 11317.773644527104, 11413.942930285379, 11437.142214333917, 11441.199116061878, 11448.542058317656, 9678.419294842297, 11447.02700270478, 11463.0, 11466.312021278709, 11508.71228219297, 11352.0, 11400.315981041082, 11401.828972565418, 11402.31586104828, 11404.0, 11055.170862185289, 11109.111271098292, 11120.165987550967, 11122.944385278102, 11133.72165695856, 39450.80274598609, 39581.812545623674, 39643.00892477683, 39663.60336396628, 39717.0, 3802.7718336899875, 3813.8474461021524, 3838.9040273993096, 3892.338302488584, 3911.178652482982, 28119.156425307272, 29652.8517357414, 30143.09570712882, 30262.84868575643, 30297.091087267196, 3005.7144571265694, 3136.905892823219, 3151.495760678303, 3288.3423315337027, 3290.1610089427045, 357334.0, 359537.0, 363090.0, 363094.0, 364567.0, 44307.11385772267, 44853.10293794106, 53366.0, 54319.45680543223, 54377.72811135919, 55388.0, 56392.15411768827, 56529.15206271827, 56754.716226418604, 56914.86170276571, 14868.330925108396, 14949.925250373679, 14999.17504537239, 15041.924790375979, 15062.246887655574, 10998.395088270061, 11205.0, 12851.614451566467, 12861.0, 12923.0, 13501.324933753272, 13507.459701612022, 13541.0, 13604.04771665974, 13632.727345453035, 6095.323785958897, 6097.939020609826, 6123.84690382744, 6127.938720612826, 6147.170132032208, 948.7343543807744, 1071.8959471744115, 1089.8147314956318, 1111.1166622535104, 1126.695792136135, 26962.115512061155, 27177.45645087127, 27310.5903411449, 27400.177994660193, 27597.0, 941.9105185007413, 998.9500524973722, 1006.7181189267017, 1040.422565476168, 1222.5904322052033, 13593.660158496117, 13676.726465470634, 13781.966352523601, 13801.723965520634, 13948.930255348861, 496411.0, 500730.0, 502347.0, 502860.0, 502923.0, 47563.28655070177, 48008.27987580189, 48087.519124809005, 48122.0, 48221.758891206024, 1293.8318018657515, 1328.156620545941, 1328.4686125549665, 1338.0767270583267, 1345.9259740714158, 20070.09684564169, 25056.62415063739, 25898.870505648105, 26302.736972630795, 26406.867965660047, 41993.0, 42236.78881605572, 42317.78841105775, 42412.575874242095, 42415.5758442424, 485927.0, 486041.0, 486111.0, 486124.0, 487521.0, 24104.75895241025, 30230.54654180145, 31005.534916976714, 32039.0, 32053.67946320507, 39099.631512896915, 39345.80327098346, 40067.59932400638, 40151.0, 40188.1962360757, 28191.0, 28244.576331355456, 28754.568681470213, 28922.42155156843, 29458.705412945597, 24985.625215621418, 26177.560234187302, 28414.715852841207, 28561.000364987125, 29026.564601531416, 32307.51538726874, 33272.00183994484, 33349.499757503174, 33522.32955340928, 33545.0, 22972.77027229773, 26545.60181597316, 27117.0, 28827.71172288334, 29403.705962940952, 22441.551168976857, 23133.421664458525, 23216.767832322137, 23622.88188559046, 23695.881520592287], "value": 18615.816122336888, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.11334008511216, 405.8396933211383, 410.2390066426779, 418.20332267031307, 439.93096774837153, 19443.319483818068, 19647.60704785905, 20038.59922801543, 20425.080871360788, 20653.586928261444, 21160.365189044314, 21222.57554848902, 21514.784852151475, 21974.0, 22255.888720556413, 5779.479846813786, 7044.753433629824, 7052.188998265188, 7055.259197784236, 7061.046758687588, 6529.510286728514, 6825.044493770876, 6856.074429951967, 6880.518363714517, 6880.759173428931, 5463.836084917439, 6098.658295175054, 6545.214574251097, 6876.724931002754, 6883.827904302382, 5942.673152976585, 6904.965475172592, 6923.653817309114, 6927.618980956071, 6934.965325173393, 6393.520485963525, 6645.900311495331, 6673.699683514254, 6684.665766711693, 6754.2907994660345, 20588.86761228132, 26062.0, 26101.73898261012, 26321.0, 26597.335066623295, 2704.837709737422, 2755.9586606200924, 2796.4826507096254, 2806.649168853893, 2812.6343575335077, 7541.944127822109, 7642.694292228304, 16620.750688739678, 16629.91685041567, 16689.0, 1783.2777725021388, 1810.63787242552, 2035.5827055453597, 2110.0504772852123, 2112.207922029239, 117066.0, 118652.40673796662, 120294.39852800767, 122251.0, 122321.16518252234, 16332.0, 21706.240281590068, 21805.345839624835, 21920.0, 21986.0, 34911.07989060575, 34982.30035399328, 35514.644853551654, 35743.28513429717, 35801.8209908954, 10656.0, 10818.29681070728, 10920.071793897609, 11009.064229540418, 11018.063464605599, 7320.524165929304, 8850.644132430229, 8908.06465321145, 8964.462132272085, 9030.683926062557, 9495.38280011797, 10188.9811018899, 10499.527521261562, 10923.508442120125, 10961.0, 3586.497890295361, 3915.4909861717792, 4262.744235345889, 4318.740875547477, 4345.327049086125, 764.3846703403702, 885.4421714319938, 885.6191837509932, 888.853339199025, 905.3798148268457, 20902.477438063866, 21762.0, 21802.672959905613, 21937.890310548344, 21971.121155153614, 842.5113434208145, 931.1970967388211, 932.6875496708678, 935.6818681648273, 947.280067148958, 7913.061299981541, 11382.317060976367, 11792.764144717057, 11799.941000294944, 11814.88185118155, 623788.0, 730522.0, 753104.0, 764026.0, 765312.0, 94658.0, 114781.0, 159931.0, 165864.17067914826, 167749.0, 1274.49020391844, 1274.8916342111024, 1325.0327261099258, 1327.8605746396684, 1336.1181620130667, 19036.714449282994, 19500.414987550397, 19803.306884258982, 20249.69625455649, 20275.0, 56855.0, 65955.01067484087, 65990.0, 66226.66886665729, 66821.32946676372, 86193.7070943949, 92164.53917730368, 93533.0, 93695.0, 95247.0, 8657.047724750399, 10152.64465743725, 11094.223404361617, 11225.49485273181, 11816.46825892854, 12689.302088385228, 12846.357682116044, 12947.741045179233, 13139.54011609589, 13243.20540767557, 10893.237473376788, 10904.672859814218, 10911.2362134653, 11118.833217501582, 11283.266587671775, 8088.0, 9085.727998080141, 9873.210143188384, 10371.222158338003, 10682.198835087554, 9885.357451765612, 10247.7438064049, 10965.725856853642, 11534.0, 11643.359615221245, 9669.854952175583, 11336.886631133582, 11406.201565890307, 11454.854514548479, 11567.595134170264, 7779.611019448892, 11017.779644407226, 11224.831627525431, 11442.713932151762, 11468.31190128595], "value": 11302.775693199119, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.803601513796, 1516.9469068582603, 1581.6757564699235, 1586.9526112765577, 1588.6902054099448, 10686.305390149635, 11116.444177791098, 11240.606578769744, 11315.886841131587, 11324.150688698339, 9051.502167380808, 9211.539423028855, 11274.323540587571, 11280.871912808736, 11307.208495405324, 2306.2043594959714, 2360.4216966843146, 2363.948043120812, 2364.988175059122, 2371.9644205336936, 2263.151318255654, 2343.297010896733, 2345.9882700586472, 2360.8819559022068, 2363.161077817376, 2257.6613507973852, 2306.8961896714686, 2342.625179971205, 2355.0815182079004, 2358.9056437742556, 2286.9771302287095, 2299.0, 2316.976830231693, 2326.813854891613, 2335.2177020698086, 2298.988505057481, 2308.4344335637707, 2315.3169814904477, 2315.3979965209, 2321.5472982768365, 11053.778924421547, 11054.281471704395, 11091.55633774648, 11136.498857551349, 11175.0, 4628.6991345562765, 5504.91742623861, 5683.0, 5684.488396044376, 5705.515031222351, 3199.856006479714, 3247.7564182686156, 3344.966550334514, 3372.426687463137, 3383.6954674079207, 1158.2645020412015, 1170.3153655111769, 1602.767598698194, 1748.6360638701833, 1757.0072908806483, 12165.270083795001, 14062.578122656336, 14232.928835355757, 15373.538793836204, 15928.681426371408, 4629.981404091094, 4630.814767409333, 4730.2431610942085, 4740.620750340034, 4762.618990480753, 9841.0, 12939.741205175844, 12950.481980720853, 12984.935075324753, 13001.349932503337, 5664.49019588239, 5680.318361796528, 5701.971490142606, 5703.714814259353, 5713.628614140151, 4907.754612269372, 5099.6685215460875, 5106.259592359087, 5160.148575485003, 5192.402873669501, 3836.3861782114727, 3887.814216663888, 3935.193285376491, 4010.298197815429, 4064.5732198119363, 1017.9871028326714, 1048.8688913885765, 1065.6909496246, 1072.8658917635296, 1081.6268387406333, 917.4632839788665, 931.0921851195166, 946.4794363100267, 950.6007476859736, 1011.110223003752, 6468.8059358219325, 6488.448481879093, 6634.0, 6750.7299708012115, 6754.493412994045, 967.2020583019038, 970.5438443931341, 992.9851052234222, 1003.7691330993912, 1023.5701005577675, 3582.283543291352, 3741.401375779862, 3956.1296514766705, 4163.625273725379, 4203.432536607519, 11353.60262390829, 13253.536126235536, 13875.58373248784, 13902.860971390359, 13907.374168162458, 11609.767804644029, 13280.0, 13540.052196346162, 13665.111767735065, 13847.376868040963, 10017.899821001842, 10274.383536987805, 10310.639127630648, 10344.844827327595, 10485.108765754843, 6504.707288171949, 6748.628825414649, 6903.309669033057, 6913.274106218976, 7037.894431583428, 11870.0, 12138.817917731418, 12153.270803751802, 12174.208676436003, 12361.320127393079, 11097.611583594535, 12217.755644887231, 12449.564265251034, 12564.434600442819, 12755.48978040868, 8885.777855553662, 9159.725208243763, 9166.862497062417, 9301.488418136796, 9313.534323283673, 10218.489075546044, 10330.225233107396, 10347.017033381817, 10434.791304173723, 10495.265331426726, 7378.704851805867, 8794.824103518022, 8795.604197810986, 8822.955885220534, 8901.376903616685, 8533.615987280711, 8614.3108551317, 8662.177093176138, 8663.0, 8729.869051964099, 7742.806429839074, 7752.341051010727, 7787.338076263581, 7863.449558530848, 7873.606319684108, 5675.205471233948, 5808.593398462067, 5858.355580886185, 5877.23595932526, 5985.88563876216, 5862.12068189775, 5880.206172166702, 5919.437653422918, 5963.2844058713235, 6046.30467496226], "value": 5107.003401334761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.1529468097843, 349.18465383329925, 369.7686703278086, 381.71943621438237, 389.581921804631, 5179.81870634527, 5203.4796520347945, 5229.450907654698, 5267.420583735786, 5278.392984806748, 4425.77871106445, 4484.461864576256, 4792.880177995552, 5203.933193695293, 5213.817516386927, 3365.4951757236486, 4000.4796977904025, 4014.808227459177, 4188.602082802144, 4328.653707703376, 3556.590992035923, 3725.962740372602, 4069.006186968379, 4366.463164836477, 4384.298512238042, 4148.274052040896, 4224.704270701052, 4378.737275763448, 4400.889977750549, 4413.470383553978, 3583.3191693578137, 4004.9599504004877, 4259.595338442843, 4410.360497727827, 4415.624671902892, 3977.3835055566433, 3994.7603143811466, 4005.517958355398, 4050.6354428101317, 4067.51189857219, 4405.22908491016, 4892.584130348924, 5182.248573956793, 5195.19474481456, 5210.921836172422, 4443.777811109431, 4921.704697718113, 5065.189569668835, 5091.0581542414775, 5110.616703747234, 5603.159526071081, 5670.0, 5699.549193846644, 5751.447109280471, 5780.913286300709, 4316.395704601358, 4516.696484792747, 4528.128450175086, 4558.521355257683, 4569.109023740372, 4840.273958906157, 4918.778654960535, 5334.119870221409, 5469.699166545838, 5805.53555715546, 3993.2845664947536, 4301.494476933049, 4403.603675669206, 4617.538246175355, 4623.398958135488, 4019.789115986196, 4521.321801729701, 4569.634429245652, 4663.370444989883, 4765.285207218945, 4350.912981740347, 4649.325847752057, 4744.695208817603, 4839.564439200489, 4888.682235654671, 5224.268602395668, 5515.896820635889, 5599.244102046253, 5627.296587926509, 5707.828765137053, 1339.6115126613367, 1592.0, 1593.8406159384201, 1594.5136733296224, 1602.1748799368336, 955.1308309438377, 1085.3270971997413, 1104.812181929074, 1197.963761346429, 1214.9514019439123, 4793.664443488922, 5070.518300761421, 5270.393904701008, 5322.760475778599, 5345.893082138336, 5794.652320860761, 5875.29496460419, 5881.00068964831, 5926.362768567946, 5969.343372229051, 4080.2346448488443, 4732.6687131900435, 4760.547747963938, 5231.3199284092825, 5273.630845840754, 2715.932101697473, 3035.1653295343517, 3065.601471808651, 3067.708567686066, 3102.1314032071054, 5682.77268909239, 6069.998450255746, 6074.514038876968, 6093.786717464867, 6106.358832322631, 5345.1447768356875, 5472.005436031719, 5539.972300138474, 5684.54523638108, 5966.181643748005, 5506.394296627368, 5801.82594522165, 5932.644041357532, 6026.0, 6050.848728781815, 4993.551869957817, 5032.986805277918, 5425.755840987086, 5783.710814459176, 5875.914050512178, 4640.429177260463, 4716.806684891542, 5037.140088937413, 5299.887023724907, 5769.336526299529, 5046.873828154178, 5096.598435430286, 5248.24183898383, 5995.970020149872, 6027.46846324536, 3916.686665066845, 4027.0536423940935, 4526.117407105715, 4559.202139625486, 4586.945002649342, 4710.845842768544, 4892.602624713936, 5444.686008446473, 5537.311120108245, 5777.8555536111935, 5223.895522089613, 5603.691796951207, 5658.840752047325, 5678.176664383724, 5684.971575142098, 5187.714675692722, 5240.34495688039, 5450.150756273237, 5555.638883472561, 5664.801731939362, 4393.62654174386, 4816.686915350631, 5208.947910520847, 5463.207834864002, 5583.832485025456, 4938.629602779878, 4978.726170060681, 5419.187121931742, 5656.830295091154, 5663.263775709132, 4667.989147000234, 4681.976590117028, 5183.663061900965, 5485.698286594116, 5547.750351234124], "value": 4241.7778741672555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.8085336105889, 689.3657834791991, 744.2111361956327, 805.5368163306099, 829.4981536170617, 15349.0, 15432.459863904765, 16021.59946001349, 16071.919640401811, 16159.030458172503, 12947.48210071596, 15348.61628459289, 15533.301001454962, 15605.297761600727, 16226.756598651029, 913.7213149989267, 918.2332752151962, 928.7770934975625, 929.9349045566813, 931.7903471718843, 888.6667499687617, 923.5520772425368, 925.0656836595053, 925.5742358515091, 926.0045451140018, 1001.7695929936083, 1002.413588050991, 1004.1063453526367, 1005.8038682456923, 1006.4112494190907, 992.7865508915581, 993.88073431188, 997.306871724152, 998.4907697074472, 999.6601155607092, 624.2010226909563, 734.4711807498646, 740.0896896816945, 740.5371642723298, 741.4624397311906, 16257.024578525326, 16677.833221667748, 16805.495835124966, 16881.40915067979, 16898.662026759517, 12570.120091593591, 12861.16402433848, 13521.188728676212, 13860.168389896638, 14106.435742570286, 11109.0, 12320.199187052813, 12404.441800119017, 12840.165389249669, 12924.0, 4308.116836048603, 4320.179165958458, 4390.692651514395, 4411.6250118739945, 4489.573490518395, 70408.6479567604, 96875.0, 102493.4875325626, 102728.48635756773, 103837.96162038359, 8752.431091979, 10369.222308326905, 10441.791164176673, 10451.02919245674, 10723.981221783917, 19552.413427597196, 20669.89665051665, 20793.792062079487, 20887.68668469974, 20941.790582094287, 7463.8507229855095, 7560.621968901533, 7576.659050342748, 7665.808354791175, 7702.845943081107, 4251.638610718123, 4278.871633850989, 4312.37470566766, 4331.7834108294455, 4431.8670439886855, 3178.3166619176986, 3259.071164718044, 3260.1849537615594, 3261.2662151015834, 3271.0677456925137, 596.4214711729616, 613.2365205319317, 625.4964753373487, 635.86964672243, 637.5186734015789, 540.4325458268802, 556.8751122732059, 572.1275055540334, 580.7676929228343, 586.7447660267798, 9360.531973401303, 9829.655962041294, 9835.704928852147, 10058.396496210251, 10142.695719128438, 616.636184651058, 640.3692363022419, 653.6862306093102, 657.4083325007532, 663.575311800448, 4249.936250956238, 4290.485141783006, 4741.336212930192, 4752.738599377068, 4818.204996175662, 79761.60119199484, 97115.54326685105, 99235.0, 100034.0, 100330.0, 75505.24494754981, 78534.0, 78573.60713196397, 87471.56264218639, 88564.6715299271, 72124.91812622815, 76122.4775504498, 76569.85145222826, 78345.0, 79522.20477795148, 10572.947135264274, 11146.119151934488, 11182.496787644739, 11401.771964560829, 11404.201705880509, 45899.0, 51155.0, 51712.74143629258, 52034.21948670697, 52721.20918186154, 62818.0, 64877.02684459831, 66401.0, 68297.0, 69886.65056674684, 12676.04929630263, 13201.933990329986, 13216.140950838164, 13285.66785830362, 13464.730705386033, 12341.50633974631, 14475.565733028026, 14697.632559186106, 14748.33632486562, 14880.466588371259, 13528.86471135276, 13734.244616546186, 13747.587572372844, 14365.712685746435, 14647.26763661834, 11106.833397498882, 12517.624471265877, 12528.874711253135, 13696.0, 13839.723205536035, 10024.147947424259, 12434.813477798021, 13570.253636050113, 13713.382897769823, 13990.930045349709, 9008.819823603622, 9108.0, 9402.95298523503, 9529.0, 9776.120149186607, 9609.327347085637, 10958.28771129874, 11106.555737770723, 11169.553217871518, 11284.0], "value": 7473.232480930305, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 135.0, 177.0, 159.0, 119.0, 119.0, 119.0, 119.0, 118.0], "value": 129.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 111.0, 113.0, 145.0, 111.0, 114.0, 112.0, 119.0, 155.0, 126.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 199.0, 203.0, 198.0, 207.0, 263.0, 282.0, 196.0, 236.0], "value": 217.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 62.0, 87.0, 63.0, 63.0, 65.0, 62.0, 100.0, 87.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 86.0, 73.0, 73.0, 70.0, 82.0, 71.0, 73.0, 108.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 128.0, 121.0, 138.0, 136.0, 88.0, 88.0, 88.0, 88.0], "value": 105.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 98.0, 130.0, 96.0, 95.0, 97.0, 97.0, 97.0, 102.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 90.0, 91.0, 91.0, 92.0, 85.0, 91.0, 91.0, 91.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 68.0, 70.0, 71.0, 69.0, 68.0, 68.0, 70.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 55.0, 58.0, 64.0, 58.0, 58.0, 56.0, 56.0, 56.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 87.0, 86.0, 84.0, 86.0, 89.0, 90.0, 102.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 138.0, 137.0, 139.0, 138.0, 138.0, 147.0, 178.0, 158.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 163.0, 164.0, 178.0, 222.0, 227.0, 193.0, 174.0, 168.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 74.0, 70.0, 65.0, 91.0, 87.0, 84.0, 86.0, 65.0, 65.0], "value": 74.7, "unit": "score"}]}]} 02:21:46 INFO - Return code: 0 02:21:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:21:46 ERROR - # TBPL SUCCESS # 02:21:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:21:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:21:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:21:46 INFO - 2017-03-28 02:21:46.119 screenresolution[1932:20681] starting screenresolution argv=screenresolution get 02:21:46 INFO - 2017-03-28 02:21:46.122 screenresolution[1932:20681] Display 0: 1600x1200x32@60 02:21:46 INFO - 2017-03-28 02:21:46.129 screenresolution[1933:20684] starting screenresolution argv=screenresolution list 02:21:46 INFO - Available Modes on Display 0 02:21:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:21:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:21:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:21:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:21:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:21:46 INFO - Intel Iris: 02:21:46 INFO - Chipset Model: Intel Iris 02:21:46 INFO - Type: GPU 02:21:46 INFO - Bus: Built-In 02:21:46 INFO - VRAM (Dynamic, Max): 1536 MB 02:21:46 INFO - Vendor: Intel (0x8086) 02:21:46 INFO - Device ID: 0x0a2e 02:21:46 INFO - Revision ID: 0x0009 02:21:46 INFO - Displays: 02:21:46 INFO - Display: 02:21:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:21:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:21:46 INFO - Display Serial Number: 1600x1200 60 02:21:46 INFO - Main Display: Yes 02:21:46 INFO - Mirror: Off 02:21:46 INFO - Online: Yes 02:21:46 INFO - Rotation: Supported 02:21:46 INFO - Return code: 0 02:21:46 INFO - Running post-action listener: _resource_record_post_action 02:21:46 INFO - [mozharness: 2017-03-28 09:21:46.368829Z] Finished run-tests step (success) 02:21:46 INFO - Running post-run listener: _resource_record_post_run 02:21:46 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 1249280; Write bytes: 511007744; Read time: 15; Write time: 1982 02:21:46 INFO - TinderboxPrint: CPU usage
54.6% 02:21:46 INFO - TinderboxPrint: I/O read bytes / time
1,249,280 / 15 02:21:46 INFO - TinderboxPrint: I/O write bytes / time
511,007,744 / 1,982 02:21:46 INFO - TinderboxPrint: CPU idle
2,181.2 (45.4%) 02:21:46 INFO - TinderboxPrint: CPU system
966.3 (20.1%) 02:21:46 INFO - TinderboxPrint: CPU user
1,654.1 (34.4%) 02:21:46 INFO - TinderboxPrint: Swap in / out
209,506,304 / 0 02:21:46 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203414016; Write bytes: 199106560; Read time: 15826; Write time: 362 02:21:46 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 1249280; Write bytes: 301124608; Read time: 15; Write time: 1589 02:21:46 INFO - Running post-run listener: _upload_blobber_files 02:21:46 INFO - Blob upload gear active. 02:21:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:21:46 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 02:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:21:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:21:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:21:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:21:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:47 INFO - (blobuploader) - INFO - Done attempting. 02:21:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:21:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:48 INFO - (blobuploader) - INFO - Done attempting. 02:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:50 INFO - (blobuploader) - INFO - Done attempting. 02:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:21:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:52 INFO - (blobuploader) - INFO - Done attempting. 02:21:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:21:52 INFO - Return code: 0 02:21:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:21:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:21:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa391803651c3db379b10c839090517e068ae0d27ffa967312fd7f4372fd270593d2423c440b94f74ff5525582fa1926a03d9c06fe96231ac491fe45c24d1a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb242479a3a8bedcb1fa370793f6b9dcdd90b978c0b4dfe47f7f0be03cdd93925aa64f4dfb733936a7057cf92d9d21a5343df2b8f3355a90a87467ee67d6fe01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c626417a57ec0b7c613e88ae374614ac6aca22705fd5e47141ed7524f2b0366c57a7f3f2471a4cc32ba2924f9c043991e346a9c1bccd6c384a334e54a6ce7965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88b207f31cd7a3b5f6ccb7d61e2b428afa970c691e9f3dc0cf0ad153c1f53d9f792d38c0213b21fbdb8f6144df1fe39cff3d0bd15348ca121dcf085524e6eacf"} 02:21:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:21:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:21:52 INFO - Contents: 02:21:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa391803651c3db379b10c839090517e068ae0d27ffa967312fd7f4372fd270593d2423c440b94f74ff5525582fa1926a03d9c06fe96231ac491fe45c24d1a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb242479a3a8bedcb1fa370793f6b9dcdd90b978c0b4dfe47f7f0be03cdd93925aa64f4dfb733936a7057cf92d9d21a5343df2b8f3355a90a87467ee67d6fe01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c626417a57ec0b7c613e88ae374614ac6aca22705fd5e47141ed7524f2b0366c57a7f3f2471a4cc32ba2924f9c043991e346a9c1bccd6c384a334e54a6ce7965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88b207f31cd7a3b5f6ccb7d61e2b428afa970c691e9f3dc0cf0ad153c1f53d9f792d38c0213b21fbdb8f6144df1fe39cff3d0bd15348ca121dcf085524e6eacf"} 02:21:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:21:52 INFO - Copying logs to upload dir... 02:21:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:21:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.417525 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-28 02:21:52.233339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 02:21:52.237127) ========= 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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa391803651c3db379b10c839090517e068ae0d27ffa967312fd7f4372fd270593d2423c440b94f74ff5525582fa1926a03d9c06fe96231ac491fe45c24d1a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb242479a3a8bedcb1fa370793f6b9dcdd90b978c0b4dfe47f7f0be03cdd93925aa64f4dfb733936a7057cf92d9d21a5343df2b8f3355a90a87467ee67d6fe01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c626417a57ec0b7c613e88ae374614ac6aca22705fd5e47141ed7524f2b0366c57a7f3f2471a4cc32ba2924f9c043991e346a9c1bccd6c384a334e54a6ce7965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88b207f31cd7a3b5f6ccb7d61e2b428afa970c691e9f3dc0cf0ad153c1f53d9f792d38c0213b21fbdb8f6144df1fe39cff3d0bd15348ca121dcf085524e6eacf"} build_url:https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/RLih5AzXS-mN1Qrsh7HNNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa391803651c3db379b10c839090517e068ae0d27ffa967312fd7f4372fd270593d2423c440b94f74ff5525582fa1926a03d9c06fe96231ac491fe45c24d1a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb242479a3a8bedcb1fa370793f6b9dcdd90b978c0b4dfe47f7f0be03cdd93925aa64f4dfb733936a7057cf92d9d21a5343df2b8f3355a90a87467ee67d6fe01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c626417a57ec0b7c613e88ae374614ac6aca22705fd5e47141ed7524f2b0366c57a7f3f2471a4cc32ba2924f9c043991e346a9c1bccd6c384a334e54a6ce7965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88b207f31cd7a3b5f6ccb7d61e2b428afa970c691e9f3dc0cf0ad153c1f53d9f792d38c0213b21fbdb8f6144df1fe39cff3d0bd15348ca121dcf085524e6eacf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 02:21:52.271488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:21:52.271865) ========= 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.0VMVrWf0XM/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.YjIGNKBMXi/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.005375 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 02:21:52.321339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 02:21:52.322110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 02:21:52.322847) ========= ========= Total master_lag: 0.21 =========