builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0324 starttime: 1488850376.73 results: success (0) buildid: 20170306160126 builduid: 9943c46c696849259453c8597d08d82f revision: 150eacc885c23d1845280917cda4e6a652f8a7b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:56.732983) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:56.733436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:56.733715) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:56.760534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:56.760925) ========= 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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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-06 17:32:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2017-03-06 17:32:57 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.236633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:57.021352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:57.021679) ========= 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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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.040703 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:57.084201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 17:32:57.084804) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 150eacc885c23d1845280917cda4e6a652f8a7b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 150eacc885c23d1845280917cda4e6a652f8a7b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ses19qwFQ6/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.Eo6GsFQRCT/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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-06 17:32:57,196 truncating revision to first 12 chars 2017-03-06 17:32:57,197 Setting DEBUG logging. 2017-03-06 17:32:57,197 attempt 1/10 2017-03-06 17:32:57,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/150eacc885c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-06 17:32:58,112 unpacking tar archive at: mozilla-beta-150eacc885c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.188502 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 17:32:58.951481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:58.951841) ========= script_repo_revision: 150eacc885c23d1845280917cda4e6a652f8a7b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:58.952259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:58.952533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 17:32:58.973474) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-06 17:32:58.973993) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ses19qwFQ6/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.Eo6GsFQRCT/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:32:59 INFO - MultiFileLogger online at 20170306 17:32:59 in /builds/slave/test 17:32:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:32:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:32:59 INFO - {'append_to_log': False, 17:32:59 INFO - 'base_work_dir': '/builds/slave/test', 17:32:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:32:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:32:59 INFO - 'branch': 'Mozilla-Beta', 17:32:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:32:59 INFO - 'config_files': ('talos/mac_config.py',), 17:32:59 INFO - 'default_actions': ('clobber', 17:32:59 INFO - 'read-buildbot-config', 17:32:59 INFO - 'download-and-extract', 17:32:59 INFO - 'populate-webroot', 17:32:59 INFO - 'create-virtualenv', 17:32:59 INFO - 'install', 17:32:59 INFO - 'run-tests'), 17:32:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:32:59 INFO - 'download_minidump_stackwalk': True, 17:32:59 INFO - 'download_symbols': 'ondemand', 17:32:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:32:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:32:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:32:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:32:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:32:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:32:59 INFO - 'installer_path': 'installer.exe', 17:32:59 INFO - 'log_level': 'info', 17:32:59 INFO - 'log_name': 'talos', 17:32:59 INFO - 'log_to_console': True, 17:32:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:32:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:32:59 INFO - 'opt_config_files': (), 17:32:59 INFO - 'pip_index': False, 17:32:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:32:59 INFO - 'cmd': ('bash', 17:32:59 INFO - '-c', 17:32:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:32:59 INFO - 'enabled': True, 17:32:59 INFO - 'halt_on_failure': False, 17:32:59 INFO - 'name': 'check_screen_resolution'},), 17:32:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:32:59 INFO - 'cmd': ('bash', 17:32:59 INFO - '-c', 17:32:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:32:59 INFO - 'enabled': True, 17:32:59 INFO - 'halt_on_failure': False, 17:32:59 INFO - 'name': 'check_screen_resolution'},), 17:32:59 INFO - 'run_cmd_checks_enabled': True, 17:32:59 INFO - 'sps_profile': False, 17:32:59 INFO - 'sps_profile_interval': 0, 17:32:59 INFO - 'suite': 'dromaeojs-e10s', 17:32:59 INFO - 'system_bits': '32', 17:32:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:32:59 INFO - 'title': 't-yosemite-r7-0324', 17:32:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:32:59 INFO - 'use_talos_json': True, 17:32:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:32:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:32:59 INFO - 'work_dir': 'build'} 17:32:59 INFO - [mozharness: 2017-03-07 01:32:59.189983Z] Running clobber step. 17:32:59 INFO - Running pre-action listener: _resource_record_pre_action 17:32:59 INFO - Running main action method: clobber 17:32:59 INFO - rmtree: /builds/slave/test/build 17:32:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:33:01 INFO - Running post-action listener: _resource_record_post_action 17:33:01 INFO - [mozharness: 2017-03-07 01:33:01.709764Z] Finished clobber step (success) 17:33:01 INFO - [mozharness: 2017-03-07 01:33:01.709843Z] Running read-buildbot-config step. 17:33:01 INFO - Running pre-action listener: _resource_record_pre_action 17:33:01 INFO - Running main action method: read_buildbot_config 17:33:01 INFO - Using buildbot properties: 17:33:01 INFO - { 17:33:01 INFO - "project": "", 17:33:01 INFO - "product": "firefox", 17:33:01 INFO - "script_repo_revision": "production", 17:33:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 17:33:01 INFO - "repository": "", 17:33:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 17:33:01 INFO - "buildid": "20170306160126", 17:33:01 INFO - "pgo_build": "False", 17:33:01 INFO - "basedir": "/builds/slave/test", 17:33:01 INFO - "buildnumber": 23, 17:33:01 INFO - "slavename": "t-yosemite-r7-0324", 17:33:01 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:33:01 INFO - "platform": "yosemite_r7", 17:33:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:33:01 INFO - "branch": "mozilla-beta", 17:33:01 INFO - "repo_path": "releases/mozilla-beta", 17:33:01 INFO - "revision": "150eacc885c23d1845280917cda4e6a652f8a7b6", 17:33:01 INFO - "stage_platform": "macosx64", 17:33:01 INFO - "builduid": "9943c46c696849259453c8597d08d82f", 17:33:01 INFO - "slavebuilddir": "test" 17:33:01 INFO - } 17:33:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 17:33:01 INFO - Running post-action listener: _resource_record_post_action 17:33:01 INFO - [mozharness: 2017-03-07 01:33:01.713159Z] Finished read-buildbot-config step (success) 17:33:01 INFO - [mozharness: 2017-03-07 01:33:01.713287Z] Running download-and-extract step. 17:33:01 INFO - Running pre-action listener: _resource_record_pre_action 17:33:01 INFO - Running main action method: download_and_extract 17:33:01 INFO - mkdir: /builds/slave/test/build/tests 17:33:01 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')]} 17:33:01 INFO - trying https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 17:33:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 17:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 17:33:03 INFO - Downloaded 1165 bytes. 17:33:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 17:33:03 INFO - Using the following test package requirements: 17:33:03 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 17:33:03 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:33:03 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 17:33:03 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:33:03 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 17:33:03 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:33:03 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:33:03 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 17:33:03 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 17:33:03 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:33:03 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 17:33:03 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:33:03 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 17:33:03 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:33:03 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 17:33:03 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:33:03 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 17:33:03 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 17:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 17:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 17:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 17:33:03 INFO - Expected file size: 16103464 17:33:03 INFO - Obtained file size: 16103464 17:33:10 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:33:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 17:33:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 17:33:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 17:33:11 INFO - Expected file size: 16103464 17:33:11 INFO - Obtained file size: 16103464 17:33:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 17:33:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 17:33:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 17:33:19 INFO - Expected file size: 14403650 17:33:19 INFO - Obtained file size: 14403650 17:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:19 INFO - trying https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:33:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 17:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 17:33:21 INFO - Downloaded 58692379 bytes. 17:33:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:33:21 INFO - mkdir: /builds/slave/test/properties 17:33:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:33:21 INFO - Writing to file /builds/slave/test/properties/build_url 17:33:21 INFO - Contents: 17:33:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:33:21 INFO - Running post-action listener: _resource_record_post_action 17:33:21 INFO - Running post-action listener: set_extra_try_arguments 17:33:21 INFO - [mozharness: 2017-03-07 01:33:21.812008Z] Finished download-and-extract step (success) 17:33:21 INFO - [mozharness: 2017-03-07 01:33:21.812190Z] Running populate-webroot step. 17:33:21 INFO - Running pre-action listener: _resource_record_pre_action 17:33:21 INFO - Running main action method: populate_webroot 17:33:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:33:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:33:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:33:21 INFO - '--tppagecycles', 17:33:21 INFO - '7'], 17:33:21 INFO - 'tests': ['tsvgm']}}, 17:33:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:33:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:33:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:33:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:33:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:33:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:33:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:33:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['damp', 'tps']}, 17:33:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:33:21 INFO - 'tests': ['damp', 'tps']}, 17:33:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['dromaeo_dom']}, 17:33:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:33:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['basic_compositor_video']}, 17:33:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:33:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tsvgx', 17:33:21 INFO - 'tsvgr_opacity', 17:33:21 INFO - 'tart', 17:33:21 INFO - 'tscrollx', 17:33:21 INFO - 'cart', 17:33:21 INFO - 'tsvg_static']}, 17:33:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:33:21 INFO - 'tsvgr_opacity', 17:33:21 INFO - 'tart', 17:33:21 INFO - 'tscrollx', 17:33:21 INFO - 'cart', 17:33:21 INFO - 'tsvg_static']}, 17:33:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tp5o']}, 17:33:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:33:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s', 17:33:21 INFO - '--xperf_path', 17:33:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:21 INFO - 'tests': ['tp5n']}, 17:33:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:33:21 INFO - 'talos_options': ['--xperf_path', 17:33:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:21 INFO - 'tests': ['tp5n']}}, 17:33:21 INFO - 'talos.zip': {'path': '', 17:33:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:33:21 INFO - Running post-action listener: _resource_record_post_action 17:33:21 INFO - [mozharness: 2017-03-07 01:33:21.832334Z] Finished populate-webroot step (success) 17:33:21 INFO - [mozharness: 2017-03-07 01:33:21.832481Z] Running create-virtualenv step. 17:33:21 INFO - Running pre-action listener: _resource_record_pre_action 17:33:21 INFO - Running main action method: create_virtualenv 17:33:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:33:21 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 17:33:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:33:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:33:21 INFO - Using real prefix '/tools/python27' 17:33:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:33:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:33:25 INFO - Installing pip.................done. 17:33:25 INFO - Return code: 0 17:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:33:25 INFO - Reading from file tmpfile_stdout 17:33:25 INFO - Output received: 17:33:25 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) 17:33:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:25 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 17:33:25 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 17:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:25 INFO - 'HOME': '/Users/cltbld', 17:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:25 INFO - 'LOGNAME': 'cltbld', 17:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:25 INFO - 'MOZ_NO_REMOTE': '1', 17:33:25 INFO - 'NO_EM_RESTART': '1', 17:33:25 INFO - 'PAGER': '/bin/cat', 17:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:25 INFO - 'PWD': '/builds/slave/test', 17:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:25 INFO - 'SHELL': '/bin/bash', 17:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:25 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:25 INFO - 'USER': 'cltbld', 17:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:25 INFO - 'XPC_FLAGS': '0x0', 17:33:25 INFO - 'XPC_SERVICE_NAME': '0', 17:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:26 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 17:33:26 INFO - Cleaning up... 17:33:26 INFO - Return code: 0 17:33:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:33:26 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')]} 17:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:26 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')]} 17:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:26 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:26 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 17:33:26 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 17:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:26 INFO - 'HOME': '/Users/cltbld', 17:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:26 INFO - 'LOGNAME': 'cltbld', 17:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:26 INFO - 'MOZ_NO_REMOTE': '1', 17:33:26 INFO - 'NO_EM_RESTART': '1', 17:33:26 INFO - 'PAGER': '/bin/cat', 17:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:26 INFO - 'PWD': '/builds/slave/test', 17:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:26 INFO - 'SHELL': '/bin/bash', 17:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:26 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:26 INFO - 'USER': 'cltbld', 17:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:26 INFO - 'XPC_FLAGS': '0x0', 17:33:26 INFO - 'XPC_SERVICE_NAME': '0', 17:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:26 INFO - Downloading/unpacking psutil>=3.1.1 17:33:26 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 17:33:26 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 17:33:26 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 17:33:26 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 17:33:26 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 17:33:26 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 17:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:33:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:33:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:33:29 INFO - Installing collected packages: psutil 17:33:29 INFO - Running setup.py install for psutil 17:33:29 INFO - building 'psutil._psutil_osx' extension 17:33:29 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 17:33:30 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 17:33:30 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 17:33:30 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 17:33:30 INFO - building 'psutil._psutil_posix' extension 17:33:30 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 17:33:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:33:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:33:30 INFO - ^ 17:33:30 INFO - 1 warning generated. 17:33:30 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 17:33:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:33:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:33:30 INFO - Successfully installed psutil 17:33:30 INFO - Cleaning up... 17:33:31 INFO - Return code: 0 17:33:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:31 INFO - 'HOME': '/Users/cltbld', 17:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:31 INFO - 'LOGNAME': 'cltbld', 17:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:31 INFO - 'MOZ_NO_REMOTE': '1', 17:33:31 INFO - 'NO_EM_RESTART': '1', 17:33:31 INFO - 'PAGER': '/bin/cat', 17:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:31 INFO - 'PWD': '/builds/slave/test', 17:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:31 INFO - 'SHELL': '/bin/bash', 17:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:31 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:31 INFO - 'USER': 'cltbld', 17:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:31 INFO - 'XPC_FLAGS': '0x0', 17:33:31 INFO - 'XPC_SERVICE_NAME': '0', 17:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:33:33 INFO - Installing collected packages: mozsystemmonitor 17:33:33 INFO - Running setup.py install for mozsystemmonitor 17:33:34 INFO - Successfully installed mozsystemmonitor 17:33:34 INFO - Cleaning up... 17:33:34 INFO - Return code: 0 17:33:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:34 INFO - 'HOME': '/Users/cltbld', 17:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:34 INFO - 'LOGNAME': 'cltbld', 17:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:34 INFO - 'MOZ_NO_REMOTE': '1', 17:33:34 INFO - 'NO_EM_RESTART': '1', 17:33:34 INFO - 'PAGER': '/bin/cat', 17:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:34 INFO - 'PWD': '/builds/slave/test', 17:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:34 INFO - 'SHELL': '/bin/bash', 17:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:34 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:34 INFO - 'USER': 'cltbld', 17:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:34 INFO - 'XPC_FLAGS': '0x0', 17:33:34 INFO - 'XPC_SERVICE_NAME': '0', 17:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:34 INFO - Downloading/unpacking jsonschema==2.5.1 17:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:33:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:33:37 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 17:33:37 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 17:33:37 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 17:33:37 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 17:33:37 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 17:33:37 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 17:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 17:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:33:37 INFO - warning: no files found matching '*.txt' 17:33:37 INFO - no previously-included directories found matching 'build' 17:33:37 INFO - no previously-included directories found matching 'dist' 17:33:37 INFO - no previously-included directories found matching '.git*' 17:33:37 INFO - Installing collected packages: jsonschema, functools32 17:33:37 INFO - Running setup.py install for functools32 17:33:37 INFO - warning: no files found matching '*.txt' 17:33:37 INFO - no previously-included directories found matching 'build' 17:33:37 INFO - no previously-included directories found matching 'dist' 17:33:37 INFO - no previously-included directories found matching '.git*' 17:33:37 INFO - Successfully installed jsonschema functools32 17:33:37 INFO - Cleaning up... 17:33:37 INFO - Return code: 0 17:33:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:33:37 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')]} 17:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:37 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')]} 17:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:37 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:37 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 17:33:37 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 17:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:37 INFO - 'HOME': '/Users/cltbld', 17:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:37 INFO - 'LOGNAME': 'cltbld', 17:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:37 INFO - 'MOZ_NO_REMOTE': '1', 17:33:37 INFO - 'NO_EM_RESTART': '1', 17:33:37 INFO - 'PAGER': '/bin/cat', 17:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:37 INFO - 'PWD': '/builds/slave/test', 17:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:37 INFO - 'SHELL': '/bin/bash', 17:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:37 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:37 INFO - 'USER': 'cltbld', 17:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:37 INFO - 'XPC_FLAGS': '0x0', 17:33:37 INFO - 'XPC_SERVICE_NAME': '0', 17:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:33:38 INFO - Cleaning up... 17:33:38 INFO - Return code: 0 17:33:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:38 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:38 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 17:33:38 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 17:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:38 INFO - 'HOME': '/Users/cltbld', 17:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:38 INFO - 'LOGNAME': 'cltbld', 17:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:38 INFO - 'MOZ_NO_REMOTE': '1', 17:33:38 INFO - 'NO_EM_RESTART': '1', 17:33:38 INFO - 'PAGER': '/bin/cat', 17:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:38 INFO - 'PWD': '/builds/slave/test', 17:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:38 INFO - 'SHELL': '/bin/bash', 17:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:38 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:38 INFO - 'USER': 'cltbld', 17:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:38 INFO - 'XPC_FLAGS': '0x0', 17:33:38 INFO - 'XPC_SERVICE_NAME': '0', 17:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:38 INFO - Downloading/unpacking blobuploader==1.2.4 17:33:38 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 17:33:38 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 17:33:38 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 17:33:38 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 17:33:38 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 17:33:38 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 17:33:40 INFO - Downloading blobuploader-1.2.4.tar.gz 17:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:33:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:33:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:33:41 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 17:33:41 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 17:33:41 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 17:33:41 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 17:33:41 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 17:33:41 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 17:33:42 INFO - Downloading docopt-0.6.1.tar.gz 17:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:33:42 INFO - Installing collected packages: blobuploader, requests, docopt 17:33:42 INFO - Running setup.py install for blobuploader 17:33:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:33:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:33:42 INFO - Running setup.py install for requests 17:33:42 INFO - Running setup.py install for docopt 17:33:43 INFO - Successfully installed blobuploader requests docopt 17:33:43 INFO - Cleaning up... 17:33:43 INFO - Return code: 0 17:33:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:43 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:43 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 17:33:43 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 17:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:43 INFO - 'HOME': '/Users/cltbld', 17:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:43 INFO - 'LOGNAME': 'cltbld', 17:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:43 INFO - 'MOZ_NO_REMOTE': '1', 17:33:43 INFO - 'NO_EM_RESTART': '1', 17:33:43 INFO - 'PAGER': '/bin/cat', 17:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:43 INFO - 'PWD': '/builds/slave/test', 17:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:43 INFO - 'SHELL': '/bin/bash', 17:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:43 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:43 INFO - 'USER': 'cltbld', 17:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:43 INFO - 'XPC_FLAGS': '0x0', 17:33:43 INFO - 'XPC_SERVICE_NAME': '0', 17:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:43 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-s7gtBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:43 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-7_NfUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:43 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-rvPdtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:43 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-8sQIfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:43 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-d7nQ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:43 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-Pt20Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-2j7crB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-hhUeyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-SA6VA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-_eLjFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-MHWOoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-CECxmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-RzXemH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-q6pqGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-qGCsZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:44 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-IppTnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:45 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-4PVkAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:33:45 INFO - Running setup.py install for manifestparser 17:33:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Running setup.py install for mozcrash 17:33:45 INFO - Running setup.py install for mozdebug 17:33:45 INFO - Running setup.py install for mozdevice 17:33:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Running setup.py install for mozfile 17:33:45 INFO - Running setup.py install for mozhttpd 17:33:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Running setup.py install for mozinfo 17:33:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Running setup.py install for mozInstall 17:33:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Running setup.py install for mozleak 17:33:46 INFO - Running setup.py install for mozlog 17:33:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Running setup.py install for moznetwork 17:33:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Running setup.py install for mozprocess 17:33:46 INFO - Running setup.py install for mozprofile 17:33:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:33:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:33:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:33:47 INFO - Running setup.py install for mozrunner 17:33:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:33:47 INFO - Running setup.py install for mozscreenshot 17:33:47 INFO - Running setup.py install for moztest 17:33:47 INFO - Running setup.py install for mozversion 17:33:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:33:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:33:47 INFO - Cleaning up... 17:33:47 INFO - Return code: 0 17:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:47 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:47 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 17:33:47 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 17:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:47 INFO - 'HOME': '/Users/cltbld', 17:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:47 INFO - 'LOGNAME': 'cltbld', 17:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:47 INFO - 'MOZ_NO_REMOTE': '1', 17:33:47 INFO - 'NO_EM_RESTART': '1', 17:33:47 INFO - 'PAGER': '/bin/cat', 17:33:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:47 INFO - 'PWD': '/builds/slave/test', 17:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:47 INFO - 'SHELL': '/bin/bash', 17:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:47 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:47 INFO - 'USER': 'cltbld', 17:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:47 INFO - 'XPC_FLAGS': '0x0', 17:33:47 INFO - 'XPC_SERVICE_NAME': '0', 17:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-wz66or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-ptrG6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-zw5HY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-37SNu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-icwloE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-wZKQUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-7_Cqaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-ufMPEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:48 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-9TP9_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-qms5Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:49 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)) 17:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-FV6UAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:49 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)) 17:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-jGNEkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-_AXcmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:49 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)) 17:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-Fj0nTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:49 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)) 17:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-ajFu05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:49 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)) 17:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-MQxFGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:49 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)) 17:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:49 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-DAV8A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:33:49 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 17:33:49 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 17:33:49 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 17:33:49 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 17:33:49 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 17:33:49 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 17:33:52 INFO - Downloading blessings-1.6.tar.gz 17:33:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:33:52 INFO - Installing collected packages: blessings 17:33:52 INFO - Running setup.py install for blessings 17:33:52 INFO - Successfully installed blessings 17:33:52 INFO - Cleaning up... 17:33:52 INFO - Return code: 0 17:33:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:53 INFO - Reading from file tmpfile_stdout 17:33:53 INFO - Current package versions: 17:33:53 INFO - blessings == 1.6 17:33:53 INFO - blobuploader == 1.2.4 17:33:53 INFO - docopt == 0.6.1 17:33:53 INFO - functools32 == 3.2.3-2 17:33:53 INFO - jsonschema == 2.5.1 17:33:53 INFO - manifestparser == 1.1 17:33:53 INFO - mozInstall == 1.12 17:33:53 INFO - mozcrash == 1.0 17:33:53 INFO - mozdebug == 0.1 17:33:53 INFO - mozdevice == 0.49 17:33:53 INFO - mozfile == 1.2 17:33:53 INFO - mozhttpd == 0.7 17:33:53 INFO - mozinfo == 0.9 17:33:53 INFO - mozleak == 0.1 17:33:53 INFO - mozlog == 3.4 17:33:53 INFO - moznetwork == 0.27 17:33:53 INFO - mozprocess == 0.24 17:33:53 INFO - mozprofile == 0.28 17:33:53 INFO - mozrunner == 6.13 17:33:53 INFO - mozscreenshot == 0.1 17:33:53 INFO - mozsystemmonitor == 0.3 17:33:53 INFO - moztest == 0.8 17:33:53 INFO - mozversion == 1.4 17:33:53 INFO - psutil == 3.1.1 17:33:53 INFO - requests == 1.2.3 17:33:53 INFO - wsgiref == 0.1.2 17:33:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:54 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:54 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 17:33:54 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 17:33:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:54 INFO - 'HOME': '/Users/cltbld', 17:33:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:54 INFO - 'LOGNAME': 'cltbld', 17:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:54 INFO - 'MOZ_NO_REMOTE': '1', 17:33:54 INFO - 'NO_EM_RESTART': '1', 17:33:54 INFO - 'PAGER': '/bin/cat', 17:33:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:54 INFO - 'PWD': '/builds/slave/test', 17:33:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:54 INFO - 'SHELL': '/bin/bash', 17:33:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:54 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:54 INFO - 'USER': 'cltbld', 17:33:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:54 INFO - 'XPC_FLAGS': '0x0', 17:33:54 INFO - 'XPC_SERVICE_NAME': '0', 17:33:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 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)) 17:33:54 INFO - Cleaning up... 17:33:54 INFO - Return code: 0 17:33:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:33:54 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')]} 17:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:54 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')]} 17:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:54 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 0x10537db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105380768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ab56f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, '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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 17:33:54 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 17:33:54 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 17:33:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:33:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:54 INFO - 'HOME': '/Users/cltbld', 17:33:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:54 INFO - 'LOGNAME': 'cltbld', 17:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:54 INFO - 'MOZ_NO_REMOTE': '1', 17:33:54 INFO - 'NO_EM_RESTART': '1', 17:33:54 INFO - 'PAGER': '/bin/cat', 17:33:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:54 INFO - 'PWD': '/builds/slave/test', 17:33:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:54 INFO - 'SHELL': '/bin/bash', 17:33:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:33:54 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:33:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:54 INFO - 'USER': 'cltbld', 17:33:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:54 INFO - 'XPC_FLAGS': '0x0', 17:33:54 INFO - 'XPC_SERVICE_NAME': '0', 17:33:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:33:55 INFO - Cleaning up... 17:33:55 INFO - Return code: 0 17:33:55 INFO - Running post-action listener: _resource_record_post_action 17:33:55 INFO - Running post-action listener: _start_resource_monitoring 17:33:55 INFO - Starting resource monitoring. 17:33:55 INFO - [mozharness: 2017-03-07 01:33:55.267328Z] Finished create-virtualenv step (success) 17:33:55 INFO - [mozharness: 2017-03-07 01:33:55.268296Z] Running install step. 17:33:55 INFO - Running pre-action listener: _resource_record_pre_action 17:33:55 INFO - Running main action method: install 17:33:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:55 INFO - Reading from file tmpfile_stdout 17:33:55 INFO - Detecting whether we're running mozinstall >=1.0... 17:33:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:33:55 INFO - Reading from file tmpfile_stdout 17:33:55 INFO - Output received: 17:33:55 INFO - Usage: mozinstall [options] installer 17:33:55 INFO - Options: 17:33:55 INFO - -h, --help show this help message and exit 17:33:55 INFO - -d DEST, --destination=DEST 17:33:55 INFO - Directory to install application into. [default: 17:33:55 INFO - "/builds/slave/test"] 17:33:55 INFO - --app=APP Application being installed. [default: firefox] 17:33:55 INFO - mkdir: /builds/slave/test/build/application 17:33:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:34:10 INFO - Reading from file tmpfile_stdout 17:34:10 INFO - Output received: 17:34:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:34:10 INFO - Running post-action listener: _resource_record_post_action 17:34:10 INFO - [mozharness: 2017-03-07 01:34:10.270378Z] Finished install step (success) 17:34:10 INFO - [mozharness: 2017-03-07 01:34:10.270506Z] Running run-tests step. 17:34:10 INFO - Running pre-action listener: _resource_record_pre_action 17:34:10 INFO - Running main action method: run_tests 17:34:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:34:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:34:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:34:10 INFO - 2017-03-06 17:34:10.284 screenresolution[1632:7319] starting screenresolution argv=screenresolution get 17:34:10 INFO - 2017-03-06 17:34:10.286 screenresolution[1632:7319] Display 0: 1600x1200x32@60 17:34:10 INFO - 2017-03-06 17:34:10.292 screenresolution[1633:7322] starting screenresolution argv=screenresolution list 17:34:10 INFO - Available Modes on Display 0 17:34:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:34:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:34:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:34:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:34:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:34:10 INFO - Intel Iris: 17:34:10 INFO - Chipset Model: Intel Iris 17:34:10 INFO - Type: GPU 17:34:10 INFO - Bus: Built-In 17:34:10 INFO - VRAM (Dynamic, Max): 1536 MB 17:34:10 INFO - Vendor: Intel (0x8086) 17:34:10 INFO - Device ID: 0x0a2e 17:34:10 INFO - Revision ID: 0x0009 17:34:10 INFO - Displays: 17:34:10 INFO - Display: 17:34:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:34:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:34:10 INFO - Display Serial Number: 1600x1200 60 17:34:10 INFO - Main Display: Yes 17:34:10 INFO - Mirror: Off 17:34:10 INFO - Online: Yes 17:34:10 INFO - Rotation: Supported 17:34:10 INFO - Return code: 0 17:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:34:10 INFO - Python 2.7.3 17:34:10 INFO - Return code: 0 17:34:10 INFO - grabbing minidump binary from tooltool 17:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515bd30>, '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 0x105082db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105150be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:34:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:34:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:34:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:34:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:34:10 INFO - Return code: 0 17:34:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:34:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:34:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:34:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:34:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 17:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0324 --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 17:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ses19qwFQ6/Render', 17:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:10 INFO - 'HOME': '/Users/cltbld', 17:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:10 INFO - 'LOGNAME': 'cltbld', 17:34:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:34:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:10 INFO - 'MOZ_NO_REMOTE': '1', 17:34:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:34:10 INFO - 'NO_EM_RESTART': '1', 17:34:10 INFO - 'PAGER': '/bin/cat', 17:34:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:10 INFO - 'PWD': '/builds/slave/test', 17:34:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:10 INFO - 'SHELL': '/bin/bash', 17:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eo6GsFQRCT/Listeners', 17:34:10 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 17:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:10 INFO - 'USER': 'cltbld', 17:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:10 INFO - 'XPC_FLAGS': '0x0', 17:34:10 INFO - 'XPC_SERVICE_NAME': '0', 17:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 17:34:10 INFO - mozversion application_buildid: 20170306160126 17:34:10 INFO - mozversion application_changeset: 150eacc885c23d1845280917cda4e6a652f8a7b6 17:34:10 INFO - mozversion application_display_name: Firefox 17:34:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:34:10 INFO - mozversion application_name: Firefox 17:34:10 INFO - mozversion application_remotingname: firefox 17:34:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:34:10 INFO - mozversion application_vendor: Mozilla 17:34:10 INFO - mozversion application_version: 53.0 17:34:10 INFO - mozversion platform_buildid: 20170306160126 17:34:10 INFO - mozversion platform_changeset: 150eacc885c23d1845280917cda4e6a652f8a7b6 17:34:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:34:10 INFO - mozversion platform_version: 53.0 17:34:10 INFO - using testdate: 1488850450 17:34:10 INFO - actual date: 1488850450 17:34:10 INFO - starting webserver on 'localhost:49238' 17:34:10 INFO - SUITE-START | Running 2 tests 17:34:10 INFO - TEST-START | dromaeo_css 17:34:10 INFO - operating with platform_type : mac_ 17:34:10 INFO - Initialising browser for dromaeo_css test... 17:34:10 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpUZtiHj/profile http://localhost:49238/getInfo.html) 17:34:13 INFO - PROCESS | 1643 | 2017-03-06 17:34:13.734 plugin-container[1646:7493] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 17:34:13 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:13 INFO - PROCESS | 1643 | 2017-03-06 17:34:13.735 plugin-container[1646:7493] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 17:34:13 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:13 INFO - PROCESS | 1643 | 2017-03-06 17:34:13.735 plugin-container[1646:7493] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:34:13 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 17:34:13 INFO - PROCESS | 1643 | colorDepth:24 17:34:13 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 17:34:13 INFO - PROCESS | 1643 | __metrics 17:34:13 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 17:34:14 INFO - TEST-INFO | 1643: exit 0 17:34:14 INFO - Browser initialized. 17:34:14 INFO - Running cycle 1/1 for dromaeo_css test... 17:34:14 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpUZtiHj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:17 INFO - PROCESS | 1647 | 2017-03-06 17:34:17.071 plugin-container[1648:7617] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 17:34:17 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:17 INFO - PROCESS | 1647 | 2017-03-06 17:34:17.071 plugin-container[1648:7617] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x420f, name = 'com.apple.CFPasteboardClient' 17:34:17 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:17 INFO - PROCESS | 1647 | 2017-03-06 17:34:17.071 plugin-container[1648:7617] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:34:26 INFO - PROCESS | 1647 | RSS: Main: 172363776 17:34:26 INFO - PROCESS | 1647 | 17:37:28 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 17:37:30 INFO - PROCESS | 1647 | RSS: Main: 192827392 17:37:30 INFO - PROCESS | 1647 | 17:40:33 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 17:40:33 INFO - PROCESS | 1647 | RSS: Main: 201125888 17:40:33 INFO - PROCESS | 1647 | 17:43:35 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 17:43:36 INFO - PROCESS | 1647 | RSS: Main: 205443072 17:43:36 INFO - PROCESS | 1647 | 17:46:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 17:46:38 INFO - PROCESS | 1647 | RSS: Main: 210358272 17:46:38 INFO - PROCESS | 1647 | 17:49:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 17:49:42 INFO - PROCESS | 1647 | RSS: Main: 211546112 17:49:42 INFO - PROCESS | 1647 | 17:52:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 17:52:45 INFO - PROCESS | 1647 | RSS: Main: 211685376 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | __start_tp_report 17:52:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 17:52:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 17:52:45 INFO - PROCESS | 1647 | |i|pagename|runs| 17:52:45 INFO - PROCESS | 1647 | |0;dojo.html;3492.5983511896134;3504.772189807664;3513.7891726496414;3517.8742802303273;3542.8051457169845;6015.3082395524525;6037.215162028936;6053.57624966252;6059.212302400692;6062.575619706611;4996;5976.701164941757;6006.4293892080295;6105.755769769204;6111.969440152793;5188.325517682696;5356.892862142755;5449.182622606601;5472.20653005314;5509.917351239735;4558.475775285851;5497.752601132958;5512.641678290898;5520.282363292767;5532.7786888524415;4250.426192464024;4771.9761401192945;5364.195370694408;5365.409804921455;5514.5864060195645;5376.435474275204;5391.514763671269;5456.317960254968;5462.235287059815;5538.113901775697;5298.417174110845;5425.6202065855405;5429.239906413105;5435.646682965634;5454.754536045887;5825;5988.550858685616;6061.212042434499;6098.664573448458;6129.877402451971;5241.3710354757295;6257.217847769029;6269.310375858652;6285.748570057192;6354.142190804228;6393.041043843415;6406.583572067801;6438;6441.25925518562;6482.41658250755;6167.167432396659;6178.62928224308;6192.504599632019;6198.845028874314;6260.029695397221;6313.905291420632;6334.9366506334345;6493.610383377012;6508.837279068061;6529.771457998947;6248.781292654735;6312.274088479791;6314.494840412756;6337.714802833883;6367.713452894538;6422.42198202164;6479.254885688112;6479.287278399373;6479.773207937699;6484.351564843478;6272.498200143978;6276.46650034743;6276.748930042839;6291.433770960635;6318.905216421757;6342.809715708536;6346.873062538723;6357.4914006879335;6373.490120790326;6378.138951241615;5182.766775495112;5201.765920533585;5214.191800270964;5223.764930578133;5249.396319423239;4527.47933987589;4570.977145114253;4597.931031034537;4640.419947506562;4695.460022097434;6028.336882942873;6128.724207410677;6130.612163469634;6132;6132.570720049643;5360.758765855546;6404.48764098871;6419.646919419477;6437.2918978912285;6458.095866578683;5947.226860508106;5977.67122808241;6026.6986650667295;6033.396660333931;6054.485368743706;5668.234788303609;5673.205751194836;5675.801346952837;5683.715814209356;5726.398728133569;6484.837879053061;6490.091387205795;6500.122483464766;6512.381323774234;6518.869622607616;6207.596506227081;6263.592866463665;6315.115883776183;6346.9682651586445;6418.775342862978;6509.218893732783;6535.738570457129;6536.444402225674;6537.5096867734155;6548;6374.235091789015;6377.585456945284;6382.234131904202;6383.904241436475;6387.371220338784;6236.844078898064;6251.281102673251;6292.182016337847;6321.146645202839;6432.163818703539;4939.6542242042715;6092.45167934888;6256.343083976117;6314.368563143649;6322.589031712924;6036.577439579188;6282.811515654537;6289.559730818799;6292.433680968735;6305.148804911279;4731.337612734289;5653.689047102449;6150.231221097363;6194.039923811816;6257.030160325156;6200.844978875564;6212.099245609452;6215.285242197205;6315.96842015787;6328.525360597881;6299.937000629935;6305.243370795534;6311.084892690443;6315.210598675166;6328 17:52:45 INFO - PROCESS | 1647 | |1;ext.html;488.8802243450353;532.5712801195037;533.7197971065187;547.2092825866622;576.9278840144982;38943.2211355773;41641.58358416415;41754.791226043904;41822.37266441002;41855.790721046425;42831.571684283146;43407.56592434075;43423.56576434235;43451.34822977658;43559.3466098008;9489.240860731124;9715.659951901685;9757.707268781913;11428.657140285804;11813.409329533531;11800.350980696057;11852.940735296312;11875.228110172811;11884.227525210834;11928.821067683992;11785.587504437346;11790.115741319436;11812.232204906697;11847.526098956032;11862.822057669142;11772.646820595353;11803.763924721501;11853.111016673784;11857.5849845255;11905.107116966263;11597.652070437816;11696.122790790725;11696.707582310426;11718.472668729928;11759.05927525796;38149.427758583646;38296;38377.848664540106;38459.23081538382;38576.61423385758;4062.6343629073526;4086.8773936781945;4098.856540021115;4208.305629571117;4242.830286788525;27940.161795146178;28618.71215795294;28794.71205287941;28799;30770.38459230825;3231.4021905947475;3413.0784688134063;3445.9655403445895;3474.652534746505;3484.407650699362;473693;475038;480440;482156;482958.9999999965;46936.765316173885;58765.41234587685;58996.82006359849;59253;59285;60572.39427605756;60943.08585371223;61020.38979610236;61066.38933610607;61143.77712445815;16336.183190840411;16415.589610259838;16549.172541372882;16602.667946641;16604.916975415046;12031.518739250332;12311.50753969849;13780.035397522277;13932.512362067278;13986.790198147037;21975.780242197692;22724.88637556835;22744.86275686242;22754;22819.74491402989;7677.005967672612;9043.59303831329;9298.767530811783;9343.859842102374;9382.953085234667;902.8916530016309;919.6643225222879;922.9769255768659;945.8723072385139;961.8893827209821;30196.396072078434;31248.843755781076;31302.373952520822;31542.526862097086;32032.199195020312;959.8608201810698;1021.7241344836852;1099.7470581766238;1123.6685177872548;1160.9941950290195;15545.844541554667;16098.873078884366;16388.836111638968;16697.91651041737;16767.077810720282;695803;706261;710222;714670;715208;63134.36865631285;63280.36719632837;63648;63930;64055.35944640587;1484.1095342794454;1510.5166346768929;1516.8460785684354;1528;1532.4559781277708;30319.393612127195;31080.22299442532;31146.065618031495;31645.525317119802;31661.683383165873;53657.92684146217;54549.90900182053;54619;58047.709761450926;58092.70953645205;635691.6430835817;638592;639809.8009509923;641017;642792;29086;36261.63738362688;39305;41790.373144403464;42051.73844784661;36437;44182.55817441784;44320.335194972744;45070.77464612787;45707;36437.63562364342;36820.81589592035;37298.627013729514;38191.427128592535;38543.42184867173;36743.448848266766;36956.260874781816;37799.81100094482;38139.61860381471;38184.42723359096;36105.0973725659;36312.63687363092;36665.71669991538;36779;36926.89219323425;31535.52696709597;33469.49795753017;33557.664423355454;33608.83195584006;33675.494867577494;24209.63685544683;24521.01915923343;24619.50760984806;25134.622980654938;25350.746492535578 17:52:45 INFO - PROCESS | 1647 | |2;jquery.html;364.6809042088174;406.8860718998681;413.83239787885907;418.12820269737597;435.6166573415396;20714.792852071474;21345.93270336483;21525.892370538124;21963.670544941837;22190.667139992915;22088.779112208875;22230.666540001872;22524.774752252473;22774.65838012431;23156.88421557894;5980.372060933593;6178.227721534809;6249.625022498664;6252.624842509441;6252.718627661743;5930.970345148268;6060.969695151518;6091.208142941411;6091.847703807396;6113.877722445548;6067.423594758491;6070.392960703938;6070.6357618543025;6075.362086980869;6092.939070609282;5870.530357571405;6031.788887388964;6076.696165191723;6122.571420000601;6139.785107521216;5276.366835979707;5308.575313974873;5347.732613369355;5393.78424863005;5399.919001214985;26329.3417664558;26444.603330950053;26523;26648.60027099595;26868.05961791328;2816.169230077132;2843.1186332236866;2848.1740295314335;2851.17315978366;2863.9713602863912;15431.614209644737;15988.920055399765;16026.278817453243;16138;16648.66702665952;1856.916438760259;1860.4418674397627;1900.1924182222501;1909.1599696133658;1928.151613290148;119926;123808.38095809553;128116.07825882712;129790.70209297881;131287;11650.766984660258;11682.649520514398;11824.76350473003;11847.407629618658;12007.699807504881;15055.54833355001;15072.246387680572;15110.320035598425;15121.16833574164;15135.091894486366;7309.342159205697;8936.46381217129;9111.997680255166;9132.452052876848;9157.542122893828;7413.629318534052;8999.460032398078;9045.914490261079;9210.631574736935;9232.630694772133;6550.639714815636;7276.090488688914;7350.154732205758;7481.401487880957;7513.661885215179;1994.461495396264;2010.638085144688;2014.7078673592248;2016.8386529077638;2018.5458271889001;821.9917800821916;931.1991687149047;937.2455173585194;968.9854652180223;970.6748239339901;22066.44833879166;22747.431314217276;23313.650295245585;23320.7667923322;23453.944572494278;960.6877764726491;965.6813251626946;982.513655740413;988.7577543501889;992.211192102266;9967.750806229902;10131.493425328705;12289.324087175291;12316.753664926651;12374.690632734253;713270;764423;765442;769522;778081;123595;129715.35142324227;133444;143758;170361;1072.2494254022215;1100.8954149355798;1123.0902968595465;1126.4424110065406;1128.5260190719753;18652.69431139807;18679.719804202676;20724.58550828945;20821.79178208259;20886.58226835485;60626.69686651538;61241.468963276275;61692.69153654203;61834.69082654558;62109.378906212165;68361;85578.14421855702;88497.55751221202;89043;89993.10006899846;8546.743597692079;8611.8708219378;8613.526256055726;8806.383553151474;8892;12455.252684838577;12596.181248218836;13211.405486753312;13508.864911351155;13552;10318.948405258227;10959.01368876805;11138.832917506406;11641.359725214856;11647.807602823557;11428.428578570873;11588.94205528967;11599.188056836278;11754.588589399329;11961.940190298992;10253.58985640566;11656.88343116558;11755;12077.939610301892;12162.817557736818;8422.831543368975;8514.978202615726;8641.308695304235;8651.91348086511;8681.2186903179;9426;9919.305648604817;9999.050090241415;10171.440570768678;10205.336653117523 17:52:45 INFO - PROCESS | 1647 | |3;mootools.html;1464.5459907428697;1488.8585584369494;1506.9924650376747;1519.8936074474784;1528.3733669195633;7816.570088645122;8057.637406316715;8341.499510029395;8700.912990870089;8793.34049946255;8224.547649879269;8542.060373358941;8578.099299573549;8615.655373785057;8618.956905215466;2363.881805909706;2409.325388891113;2409.7590240975937;2411.2766170148975;2416.069813121952;2422.34596658902;2435.8051355891484;2465.0879174705296;2465.272744540365;2468.4075821802817;2409.891554880026;2417.190241269177;2426.963595546068;2432.963505547418;2439.914602988887;2029.3911826452006;2397.412633904687;2403.098837935774;2403.6875206223253;2423.9636405453934;2379.940501487459;2388.4267775733874;2446.8287219894614;2452.9632055519182;2456.987715061431;8602.612882420306;8620.698275560388;8652.697155599524;8670.653173873037;8678.435901666371;4476.418065651477;4527.592516673515;5053.873653158664;5161.561267292284;5177.016366890279;3536.7621332533663;3588.3002814451193;3595.380215443785;3624.800635965021;3667.9816600916824;1283.7496688145816;1290.696686278733;1309.1098053323735;1328.5947785925289;1349.817774600436;9329.580168892417;11130.777384452347;11141.610043648514;11149.16381271408;11157.944210278896;3643.5972150722164;4619.376384188159;4822.903541929142;4866.294387313819;4911.582515486224;9653.613855445845;9784.706458806248;9796.971318011649;9808.411495310162;9823.115919567274;4598.609118224988;5402.810901618424;5412.296401467863;5430.592705547021;5434.510894019557;3679.2641471705765;4142.5857414258935;4467.218236808546;4863.513648635179;4874.390701162355;3994.840206391712;4044.8584299549375;4078.898027549335;4125.360569111793;4139.751614903115;1332.5336132353598;1338.772408690525;1340.4839136932155;1348.1776116568885;1351.4594162334947;763.9694412223449;810.440795850861;874.1695389380114;915.9221466175317;934.0426063285187;4579.771011449414;5030.471800460972;5671.631343962629;5699;5868.970655146697;574.8016934157793;577.4110407384444;592.318833341652;595.3629616310507;596.7255062671134;3827.2919509890758;3852.499175107218;3857.652811246945;3930.9213815724097;3945.940810887839;9645.276604254708;9968.252381071303;10084.899151008543;10087.899121008842;10133.240006999504;9917.074463033423;10088.596456141671;10090.596376144871;10092.192624590016;10106.343087699275;7952.403569732293;7967.56178410193;8047.839043219103;8051.919480805234;8065.516069035877;5528.9723551381985;5534.1145416733125;5714.257146570919;5755.482006619424;5798.927198468297;9105.954470227607;9402.95298523503;9435.009324021154;9450.669226577036;9451.432914025181;9142.954285228532;9417.529123543658;9465.100815422524;9474.099960503741;9488.051194880456;6799.864002719819;6983.860322793617;7194.424446044409;7339.8532029360185;7528.661210245662;8022.799430014296;8236.670533178845;8238.670453181805;8239.382046346429;8249.505029698237;7186.60473673932;7254.709811607477;7287.854242915006;7411.1477180124975;7419.851602967802;7139.750108746169;7145.535540189871;7158.570485770662;7296.7446139384865;7330.560166390033;5479.2602998594675;6454.290028097;6575.80272591823;6593.076969224217;6619;5034.407280250601;5053.69677819332;5126.487686132526;5255;5340.225667278145;4649.837540614846;5003.674761140514;5134.7175905324075;5184.948150518447;5222.3472065991755 17:52:45 INFO - PROCESS | 1647 | |4;prototype.html;301.820416851973;347.54818735643664;371.69892387166396;372.91667705316047;392.0062641204547;5335.946640533593;5482.095454250054;5526.3920968693465;5620.229627667287;5684.744186511602;5276.8153114641;5396.893636804455;5522.420145884685;5575.804846830361;5577.9163312550345;4339.414179085815;4340.460830414204;4358.8474403395885;4364.25807612705;4400.8019639116155;3615.566132064143;4143.357779544175;4319.114581510783;4355.8457008892665;4386.97806510967;4306.913861722764;4307.353896915472;4313.462960372496;4321.265384884561;4327.74033557986;4306.44016277885;4310.956890431103;4321.9135617287475;4355.281378572532;4361.389405483234;3456.879009234665;3492.550591504523;3862.2854771867296;3864.95646175531;3877.9030524236837;5078.654156648491;5416.593755468356;5434.75543600535;5451.454854514556;5473.343198816127;4037.576054514263;4834.129856625841;4855.830045948375;4856.805727770885;4872.8538143855385;4572.634189264851;5242.6330156889035;5955.464008239236;5991.214085450287;5993.640381577119;3939.546952100488;4015.678745700366;4027.436158937751;4031.5162180538523;4048.287647276332;5220.530152286275;6213.533984951102;6226.283977342573;6243.375662433766;6265.906011409833;3437.0237113659246;3553.875614353537;3669.3395188865725;4064.207479541461;4080.5511393746665;3186.7609929254936;3320.883769068071;4082.1019375737883;4104.548499665035;4113.835446582163;3853.61463853618;3974.4833171688074;4791.496892826272;4792.568668819753;4798.2802579612635;5274.736263186825;5433.7397561463595;5469.535089517435;5699.523290792613;6020.69896505173;1218.9085818563642;1265.9682358877485;1291.185883833216;1304.8434187897512;1332.160738734591;808.8150858991605;875.5072601214913;904.4076130134772;910.6721580231111;920.9447433154032;4936.3829521309835;5076.873078173001;5181.253935414236;5211.557017653542;5308.840734777963;5068.898622027613;5073.0606600669835;5912.989583541616;5925.429761113309;5930.347661757203;4751.717036400152;4924.8768780780765;5287.471252874759;5302.68183908959;5327.786888524493;2555.795536357087;2798.4263226038615;3024.485837407646;3033.9241518962203;3046.5277881928337;5032.874178145576;5270.7101109439345;5321.6540924839765;5569.637973531708;6014.503980847987;5446.319210098738;5564.443555644403;5628.807003156727;5654.663748388471;6026.6384016958245;5430.782768689208;5501.559875210054;5643.774249030075;5950.6676261293815;5951.137085122633;5170.71561064145;5189.96200759842;5198.610104242121;5201.505856943584;5381.408045114956;5052.494750525065;5158.97420512895;5737.90979713853;5753;5753.252077229933;4912.803487860446;5185.914380943333;5688.691600931892;5955.731992060454;5972;3310.222097807062;3316.9170770730925;3579.3736096182542;3691.630836916287;3731.8134093294684;5154.737089413118;5747.913781293368;5777.133429985536;5785.3636100028125;5819.82540523785;4926.679765815211;5722.62802917809;5745.971270143623;5849.5612829037145;5854.707264636836;4812.5187481253;5613;5853.882922341444;5872.677002764889;5920.881582368243;5547.8890422192135;5624.46567576096;5697.316322041382;5758.222639943554;5810.970945145247;5456.672599644034;5864.361037533042;5884.0585506318785;5925.52595792327;5944.910826337695;5264.1314183160885;5350.866228344167;5432.891342173055;5436;5988.700564971821 17:52:45 INFO - PROCESS | 1647 | |5;yui.html;684.6405637040556;701.1726163127514;771.2595907928387;786.1705900275209;799.0092285565896;15021.774673379909;15582.454614088509;15846.841531584681;16008.359665613376;16216.108114053723;11398;14619.561413157595;14936.925315373435;14957.252137393114;14966.476173333935;883.5847151838642;886.4681191285209;887.2369762004671;887.9378443508957;888.4003297774009;708.3766285668604;727.7743899391179;885.3006125161115;914.3279689428265;915.6703586708779;919.9908000920005;941.835178843703;952.6475204174466;953.6852838563258;954.6229239450413;917.6054296652437;921.9492927888963;949.8337790886602;951.9861347664715;955.8757361543024;691.8512519808265;702.4871843554234;708.9291070892921;713.3651050565002;718.4683334332608;15166;15417.614559636098;15424.305906234247;15879.444219452263;16142.596435089099;14366.640833979129;14699;15001.099934003885;15008.324625391884;15011.699766004618;11055.889441105646;11477.506257246225;11482.88517114835;11624.6512604622;11747.412629368582;3797.8480860765535;3878.612138786127;3879.069023434384;3921.960780392188;4050.4734384530116;98020.05939821817;103529.03893480172;105297.42053869122;106529;108820.45589772079;9344.439333639868;11171.608993685182;11289;11599.594014209462;11778.941105294418;23525.41186470352;23694.644580331307;23717;23815.880920595286;23842.046318147426;6837.384635382839;7844.568548729761;8188.385871059694;8285.544295063708;8390.119037501097;4431.091626216617;4460.30865215892;4466;4501.662375321798;4516.029053753393;3705.5923848376656;3778.112143646296;3781.3760729479877;3800.980995095062;3824.3689791184142;683.8803209438329;687.8658661561047;696.9268226836109;699.1016543741268;705.0728292295615;668.5019660352971;677.8983152527161;694.1808665774333;706.1773034414849;737.8634952533798;10211.846822297523;10595.364278143183;10632.521536530874;10672.199585030998;11010.944945275221;621.6114928169894;679.5175425447889;713.8857782754734;717.9317964793337;739.782131187371;4873.585745211697;5139.486051394831;5170.431252562215;5176.1459359206065;5194.6104042196985;83591;109594;110377;111992.44003779929;114027.42986285016;86278;90338;95039.04960950302;97457;98976.01023989668;80181.59909200533;81115.7832632511;87858;91756.54121729349;94032.52983735038;11068.723281918017;11235.943820280847;11517.366544840113;11567.479463423997;11578.131640127192;51358.716032099495;51475.485245148564;52441;53079;53389.73305133605;65567.67216163888;68465.63068738698;68653;68729.65635171792;69235.96146057914;11967.880321197024;14570.198639074528;14633.048851824597;14786.441285033256;14837.92581037088;14762.409503619734;15570.065796052273;15611.056209385073;15701.528954131394;15943.282552284943;13897.930510347383;14524.20116893581;14631.92684036573;14701;14764.63088422798;13828.654283642989;14304.141751494944;14497.275136242935;15007.399704011717;15022.173780442181;13454.93272533631;14490;14564;14680.778763892255;14706.117632942058;10995.450227488753;11231.338994317266;11324.6036388726;11352.148588855704;11666.824997624874;10168.644097456554;10742.10864721804;11359.375234362189;11410.201285910238;11493.195476316578 17:52:45 INFO - PROCESS | 1647 | __end_tp_report 17:52:45 INFO - PROCESS | 1647 | __start_cc_report 17:52:45 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,379 17:52:45 INFO - PROCESS | 1647 | __end_cc_report 17:52:45 INFO - PROCESS | 1647 | __startTimestamp1488851565223__endTimestamp 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | ------- Summary: start ------- 17:52:45 INFO - PROCESS | 1647 | Number of tests: 6 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5911.88 Median:6198.85 stddev:670.21 (10.8%) stddev-sans-first:644.83 17:52:45 INFO - PROCESS | 1647 | Values: 3492.6 3504.8 3513.8 3517.9 3542.8 6015.3 6037.2 6053.6 6059.2 6062.6 4996.0 5976.7 6006.4 6105.8 6112.0 5188.3 5356.9 5449.2 5472.2 5509.9 4558.5 5497.8 5512.6 5520.3 5532.8 4250.4 4772.0 5364.2 5365.4 5514.6 5376.4 5391.5 5456.3 5462.2 5538.1 5298.4 5425.6 5429.2 5435.6 5454.8 5825.0 5988.6 6061.2 6098.7 6129.9 5241.4 6257.2 6269.3 6285.7 6354.1 6393.0 6406.6 6438.0 6441.3 6482.4 6167.2 6178.6 6192.5 6198.8 6260.0 6313.9 6334.9 6493.6 6508.8 6529.8 6248.8 6312.3 6314.5 6337.7 6367.7 6422.4 6479.3 6479.3 6479.8 6484.4 6272.5 6276.5 6276.7 6291.4 6318.9 6342.8 6346.9 6357.5 6373.5 6378.1 5182.8 5201.8 5214.2 5223.8 5249.4 4527.5 4571.0 4597.9 4640.4 4695.5 6028.3 6128.7 6130.6 6132.0 6132.6 5360.8 6404.5 6419.6 6437.3 6458.1 5947.2 5977.7 6026.7 6033.4 6054.5 5668.2 5673.2 5675.8 5683.7 5726.4 6484.8 6490.1 6500.1 6512.4 6518.9 6207.6 6263.6 6315.1 6347.0 6418.8 6509.2 6535.7 6536.4 6537.5 6548.0 6374.2 6377.6 6382.2 6383.9 6387.4 6236.8 6251.3 6292.2 6321.1 6432.2 4939.7 6092.5 6256.3 6314.4 6322.6 6036.6 6282.8 6289.6 6292.4 6305.1 4731.3 5653.7 6150.2 6194.0 6257.0 6200.8 6212.1 6215.3 6316.0 6328.5 6299.9 6305.2 6311.1 6315.2 6328.0 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:74316.32 Median:36873.85 stddev:164997.82 (447.5%) stddev-sans-first:165367.57 17:52:45 INFO - PROCESS | 1647 | Values: 488.9 532.6 533.7 547.2 576.9 38943.2 41641.6 41754.8 41822.4 41855.8 42831.6 43407.6 43423.6 43451.3 43559.3 9489.2 9715.7 9757.7 11428.7 11813.4 11800.4 11852.9 11875.2 11884.2 11928.8 11785.6 11790.1 11812.2 11847.5 11862.8 11772.6 11803.8 11853.1 11857.6 11905.1 11597.7 11696.1 11696.7 11718.5 11759.1 38149.4 38296.0 38377.8 38459.2 38576.6 4062.6 4086.9 4098.9 4208.3 4242.8 27940.2 28618.7 28794.7 28799.0 30770.4 3231.4 3413.1 3446.0 3474.7 3484.4 473693.0 475038.0 480440.0 482156.0 482959.0 46936.8 58765.4 58996.8 59253.0 59285.0 60572.4 60943.1 61020.4 61066.4 61143.8 16336.2 16415.6 16549.2 16602.7 16604.9 12031.5 12311.5 13780.0 13932.5 13986.8 21975.8 22724.9 22744.9 22754.0 22819.7 7677.0 9043.6 9298.8 9343.9 9383.0 902.9 919.7 923.0 945.9 961.9 30196.4 31248.8 31302.4 31542.5 32032.2 959.9 1021.7 1099.7 1123.7 1161.0 15545.8 16098.9 16388.8 16697.9 16767.1 695803.0 706261.0 710222.0 714670.0 715208.0 63134.4 63280.4 63648.0 63930.0 64055.4 1484.1 1510.5 1516.8 1528.0 1532.5 30319.4 31080.2 31146.1 31645.5 31661.7 53657.9 54549.9 54619.0 58047.7 58092.7 635691.6 638592.0 639809.8 641017.0 642792.0 29086.0 36261.6 39305.0 41790.4 42051.7 36437.0 44182.6 44320.3 45070.8 45707.0 36437.6 36820.8 37298.6 38191.4 38543.4 36743.4 36956.3 37799.8 38139.6 38184.4 36105.1 36312.6 36665.7 36779.0 36926.9 31535.5 33469.5 33557.7 33608.8 33675.5 24209.6 24521.0 24619.5 25134.6 25350.7 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:41054.56 Median:14842.11 stddev:125752.73 (847.3%) stddev-sans-first:126068.38 17:52:45 INFO - PROCESS | 1647 | Values: 364.7 406.9 413.8 418.1 435.6 20714.8 21345.9 21525.9 21963.7 22190.7 22088.8 22230.7 22524.8 22774.7 23156.9 5980.4 6178.2 6249.6 6252.6 6252.7 5931.0 6061.0 6091.2 6091.8 6113.9 6067.4 6070.4 6070.6 6075.4 6092.9 5870.5 6031.8 6076.7 6122.6 6139.8 5276.4 5308.6 5347.7 5393.8 5399.9 26329.3 26444.6 26523.0 26648.6 26868.1 2816.2 2843.1 2848.2 2851.2 2864.0 15431.6 15988.9 16026.3 16138.0 16648.7 1856.9 1860.4 1900.2 1909.2 1928.2 119926.0 123808.4 128116.1 129790.7 131287.0 11650.8 11682.6 11824.8 11847.4 12007.7 15055.5 15072.2 15110.3 15121.2 15135.1 7309.3 8936.5 9112.0 9132.5 9157.5 7413.6 8999.5 9045.9 9210.6 9232.6 6550.6 7276.1 7350.2 7481.4 7513.7 1994.5 2010.6 2014.7 2016.8 2018.5 822.0 931.2 937.2 969.0 970.7 22066.4 22747.4 23313.7 23320.8 23453.9 960.7 965.7 982.5 988.8 992.2 9967.8 10131.5 12289.3 12316.8 12374.7 713270.0 764423.0 765442.0 769522.0 778081.0 123595.0 129715.4 133444.0 143758.0 170361.0 1072.2 1100.9 1123.1 1126.4 1128.5 18652.7 18679.7 20724.6 20821.8 20886.6 60626.7 61241.5 61692.7 61834.7 62109.4 68361.0 85578.1 88497.6 89043.0 89993.1 8546.7 8611.9 8613.5 8806.4 8892.0 12455.3 12596.2 13211.4 13508.9 13552.0 10318.9 10959.0 11138.8 11641.4 11647.8 11428.4 11588.9 11599.2 11754.6 11961.9 10253.6 11656.9 11755.0 12077.9 12162.8 8422.8 8515.0 8641.3 8651.9 8681.2 9426.0 9919.3 9999.1 10171.4 10205.3 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5518.71 Median:5203.65 stddev:3013.24 (57.9%) stddev-sans-first:3006.29 17:52:45 INFO - PROCESS | 1647 | Values: 1464.5 1488.9 1507.0 1519.9 1528.4 7816.6 8057.6 8341.5 8700.9 8793.3 8224.5 8542.1 8578.1 8615.7 8619.0 2363.9 2409.3 2409.8 2411.3 2416.1 2422.3 2435.8 2465.1 2465.3 2468.4 2409.9 2417.2 2427.0 2433.0 2439.9 2029.4 2397.4 2403.1 2403.7 2424.0 2379.9 2388.4 2446.8 2453.0 2457.0 8602.6 8620.7 8652.7 8670.7 8678.4 4476.4 4527.6 5053.9 5161.6 5177.0 3536.8 3588.3 3595.4 3624.8 3668.0 1283.7 1290.7 1309.1 1328.6 1349.8 9329.6 11130.8 11141.6 11149.2 11157.9 3643.6 4619.4 4822.9 4866.3 4911.6 9653.6 9784.7 9797.0 9808.4 9823.1 4598.6 5402.8 5412.3 5430.6 5434.5 3679.3 4142.6 4467.2 4863.5 4874.4 3994.8 4044.9 4078.9 4125.4 4139.8 1332.5 1338.8 1340.5 1348.2 1351.5 764.0 810.4 874.2 915.9 934.0 4579.8 5030.5 5671.6 5699.0 5869.0 574.8 577.4 592.3 595.4 596.7 3827.3 3852.5 3857.7 3930.9 3945.9 9645.3 9968.3 10084.9 10087.9 10133.2 9917.1 10088.6 10090.6 10092.2 10106.3 7952.4 7967.6 8047.8 8051.9 8065.5 5529.0 5534.1 5714.3 5755.5 5798.9 9106.0 9403.0 9435.0 9450.7 9451.4 9143.0 9417.5 9465.1 9474.1 9488.1 6799.9 6983.9 7194.4 7339.9 7528.7 8022.8 8236.7 8238.7 8239.4 8249.5 7186.6 7254.7 7287.9 7411.1 7419.9 7139.8 7145.5 7158.6 7296.7 7330.6 5479.3 6454.3 6575.8 6593.1 6619.0 5034.4 5053.7 5126.5 5255.0 5340.2 4649.8 5003.7 5134.7 5184.9 5222.3 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4634.04 Median:5206.53 stddev:1416.03 (27.2%) stddev-sans-first:1382.17 17:52:45 INFO - PROCESS | 1647 | Values: 301.8 347.5 371.7 372.9 392.0 5335.9 5482.1 5526.4 5620.2 5684.7 5276.8 5396.9 5522.4 5575.8 5577.9 4339.4 4340.5 4358.8 4364.3 4400.8 3615.6 4143.4 4319.1 4355.8 4387.0 4306.9 4307.4 4313.5 4321.3 4327.7 4306.4 4311.0 4321.9 4355.3 4361.4 3456.9 3492.6 3862.3 3865.0 3877.9 5078.7 5416.6 5434.8 5451.5 5473.3 4037.6 4834.1 4855.8 4856.8 4872.9 4572.6 5242.6 5955.5 5991.2 5993.6 3939.5 4015.7 4027.4 4031.5 4048.3 5220.5 6213.5 6226.3 6243.4 6265.9 3437.0 3553.9 3669.3 4064.2 4080.6 3186.8 3320.9 4082.1 4104.5 4113.8 3853.6 3974.5 4791.5 4792.6 4798.3 5274.7 5433.7 5469.5 5699.5 6020.7 1218.9 1266.0 1291.2 1304.8 1332.2 808.8 875.5 904.4 910.7 920.9 4936.4 5076.9 5181.3 5211.6 5308.8 5068.9 5073.1 5913.0 5925.4 5930.3 4751.7 4924.9 5287.5 5302.7 5327.8 2555.8 2798.4 3024.5 3033.9 3046.5 5032.9 5270.7 5321.7 5569.6 6014.5 5446.3 5564.4 5628.8 5654.7 6026.6 5430.8 5501.6 5643.8 5950.7 5951.1 5170.7 5190.0 5198.6 5201.5 5381.4 5052.5 5159.0 5737.9 5753.0 5753.3 4912.8 5185.9 5688.7 5955.7 5972.0 3310.2 3316.9 3579.4 3691.6 3731.8 5154.7 5747.9 5777.1 5785.4 5819.8 4926.7 5722.6 5746.0 5849.6 5854.7 4812.5 5613.0 5853.9 5872.7 5920.9 5547.9 5624.5 5697.3 5758.2 5811.0 5456.7 5864.4 5884.1 5925.5 5944.9 5264.1 5350.9 5432.9 5436.0 5988.7 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:21327.46 Median:3799.41 stddev:30406.59 (800.3%) stddev-sans-first:30452.39 17:52:45 INFO - PROCESS | 1647 | Values: 684.6 701.2 771.3 786.2 799.0 15021.8 15582.5 15846.8 16008.4 16216.1 11398.0 14619.6 14936.9 14957.3 14966.5 883.6 886.5 887.2 887.9 888.4 708.4 727.8 885.3 914.3 915.7 920.0 941.8 952.6 953.7 954.6 917.6 921.9 949.8 952.0 955.9 691.9 702.5 708.9 713.4 718.5 15166.0 15417.6 15424.3 15879.4 16142.6 14366.6 14699.0 15001.1 15008.3 15011.7 11055.9 11477.5 11482.9 11624.7 11747.4 3797.8 3878.6 3879.1 3922.0 4050.5 98020.1 103529.0 105297.4 106529.0 108820.5 9344.4 11171.6 11289.0 11599.6 11778.9 23525.4 23694.6 23717.0 23815.9 23842.0 6837.4 7844.6 8188.4 8285.5 8390.1 4431.1 4460.3 4466.0 4501.7 4516.0 3705.6 3778.1 3781.4 3801.0 3824.4 683.9 687.9 696.9 699.1 705.1 668.5 677.9 694.2 706.2 737.9 10211.8 10595.4 10632.5 10672.2 11010.9 621.6 679.5 713.9 717.9 739.8 4873.6 5139.5 5170.4 5176.1 5194.6 83591.0 109594.0 110377.0 111992.4 114027.4 86278.0 90338.0 95039.0 97457.0 98976.0 80181.6 81115.8 87858.0 91756.5 94032.5 11068.7 11235.9 11517.4 11567.5 11578.1 51358.7 51475.5 52441.0 53079.0 53389.7 65567.7 68465.6 68653.0 68729.7 69236.0 11967.9 14570.2 14633.0 14786.4 14837.9 14762.4 15570.1 15611.1 15701.5 15943.3 13897.9 14524.2 14631.9 14701.0 14764.6 13828.7 14304.1 14497.3 15007.4 15022.2 13454.9 14490.0 14564.0 14680.8 14706.1 10995.5 11231.3 11324.6 11352.1 11666.8 10168.6 10742.1 11359.4 11410.2 11493.2 17:52:45 INFO - PROCESS | 1647 | -------- Summary: end -------- 17:52:45 INFO - PROCESS | 1647 | 17:52:45 INFO - TEST-INFO | 1647: exit 0 17:52:45 INFO - TEST-OK | dromaeo_css | took 1114972ms 17:52:45 INFO - TEST-START | kraken 17:52:45 INFO - operating with platform_type : mac_ 17:52:45 INFO - Initialising browser for kraken test... 17:52:45 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpWuGxBQ/profile http://localhost:49238/getInfo.html) 17:52:48 INFO - PROCESS | 1659 | 2017-03-06 17:52:48.262 plugin-container[1660:9919] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8537, name = 'com.apple.tsm.portname' 17:52:48 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:48 INFO - PROCESS | 1659 | 2017-03-06 17:52:48.262 plugin-container[1660:9919] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 17:52:48 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:48 INFO - PROCESS | 1659 | 2017-03-06 17:52:48.262 plugin-container[1660:9919] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:52:48 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 17:52:48 INFO - PROCESS | 1659 | colorDepth:24 17:52:48 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 17:52:48 INFO - PROCESS | 1659 | __metrics 17:52:48 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 17:52:49 INFO - TEST-INFO | 1659: exit 0 17:52:49 INFO - Browser initialized. 17:52:49 INFO - Running cycle 1/1 for kraken test... 17:52:49 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpWuGxBQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:52:51 INFO - PROCESS | 1661 | 2017-03-06 17:52:51.402 plugin-container[1662:10042] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 17:52:51 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:51 INFO - PROCESS | 1661 | 2017-03-06 17:52:51.402 plugin-container[1662:10042] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 17:52:51 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:51 INFO - PROCESS | 1661 | 2017-03-06 17:52:51.402 plugin-container[1662:10042] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:53:01 INFO - PROCESS | 1661 | RSS: Main: 172634112 17:53:01 INFO - PROCESS | 1661 | 17:53:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 17:53:05 INFO - PROCESS | 1661 | RSS: Main: 185552896 17:53:05 INFO - PROCESS | 1661 | 17:53:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 17:53:08 INFO - PROCESS | 1661 | RSS: Main: 194531328 17:53:08 INFO - PROCESS | 1661 | 17:53:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 17:53:12 INFO - PROCESS | 1661 | RSS: Main: 197677056 17:53:12 INFO - PROCESS | 1661 | 17:53:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 17:53:14 INFO - PROCESS | 1661 | RSS: Main: 197791744 17:53:14 INFO - PROCESS | 1661 | 17:53:16 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:53:17 INFO - PROCESS | 1661 | RSS: Main: 198193152 17:53:17 INFO - PROCESS | 1661 | 17:53:20 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 17:53:20 INFO - PROCESS | 1661 | RSS: Main: 201797632 17:53:20 INFO - PROCESS | 1661 | 17:53:24 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 17:53:24 INFO - PROCESS | 1661 | RSS: Main: 202436608 17:53:24 INFO - PROCESS | 1661 | 17:53:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 17:53:28 INFO - PROCESS | 1661 | RSS: Main: 202764288 17:53:28 INFO - PROCESS | 1661 | 17:53:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:53:30 INFO - PROCESS | 1661 | RSS: Main: 201715712 17:53:30 INFO - PROCESS | 1661 | 17:53:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:53:33 INFO - PROCESS | 1661 | RSS: Main: 201736192 17:53:33 INFO - PROCESS | 1661 | 17:53:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:53:35 INFO - PROCESS | 1661 | RSS: Main: 202235904 17:53:35 INFO - PROCESS | 1661 | 17:53:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:53:39 INFO - PROCESS | 1661 | RSS: Main: 202133504 17:53:39 INFO - PROCESS | 1661 | 17:53:42 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:53:43 INFO - PROCESS | 1661 | RSS: Main: 202133504 17:53:43 INFO - PROCESS | 1661 | 17:53:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 17:53:45 INFO - PROCESS | 1661 | RSS: Main: 204111872 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | __start_tp_report 17:53:45 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 17:53:45 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 17:53:45 INFO - PROCESS | 1661 | |i|pagename|runs| 17:53:45 INFO - PROCESS | 1661 | |0;ai-astar;104;110;113;165;172;166;117;120;168;96 17:53:45 INFO - PROCESS | 1661 | |1;audio-beat-detection;176;138;111;141;114;140;141;115;135;142 17:53:45 INFO - PROCESS | 1661 | |2;audio-dft;197;197;192;198;194;207;199;196;198;197 17:53:45 INFO - PROCESS | 1661 | |3;audio-fft;81;58;59;86;62;60;60;60;94;57 17:53:45 INFO - PROCESS | 1661 | |4;audio-oscillator;81;70;85;72;69;71;82;84;58;90 17:53:45 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;88;85;87;102;136;85;91;89;87;86 17:53:45 INFO - PROCESS | 1661 | |6;imaging-darkroom;96;99;97;108;142;106;104;175;148;120 17:53:45 INFO - PROCESS | 1661 | |7;imaging-desaturate;130;135;91;77;143;142;92;98;90;92 17:53:45 INFO - PROCESS | 1661 | |8;json-parse-financial;57;56;56;58;60;61;60;61;60;61 17:53:45 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;73;80;73;81;82;80;73;75;102;76 17:53:45 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;84;86;85;82;84;84;83;88;86;84 17:53:45 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;134;134;142;157;150;127;154;140;200;176 17:53:45 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;164;165;166;163;165;165;164;190;161;166 17:53:45 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;63;64;65;65;64;68;65;66;65;64 17:53:45 INFO - PROCESS | 1661 | __end_tp_report 17:53:45 INFO - PROCESS | 1661 | __start_cc_report 17:53:45 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,931 17:53:45 INFO - PROCESS | 1661 | __end_cc_report 17:53:45 INFO - PROCESS | 1661 | __startTimestamp1488851625008__endTimestamp 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | ------- Summary: start ------- 17:53:45 INFO - PROCESS | 1661 | Number of tests: 14 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:133.10 Median:165.50 stddev:30.59 (18.5%) stddev-sans-first:30.58 17:53:45 INFO - PROCESS | 1661 | Values: 104.0 110.0 113.0 165.0 172.0 166.0 117.0 120.0 168.0 96.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:140.50 stddev:19.01 (13.5%) stddev-sans-first:13.28 17:53:45 INFO - PROCESS | 1661 | Values: 176.0 138.0 111.0 141.0 114.0 140.0 141.0 115.0 135.0 142.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:197.50 Median:197.50 stddev:3.92 (2.0%) stddev-sans-first:4.16 17:53:45 INFO - PROCESS | 1661 | Values: 197.0 197.0 192.0 198.0 194.0 207.0 199.0 196.0 198.0 197.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:67.70 Median:61.00 stddev:13.74 (22.5%) stddev-sans-first:13.70 17:53:45 INFO - PROCESS | 1661 | Values: 81.0 58.0 59.0 86.0 62.0 60.0 60.0 60.0 94.0 57.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:81.50 stddev:9.73 (11.9%) stddev-sans-first:10.16 17:53:45 INFO - PROCESS | 1661 | Values: 81.0 70.0 85.0 72.0 69.0 71.0 82.0 84.0 58.0 90.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:87.00 stddev:15.71 (18.1%) stddev-sans-first:16.53 17:53:45 INFO - PROCESS | 1661 | Values: 88.0 85.0 87.0 102.0 136.0 85.0 91.0 89.0 87.0 86.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:119.50 Median:161.50 stddev:26.73 (16.6%) stddev-sans-first:26.97 17:53:45 INFO - PROCESS | 1661 | Values: 96.0 99.0 97.0 108.0 142.0 106.0 104.0 175.0 148.0 120.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:90.50 stddev:25.32 (28.0%) stddev-sans-first:25.69 17:53:45 INFO - PROCESS | 1661 | Values: 130.0 135.0 91.0 77.0 143.0 142.0 92.0 98.0 90.0 92.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:60.00 stddev:2.05 (3.4%) stddev-sans-first:2.05 17:53:45 INFO - PROCESS | 1661 | Values: 57.0 56.0 56.0 58.0 60.0 61.0 60.0 61.0 60.0 61.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:79.50 Median:78.00 stddev:8.66 (11.1%) stddev-sans-first:8.86 17:53:45 INFO - PROCESS | 1661 | Values: 73.0 80.0 73.0 81.0 82.0 80.0 73.0 75.0 102.0 76.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:1.71 (2.0%) stddev-sans-first:1.80 17:53:45 INFO - PROCESS | 1661 | Values: 84.0 86.0 85.0 82.0 84.0 84.0 83.0 88.0 86.0 84.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:152.00 stddev:22.18 (14.6%) stddev-sans-first:22.61 17:53:45 INFO - PROCESS | 1661 | Values: 134.0 134.0 142.0 157.0 150.0 127.0 154.0 140.0 200.0 176.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:165.00 stddev:8.25 (5.0%) stddev-sans-first:8.69 17:53:45 INFO - PROCESS | 1661 | Values: 164.0 165.0 166.0 163.0 165.0 165.0 164.0 190.0 161.0 166.0 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.27 17:53:45 INFO - PROCESS | 1661 | Values: 63.0 64.0 65.0 65.0 64.0 68.0 65.0 66.0 65.0 64.0 17:53:45 INFO - PROCESS | 1661 | -------- Summary: end -------- 17:53:45 INFO - PROCESS | 1661 | 17:53:45 INFO - TEST-INFO | 1661: exit 0 17:53:45 INFO - TEST-OK | kraken | took 60068ms 17:53:45 INFO - SUITE-END | took 1175s 17:53:46 INFO - Completed test suite (00:19:35) 17:53:46 INFO - javascript benchmark 17:53:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7575.579869158019, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3492.5983511896134, 3504.772189807664, 3513.7891726496414, 3517.8742802303273, 3542.8051457169845, 6015.3082395524525, 6037.215162028936, 6053.57624966252, 6059.212302400692, 6062.575619706611, 4996.0, 5976.701164941757, 6006.4293892080295, 6105.755769769204, 6111.969440152793, 5188.325517682696, 5356.892862142755, 5449.182622606601, 5472.20653005314, 5509.917351239735, 4558.475775285851, 5497.752601132958, 5512.641678290898, 5520.282363292767, 5532.7786888524415, 4250.426192464024, 4771.9761401192945, 5364.195370694408, 5365.409804921455, 5514.5864060195645, 5376.435474275204, 5391.514763671269, 5456.317960254968, 5462.235287059815, 5538.113901775697, 5298.417174110845, 5425.6202065855405, 5429.239906413105, 5435.646682965634, 5454.754536045887, 5825.0, 5988.550858685616, 6061.212042434499, 6098.664573448458, 6129.877402451971, 5241.3710354757295, 6257.217847769029, 6269.310375858652, 6285.748570057192, 6354.142190804228, 6393.041043843415, 6406.583572067801, 6438.0, 6441.25925518562, 6482.41658250755, 6167.167432396659, 6178.62928224308, 6192.504599632019, 6198.845028874314, 6260.029695397221, 6313.905291420632, 6334.9366506334345, 6493.610383377012, 6508.837279068061, 6529.771457998947, 6248.781292654735, 6312.274088479791, 6314.494840412756, 6337.714802833883, 6367.713452894538, 6422.42198202164, 6479.254885688112, 6479.287278399373, 6479.773207937699, 6484.351564843478, 6272.498200143978, 6276.46650034743, 6276.748930042839, 6291.433770960635, 6318.905216421757, 6342.809715708536, 6346.873062538723, 6357.4914006879335, 6373.490120790326, 6378.138951241615, 5182.766775495112, 5201.765920533585, 5214.191800270964, 5223.764930578133, 5249.396319423239, 4527.47933987589, 4570.977145114253, 4597.931031034537, 4640.419947506562, 4695.460022097434, 6028.336882942873, 6128.724207410677, 6130.612163469634, 6132.0, 6132.570720049643, 5360.758765855546, 6404.48764098871, 6419.646919419477, 6437.2918978912285, 6458.095866578683, 5947.226860508106, 5977.67122808241, 6026.6986650667295, 6033.396660333931, 6054.485368743706, 5668.234788303609, 5673.205751194836, 5675.801346952837, 5683.715814209356, 5726.398728133569, 6484.837879053061, 6490.091387205795, 6500.122483464766, 6512.381323774234, 6518.869622607616, 6207.596506227081, 6263.592866463665, 6315.115883776183, 6346.9682651586445, 6418.775342862978, 6509.218893732783, 6535.738570457129, 6536.444402225674, 6537.5096867734155, 6548.0, 6374.235091789015, 6377.585456945284, 6382.234131904202, 6383.904241436475, 6387.371220338784, 6236.844078898064, 6251.281102673251, 6292.182016337847, 6321.146645202839, 6432.163818703539, 4939.6542242042715, 6092.45167934888, 6256.343083976117, 6314.368563143649, 6322.589031712924, 6036.577439579188, 6282.811515654537, 6289.559730818799, 6292.433680968735, 6305.148804911279, 4731.337612734289, 5653.689047102449, 6150.231221097363, 6194.039923811816, 6257.030160325156, 6200.844978875564, 6212.099245609452, 6215.285242197205, 6315.96842015787, 6328.525360597881, 6299.937000629935, 6305.243370795534, 6311.084892690443, 6315.210598675166, 6328.0], "value": 5871.729595000605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.8802243450353, 532.5712801195037, 533.7197971065187, 547.2092825866622, 576.9278840144982, 38943.2211355773, 41641.58358416415, 41754.791226043904, 41822.37266441002, 41855.790721046425, 42831.571684283146, 43407.56592434075, 43423.56576434235, 43451.34822977658, 43559.3466098008, 9489.240860731124, 9715.659951901685, 9757.707268781913, 11428.657140285804, 11813.409329533531, 11800.350980696057, 11852.940735296312, 11875.228110172811, 11884.227525210834, 11928.821067683992, 11785.587504437346, 11790.115741319436, 11812.232204906697, 11847.526098956032, 11862.822057669142, 11772.646820595353, 11803.763924721501, 11853.111016673784, 11857.5849845255, 11905.107116966263, 11597.652070437816, 11696.122790790725, 11696.707582310426, 11718.472668729928, 11759.05927525796, 38149.427758583646, 38296.0, 38377.848664540106, 38459.23081538382, 38576.61423385758, 4062.6343629073526, 4086.8773936781945, 4098.856540021115, 4208.305629571117, 4242.830286788525, 27940.161795146178, 28618.71215795294, 28794.71205287941, 28799.0, 30770.38459230825, 3231.4021905947475, 3413.0784688134063, 3445.9655403445895, 3474.652534746505, 3484.407650699362, 473693.0, 475038.0, 480440.0, 482156.0, 482958.9999999965, 46936.765316173885, 58765.41234587685, 58996.82006359849, 59253.0, 59285.0, 60572.39427605756, 60943.08585371223, 61020.38979610236, 61066.38933610607, 61143.77712445815, 16336.183190840411, 16415.589610259838, 16549.172541372882, 16602.667946641, 16604.916975415046, 12031.518739250332, 12311.50753969849, 13780.035397522277, 13932.512362067278, 13986.790198147037, 21975.780242197692, 22724.88637556835, 22744.86275686242, 22754.0, 22819.74491402989, 7677.005967672612, 9043.59303831329, 9298.767530811783, 9343.859842102374, 9382.953085234667, 902.8916530016309, 919.6643225222879, 922.9769255768659, 945.8723072385139, 961.8893827209821, 30196.396072078434, 31248.843755781076, 31302.373952520822, 31542.526862097086, 32032.199195020312, 959.8608201810698, 1021.7241344836852, 1099.7470581766238, 1123.6685177872548, 1160.9941950290195, 15545.844541554667, 16098.873078884366, 16388.836111638968, 16697.91651041737, 16767.077810720282, 695803.0, 706261.0, 710222.0, 714670.0, 715208.0, 63134.36865631285, 63280.36719632837, 63648.0, 63930.0, 64055.35944640587, 1484.1095342794454, 1510.5166346768929, 1516.8460785684354, 1528.0, 1532.4559781277708, 30319.393612127195, 31080.22299442532, 31146.065618031495, 31645.525317119802, 31661.683383165873, 53657.92684146217, 54549.90900182053, 54619.0, 58047.709761450926, 58092.70953645205, 635691.6430835817, 638592.0, 639809.8009509923, 641017.0, 642792.0, 29086.0, 36261.63738362688, 39305.0, 41790.373144403464, 42051.73844784661, 36437.0, 44182.55817441784, 44320.335194972744, 45070.77464612787, 45707.0, 36437.63562364342, 36820.81589592035, 37298.627013729514, 38191.427128592535, 38543.42184867173, 36743.448848266766, 36956.260874781816, 37799.81100094482, 38139.61860381471, 38184.42723359096, 36105.0973725659, 36312.63687363092, 36665.71669991538, 36779.0, 36926.89219323425, 31535.52696709597, 33469.49795753017, 33557.664423355454, 33608.83195584006, 33675.494867577494, 24209.63685544683, 24521.01915923343, 24619.50760984806, 25134.622980654938, 25350.746492535578], "value": 21233.21114627607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6809042088174, 406.8860718998681, 413.83239787885907, 418.12820269737597, 435.6166573415396, 20714.792852071474, 21345.93270336483, 21525.892370538124, 21963.670544941837, 22190.667139992915, 22088.779112208875, 22230.666540001872, 22524.774752252473, 22774.65838012431, 23156.88421557894, 5980.372060933593, 6178.227721534809, 6249.625022498664, 6252.624842509441, 6252.718627661743, 5930.970345148268, 6060.969695151518, 6091.208142941411, 6091.847703807396, 6113.877722445548, 6067.423594758491, 6070.392960703938, 6070.6357618543025, 6075.362086980869, 6092.939070609282, 5870.530357571405, 6031.788887388964, 6076.696165191723, 6122.571420000601, 6139.785107521216, 5276.366835979707, 5308.575313974873, 5347.732613369355, 5393.78424863005, 5399.919001214985, 26329.3417664558, 26444.603330950053, 26523.0, 26648.60027099595, 26868.05961791328, 2816.169230077132, 2843.1186332236866, 2848.1740295314335, 2851.17315978366, 2863.9713602863912, 15431.614209644737, 15988.920055399765, 16026.278817453243, 16138.0, 16648.66702665952, 1856.916438760259, 1860.4418674397627, 1900.1924182222501, 1909.1599696133658, 1928.151613290148, 119926.0, 123808.38095809553, 128116.07825882712, 129790.70209297881, 131287.0, 11650.766984660258, 11682.649520514398, 11824.76350473003, 11847.407629618658, 12007.699807504881, 15055.54833355001, 15072.246387680572, 15110.320035598425, 15121.16833574164, 15135.091894486366, 7309.342159205697, 8936.46381217129, 9111.997680255166, 9132.452052876848, 9157.542122893828, 7413.629318534052, 8999.460032398078, 9045.914490261079, 9210.631574736935, 9232.630694772133, 6550.639714815636, 7276.090488688914, 7350.154732205758, 7481.401487880957, 7513.661885215179, 1994.461495396264, 2010.638085144688, 2014.7078673592248, 2016.8386529077638, 2018.5458271889001, 821.9917800821916, 931.1991687149047, 937.2455173585194, 968.9854652180223, 970.6748239339901, 22066.44833879166, 22747.431314217276, 23313.650295245585, 23320.7667923322, 23453.944572494278, 960.6877764726491, 965.6813251626946, 982.513655740413, 988.7577543501889, 992.211192102266, 9967.750806229902, 10131.493425328705, 12289.324087175291, 12316.753664926651, 12374.690632734253, 713270.0, 764423.0, 765442.0, 769522.0, 778081.0, 123595.0, 129715.35142324227, 133444.0, 143758.0, 170361.0, 1072.2494254022215, 1100.8954149355798, 1123.0902968595465, 1126.4424110065406, 1128.5260190719753, 18652.69431139807, 18679.719804202676, 20724.58550828945, 20821.79178208259, 20886.58226835485, 60626.69686651538, 61241.468963276275, 61692.69153654203, 61834.69082654558, 62109.378906212165, 68361.0, 85578.14421855702, 88497.55751221202, 89043.0, 89993.10006899846, 8546.743597692079, 8611.8708219378, 8613.526256055726, 8806.383553151474, 8892.0, 12455.252684838577, 12596.181248218836, 13211.405486753312, 13508.864911351155, 13552.0, 10318.948405258227, 10959.01368876805, 11138.832917506406, 11641.359725214856, 11647.807602823557, 11428.428578570873, 11588.94205528967, 11599.188056836278, 11754.588589399329, 11961.940190298992, 10253.58985640566, 11656.88343116558, 11755.0, 12077.939610301892, 12162.817557736818, 8422.831543368975, 8514.978202615726, 8641.308695304235, 8651.91348086511, 8681.2186903179, 9426.0, 9919.305648604817, 9999.050090241415, 10171.440570768678, 10205.336653117523], "value": 10360.564007536255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.5459907428697, 1488.8585584369494, 1506.9924650376747, 1519.8936074474784, 1528.3733669195633, 7816.570088645122, 8057.637406316715, 8341.499510029395, 8700.912990870089, 8793.34049946255, 8224.547649879269, 8542.060373358941, 8578.099299573549, 8615.655373785057, 8618.956905215466, 2363.881805909706, 2409.325388891113, 2409.7590240975937, 2411.2766170148975, 2416.069813121952, 2422.34596658902, 2435.8051355891484, 2465.0879174705296, 2465.272744540365, 2468.4075821802817, 2409.891554880026, 2417.190241269177, 2426.963595546068, 2432.963505547418, 2439.914602988887, 2029.3911826452006, 2397.412633904687, 2403.098837935774, 2403.6875206223253, 2423.9636405453934, 2379.940501487459, 2388.4267775733874, 2446.8287219894614, 2452.9632055519182, 2456.987715061431, 8602.612882420306, 8620.698275560388, 8652.697155599524, 8670.653173873037, 8678.435901666371, 4476.418065651477, 4527.592516673515, 5053.873653158664, 5161.561267292284, 5177.016366890279, 3536.7621332533663, 3588.3002814451193, 3595.380215443785, 3624.800635965021, 3667.9816600916824, 1283.7496688145816, 1290.696686278733, 1309.1098053323735, 1328.5947785925289, 1349.817774600436, 9329.580168892417, 11130.777384452347, 11141.610043648514, 11149.16381271408, 11157.944210278896, 3643.5972150722164, 4619.376384188159, 4822.903541929142, 4866.294387313819, 4911.582515486224, 9653.613855445845, 9784.706458806248, 9796.971318011649, 9808.411495310162, 9823.115919567274, 4598.609118224988, 5402.810901618424, 5412.296401467863, 5430.592705547021, 5434.510894019557, 3679.2641471705765, 4142.5857414258935, 4467.218236808546, 4863.513648635179, 4874.390701162355, 3994.840206391712, 4044.8584299549375, 4078.898027549335, 4125.360569111793, 4139.751614903115, 1332.5336132353598, 1338.772408690525, 1340.4839136932155, 1348.1776116568885, 1351.4594162334947, 763.9694412223449, 810.440795850861, 874.1695389380114, 915.9221466175317, 934.0426063285187, 4579.771011449414, 5030.471800460972, 5671.631343962629, 5699.0, 5868.970655146697, 574.8016934157793, 577.4110407384444, 592.318833341652, 595.3629616310507, 596.7255062671134, 3827.2919509890758, 3852.499175107218, 3857.652811246945, 3930.9213815724097, 3945.940810887839, 9645.276604254708, 9968.252381071303, 10084.899151008543, 10087.899121008842, 10133.240006999504, 9917.074463033423, 10088.596456141671, 10090.596376144871, 10092.192624590016, 10106.343087699275, 7952.403569732293, 7967.56178410193, 8047.839043219103, 8051.919480805234, 8065.516069035877, 5528.9723551381985, 5534.1145416733125, 5714.257146570919, 5755.482006619424, 5798.927198468297, 9105.954470227607, 9402.95298523503, 9435.009324021154, 9450.669226577036, 9451.432914025181, 9142.954285228532, 9417.529123543658, 9465.100815422524, 9474.099960503741, 9488.051194880456, 6799.864002719819, 6983.860322793617, 7194.424446044409, 7339.8532029360185, 7528.661210245662, 8022.799430014296, 8236.670533178845, 8238.670453181805, 8239.382046346429, 8249.505029698237, 7186.60473673932, 7254.709811607477, 7287.854242915006, 7411.1477180124975, 7419.851602967802, 7139.750108746169, 7145.535540189871, 7158.570485770662, 7296.7446139384865, 7330.560166390033, 5479.2602998594675, 6454.290028097, 6575.80272591823, 6593.076969224217, 6619.0, 5034.407280250601, 5053.69677819332, 5126.487686132526, 5255.0, 5340.225667278145, 4649.837540614846, 5003.674761140514, 5134.7175905324075, 5184.948150518447, 5222.3472065991755], "value": 4454.648420136155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.820416851973, 347.54818735643664, 371.69892387166396, 372.91667705316047, 392.0062641204547, 5335.946640533593, 5482.095454250054, 5526.3920968693465, 5620.229627667287, 5684.744186511602, 5276.8153114641, 5396.893636804455, 5522.420145884685, 5575.804846830361, 5577.9163312550345, 4339.414179085815, 4340.460830414204, 4358.8474403395885, 4364.25807612705, 4400.8019639116155, 3615.566132064143, 4143.357779544175, 4319.114581510783, 4355.8457008892665, 4386.97806510967, 4306.913861722764, 4307.353896915472, 4313.462960372496, 4321.265384884561, 4327.74033557986, 4306.44016277885, 4310.956890431103, 4321.9135617287475, 4355.281378572532, 4361.389405483234, 3456.879009234665, 3492.550591504523, 3862.2854771867296, 3864.95646175531, 3877.9030524236837, 5078.654156648491, 5416.593755468356, 5434.75543600535, 5451.454854514556, 5473.343198816127, 4037.576054514263, 4834.129856625841, 4855.830045948375, 4856.805727770885, 4872.8538143855385, 4572.634189264851, 5242.6330156889035, 5955.464008239236, 5991.214085450287, 5993.640381577119, 3939.546952100488, 4015.678745700366, 4027.436158937751, 4031.5162180538523, 4048.287647276332, 5220.530152286275, 6213.533984951102, 6226.283977342573, 6243.375662433766, 6265.906011409833, 3437.0237113659246, 3553.875614353537, 3669.3395188865725, 4064.207479541461, 4080.5511393746665, 3186.7609929254936, 3320.883769068071, 4082.1019375737883, 4104.548499665035, 4113.835446582163, 3853.61463853618, 3974.4833171688074, 4791.496892826272, 4792.568668819753, 4798.2802579612635, 5274.736263186825, 5433.7397561463595, 5469.535089517435, 5699.523290792613, 6020.69896505173, 1218.9085818563642, 1265.9682358877485, 1291.185883833216, 1304.8434187897512, 1332.160738734591, 808.8150858991605, 875.5072601214913, 904.4076130134772, 910.6721580231111, 920.9447433154032, 4936.3829521309835, 5076.873078173001, 5181.253935414236, 5211.557017653542, 5308.840734777963, 5068.898622027613, 5073.0606600669835, 5912.989583541616, 5925.429761113309, 5930.347661757203, 4751.717036400152, 4924.8768780780765, 5287.471252874759, 5302.68183908959, 5327.786888524493, 2555.795536357087, 2798.4263226038615, 3024.485837407646, 3033.9241518962203, 3046.5277881928337, 5032.874178145576, 5270.7101109439345, 5321.6540924839765, 5569.637973531708, 6014.503980847987, 5446.319210098738, 5564.443555644403, 5628.807003156727, 5654.663748388471, 6026.6384016958245, 5430.782768689208, 5501.559875210054, 5643.774249030075, 5950.6676261293815, 5951.137085122633, 5170.71561064145, 5189.96200759842, 5198.610104242121, 5201.505856943584, 5381.408045114956, 5052.494750525065, 5158.97420512895, 5737.90979713853, 5753.0, 5753.252077229933, 4912.803487860446, 5185.914380943333, 5688.691600931892, 5955.731992060454, 5972.0, 3310.222097807062, 3316.9170770730925, 3579.3736096182542, 3691.630836916287, 3731.8134093294684, 5154.737089413118, 5747.913781293368, 5777.133429985536, 5785.3636100028125, 5819.82540523785, 4926.679765815211, 5722.62802917809, 5745.971270143623, 5849.5612829037145, 5854.707264636836, 4812.5187481253, 5613.0, 5853.882922341444, 5872.677002764889, 5920.881582368243, 5547.8890422192135, 5624.46567576096, 5697.316322041382, 5758.222639943554, 5810.970945145247, 5456.672599644034, 5864.361037533042, 5884.0585506318785, 5925.52595792327, 5944.910826337695, 5264.1314183160885, 5350.866228344167, 5432.891342173055, 5436.0, 5988.700564971821], "value": 4189.332074688298, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.6405637040556, 701.1726163127514, 771.2595907928387, 786.1705900275209, 799.0092285565896, 15021.774673379909, 15582.454614088509, 15846.841531584681, 16008.359665613376, 16216.108114053723, 11398.0, 14619.561413157595, 14936.925315373435, 14957.252137393114, 14966.476173333935, 883.5847151838642, 886.4681191285209, 887.2369762004671, 887.9378443508957, 888.4003297774009, 708.3766285668604, 727.7743899391179, 885.3006125161115, 914.3279689428265, 915.6703586708779, 919.9908000920005, 941.835178843703, 952.6475204174466, 953.6852838563258, 954.6229239450413, 917.6054296652437, 921.9492927888963, 949.8337790886602, 951.9861347664715, 955.8757361543024, 691.8512519808265, 702.4871843554234, 708.9291070892921, 713.3651050565002, 718.4683334332608, 15166.0, 15417.614559636098, 15424.305906234247, 15879.444219452263, 16142.596435089099, 14366.640833979129, 14699.0, 15001.099934003885, 15008.324625391884, 15011.699766004618, 11055.889441105646, 11477.506257246225, 11482.88517114835, 11624.6512604622, 11747.412629368582, 3797.8480860765535, 3878.612138786127, 3879.069023434384, 3921.960780392188, 4050.4734384530116, 98020.05939821817, 103529.03893480172, 105297.42053869122, 106529.0, 108820.45589772079, 9344.439333639868, 11171.608993685182, 11289.0, 11599.594014209462, 11778.941105294418, 23525.41186470352, 23694.644580331307, 23717.0, 23815.880920595286, 23842.046318147426, 6837.384635382839, 7844.568548729761, 8188.385871059694, 8285.544295063708, 8390.119037501097, 4431.091626216617, 4460.30865215892, 4466.0, 4501.662375321798, 4516.029053753393, 3705.5923848376656, 3778.112143646296, 3781.3760729479877, 3800.980995095062, 3824.3689791184142, 683.8803209438329, 687.8658661561047, 696.9268226836109, 699.1016543741268, 705.0728292295615, 668.5019660352971, 677.8983152527161, 694.1808665774333, 706.1773034414849, 737.8634952533798, 10211.846822297523, 10595.364278143183, 10632.521536530874, 10672.199585030998, 11010.944945275221, 621.6114928169894, 679.5175425447889, 713.8857782754734, 717.9317964793337, 739.782131187371, 4873.585745211697, 5139.486051394831, 5170.431252562215, 5176.1459359206065, 5194.6104042196985, 83591.0, 109594.0, 110377.0, 111992.44003779929, 114027.42986285016, 86278.0, 90338.0, 95039.04960950302, 97457.0, 98976.01023989668, 80181.59909200533, 81115.7832632511, 87858.0, 91756.54121729349, 94032.52983735038, 11068.723281918017, 11235.943820280847, 11517.366544840113, 11567.479463423997, 11578.131640127192, 51358.716032099495, 51475.485245148564, 52441.0, 53079.0, 53389.73305133605, 65567.67216163888, 68465.63068738698, 68653.0, 68729.65635171792, 69235.96146057914, 11967.880321197024, 14570.198639074528, 14633.048851824597, 14786.441285033256, 14837.92581037088, 14762.409503619734, 15570.065796052273, 15611.056209385073, 15701.528954131394, 15943.282552284943, 13897.930510347383, 14524.20116893581, 14631.92684036573, 14701.0, 14764.63088422798, 13828.654283642989, 14304.141751494944, 14497.275136242935, 15007.399704011717, 15022.173780442181, 13454.93272533631, 14490.0, 14564.0, 14680.778763892255, 14706.117632942058, 10995.450227488753, 11231.338994317266, 11324.6036388726, 11352.148588855704, 11666.824997624874, 10168.644097456554, 10742.10864721804, 11359.375234362189, 11410.201285910238, 11493.195476316578], "value": 7840.1259189550365, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 113.0, 165.0, 172.0, 166.0, 117.0, 120.0, 168.0, 96.0], "value": 133.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 138.0, 111.0, 141.0, 114.0, 140.0, 141.0, 115.0, 135.0, 142.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 192.0, 198.0, 194.0, 207.0, 199.0, 196.0, 198.0, 197.0], "value": 197.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 86.0, 62.0, 60.0, 60.0, 60.0, 94.0, 57.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 85.0, 72.0, 69.0, 71.0, 82.0, 84.0, 58.0, 90.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 102.0, 136.0, 85.0, 91.0, 89.0, 87.0, 86.0], "value": 93.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 97.0, 108.0, 142.0, 106.0, 104.0, 175.0, 148.0, 120.0], "value": 119.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 91.0, 77.0, 143.0, 142.0, 92.0, 98.0, 90.0, 92.0], "value": 109.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 58.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 73.0, 81.0, 82.0, 80.0, 73.0, 75.0, 102.0, 76.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 82.0, 84.0, 84.0, 83.0, 88.0, 86.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 142.0, 157.0, 150.0, 127.0, 154.0, 140.0, 200.0, 176.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 163.0, 165.0, 165.0, 164.0, 190.0, 161.0, 166.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 65.0, 64.0, 68.0, 65.0, 66.0, 65.0, 64.0], "value": 64.9, "unit": "score"}]}]} 17:53:46 INFO - Return code: 0 17:53:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:53:46 ERROR - # TBPL SUCCESS # 17:53:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:53:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:53:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:53:46 INFO - 2017-03-06 17:53:46.341 screenresolution[1666:10424] starting screenresolution argv=screenresolution get 17:53:46 INFO - 2017-03-06 17:53:46.343 screenresolution[1666:10424] Display 0: 1600x1200x32@60 17:53:46 INFO - 2017-03-06 17:53:46.350 screenresolution[1667:10427] starting screenresolution argv=screenresolution list 17:53:46 INFO - Available Modes on Display 0 17:53:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:53:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:53:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:53:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:53:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:53:46 INFO - Intel Iris: 17:53:46 INFO - Chipset Model: Intel Iris 17:53:46 INFO - Type: GPU 17:53:46 INFO - Bus: Built-In 17:53:46 INFO - VRAM (Dynamic, Max): 1536 MB 17:53:46 INFO - Vendor: Intel (0x8086) 17:53:46 INFO - Device ID: 0x0a2e 17:53:46 INFO - Revision ID: 0x0009 17:53:46 INFO - Displays: 17:53:46 INFO - Display: 17:53:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:53:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:53:46 INFO - Display Serial Number: 1600x1200 60 17:53:46 INFO - Main Display: Yes 17:53:46 INFO - Mirror: Off 17:53:46 INFO - Online: Yes 17:53:46 INFO - Rotation: Supported 17:53:46 INFO - Return code: 0 17:53:46 INFO - Running post-action listener: _resource_record_post_action 17:53:46 INFO - [mozharness: 2017-03-07 01:53:46.586968Z] Finished run-tests step (success) 17:53:46 INFO - Running post-run listener: _resource_record_post_run 17:53:46 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38705152; Write bytes: 421844992; Read time: 247; Write time: 1401 17:53:46 INFO - TinderboxPrint: CPU usage
54.4% 17:53:46 INFO - TinderboxPrint: I/O read bytes / time
38,705,152 / 247 17:53:46 INFO - TinderboxPrint: I/O write bytes / time
421,844,992 / 1,401 17:53:46 INFO - TinderboxPrint: CPU idle
2,169.0 (45.6%) 17:53:46 INFO - TinderboxPrint: CPU system
958.5 (20.1%) 17:53:46 INFO - TinderboxPrint: CPU user
1,634.2 (34.3%) 17:53:46 INFO - TinderboxPrint: Swap in / out
160,714,752 / 0 17:53:46 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 109904384; Write bytes: 103900672; Read time: 9812; Write time: 236 17:53:46 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37775360; Write bytes: 297468416; Read time: 235; Write time: 1105 17:53:47 INFO - Running post-run listener: _upload_blobber_files 17:53:47 INFO - Blob upload gear active. 17:53:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:53:47 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 17:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:53:47 INFO - (blobuploader) - INFO - Open directory for files ... 17:53:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:53:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:48 INFO - (blobuploader) - INFO - Done attempting. 17:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:49 INFO - (blobuploader) - INFO - Done attempting. 17:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:50 INFO - (blobuploader) - INFO - Done attempting. 17:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:53:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:52 INFO - (blobuploader) - INFO - Done attempting. 17:53:52 INFO - (blobuploader) - INFO - Iteration through files over. 17:53:52 INFO - Return code: 0 17:53:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:53:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:53:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1775d7c961482bc86c1ccd8fba41162a78b8e2de044db3b2cb3b2f9a718300cf9f7306522d9558202d297f68a111acc947258649f9fb8ad1456317ca308187ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63081fde236ce24de18d9edef214ebe0d204ac507393e911d78d61681aa9220d5500e3d37bd57cea9c32da5c9b5ba529f9a423b9fcd9678b905377904f714ca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fe5ac903ba128204dae3c8a7324e2c5553ec1f4721e9556883baecee293a474079dddcb84b7c33598949ce661a4cf6be290b9daf1544c6ba64b240a617b4965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/715c7b2773ce1e162a260e03b444f394361505544ee8bdacfe33ccb33cfcbf5498d3ee2055db635cf50490d897bd0411f48045a21d8bc4838777f4418e7c9e0d"} 17:53:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:53:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:53:52 INFO - Contents: 17:53:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1775d7c961482bc86c1ccd8fba41162a78b8e2de044db3b2cb3b2f9a718300cf9f7306522d9558202d297f68a111acc947258649f9fb8ad1456317ca308187ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63081fde236ce24de18d9edef214ebe0d204ac507393e911d78d61681aa9220d5500e3d37bd57cea9c32da5c9b5ba529f9a423b9fcd9678b905377904f714ca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fe5ac903ba128204dae3c8a7324e2c5553ec1f4721e9556883baecee293a474079dddcb84b7c33598949ce661a4cf6be290b9daf1544c6ba64b240a617b4965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/715c7b2773ce1e162a260e03b444f394361505544ee8bdacfe33ccb33cfcbf5498d3ee2055db635cf50490d897bd0411f48045a21d8bc4838777f4418e7c9e0d"} 17:53:52 INFO - Running post-run listener: copy_logs_to_upload_dir 17:53:52 INFO - Copying logs to upload dir... 17:53:52 INFO - mkdir: /builds/slave/test/build/upload/logs 17:53:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.351116 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-06 17:53:52.366305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 17:53:52.369610) ========= 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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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-Beta/sha512/1775d7c961482bc86c1ccd8fba41162a78b8e2de044db3b2cb3b2f9a718300cf9f7306522d9558202d297f68a111acc947258649f9fb8ad1456317ca308187ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63081fde236ce24de18d9edef214ebe0d204ac507393e911d78d61681aa9220d5500e3d37bd57cea9c32da5c9b5ba529f9a423b9fcd9678b905377904f714ca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fe5ac903ba128204dae3c8a7324e2c5553ec1f4721e9556883baecee293a474079dddcb84b7c33598949ce661a4cf6be290b9daf1544c6ba64b240a617b4965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/715c7b2773ce1e162a260e03b444f394361505544ee8bdacfe33ccb33cfcbf5498d3ee2055db635cf50490d897bd0411f48045a21d8bc4838777f4418e7c9e0d"} build_url:https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010937 build_url: 'https://queue.taskcluster.net/v1/task/Lm_aWAANQ56q5QKdRc5qdw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1775d7c961482bc86c1ccd8fba41162a78b8e2de044db3b2cb3b2f9a718300cf9f7306522d9558202d297f68a111acc947258649f9fb8ad1456317ca308187ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63081fde236ce24de18d9edef214ebe0d204ac507393e911d78d61681aa9220d5500e3d37bd57cea9c32da5c9b5ba529f9a423b9fcd9678b905377904f714ca5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8fe5ac903ba128204dae3c8a7324e2c5553ec1f4721e9556883baecee293a474079dddcb84b7c33598949ce661a4cf6be290b9daf1544c6ba64b240a617b4965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/715c7b2773ce1e162a260e03b444f394361505544ee8bdacfe33ccb33cfcbf5498d3ee2055db635cf50490d897bd0411f48045a21d8bc4838777f4418e7c9e0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 17:53:52.403822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 17:53:52.404142) ========= 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.ses19qwFQ6/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.Eo6GsFQRCT/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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.005197 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 17:53:52.452782) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 17:53:52.453076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 17:53:52.453378) ========= ========= Total master_lag: 0.83 =========