builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0012 starttime: 1490841243.75 results: success (0) buildid: 20170329183958 builduid: 5aadaee5329e490db7fd505d0b8ae85d revision: 4b4a2a430c62de7204392ea83df41fae2ea00cd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.755355) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.755846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.756123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.782959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.783343) ========= 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.i6xNEOWHos/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.ccno699742/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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-29 19:34:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2017-03-29 19:34:03 (181 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.901979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.902298) ========= 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.i6xNEOWHos/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.ccno699742/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.028410 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:03.954425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 19:34:03.954863) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4b4a2a430c62de7204392ea83df41fae2ea00cd3 --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 4b4a2a430c62de7204392ea83df41fae2ea00cd3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.i6xNEOWHos/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.ccno699742/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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-29 19:34:04,038 truncating revision to first 12 chars 2017-03-29 19:34:04,038 Setting DEBUG logging. 2017-03-29 19:34:04,038 attempt 1/10 2017-03-29 19:34:04,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4b4a2a430c62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 19:34:05,345 unpacking tar archive at: mozilla-beta-4b4a2a430c62/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 19:34:05.548447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:05.548809) ========= script_repo_revision: 4b4a2a430c62de7204392ea83df41fae2ea00cd3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:05.549218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:05.549488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 19:34:05.567429) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-29 19:34:05.567793) ========= /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.i6xNEOWHos/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.ccno699742/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:05 INFO - MultiFileLogger online at 20170329 19:34:05 in /builds/slave/test 19:34:05 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 19:34:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:34:05 INFO - {'append_to_log': False, 19:34:05 INFO - 'base_work_dir': '/builds/slave/test', 19:34:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:34:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:34:05 INFO - 'branch': 'Mozilla-Beta', 19:34:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:34:05 INFO - 'config_files': ('talos/mac_config.py',), 19:34:05 INFO - 'default_actions': ('clobber', 19:34:05 INFO - 'read-buildbot-config', 19:34:05 INFO - 'download-and-extract', 19:34:05 INFO - 'populate-webroot', 19:34:05 INFO - 'create-virtualenv', 19:34:05 INFO - 'install', 19:34:05 INFO - 'run-tests'), 19:34:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:34:05 INFO - 'download_minidump_stackwalk': True, 19:34:05 INFO - 'download_symbols': 'ondemand', 19:34:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:34:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:34:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:34:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:34:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:34:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:34:05 INFO - 'installer_path': 'installer.exe', 19:34:05 INFO - 'log_level': 'info', 19:34:05 INFO - 'log_name': 'talos', 19:34:05 INFO - 'log_to_console': True, 19:34:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:34:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:34:05 INFO - 'opt_config_files': (), 19:34:05 INFO - 'pip_index': False, 19:34:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:05 INFO - 'cmd': ('bash', 19:34:05 INFO - '-c', 19:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:05 INFO - 'enabled': True, 19:34:05 INFO - 'halt_on_failure': False, 19:34:05 INFO - 'name': 'check_screen_resolution'},), 19:34:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:05 INFO - 'cmd': ('bash', 19:34:05 INFO - '-c', 19:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:05 INFO - 'enabled': True, 19:34:05 INFO - 'halt_on_failure': False, 19:34:05 INFO - 'name': 'check_screen_resolution'},), 19:34:05 INFO - 'run_cmd_checks_enabled': True, 19:34:05 INFO - 'sps_profile': False, 19:34:05 INFO - 'sps_profile_interval': 0, 19:34:05 INFO - 'suite': 'dromaeojs-e10s', 19:34:05 INFO - 'system_bits': '32', 19:34:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:34:05 INFO - 'title': 't-yosemite-r7-0012', 19:34:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:34:05 INFO - 'use_talos_json': True, 19:34:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:34:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:34:05 INFO - 'work_dir': 'build'} 19:34:05 INFO - [mozharness: 2017-03-30 02:34:05.760099Z] Running clobber step. 19:34:05 INFO - Running pre-action listener: _resource_record_pre_action 19:34:05 INFO - Running main action method: clobber 19:34:05 INFO - rmtree: /builds/slave/test/build 19:34:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:34:08 INFO - Running post-action listener: _resource_record_post_action 19:34:08 INFO - [mozharness: 2017-03-30 02:34:08.363153Z] Finished clobber step (success) 19:34:08 INFO - [mozharness: 2017-03-30 02:34:08.363315Z] Running read-buildbot-config step. 19:34:08 INFO - Running pre-action listener: _resource_record_pre_action 19:34:08 INFO - Running main action method: read_buildbot_config 19:34:08 INFO - Using buildbot properties: 19:34:08 INFO - { 19:34:08 INFO - "project": "", 19:34:08 INFO - "product": "firefox", 19:34:08 INFO - "script_repo_revision": "production", 19:34:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 19:34:08 INFO - "repository": "", 19:34:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 19:34:08 INFO - "buildid": "20170329183958", 19:34:08 INFO - "pgo_build": "False", 19:34:08 INFO - "basedir": "/builds/slave/test", 19:34:08 INFO - "buildnumber": 9, 19:34:08 INFO - "slavename": "t-yosemite-r7-0012", 19:34:08 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:34:08 INFO - "platform": "yosemite_r7", 19:34:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:34:08 INFO - "branch": "mozilla-beta", 19:34:08 INFO - "repo_path": "releases/mozilla-beta", 19:34:08 INFO - "revision": "4b4a2a430c62de7204392ea83df41fae2ea00cd3", 19:34:08 INFO - "stage_platform": "macosx64", 19:34:08 INFO - "builduid": "5aadaee5329e490db7fd505d0b8ae85d", 19:34:08 INFO - "slavebuilddir": "test" 19:34:08 INFO - } 19:34:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 19:34:08 INFO - Running post-action listener: _resource_record_post_action 19:34:08 INFO - [mozharness: 2017-03-30 02:34:08.366752Z] Finished read-buildbot-config step (success) 19:34:08 INFO - [mozharness: 2017-03-30 02:34:08.366891Z] Running download-and-extract step. 19:34:08 INFO - Running pre-action listener: _resource_record_pre_action 19:34:08 INFO - Running main action method: download_and_extract 19:34:08 INFO - mkdir: /builds/slave/test/build/tests 19:34:08 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')]} 19:34:08 INFO - trying https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 19:34:08 INFO - Downloading https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/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 19:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/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 19:34:09 INFO - Downloaded 1165 bytes. 19:34:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 19:34:09 INFO - Using the following test package requirements: 19:34:09 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 19:34:09 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 19:34:09 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 19:34:09 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 19:34:09 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 19:34:09 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:34:09 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 19:34:09 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 19:34:09 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 19:34:09 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 19:34:09 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 19:34:09 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 19:34:09 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 19:34:09 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 19:34:09 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 19:34:09 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 19:34:09 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 19:34:09 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 19:34:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 19:34:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 19:34:09 INFO - Fetch https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 19:34:10 INFO - Expected file size: 16108771 19:34:10 INFO - Obtained file size: 16108771 19:34:17 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 19:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 19:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 19:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 19:34:18 INFO - Expected file size: 16108771 19:34:18 INFO - Obtained file size: 16108771 19:34:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 19:34:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 19:34:24 INFO - Fetch https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 19:34:25 INFO - Expected file size: 14403663 19:34:25 INFO - Obtained file size: 14403663 19:34: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')]} 19:34:26 INFO - trying https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 19:34:26 INFO - Downloading https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 19:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/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 19:34:27 INFO - Downloaded 58690715 bytes. 19:34:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 19:34:27 INFO - mkdir: /builds/slave/test/properties 19:34:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:34:27 INFO - Writing to file /builds/slave/test/properties/build_url 19:34:27 INFO - Contents: 19:34:27 INFO - build_url:https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 19:34:28 INFO - Running post-action listener: _resource_record_post_action 19:34:28 INFO - Running post-action listener: set_extra_try_arguments 19:34:28 INFO - [mozharness: 2017-03-30 02:34:28.644485Z] Finished download-and-extract step (success) 19:34:28 INFO - [mozharness: 2017-03-30 02:34:28.644639Z] Running populate-webroot step. 19:34:28 INFO - Running pre-action listener: _resource_record_pre_action 19:34:28 INFO - Running main action method: populate_webroot 19:34:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:34:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:34:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:34:28 INFO - '--tppagecycles', 19:34:28 INFO - '7'], 19:34:28 INFO - 'tests': ['tsvgm']}}, 19:34:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:34:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:34:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:34:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:34:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:34:28 INFO - 'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:34:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:34:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:34:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:34:28 INFO - 'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['damp', 'tps']}, 19:34:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:34:28 INFO - 'tests': ['damp', 'tps']}, 19:34:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['dromaeo_dom']}, 19:34:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:34:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['basic_compositor_video']}, 19:34:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:34:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['a11yr', 19:34:28 INFO - 'ts_paint', 19:34:28 INFO - 'tpaint', 19:34:28 INFO - 'sessionrestore', 19:34:28 INFO - 'sessionrestore_no_auto_restore', 19:34:28 INFO - 'tabpaint']}, 19:34:28 INFO - 'other-e10s': {'tests': ['a11yr', 19:34:28 INFO - 'ts_paint', 19:34:28 INFO - 'tpaint', 19:34:28 INFO - 'sessionrestore', 19:34:28 INFO - 'sessionrestore_no_auto_restore', 19:34:28 INFO - 'tabpaint']}, 19:34:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:34:28 INFO - 'ts_paint', 19:34:28 INFO - 'tpaint', 19:34:28 INFO - 'sessionrestore', 19:34:28 INFO - 'sessionrestore_no_auto_restore', 19:34:28 INFO - 'tabpaint']}, 19:34:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:34:28 INFO - 'ts_paint', 19:34:28 INFO - 'tpaint', 19:34:28 INFO - 'sessionrestore', 19:34:28 INFO - 'sessionrestore_no_auto_restore', 19:34:28 INFO - 'tabpaint']}, 19:34:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['a11yr', 19:34:28 INFO - 'ts_paint', 19:34:28 INFO - 'tpaint', 19:34:28 INFO - 'sessionrestore', 19:34:28 INFO - 'sessionrestore_no_auto_restore', 19:34:28 INFO - 'tabpaint']}, 19:34:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['a11yr', 19:34:28 INFO - 'ts_paint', 19:34:28 INFO - 'tpaint', 19:34:28 INFO - 'sessionrestore', 19:34:28 INFO - 'sessionrestore_no_auto_restore', 19:34:28 INFO - 'tabpaint']}, 19:34:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['tsvgx', 19:34:28 INFO - 'tsvgr_opacity', 19:34:28 INFO - 'tart', 19:34:28 INFO - 'tscrollx', 19:34:28 INFO - 'cart', 19:34:28 INFO - 'tsvg_static']}, 19:34:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:34:28 INFO - 'tsvgr_opacity', 19:34:28 INFO - 'tart', 19:34:28 INFO - 'tscrollx', 19:34:28 INFO - 'cart', 19:34:28 INFO - 'tsvg_static']}, 19:34:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:34:28 INFO - 'talos_options': ['--disable-e10s'], 19:34:28 INFO - 'tests': ['tp5o']}, 19:34:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:34:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:34:28 INFO - 'talos_options': ['--disable-e10s', 19:34:28 INFO - '--xperf_path', 19:34:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:34:28 INFO - 'tests': ['tp5n']}, 19:34:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:34:28 INFO - 'talos_options': ['--xperf_path', 19:34:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:34:28 INFO - 'tests': ['tp5n']}}, 19:34:28 INFO - 'talos.zip': {'path': '', 19:34:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:34:28 INFO - Running post-action listener: _resource_record_post_action 19:34:28 INFO - [mozharness: 2017-03-30 02:34:28.662597Z] Finished populate-webroot step (success) 19:34:28 INFO - [mozharness: 2017-03-30 02:34:28.662702Z] Running create-virtualenv step. 19:34:28 INFO - Running pre-action listener: _resource_record_pre_action 19:34:28 INFO - Running main action method: create_virtualenv 19:34:28 INFO - Creating virtualenv /builds/slave/test/build/venv 19:34:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:34:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:34:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:34:28 INFO - Using real prefix '/tools/python27' 19:34:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:34:29 INFO - Installing distribute.............................................................................................................................................................................................done. 19:34:32 INFO - Installing pip.................done. 19:34:32 INFO - Return code: 0 19:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:34:32 INFO - Reading from file tmpfile_stdout 19:34:32 INFO - Output received: 19:34:32 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) 19:34:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:32 INFO - 'HOME': '/Users/cltbld', 19:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:32 INFO - 'LOGNAME': 'cltbld', 19:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:32 INFO - 'MOZ_NO_REMOTE': '1', 19:34:32 INFO - 'NO_EM_RESTART': '1', 19:34:32 INFO - 'PAGER': '/bin/cat', 19:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:32 INFO - 'PWD': '/builds/slave/test', 19:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:32 INFO - 'SHELL': '/bin/bash', 19:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:32 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:32 INFO - 'USER': 'cltbld', 19:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:32 INFO - 'XPC_FLAGS': '0x0', 19:34:32 INFO - 'XPC_SERVICE_NAME': '0', 19:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:32 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 19:34:32 INFO - Cleaning up... 19:34:32 INFO - Return code: 0 19:34:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:32 INFO - 'HOME': '/Users/cltbld', 19:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:32 INFO - 'LOGNAME': 'cltbld', 19:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:32 INFO - 'MOZ_NO_REMOTE': '1', 19:34:32 INFO - 'NO_EM_RESTART': '1', 19:34:32 INFO - 'PAGER': '/bin/cat', 19:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:32 INFO - 'PWD': '/builds/slave/test', 19:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:32 INFO - 'SHELL': '/bin/bash', 19:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:32 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:32 INFO - 'USER': 'cltbld', 19:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:32 INFO - 'XPC_FLAGS': '0x0', 19:34:32 INFO - 'XPC_SERVICE_NAME': '0', 19:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:33 INFO - Downloading/unpacking psutil>=3.1.1 19:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:34:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:34:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:34:36 INFO - Installing collected packages: psutil 19:34:36 INFO - Running setup.py install for psutil 19:34:36 INFO - building 'psutil._psutil_osx' extension 19:34:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:34:37 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 19:34:37 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 19:34:37 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 19:34:37 INFO - building 'psutil._psutil_posix' extension 19:34:37 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 19:34:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:34:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:34:37 INFO - ^ 19:34:37 INFO - 1 warning generated. 19:34:37 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 19:34:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:34:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:34:37 INFO - Successfully installed psutil 19:34:37 INFO - Cleaning up... 19:34:37 INFO - Return code: 0 19:34:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:34: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')]} 19:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34: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')]} 19:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:34: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 mozsystemmonitor==0.3 19:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:37 INFO - 'HOME': '/Users/cltbld', 19:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:37 INFO - 'LOGNAME': 'cltbld', 19:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:37 INFO - 'MOZ_NO_REMOTE': '1', 19:34:37 INFO - 'NO_EM_RESTART': '1', 19:34:37 INFO - 'PAGER': '/bin/cat', 19:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:37 INFO - 'PWD': '/builds/slave/test', 19:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:37 INFO - 'SHELL': '/bin/bash', 19:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:37 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:37 INFO - 'USER': 'cltbld', 19:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:37 INFO - 'XPC_FLAGS': '0x0', 19:34:37 INFO - 'XPC_SERVICE_NAME': '0', 19:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:34:40 INFO - Installing collected packages: mozsystemmonitor 19:34:40 INFO - Running setup.py install for mozsystemmonitor 19:34:41 INFO - Successfully installed mozsystemmonitor 19:34:41 INFO - Cleaning up... 19:34:41 INFO - Return code: 0 19:34:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:41 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 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:41 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 19:34:41 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 19:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:41 INFO - 'HOME': '/Users/cltbld', 19:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:41 INFO - 'LOGNAME': 'cltbld', 19:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:41 INFO - 'MOZ_NO_REMOTE': '1', 19:34:41 INFO - 'NO_EM_RESTART': '1', 19:34:41 INFO - 'PAGER': '/bin/cat', 19:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:41 INFO - 'PWD': '/builds/slave/test', 19:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:41 INFO - 'SHELL': '/bin/bash', 19:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:41 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:41 INFO - 'USER': 'cltbld', 19:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:41 INFO - 'XPC_FLAGS': '0x0', 19:34:41 INFO - 'XPC_SERVICE_NAME': '0', 19:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:41 INFO - Downloading/unpacking jsonschema==2.5.1 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:34:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:44 INFO - Downloading functools32-3.2.3-2.tar.gz 19:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:34:44 INFO - warning: no files found matching '*.txt' 19:34:44 INFO - no previously-included directories found matching 'build' 19:34:44 INFO - no previously-included directories found matching 'dist' 19:34:44 INFO - no previously-included directories found matching '.git*' 19:34:44 INFO - Installing collected packages: jsonschema, functools32 19:34:44 INFO - Running setup.py install for functools32 19:34:44 INFO - warning: no files found matching '*.txt' 19:34:44 INFO - no previously-included directories found matching 'build' 19:34:44 INFO - no previously-included directories found matching 'dist' 19:34:44 INFO - no previously-included directories found matching '.git*' 19:34:44 INFO - Successfully installed jsonschema functools32 19:34:44 INFO - Cleaning up... 19:34:44 INFO - Return code: 0 19:34:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:44 INFO - 'HOME': '/Users/cltbld', 19:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:44 INFO - 'LOGNAME': 'cltbld', 19:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:44 INFO - 'MOZ_NO_REMOTE': '1', 19:34:44 INFO - 'NO_EM_RESTART': '1', 19:34:44 INFO - 'PAGER': '/bin/cat', 19:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:44 INFO - 'PWD': '/builds/slave/test', 19:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:44 INFO - 'SHELL': '/bin/bash', 19:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:44 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:44 INFO - 'USER': 'cltbld', 19:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:44 INFO - 'XPC_FLAGS': '0x0', 19:34:44 INFO - 'XPC_SERVICE_NAME': '0', 19:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:34:44 INFO - Cleaning up... 19:34:44 INFO - Return code: 0 19:34:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:44 INFO - 'HOME': '/Users/cltbld', 19:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:44 INFO - 'LOGNAME': 'cltbld', 19:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:44 INFO - 'MOZ_NO_REMOTE': '1', 19:34:44 INFO - 'NO_EM_RESTART': '1', 19:34:44 INFO - 'PAGER': '/bin/cat', 19:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:44 INFO - 'PWD': '/builds/slave/test', 19:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:44 INFO - 'SHELL': '/bin/bash', 19:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:44 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:44 INFO - 'USER': 'cltbld', 19:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:44 INFO - 'XPC_FLAGS': '0x0', 19:34:44 INFO - 'XPC_SERVICE_NAME': '0', 19:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:34:45 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 19:34:45 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 19:34:45 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 19:34:45 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 19:34:45 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 19:34:45 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 19:34:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:34:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:49 INFO - Downloading docopt-0.6.1.tar.gz 19:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:34:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:34:49 INFO - Running setup.py install for blobuploader 19:34:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:34:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:34:49 INFO - Running setup.py install for requests 19:34:49 INFO - Running setup.py install for docopt 19:34:50 INFO - Successfully installed blobuploader requests docopt 19:34:50 INFO - Cleaning up... 19:34:50 INFO - Return code: 0 19:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:34:50 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')]} 19:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:50 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')]} 19:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:50 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 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:50 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 19:34:50 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 19:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:50 INFO - 'HOME': '/Users/cltbld', 19:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:50 INFO - 'LOGNAME': 'cltbld', 19:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:50 INFO - 'MOZ_NO_REMOTE': '1', 19:34:50 INFO - 'NO_EM_RESTART': '1', 19:34:50 INFO - 'PAGER': '/bin/cat', 19:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:50 INFO - 'PWD': '/builds/slave/test', 19:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:50 INFO - 'SHELL': '/bin/bash', 19:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:50 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:50 INFO - 'USER': 'cltbld', 19:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:50 INFO - 'XPC_FLAGS': '0x0', 19:34:50 INFO - 'XPC_SERVICE_NAME': '0', 19:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:34:50 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-8wYFEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:34:50 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Vzquzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:34:50 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-45nMS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:34:50 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-qVyNr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:34:50 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-9fK9Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:34:50 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-jXqT_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-E5Mjld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Dy9XMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-S1yk4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-wJdxSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-1G9fKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Yb0Ywh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-edjvY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-eKU6US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:51 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-sg7FLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:34:52 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-b7Aofh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:34:52 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-UoREcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:34:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:34:52 INFO - Running setup.py install for manifestparser 19:34:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Running setup.py install for mozcrash 19:34:52 INFO - Running setup.py install for mozdebug 19:34:52 INFO - Running setup.py install for mozdevice 19:34:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Running setup.py install for mozfile 19:34:52 INFO - Running setup.py install for mozhttpd 19:34:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for mozinfo 19:34:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for mozInstall 19:34:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for mozleak 19:34:53 INFO - Running setup.py install for mozlog 19:34:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for moznetwork 19:34:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for mozprocess 19:34:54 INFO - Running setup.py install for mozprofile 19:34:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:34:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:34:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:34:54 INFO - Running setup.py install for mozrunner 19:34:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:34:54 INFO - Running setup.py install for mozscreenshot 19:34:54 INFO - Running setup.py install for moztest 19:34:54 INFO - Running setup.py install for mozversion 19:34:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:34:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:34:54 INFO - Cleaning up... 19:34:54 INFO - Return code: 0 19:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:34: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')]} 19:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34: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')]} 19:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:54 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 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:34:54 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 19:34:54 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 19:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:54 INFO - 'HOME': '/Users/cltbld', 19:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:54 INFO - 'LOGNAME': 'cltbld', 19:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:54 INFO - 'MOZ_NO_REMOTE': '1', 19:34:54 INFO - 'NO_EM_RESTART': '1', 19:34:54 INFO - 'PAGER': '/bin/cat', 19:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:54 INFO - 'PWD': '/builds/slave/test', 19:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:54 INFO - 'SHELL': '/bin/bash', 19:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:34:54 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:54 INFO - 'USER': 'cltbld', 19:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:54 INFO - 'XPC_FLAGS': '0x0', 19:34:54 INFO - 'XPC_SERVICE_NAME': '0', 19:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-OCQ4kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ff_njI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-OplhNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Pg1aue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-X_xKgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-wMvHiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-UgHjfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-lz9GFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:34:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-YF0S82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ZaPMqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-wWlbLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-mrmlRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-JyQWR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-iC1iRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-FD5a1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-MqwwKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:34:56 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-XXTpPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:34:56 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 19:34:56 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 19:34:56 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 19:34:56 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 19:34:56 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 19:34:56 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 19:34:59 INFO - Downloading blessings-1.6.tar.gz 19:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:34:59 INFO - Installing collected packages: blessings 19:34:59 INFO - Running setup.py install for blessings 19:34:59 INFO - Successfully installed blessings 19:34:59 INFO - Cleaning up... 19:34:59 INFO - Return code: 0 19:34:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:35:00 INFO - Reading from file tmpfile_stdout 19:35:00 INFO - Current package versions: 19:35:00 INFO - blessings == 1.6 19:35:00 INFO - blobuploader == 1.2.4 19:35:00 INFO - docopt == 0.6.1 19:35:00 INFO - functools32 == 3.2.3-2 19:35:00 INFO - jsonschema == 2.5.1 19:35:00 INFO - manifestparser == 1.1 19:35:00 INFO - mozInstall == 1.12 19:35:00 INFO - mozcrash == 1.0 19:35:00 INFO - mozdebug == 0.1 19:35:00 INFO - mozdevice == 0.49 19:35:00 INFO - mozfile == 1.2 19:35:00 INFO - mozhttpd == 0.7 19:35:00 INFO - mozinfo == 0.9 19:35:00 INFO - mozleak == 0.1 19:35:00 INFO - mozlog == 3.4 19:35:00 INFO - moznetwork == 0.27 19:35:00 INFO - mozprocess == 0.24 19:35:00 INFO - mozprofile == 0.28 19:35:00 INFO - mozrunner == 6.13 19:35:00 INFO - mozscreenshot == 0.1 19:35:00 INFO - mozsystemmonitor == 0.3 19:35:00 INFO - moztest == 0.8 19:35:00 INFO - mozversion == 1.4 19:35:00 INFO - psutil == 3.1.1 19:35:00 INFO - requests == 1.2.3 19:35:00 INFO - wsgiref == 0.1.2 19:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:01 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 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:35:01 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 19:35:01 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 19:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:01 INFO - 'HOME': '/Users/cltbld', 19:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:01 INFO - 'LOGNAME': 'cltbld', 19:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:01 INFO - 'MOZ_NO_REMOTE': '1', 19:35:01 INFO - 'NO_EM_RESTART': '1', 19:35:01 INFO - 'PAGER': '/bin/cat', 19:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:01 INFO - 'PWD': '/builds/slave/test', 19:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:01 INFO - 'SHELL': '/bin/bash', 19:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:35:01 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:01 INFO - 'USER': 'cltbld', 19:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:01 INFO - 'XPC_FLAGS': '0x0', 19:35:01 INFO - 'XPC_SERVICE_NAME': '0', 19:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 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)) 19:35:01 INFO - Cleaning up... 19:35:01 INFO - Return code: 0 19:35:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:01 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 0x10716bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342476e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, '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.i6xNEOWHos/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.ccno699742/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 19:35:01 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 19:35:01 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 19:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:01 INFO - 'HOME': '/Users/cltbld', 19:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:01 INFO - 'LOGNAME': 'cltbld', 19:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:01 INFO - 'MOZ_NO_REMOTE': '1', 19:35:01 INFO - 'NO_EM_RESTART': '1', 19:35:01 INFO - 'PAGER': '/bin/cat', 19:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:01 INFO - 'PWD': '/builds/slave/test', 19:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:01 INFO - 'SHELL': '/bin/bash', 19:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:35:01 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:01 INFO - 'USER': 'cltbld', 19:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:01 INFO - 'XPC_FLAGS': '0x0', 19:35:01 INFO - 'XPC_SERVICE_NAME': '0', 19:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:35:02 INFO - Cleaning up... 19:35:02 INFO - Return code: 0 19:35:02 INFO - Running post-action listener: _resource_record_post_action 19:35:02 INFO - Running post-action listener: _start_resource_monitoring 19:35:02 INFO - Starting resource monitoring. 19:35:02 INFO - [mozharness: 2017-03-30 02:35:02.283686Z] Finished create-virtualenv step (success) 19:35:02 INFO - [mozharness: 2017-03-30 02:35:02.284679Z] Running install step. 19:35:02 INFO - Running pre-action listener: _resource_record_pre_action 19:35:02 INFO - Running main action method: install 19:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:35:02 INFO - Reading from file tmpfile_stdout 19:35:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:35:02 INFO - Reading from file tmpfile_stdout 19:35:02 INFO - Output received: 19:35:02 INFO - Usage: mozinstall [options] installer 19:35:02 INFO - Options: 19:35:02 INFO - -h, --help show this help message and exit 19:35:02 INFO - -d DEST, --destination=DEST 19:35:02 INFO - Directory to install application into. [default: 19:35:02 INFO - "/builds/slave/test"] 19:35:02 INFO - --app=APP Application being installed. [default: firefox] 19:35:02 INFO - mkdir: /builds/slave/test/build/application 19:35:02 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'] 19:35:02 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 19:35:17 INFO - Reading from file tmpfile_stdout 19:35:17 INFO - Output received: 19:35:17 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:35:17 INFO - Running post-action listener: _resource_record_post_action 19:35:17 INFO - [mozharness: 2017-03-30 02:35:17.223253Z] Finished install step (success) 19:35:17 INFO - [mozharness: 2017-03-30 02:35:17.223416Z] Running run-tests step. 19:35:17 INFO - Running pre-action listener: _resource_record_pre_action 19:35:17 INFO - Running main action method: run_tests 19:35:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:35:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:35:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:35:17 INFO - 2017-03-29 19:35:17.237 screenresolution[1623:7273] starting screenresolution argv=screenresolution get 19:35:17 INFO - 2017-03-29 19:35:17.240 screenresolution[1623:7273] Display 0: 1600x1200x32@60 19:35:17 INFO - 2017-03-29 19:35:17.245 screenresolution[1624:7275] starting screenresolution argv=screenresolution list 19:35:17 INFO - Available Modes on Display 0 19:35:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:35:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:35:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:35:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:35:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:35:17 INFO - Intel Iris: 19:35:17 INFO - Chipset Model: Intel Iris 19:35:17 INFO - Type: GPU 19:35:17 INFO - Bus: Built-In 19:35:17 INFO - VRAM (Dynamic, Max): 1536 MB 19:35:17 INFO - Vendor: Intel (0x8086) 19:35:17 INFO - Device ID: 0x0a2e 19:35:17 INFO - Revision ID: 0x0009 19:35:17 INFO - Displays: 19:35:17 INFO - Display: 19:35:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:35:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:35:17 INFO - Display Serial Number: 1600x1200 60 19:35:17 INFO - Main Display: Yes 19:35:17 INFO - Mirror: Off 19:35:17 INFO - Online: Yes 19:35:17 INFO - Rotation: Supported 19:35:17 INFO - Return code: 0 19:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:35:17 INFO - Python 2.7.3 19:35:17 INFO - Return code: 0 19:35:17 INFO - grabbing minidump binary from tooltool 19:35:17 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')]} 19:35:17 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 0x106f49d30>, '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 0x106e70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f3ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:35:17 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 19:35:17 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 19:35:17 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 19:35:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:35:17 INFO - Return code: 0 19:35:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:35:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:35:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:35:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:35:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:35:17 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/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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 19:35:17 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/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0012 --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 19:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6xNEOWHos/Render', 19:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:17 INFO - 'HOME': '/Users/cltbld', 19:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:17 INFO - 'LOGNAME': 'cltbld', 19:35:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:35:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:17 INFO - 'MOZ_NO_REMOTE': '1', 19:35:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:35:17 INFO - 'NO_EM_RESTART': '1', 19:35:17 INFO - 'PAGER': '/bin/cat', 19:35:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:17 INFO - 'PWD': '/builds/slave/test', 19:35:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:17 INFO - 'SHELL': '/bin/bash', 19:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ccno699742/Listeners', 19:35:17 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 19:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:17 INFO - 'USER': 'cltbld', 19:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:17 INFO - 'XPC_FLAGS': '0x0', 19:35:17 INFO - 'XPC_SERVICE_NAME': '0', 19:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:17 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/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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 19:35:17 INFO - mozversion application_buildid: 20170329183958 19:35:17 INFO - mozversion application_changeset: 4b4a2a430c62de7204392ea83df41fae2ea00cd3 19:35:17 INFO - mozversion application_display_name: Firefox 19:35:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:35:17 INFO - mozversion application_name: Firefox 19:35:17 INFO - mozversion application_remotingname: firefox 19:35:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:35:17 INFO - mozversion application_vendor: Mozilla 19:35:17 INFO - mozversion application_version: 53.0 19:35:17 INFO - mozversion platform_buildid: 20170329183958 19:35:17 INFO - mozversion platform_changeset: 4b4a2a430c62de7204392ea83df41fae2ea00cd3 19:35:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:35:17 INFO - mozversion platform_version: 53.0 19:35:17 INFO - using testdate: 1490841317 19:35:17 INFO - actual date: 1490841317 19:35:17 INFO - starting webserver on 'localhost:49236' 19:35:17 INFO - SUITE-START | Running 2 tests 19:35:17 INFO - TEST-START | dromaeo_css 19:35:17 INFO - operating with platform_type : mac_ 19:35:17 INFO - Initialising browser for dromaeo_css test... 19:35:17 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpOUvNWr/profile http://localhost:49236/getInfo.html) 19:35:20 INFO - PROCESS | 1634 | 2017-03-29 19:35:20.522 plugin-container[1637:7440] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 19:35:20 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:35:20 INFO - PROCESS | 1634 | 2017-03-29 19:35:20.522 plugin-container[1637:7440] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d13, name = 'com.apple.CFPasteboardClient' 19:35:20 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:35:20 INFO - PROCESS | 1634 | 2017-03-29 19:35:20.522 plugin-container[1637:7440] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:35:20 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 19:35:20 INFO - PROCESS | 1634 | colorDepth:24 19:35:20 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 19:35:20 INFO - PROCESS | 1634 | __metrics 19:35:20 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 19:35:21 INFO - TEST-INFO | 1634: exit 0 19:35:21 INFO - Browser initialized. 19:35:21 INFO - Running cycle 1/1 for dromaeo_css test... 19:35:21 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpOUvNWr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:35:23 INFO - PROCESS | 1638 | 2017-03-29 19:35:23.694 plugin-container[1639:7570] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8547, name = 'com.apple.tsm.portname' 19:35:23 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:35:23 INFO - PROCESS | 1638 | 2017-03-29 19:35:23.695 plugin-container[1639:7570] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 19:35:23 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:35:23 INFO - PROCESS | 1638 | 2017-03-29 19:35:23.695 plugin-container[1639:7570] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:35:33 INFO - PROCESS | 1638 | RSS: Main: 173035520 19:35:33 INFO - PROCESS | 1638 | 19:38:34 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 19:38:36 INFO - PROCESS | 1638 | RSS: Main: 188960768 19:38:36 INFO - PROCESS | 1638 | 19:41:39 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 19:41:39 INFO - PROCESS | 1638 | RSS: Main: 199094272 19:41:39 INFO - PROCESS | 1638 | 19:44:41 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 19:44:42 INFO - PROCESS | 1638 | RSS: Main: 203284480 19:44:42 INFO - PROCESS | 1638 | 19:47:44 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 19:47:44 INFO - PROCESS | 1638 | RSS: Main: 206327808 19:47:44 INFO - PROCESS | 1638 | 19:50:47 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 19:50:48 INFO - PROCESS | 1638 | RSS: Main: 207667200 19:50:48 INFO - PROCESS | 1638 | 19:53:50 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 19:53:51 INFO - PROCESS | 1638 | RSS: Main: 208703488 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | __start_tp_report 19:53:51 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 19:53:51 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 19:53:51 INFO - PROCESS | 1638 | |i|pagename|runs| 19:53:51 INFO - PROCESS | 1638 | |0;dojo.html;3521.436570148776;3524.3303772283266;3532.275883443894;3534.7879127252368;3534.9469757953625;5986.012307969186;5999.82000539984;6050.122732203828;6058.303295121057;6087.695615219243;6014.669193194372;6105.572609917308;6105.725242364093;6109.633421994683;6127.908081378783;5444.6932736143335;5483.122700367942;5489.670619762827;5491.368492623339;5567.8886422271535;4247.15056988602;4565.406497155365;5528.9494995950845;5563.304586926634;5603.80386686466;4377.540358262384;4949.579285760715;5416.647917885344;5537.496464002288;5592.99326121298;4453.309736990739;5026.195808670614;5067.594592432615;5524.14375771756;5601.551875849922;4814;5034.194528875399;5375.220593013991;5537.252470916415;5542.307211598551;4686.507916668769;5183.578837966924;5873.442023007808;6003.939960600425;6093.421124993119;6201.441870231701;6207.503399728056;6210.751569937197;6221.937780622181;6366.87266254677;6468.482521398277;6471.255805582324;6472.838179045514;6493.188351456068;6493.935060649427;6081.391860813927;6130.754769809247;6140.600860944024;6156.815295541186;6158.261008678987;5489.4236105209175;6266.586338582895;6319.273283572356;6371.776987805404;6387.457066149429;6150.538709596709;6258.15514905491;6258.280297765724;6269.247690277196;6275.215598050244;6355.332690067568;6387.840303992437;6390.456811171102;6390.488760899117;6417.839554011093;6165.445109940038;6183.072539119168;6187.721552530147;6202.379762023852;6225.315215326311;6275.309715931244;6283.183186185858;6288.339724328879;6293.402126797947;6373.840653983688;4259.701820872509;5142.948570514322;5164.14791559396;5165.715885626251;5172.870678233075;4485.0805584855025;4557.293619488984;4587.243104887723;4640.79116439761;4658.254679251304;5578.716895114066;5600.4399560044485;6117;6119.959572021022;6130.111133885562;6360.618362898241;6394.8721025579225;6401;6403.071554624554;6409.7115629795835;4754.595859351924;5765.279340082489;5774.82675519735;5980.461758441761;6130.417610327012;5660.8867822643315;5672.546196304285;5679.517241034476;5686.772529098873;5710.029295019774;6598.241202261801;6602.141721576164;6610.041543976096;6611.73553057882;6612.603243805387;6144.095330447575;6246.187995560548;6246.968765156145;6270.372962703693;6338.239411270677;6629.966850165718;6638;6647.767328143492;6649.667516624246;6650.3682150195655;6300.306966233619;6315.557910946373;6319.431251187415;6331.651759153291;6332.588381755171;4714.175019371665;6161.260648722003;6255.499560035278;6375.298717141203;6418.807435776934;6048.969755151196;6178.5366097543765;6235.158253635883;6249.468795152463;6257.906131407942;4750.741053620863;5879.911801322898;6221.844453888689;6225.750969961151;6245.0632405139595;4763.976180119216;6108.402780883668;6131.284916201153;6212.72042758086;6240.812775616739;6152.953997820292;6164.291106522807;6213.844653883689;6216.098665693539;6225.595336303126;6235.812925612239;6245.406686364788;6249.468795152463;6252.812415627538;6253.093301471352 19:53:51 INFO - PROCESS | 1638 | |1;ext.html;450.80615335405764;459.24225028702637;509.84449742828446;544.1728572569693;564.0608387035586;38974.61025389745;41628.79185604071;41742.58257417429;41764.37353439701;41800.95497612561;42993.35509967345;43441.782791086;43555.6933292001;43583.78208108955;43614;9498.335116541844;9712.66005689801;9749.878763942166;11477.770444591104;11832.053435725122;11589.53641854329;11634.418279086054;11683.357415342152;11709.063274937984;11716.824247636292;11730.53077876884;11762.294262344243;11764.941175294112;11772.528433945758;11786.705332366673;9939.652112176076;11662.475188616532;11707;11710.180287379844;11726.237794543327;11684.00685941696;11696.766064678744;11738.647840564796;11756;11765.764684706344;38235;38389.424158637645;38468;38579.807100964594;38652.033699157466;4031.5363733170475;4057.3102572562734;4068.9593104068877;4151.813168407429;4164.167166566699;27963.440731185263;28508.144755657362;28686.569701454497;28716.712832871614;30880.8455957721;3319.203391186122;3470.7396945228957;3491.6333784952467;3521.454174602941;3523.823808809549;499223;500139;501856;505640;505957;58921;58999.41000590025;59400.70299648474;59422.10866837001;59457.70271148616;58971.41028589745;61910.380896190465;62053.069203961975;62104.689476552325;62120.68939655363;13638.931805341108;16439.6712065758;16527.91736041312;16548.42080527176;16551.91724041372;11381.260218085798;11424.714382140346;11571.768564628828;12790.36048197605;13116.278604676834;18409.81590184081;21223.893880530806;22420.66369004466;22582.548349033255;22583.7578933157;9118.772030699285;9345;9354.71935841926;9375.343725939256;9411.05889411067;854.4275335525213;856.0754385264024;896.3143195455482;898.1333013641867;917.3899356927568;29826.40347193044;30452.39095218083;30531.542026869614;31592.684073158973;31985.680143198737;994.7811481474064;1011.3830563356347;1032.5043978890176;1046.6441409920512;1062.436908438529;12873.613791586267;13632.250226237653;14739.852601474062;14961.625959350886;15170.360338380608;682023;686948;687687;688562;688843.5557822179;47490.81272968134;47497.52502475;47715;47808;48080.03839923252;1410.9717805644034;1428.435767871685;1454.1493226462637;1458;1459.408939379553;27938.72061279361;28068.43863122767;28780.848766049123;28865.80466358961;28910.710892890802;47744.2838357418;47782.522174777805;48342.27486587634;48486.272705910145;48524.514754851996;623191;623447.8827605833;626526;626965;627280;26175.607365889147;26902.461950760484;27582.86208568944;27602.585961210196;28531.572026419206;36203.81898090493;43474.782626086664;44926.55073449224;44982.77508612436;45344;30464;30763.230919226302;30809;31247.53128703026;31580.684193157773;30581.847090764404;30945.535816962314;31090;31504.369912602077;31607.20981975469;35941.460878087375;36110.63889361178;36520.81739591285;36742.44886326761;36745.265094698494;30987.380252394374;31167.376652467276;31168.844155779076;31195.84402077975;31589.52615710812;23547.41131471727;24480.51038979246;24875.87562062178;24930.75069249357;25203.873980629978 19:53:51 INFO - PROCESS | 1638 | |2;jquery.html;382.1897577136471;382.47600786921913;395.10311592684627;398.57949862894645;424.14111424365655;18657.34699285525;20614.48463788406;21599.568008639817;22027.559448811033;22045.669314960287;20999.160033598677;21922.89038554809;22586.88706556469;23335.766642333572;23448.88275558624;5506.972465137669;6037.516998640121;6153.846153846145;6155.569110162291;6156.630602163862;5812.825615231529;5979.46184843364;5980.940190598104;6014.4286292802335;6076.361981991893;5927.911081333784;5963.433473820002;5965.313988891268;5979.043353063511;5991.460768530831;5702.173184888189;5947.6134051286745;5961.016432288668;6008.158857759917;6008.609440386361;5235.293235413209;5317.361916569997;5324.92012619811;5335;5396.244525766396;22605.43486412853;22764.886175569183;22901.427464313358;22916.54166916669;27192.72807271922;2786.986065069682;2847.03200911691;2882.394697113588;2884.307766136133;2888.8844446222124;15600.453984110502;15790.605234869105;16442.588935276595;16647.41734039315;16856.915715421466;1884.9905750471296;1889.5842914558912;1890.914908829106;1900.6103748731616;1914.4639500939759;106098.46950765197;124197;128948.71051289461;136302.95545566923;138942;10558.366498010144;11795.761445048318;11822.408879555987;11980.161388702882;11986.101042421853;10842.783144337069;14283.714325713427;15052;15064;15141.167235802137;8697.304215662733;8760.605772740115;8970.68602598919;8979.46123232608;9195.172434480928;8836.646534138563;8866.601002954883;8884.689035883714;8956.596953137125;8967.910320896837;7469.514481558681;7547.471676982668;7592.126905405949;7616.885746713804;7620.009398778124;1962.3033822992918;1982.3359174676646;1983.9504012399516;1990.5919286546223;1990.850686198512;1043.7964596903682;1055.8627378440908;1066.6746642274027;1078.6710053433778;1120.1598800899326;22871.88564057169;23235.419114521934;23263.06947722106;23281.650775238384;23314.533709326057;944.5985456181232;989.2391543053377;1084.4035780320792;1111.288775183883;1123.9269447485888;11575.247608905394;12098.637040888787;12200.51197952072;12249.510019599295;12309.44607492647;649139;715662;744650;775750;789804;119046.4047679756;141801.8729719055;142864.28567857094;143556;143651;1072.4316112460408;1081.7241603391085;1112.593903225317;1113.4154568851418;1115.6597237842373;19709.40871773849;20100.79899200989;20339.59320813605;20458.69311960292;20517.281895133598;48041;54919.725401372736;56469;58107.709461452425;59221;82985.75521367305;84608;84817.57591212004;85240;86641.40075797736;8243.629036693243;8391.07698153215;8421.07368189511;8504;8758.518281494578;13279.867201327863;13384.531541396005;13540.322983850965;13806.240656763974;13890.722185556031;11473.655790326304;11694.88305116972;11781.293122412682;11927.821082683593;11997.520099195934;11049.889501104886;11071.003609675168;11085.113190944867;11291.717707057389;11535.480903359537;11843.822342664695;12048.638540843789;12110.152289339661;12128;12174.695632609255;6967;8212.3430125591;8351.415400921876;8749;8766.956165219388;10494.108000820015;11145.49845256949;11563.884361156617;11876.940615296868;12015.699607509532 19:53:51 INFO - PROCESS | 1638 | |3;mootools.html;1180.9055275577944;1482.0662982321137;1496.663250768577;1496.7380708376036;1503.7969874067005;7807.843843123148;8049.678012879493;8282.213189746972;8719.389642725011;8767.956160219197;8290.336773058156;8548;8562.058173600899;8655.43739656922;8673.956630216855;1824.4253060286035;2385.9045638174453;2420.9273721788286;2430.2587710748217;2435.062500937143;2042.765082015565;2150.5591253859952;2221.489057516764;2271.1029143488313;2399.6400539919064;2138.9251376201837;2210.370044537307;2215.0475295622878;2224.088123869214;2233.463968647521;2397.1969390254285;2398.65219543167;2421.0678888628004;2421.4309637235237;2430.5746494363416;2025.6252593270292;2413.2880800163994;2420;2443.389152711822;2453.815963802722;7631.503952243086;8675.26260267878;8698.608562614698;8737.650493980233;8779.078196789309;4104.8768536943935;4619.307103934437;5309.548688361455;5419.970205660912;5527.115661494142;3439.226174110805;3663.1025398777206;3671.430928206132;3720.4233343831747;3731.776093434403;1214.6477521518748;1241.2862604002735;1268.6828292926768;1276.0875973678865;1305.4908585651604;11113.444327783578;11165.441727913652;11189.776204475866;11197.66407007791;11207.551697932073;4763.071201115818;4874.8537543873745;4923.212286034217;4929.211326187793;4935.087008903364;9651.855222171673;9709.757256068655;9800.656977005914;9832.950835245778;9856.014398560086;5471.753771080311;5501.614886957955;5504.752286147133;5505.944940550623;5525.834224973257;4844.515548445127;4948.8762780930765;4966.379202599675;5006.874828129326;5059.8988020239385;4013.150771229721;4065.10567675111;4137.420761093449;4171.958280417218;4186.769727664947;1230.1450491908038;1271;1297.9935100324626;1310.2924420812844;1333.8132661427408;927.1192367251003;931.9301052421096;938.3244064273712;945.5603144537823;976.9706908792748;5663.631863928831;5711.885762284731;5957.463828255478;6024.397560244028;6096.908546371808;960.6982538660154;1013.807376598444;1021.213665477578;1032.6282538286212;1075.623531763892;3742.2702572998546;3949.6642785363565;4032.572313533473;4041.656459201001;4045.1505183911117;9624.566894489764;10012.098911098035;10135.49322533885;10150.98490150979;10163.491825408848;9884.65403710881;9993.450360230258;10107.7473063174;10142.239332050125;10174.796504069876;8049.436539442183;8140.430169888169;8143.982002249719;8155.388345874083;8193.262606365455;5627;5657.321121465286;5748.770049198152;5823.4467725566;5888.087346461305;9349.953250233706;9351.39215950961;9460.337776355864;9479.763005924908;9484.430934143973;9095.590698418719;9368.15686588183;9372.95313523428;9441.669541566012;9567.904320956979;7367.373773229336;7468.10382754073;7488.026556547614;7492.662830172546;7495.7001719930595;7716.074071111502;8045.557494337868;8094.392920530866;8094.433389662667;8106.797330066795;6817.7272909083085;7056.15326160864;7135.322144396482;7140.607266600179;7264.019357386685;6944.826379340557;6998.650067496503;7018;7022.508424410242;7030.437564994891;6481.708323125565;6602.3397660233595;6612.900806488003;6629.701663425061;6630.734770609314;4471.910561788811;4674.74288914113;5008.248762685626;5054.570361519165;5146.356705411824;5092.134337162617;5092.414372347227;5181.1969144782615;5263.499967503081;5268.4994925482015 19:53:51 INFO - PROCESS | 1638 | |4;prototype.html;267.7202323571867;358.3605007092549;360.75108175359003;375.8459031796964;376.1799277574887;5338.62629615927;5530.073647710131;5538.7784488620455;5621.2692349994495;5714.285714285715;5047.394312682474;5380.515753582177;5486;5506.201600767887;5583;3927.803609819512;4101.774402407881;4357.411749413836;4366.301391777316;4387.780610969438;3383.1034775784437;3467.219875528011;4348.934765978513;4349.13017396522;4392.3631073494325;4162.43807086044;4167;4171.937420938689;4197;4211.978940105295;4059.6346328830546;4173.081921977145;4188.32986722126;4190.371444283367;4199.517055538621;3634.56385233771;3643.198496330803;3643.6902863256655;3644.69020133289;3664.5236119304586;5216.5915202895;5378.91931621026;5403.729813509348;5419.051665958442;5442.591805614595;4672.0799500312305;4815.362776655954;4827.348307978413;4831.85504434864;4837.758112094381;4654.581087702123;5109.872253193663;5604.635698679614;5877.764889404419;5916.97041514794;3550.1834578046937;3782.3569993101237;3975.8012099395205;3979.5025621797276;4011.1548687603736;5416.133418652997;5682.829515114553;6150.108234306045;6157.768446310756;6211.81364559064;3381;4054.493188351456;4071.633552980187;4079.286124928126;4084.223997440477;3595.5325807645363;3615.94576081359;4072.063425412172;4382.9342559861625;4544.363789069533;5003.874903127378;5006.424261210008;5026.472220416804;5063.493650634907;5063.9618878129895;4539.0694907543875;4801.18379875422;5278.9472105278455;5996.280446346379;6002.849928751816;1235.3576140406938;1298.513202383266;1314.59247633234;1431.169921445559;1457.890658200639;864.3992425264381;877.3814460805118;887.0065526610109;999.14073896449;1017.2777328097134;4465.910681786346;4917.336159618406;5162.167430562172;5171.612129090333;5216.295800067019;4833.830815921426;5347.144456886879;5579.330480342385;5736.77052917887;5795.13073039039;4652.581267685924;4792.507895894116;5138.073222541547;5153.819616313411;5188.092083885381;2616.5944278636844;2961.9337038666063;2991.100651086576;2999.820010799359;3022.501287287617;4591;4963.478834722302;5094.949050509522;5967.582269241111;5969.1495636352865;4964.386574363274;4999.625028122905;5263.552598029134;5467.535259502907;6181.412765787243;5284.652413634575;5513.365962914316;6310.958691815799;6330.651814150266;6357.364263573698;5040.596752259884;5746.224259725051;5999.130126131774;6086.878262434638;6141.7543298267565;5232.540705868236;5962.821115366546;5997.7404745002295;6016.759329626766;6043.516518678583;5554.777808887599;6272.052135496309;6305.148804911279;6316.810495685137;6318.0414071636105;3329.3840639481773;3497.0208341664375;4007.4971885542923;4042.838286468508;4074.5925407459017;5606.6636001840025;5669.809340038638;6082.817515474543;6088.726007329592;6108.541859360477;4207.873763787091;4687.882802929954;5382.381026182039;5679;5864.824055278348;4708.905821883612;5739.196512488338;5842.211301474246;5875.882482350415;5916.911246331395;5445.455454454523;5699.857503562444;5728.283964504437;5738.942610573841;5776.306843178677;4939.308496810378;5846.41535846412;5853.151293062568;5904.3210030847;5925.466707996128;5736.762662561688;5759.308882933907;5789.942100579109;5791.9131213031;5822.679752613647 19:53:51 INFO - PROCESS | 1638 | |5;yui.html;638.4987784589099;729.6388287797541;772.910196622762;852.5609311204729;860.3590325207721;15172.165530895796;15949.20253987299;16077;17626.559336016606;18509.62980740388;14166.220857852813;16458.259378327974;17109.716771242143;17332.653346933053;17629.911850440763;854.615423059624;871.4727589808169;875.7460336502438;876.97807554811;877.9868301975475;583.6877270660198;698.2458944340101;844.2865778417228;861.3970220845401;864.2826454043129;923.1922068190333;931.5388882503137;932.8087742012905;935.4854829843558;936.7096200177966;827.6854795177824;868.4745728834059;934.0472717827778;936.279065119854;936.5223735894708;684.6097724297152;685.8388278754488;693.3759616345279;693.7675878580682;694.0214297840072;14018.158910465405;15972.840271597252;16364.427245046485;16566.337346506127;16829.495115146565;14294.71410571793;14589.70820583593;14637.853621463863;14652.194129322883;14656.560303190921;11894.88105118955;11993.700157496045;12021.278723276631;12038.217515861441;12048.156629035971;3740.532433445819;3757.4176002719623;3779.3764028935193;3882.068303607114;3885.0870045539277;101261.4936925318;114333;115662.84337156605;117621;123275;9661.613535458644;10777.245592808586;10880.61917832888;11466.942665286788;11879.524819007143;23050.423739406648;23464.944077516553;23507.529849402916;23583;23584.64623030656;7869.921300787033;7871.763847084597;7953.739566853949;8004.319632831274;8233.423660343718;4462.843800466968;4466.845234853497;4490.461144662661;4528.909421811545;4538.500764915857;3695.242475292612;3725.2549490102087;3748.381517049711;3803.3724435468393;3807.961920380816;673.5588189735633;675.9695813688396;676.3844901140037;684.8082536889679;690.7858563845224;673.5049738442241;683.7265093962454;686.2759788423261;708.6500217086459;710.7192658899705;9726.297897867846;9778.266630002778;10586.629467968583;10710.678679639623;10782.67651970442;689.3761146162731;716.3409663109951;716.3695947566213;717.4224749076939;723.2297603052732;5061.5950723942;5278.841634750964;5282.656627319288;5284.656497327662;5375.3012108425655;91751;100549.99450005553;104979.475102624;109659.90340096496;117816.23275650872;75097.87353189707;76427.23572764313;76563.61718191374;77412.83880741794;79895;75162.87255691279;77346.6132669333;78565;80819.7877031845;83285;10775.838362424412;11078.446077695922;11158.553657853596;11283.266587671775;11433.714157146138;48860;49393.753031236054;49516.75241623913;51440.713982150744;52910;67099;68470;69290.65354673195;69961;70324;13417.798733018817;13621.25083120438;13636.522721704692;14188.574342769733;14796.704065918837;14503.492377766728;14675.853241467448;14714;14926.925365373103;15474.613134671723;14094;14301.213433260855;14417.711645767236;14514.491992780202;14569.781453278421;11613.709657258636;14228;14259.42962281497;14530.346134424188;15086.019408738397;12206.084543659439;13415.262160581262;14416.855831441551;14557.563273101823;14921.253937302874;7578.962105189439;8447.704330348408;8693.434926729742;9116.4074335168;9485.715428537154;9240;10763.784724305313;11409.486573104396;11519.827202592136;11603.941980290045 19:53:51 INFO - PROCESS | 1638 | __end_tp_report 19:53:51 INFO - PROCESS | 1638 | __start_cc_report 19:53:51 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,385 19:53:51 INFO - PROCESS | 1638 | __end_cc_report 19:53:51 INFO - PROCESS | 1638 | __startTimestamp1490842431235__endTimestamp 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | ------- Summary: start ------- 19:53:51 INFO - PROCESS | 1638 | Number of tests: 6 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5847.62 Median:6150.54 stddev:709.15 (11.5%) stddev-sans-first:687.44 19:53:51 INFO - PROCESS | 1638 | Values: 3521.4 3524.3 3532.3 3534.8 3534.9 5986.0 5999.8 6050.1 6058.3 6087.7 6014.7 6105.6 6105.7 6109.6 6127.9 5444.7 5483.1 5489.7 5491.4 5567.9 4247.2 4565.4 5528.9 5563.3 5603.8 4377.5 4949.6 5416.6 5537.5 5593.0 4453.3 5026.2 5067.6 5524.1 5601.6 4814.0 5034.2 5375.2 5537.3 5542.3 4686.5 5183.6 5873.4 6003.9 6093.4 6201.4 6207.5 6210.8 6221.9 6366.9 6468.5 6471.3 6472.8 6493.2 6493.9 6081.4 6130.8 6140.6 6156.8 6158.3 5489.4 6266.6 6319.3 6371.8 6387.5 6150.5 6258.2 6258.3 6269.2 6275.2 6355.3 6387.8 6390.5 6390.5 6417.8 6165.4 6183.1 6187.7 6202.4 6225.3 6275.3 6283.2 6288.3 6293.4 6373.8 4259.7 5142.9 5164.1 5165.7 5172.9 4485.1 4557.3 4587.2 4640.8 4658.3 5578.7 5600.4 6117.0 6120.0 6130.1 6360.6 6394.9 6401.0 6403.1 6409.7 4754.6 5765.3 5774.8 5980.5 6130.4 5660.9 5672.5 5679.5 5686.8 5710.0 6598.2 6602.1 6610.0 6611.7 6612.6 6144.1 6246.2 6247.0 6270.4 6338.2 6630.0 6638.0 6647.8 6649.7 6650.4 6300.3 6315.6 6319.4 6331.7 6332.6 4714.2 6161.3 6255.5 6375.3 6418.8 6049.0 6178.5 6235.2 6249.5 6257.9 4750.7 5879.9 6221.8 6225.8 6245.1 4764.0 6108.4 6131.3 6212.7 6240.8 6153.0 6164.3 6213.8 6216.1 6225.6 6235.8 6245.4 6249.5 6252.8 6253.1 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:72471.64 Median:3394.97 stddev:163352.38 (4811.6%) stddev-sans-first:163721.12 19:53:51 INFO - PROCESS | 1638 | Values: 450.8 459.2 509.8 544.2 564.1 38974.6 41628.8 41742.6 41764.4 41801.0 42993.4 43441.8 43555.7 43583.8 43614.0 9498.3 9712.7 9749.9 11477.8 11832.1 11589.5 11634.4 11683.4 11709.1 11716.8 11730.5 11762.3 11764.9 11772.5 11786.7 9939.7 11662.5 11707.0 11710.2 11726.2 11684.0 11696.8 11738.6 11756.0 11765.8 38235.0 38389.4 38468.0 38579.8 38652.0 4031.5 4057.3 4069.0 4151.8 4164.2 27963.4 28508.1 28686.6 28716.7 30880.8 3319.2 3470.7 3491.6 3521.5 3523.8 499223.0 500139.0 501856.0 505640.0 505957.0 58921.0 58999.4 59400.7 59422.1 59457.7 58971.4 61910.4 62053.1 62104.7 62120.7 13638.9 16439.7 16527.9 16548.4 16551.9 11381.3 11424.7 11571.8 12790.4 13116.3 18409.8 21223.9 22420.7 22582.5 22583.8 9118.8 9345.0 9354.7 9375.3 9411.1 854.4 856.1 896.3 898.1 917.4 29826.4 30452.4 30531.5 31592.7 31985.7 994.8 1011.4 1032.5 1046.6 1062.4 12873.6 13632.3 14739.9 14961.6 15170.4 682023.0 686948.0 687687.0 688562.0 688843.6 47490.8 47497.5 47715.0 47808.0 48080.0 1411.0 1428.4 1454.1 1458.0 1459.4 27938.7 28068.4 28780.8 28865.8 28910.7 47744.3 47782.5 48342.3 48486.3 48524.5 623191.0 623447.9 626526.0 626965.0 627280.0 26175.6 26902.5 27582.9 27602.6 28531.6 36203.8 43474.8 44926.6 44982.8 45344.0 30464.0 30763.2 30809.0 31247.5 31580.7 30581.8 30945.5 31090.0 31504.4 31607.2 35941.5 36110.6 36520.8 36742.4 36745.3 30987.4 31167.4 31168.8 31195.8 31589.5 23547.4 24480.5 24875.9 24930.8 25203.9 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:40181.82 Median:22596.16 stddev:122221.71 (540.9%) stddev-sans-first:122528.04 19:53:51 INFO - PROCESS | 1638 | Values: 382.2 382.5 395.1 398.6 424.1 18657.3 20614.5 21599.6 22027.6 22045.7 20999.2 21922.9 22586.9 23335.8 23448.9 5507.0 6037.5 6153.8 6155.6 6156.6 5812.8 5979.5 5980.9 6014.4 6076.4 5927.9 5963.4 5965.3 5979.0 5991.5 5702.2 5947.6 5961.0 6008.2 6008.6 5235.3 5317.4 5324.9 5335.0 5396.2 22605.4 22764.9 22901.4 22916.5 27192.7 2787.0 2847.0 2882.4 2884.3 2888.9 15600.5 15790.6 16442.6 16647.4 16856.9 1885.0 1889.6 1890.9 1900.6 1914.5 106098.5 124197.0 128948.7 136303.0 138942.0 10558.4 11795.8 11822.4 11980.2 11986.1 10842.8 14283.7 15052.0 15064.0 15141.2 8697.3 8760.6 8970.7 8979.5 9195.2 8836.6 8866.6 8884.7 8956.6 8967.9 7469.5 7547.5 7592.1 7616.9 7620.0 1962.3 1982.3 1984.0 1990.6 1990.9 1043.8 1055.9 1066.7 1078.7 1120.2 22871.9 23235.4 23263.1 23281.7 23314.5 944.6 989.2 1084.4 1111.3 1123.9 11575.2 12098.6 12200.5 12249.5 12309.4 649139.0 715662.0 744650.0 775750.0 789804.0 119046.4 141801.9 142864.3 143556.0 143651.0 1072.4 1081.7 1112.6 1113.4 1115.7 19709.4 20100.8 20339.6 20458.7 20517.3 48041.0 54919.7 56469.0 58107.7 59221.0 82985.8 84608.0 84817.6 85240.0 86641.4 8243.6 8391.1 8421.1 8504.0 8758.5 13279.9 13384.5 13540.3 13806.2 13890.7 11473.7 11694.9 11781.3 11927.8 11997.5 11049.9 11071.0 11085.1 11291.7 11535.5 11843.8 12048.6 12110.2 12128.0 12174.7 6967.0 8212.3 8351.4 8749.0 8767.0 10494.1 11145.5 11563.9 11876.9 12015.7 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5574.29 Median:5222.35 stddev:3017.55 (57.8%) stddev-sans-first:3007.94 19:53:51 INFO - PROCESS | 1638 | Values: 1180.9 1482.1 1496.7 1496.7 1503.8 7807.8 8049.7 8282.2 8719.4 8768.0 8290.3 8548.0 8562.1 8655.4 8674.0 1824.4 2385.9 2420.9 2430.3 2435.1 2042.8 2150.6 2221.5 2271.1 2399.6 2138.9 2210.4 2215.0 2224.1 2233.5 2397.2 2398.7 2421.1 2421.4 2430.6 2025.6 2413.3 2420.0 2443.4 2453.8 7631.5 8675.3 8698.6 8737.7 8779.1 4104.9 4619.3 5309.5 5420.0 5527.1 3439.2 3663.1 3671.4 3720.4 3731.8 1214.6 1241.3 1268.7 1276.1 1305.5 11113.4 11165.4 11189.8 11197.7 11207.6 4763.1 4874.9 4923.2 4929.2 4935.1 9651.9 9709.8 9800.7 9833.0 9856.0 5471.8 5501.6 5504.8 5505.9 5525.8 4844.5 4948.9 4966.4 5006.9 5059.9 4013.2 4065.1 4137.4 4172.0 4186.8 1230.1 1271.0 1298.0 1310.3 1333.8 927.1 931.9 938.3 945.6 977.0 5663.6 5711.9 5957.5 6024.4 6096.9 960.7 1013.8 1021.2 1032.6 1075.6 3742.3 3949.7 4032.6 4041.7 4045.2 9624.6 10012.1 10135.5 10151.0 10163.5 9884.7 9993.5 10107.7 10142.2 10174.8 8049.4 8140.4 8144.0 8155.4 8193.3 5627.0 5657.3 5748.8 5823.4 5888.1 9350.0 9351.4 9460.3 9479.8 9484.4 9095.6 9368.2 9373.0 9441.7 9567.9 7367.4 7468.1 7488.0 7492.7 7495.7 7716.1 8045.6 8094.4 8094.4 8106.8 6817.7 7056.2 7135.3 7140.6 7264.0 6944.8 6998.7 7018.0 7022.5 7030.4 6481.7 6602.3 6612.9 6629.7 6630.7 4471.9 4674.7 5008.2 5054.6 5146.4 5092.1 5092.4 5181.2 5263.5 5268.5 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4665.00 Median:5123.97 stddev:1434.41 (28.0%) stddev-sans-first:1399.95 19:53:51 INFO - PROCESS | 1638 | Values: 267.7 358.4 360.8 375.8 376.2 5338.6 5530.1 5538.8 5621.3 5714.3 5047.4 5380.5 5486.0 5506.2 5583.0 3927.8 4101.8 4357.4 4366.3 4387.8 3383.1 3467.2 4348.9 4349.1 4392.4 4162.4 4167.0 4171.9 4197.0 4212.0 4059.6 4173.1 4188.3 4190.4 4199.5 3634.6 3643.2 3643.7 3644.7 3664.5 5216.6 5378.9 5403.7 5419.1 5442.6 4672.1 4815.4 4827.3 4831.9 4837.8 4654.6 5109.9 5604.6 5877.8 5917.0 3550.2 3782.4 3975.8 3979.5 4011.2 5416.1 5682.8 6150.1 6157.8 6211.8 3381.0 4054.5 4071.6 4079.3 4084.2 3595.5 3615.9 4072.1 4382.9 4544.4 5003.9 5006.4 5026.5 5063.5 5064.0 4539.1 4801.2 5278.9 5996.3 6002.8 1235.4 1298.5 1314.6 1431.2 1457.9 864.4 877.4 887.0 999.1 1017.3 4465.9 4917.3 5162.2 5171.6 5216.3 4833.8 5347.1 5579.3 5736.8 5795.1 4652.6 4792.5 5138.1 5153.8 5188.1 2616.6 2961.9 2991.1 2999.8 3022.5 4591.0 4963.5 5094.9 5967.6 5969.1 4964.4 4999.6 5263.6 5467.5 6181.4 5284.7 5513.4 6311.0 6330.7 6357.4 5040.6 5746.2 5999.1 6086.9 6141.8 5232.5 5962.8 5997.7 6016.8 6043.5 5554.8 6272.1 6305.1 6316.8 6318.0 3329.4 3497.0 4007.5 4042.8 4074.6 5606.7 5669.8 6082.8 6088.7 6108.5 4207.9 4687.9 5382.4 5679.0 5864.8 4708.9 5739.2 5842.2 5875.9 5916.9 5445.5 5699.9 5728.3 5738.9 5776.3 4939.3 5846.4 5853.2 5904.3 5925.5 5736.8 5759.3 5789.9 5791.9 5822.7 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20817.29 Median:4464.84 stddev:29694.15 (665.1%) stddev-sans-first:29738.79 19:53:51 INFO - PROCESS | 1638 | Values: 638.5 729.6 772.9 852.6 860.4 15172.2 15949.2 16077.0 17626.6 18509.6 14166.2 16458.3 17109.7 17332.7 17629.9 854.6 871.5 875.7 877.0 878.0 583.7 698.2 844.3 861.4 864.3 923.2 931.5 932.8 935.5 936.7 827.7 868.5 934.0 936.3 936.5 684.6 685.8 693.4 693.8 694.0 14018.2 15972.8 16364.4 16566.3 16829.5 14294.7 14589.7 14637.9 14652.2 14656.6 11894.9 11993.7 12021.3 12038.2 12048.2 3740.5 3757.4 3779.4 3882.1 3885.1 101261.5 114333.0 115662.8 117621.0 123275.0 9661.6 10777.2 10880.6 11466.9 11879.5 23050.4 23464.9 23507.5 23583.0 23584.6 7869.9 7871.8 7953.7 8004.3 8233.4 4462.8 4466.8 4490.5 4528.9 4538.5 3695.2 3725.3 3748.4 3803.4 3808.0 673.6 676.0 676.4 684.8 690.8 673.5 683.7 686.3 708.7 710.7 9726.3 9778.3 10586.6 10710.7 10782.7 689.4 716.3 716.4 717.4 723.2 5061.6 5278.8 5282.7 5284.7 5375.3 91751.0 100550.0 104979.5 109659.9 117816.2 75097.9 76427.2 76563.6 77412.8 79895.0 75162.9 77346.6 78565.0 80819.8 83285.0 10775.8 11078.4 11158.6 11283.3 11433.7 48860.0 49393.8 49516.8 51440.7 52910.0 67099.0 68470.0 69290.7 69961.0 70324.0 13417.8 13621.3 13636.5 14188.6 14796.7 14503.5 14675.9 14714.0 14926.9 15474.6 14094.0 14301.2 14417.7 14514.5 14569.8 11613.7 14228.0 14259.4 14530.3 15086.0 12206.1 13415.3 14416.9 14557.6 14921.3 7579.0 8447.7 8693.4 9116.4 9485.7 9240.0 10763.8 11409.5 11519.8 11603.9 19:53:51 INFO - PROCESS | 1638 | -------- Summary: end -------- 19:53:51 INFO - PROCESS | 1638 | 19:53:51 INFO - TEST-INFO | 1638: exit 0 19:53:51 INFO - TEST-OK | dromaeo_css | took 1113989ms 19:53:51 INFO - TEST-START | kraken 19:53:51 INFO - operating with platform_type : mac_ 19:53:51 INFO - Initialising browser for kraken test... 19:53:51 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpKcUtbK/profile http://localhost:49236/getInfo.html) 19:53:54 INFO - PROCESS | 1650 | 2017-03-29 19:53:54.272 plugin-container[1652:9837] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864b, name = 'com.apple.tsm.portname' 19:53:54 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:53:54 INFO - PROCESS | 1650 | 2017-03-29 19:53:54.273 plugin-container[1652:9837] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.CFPasteboardClient' 19:53:54 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:53:54 INFO - PROCESS | 1650 | 2017-03-29 19:53:54.273 plugin-container[1652:9837] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:53:54 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 19:53:54 INFO - PROCESS | 1650 | colorDepth:24 19:53:54 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 19:53:54 INFO - PROCESS | 1650 | __metrics 19:53:54 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 19:53:55 INFO - TEST-INFO | 1650: exit 0 19:53:55 INFO - Browser initialized. 19:53:55 INFO - Running cycle 1/1 for kraken test... 19:53:55 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpKcUtbK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:53:57 INFO - PROCESS | 1653 | 2017-03-29 19:53:57.494 plugin-container[1654:9955] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 19:53:57 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:53:57 INFO - PROCESS | 1653 | 2017-03-29 19:53:57.495 plugin-container[1654:9955] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 19:53:57 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:53:57 INFO - PROCESS | 1653 | 2017-03-29 19:53:57.495 plugin-container[1654:9955] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:54:07 INFO - PROCESS | 1653 | RSS: Main: 172998656 19:54:07 INFO - PROCESS | 1653 | 19:54:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 19:54:11 INFO - PROCESS | 1653 | RSS: Main: 185819136 19:54:11 INFO - PROCESS | 1653 | 19:54:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 19:54:14 INFO - PROCESS | 1653 | RSS: Main: 193785856 19:54:14 INFO - PROCESS | 1653 | 19:54:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 19:54:18 INFO - PROCESS | 1653 | RSS: Main: 197644288 19:54:18 INFO - PROCESS | 1653 | 19:54:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 19:54:21 INFO - PROCESS | 1653 | RSS: Main: 198881280 19:54:21 INFO - PROCESS | 1653 | 19:54:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:54:23 INFO - PROCESS | 1653 | RSS: Main: 198881280 19:54:23 INFO - PROCESS | 1653 | 19:54:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 19:54:27 INFO - PROCESS | 1653 | RSS: Main: 203509760 19:54:27 INFO - PROCESS | 1653 | 19:54:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 19:54:31 INFO - PROCESS | 1653 | RSS: Main: 202698752 19:54:31 INFO - PROCESS | 1653 | 19:54:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 19:54:34 INFO - PROCESS | 1653 | RSS: Main: 202870784 19:54:34 INFO - PROCESS | 1653 | 19:54:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:54:36 INFO - PROCESS | 1653 | RSS: Main: 201891840 19:54:36 INFO - PROCESS | 1653 | 19:54:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:54:39 INFO - PROCESS | 1653 | RSS: Main: 201924608 19:54:39 INFO - PROCESS | 1653 | 19:54:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:54:42 INFO - PROCESS | 1653 | RSS: Main: 201920512 19:54:42 INFO - PROCESS | 1653 | 19:54:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:54:45 INFO - PROCESS | 1653 | RSS: Main: 202244096 19:54:45 INFO - PROCESS | 1653 | 19:54:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:54:49 INFO - PROCESS | 1653 | RSS: Main: 202350592 19:54:49 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 19:54:51 INFO - PROCESS | 1653 | RSS: Main: 204042240 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | __start_tp_report 19:54:51 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 19:54:51 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 19:54:51 INFO - PROCESS | 1653 | |i|pagename|runs| 19:54:51 INFO - PROCESS | 1653 | |0;ai-astar;113;164;121;119;118;119;118;118;117;113 19:54:51 INFO - PROCESS | 1653 | |1;audio-beat-detection;172;106;143;162;129;96;124;140;140;133 19:54:51 INFO - PROCESS | 1653 | |2;audio-dft;203;200;194;202;194;201;195;198;199;286 19:54:51 INFO - PROCESS | 1653 | |3;audio-fft;81;62;60;77;87;82;49;73;92;83 19:54:51 INFO - PROCESS | 1653 | |4;audio-oscillator;86;69;84;95;99;94;80;69;71;81 19:54:51 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;86;89;85;88;86;77;127;134;85 19:54:51 INFO - PROCESS | 1653 | |6;imaging-darkroom;96;99;136;124;104;165;112;174;160;98 19:54:51 INFO - PROCESS | 1653 | |7;imaging-desaturate;93;94;86;138;144;113;95;93;93;93 19:54:51 INFO - PROCESS | 1653 | |8;json-parse-financial;58;57;58;59;61;64;78;93;88;82 19:54:51 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;67;73;69;73;71;67;72;71;71;71 19:54:51 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;86;80;83;84;83;85;85;89;84;83 19:54:51 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;126;127;141;146;148;149;158;160;185;143 19:54:51 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;165;168;179;165;169;164;168;160;164;166 19:54:51 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;65;66;65;69;86;85;86;85;65;67 19:54:51 INFO - PROCESS | 1653 | __end_tp_report 19:54:51 INFO - PROCESS | 1653 | __start_cc_report 19:54:51 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,953 19:54:51 INFO - PROCESS | 1653 | __end_cc_report 19:54:51 INFO - PROCESS | 1653 | __startTimestamp1490842491351__endTimestamp 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | ------- Summary: start ------- 19:54:51 INFO - PROCESS | 1653 | Number of tests: 14 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:122.00 Median:118.50 stddev:14.97 (12.6%) stddev-sans-first:15.52 19:54:51 INFO - PROCESS | 1653 | Values: 113.0 164.0 121.0 119.0 118.0 119.0 118.0 118.0 117.0 113.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:141.50 stddev:22.93 (16.2%) stddev-sans-first:19.91 19:54:51 INFO - PROCESS | 1653 | Values: 172.0 106.0 143.0 162.0 129.0 96.0 124.0 140.0 140.0 133.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:207.20 Median:200.50 stddev:27.88 (13.9%) stddev-sans-first:29.53 19:54:51 INFO - PROCESS | 1653 | Values: 203.0 200.0 194.0 202.0 194.0 201.0 195.0 198.0 199.0 286.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:74.60 Median:81.50 stddev:13.57 (16.7%) stddev-sans-first:14.20 19:54:51 INFO - PROCESS | 1653 | Values: 81.0 62.0 60.0 77.0 87.0 82.0 49.0 73.0 92.0 83.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:85.00 stddev:10.95 (12.9%) stddev-sans-first:11.56 19:54:51 INFO - PROCESS | 1653 | Values: 86.0 69.0 84.0 95.0 99.0 94.0 80.0 69.0 71.0 81.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:86.00 stddev:19.29 (22.4%) stddev-sans-first:20.36 19:54:51 INFO - PROCESS | 1653 | Values: 89.0 86.0 89.0 85.0 88.0 86.0 77.0 127.0 134.0 85.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:126.80 Median:169.50 stddev:30.13 (17.8%) stddev-sans-first:29.83 19:54:51 INFO - PROCESS | 1653 | Values: 96.0 99.0 136.0 124.0 104.0 165.0 112.0 174.0 160.0 98.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:104.20 Median:93.00 stddev:20.62 (22.2%) stddev-sans-first:21.47 19:54:51 INFO - PROCESS | 1653 | Values: 93.0 94.0 86.0 138.0 144.0 113.0 95.0 93.0 93.0 93.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:71.00 stddev:13.97 (19.7%) stddev-sans-first:14.15 19:54:51 INFO - PROCESS | 1653 | Values: 58.0 57.0 58.0 59.0 61.0 64.0 78.0 93.0 88.0 82.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:2.17 (3.1%) stddev-sans-first:1.90 19:54:51 INFO - PROCESS | 1653 | Values: 67.0 73.0 69.0 73.0 71.0 67.0 72.0 71.0 71.0 71.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:2.35 (2.8%) stddev-sans-first:2.40 19:54:51 INFO - PROCESS | 1653 | Values: 86.0 80.0 83.0 84.0 83.0 85.0 85.0 89.0 84.0 83.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:148.50 stddev:17.05 (11.5%) stddev-sans-first:16.06 19:54:51 INFO - PROCESS | 1653 | Values: 126.0 127.0 141.0 146.0 148.0 149.0 158.0 160.0 185.0 143.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:5.01 (3.0%) stddev-sans-first:5.27 19:54:51 INFO - PROCESS | 1653 | Values: 165.0 168.0 179.0 165.0 169.0 164.0 168.0 160.0 164.0 166.0 19:54:51 INFO - PROCESS | 1653 | 19:54:51 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:77.00 stddev:10.06 (13.1%) stddev-sans-first:10.14 19:54:51 INFO - PROCESS | 1653 | Values: 65.0 66.0 65.0 69.0 86.0 85.0 86.0 85.0 65.0 67.0 19:54:51 INFO - PROCESS | 1653 | -------- Summary: end -------- 19:54:51 INFO - PROCESS | 1653 | 19:54:52 INFO - TEST-INFO | 1653: exit 0 19:54:52 INFO - TEST-OK | kraken | took 60355ms 19:54:52 INFO - SUITE-END | took 1174s 19:54:52 INFO - Completed test suite (00:19:34) 19:54:52 INFO - javascript benchmark 19:54:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7513.5992576542585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3521.436570148776, 3524.3303772283266, 3532.275883443894, 3534.7879127252368, 3534.9469757953625, 5986.012307969186, 5999.82000539984, 6050.122732203828, 6058.303295121057, 6087.695615219243, 6014.669193194372, 6105.572609917308, 6105.725242364093, 6109.633421994683, 6127.908081378783, 5444.6932736143335, 5483.122700367942, 5489.670619762827, 5491.368492623339, 5567.8886422271535, 4247.15056988602, 4565.406497155365, 5528.9494995950845, 5563.304586926634, 5603.80386686466, 4377.540358262384, 4949.579285760715, 5416.647917885344, 5537.496464002288, 5592.99326121298, 4453.309736990739, 5026.195808670614, 5067.594592432615, 5524.14375771756, 5601.551875849922, 4814.0, 5034.194528875399, 5375.220593013991, 5537.252470916415, 5542.307211598551, 4686.507916668769, 5183.578837966924, 5873.442023007808, 6003.939960600425, 6093.421124993119, 6201.441870231701, 6207.503399728056, 6210.751569937197, 6221.937780622181, 6366.87266254677, 6468.482521398277, 6471.255805582324, 6472.838179045514, 6493.188351456068, 6493.935060649427, 6081.391860813927, 6130.754769809247, 6140.600860944024, 6156.815295541186, 6158.261008678987, 5489.4236105209175, 6266.586338582895, 6319.273283572356, 6371.776987805404, 6387.457066149429, 6150.538709596709, 6258.15514905491, 6258.280297765724, 6269.247690277196, 6275.215598050244, 6355.332690067568, 6387.840303992437, 6390.456811171102, 6390.488760899117, 6417.839554011093, 6165.445109940038, 6183.072539119168, 6187.721552530147, 6202.379762023852, 6225.315215326311, 6275.309715931244, 6283.183186185858, 6288.339724328879, 6293.402126797947, 6373.840653983688, 4259.701820872509, 5142.948570514322, 5164.14791559396, 5165.715885626251, 5172.870678233075, 4485.0805584855025, 4557.293619488984, 4587.243104887723, 4640.79116439761, 4658.254679251304, 5578.716895114066, 5600.4399560044485, 6117.0, 6119.959572021022, 6130.111133885562, 6360.618362898241, 6394.8721025579225, 6401.0, 6403.071554624554, 6409.7115629795835, 4754.595859351924, 5765.279340082489, 5774.82675519735, 5980.461758441761, 6130.417610327012, 5660.8867822643315, 5672.546196304285, 5679.517241034476, 5686.772529098873, 5710.029295019774, 6598.241202261801, 6602.141721576164, 6610.041543976096, 6611.73553057882, 6612.603243805387, 6144.095330447575, 6246.187995560548, 6246.968765156145, 6270.372962703693, 6338.239411270677, 6629.966850165718, 6638.0, 6647.767328143492, 6649.667516624246, 6650.3682150195655, 6300.306966233619, 6315.557910946373, 6319.431251187415, 6331.651759153291, 6332.588381755171, 4714.175019371665, 6161.260648722003, 6255.499560035278, 6375.298717141203, 6418.807435776934, 6048.969755151196, 6178.5366097543765, 6235.158253635883, 6249.468795152463, 6257.906131407942, 4750.741053620863, 5879.911801322898, 6221.844453888689, 6225.750969961151, 6245.0632405139595, 4763.976180119216, 6108.402780883668, 6131.284916201153, 6212.72042758086, 6240.812775616739, 6152.953997820292, 6164.291106522807, 6213.844653883689, 6216.098665693539, 6225.595336303126, 6235.812925612239, 6245.406686364788, 6249.468795152463, 6252.812415627538, 6253.093301471352], "value": 5806.052280802737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.80615335405764, 459.24225028702637, 509.84449742828446, 544.1728572569693, 564.0608387035586, 38974.61025389745, 41628.79185604071, 41742.58257417429, 41764.37353439701, 41800.95497612561, 42993.35509967345, 43441.782791086, 43555.6933292001, 43583.78208108955, 43614.0, 9498.335116541844, 9712.66005689801, 9749.878763942166, 11477.770444591104, 11832.053435725122, 11589.53641854329, 11634.418279086054, 11683.357415342152, 11709.063274937984, 11716.824247636292, 11730.53077876884, 11762.294262344243, 11764.941175294112, 11772.528433945758, 11786.705332366673, 9939.652112176076, 11662.475188616532, 11707.0, 11710.180287379844, 11726.237794543327, 11684.00685941696, 11696.766064678744, 11738.647840564796, 11756.0, 11765.764684706344, 38235.0, 38389.424158637645, 38468.0, 38579.807100964594, 38652.033699157466, 4031.5363733170475, 4057.3102572562734, 4068.9593104068877, 4151.813168407429, 4164.167166566699, 27963.440731185263, 28508.144755657362, 28686.569701454497, 28716.712832871614, 30880.8455957721, 3319.203391186122, 3470.7396945228957, 3491.6333784952467, 3521.454174602941, 3523.823808809549, 499223.0, 500139.0, 501856.0, 505640.0, 505957.0, 58921.0, 58999.41000590025, 59400.70299648474, 59422.10866837001, 59457.70271148616, 58971.41028589745, 61910.380896190465, 62053.069203961975, 62104.689476552325, 62120.68939655363, 13638.931805341108, 16439.6712065758, 16527.91736041312, 16548.42080527176, 16551.91724041372, 11381.260218085798, 11424.714382140346, 11571.768564628828, 12790.36048197605, 13116.278604676834, 18409.81590184081, 21223.893880530806, 22420.66369004466, 22582.548349033255, 22583.7578933157, 9118.772030699285, 9345.0, 9354.71935841926, 9375.343725939256, 9411.05889411067, 854.4275335525213, 856.0754385264024, 896.3143195455482, 898.1333013641867, 917.3899356927568, 29826.40347193044, 30452.39095218083, 30531.542026869614, 31592.684073158973, 31985.680143198737, 994.7811481474064, 1011.3830563356347, 1032.5043978890176, 1046.6441409920512, 1062.436908438529, 12873.613791586267, 13632.250226237653, 14739.852601474062, 14961.625959350886, 15170.360338380608, 682023.0, 686948.0, 687687.0, 688562.0, 688843.5557822179, 47490.81272968134, 47497.52502475, 47715.0, 47808.0, 48080.03839923252, 1410.9717805644034, 1428.435767871685, 1454.1493226462637, 1458.0, 1459.408939379553, 27938.72061279361, 28068.43863122767, 28780.848766049123, 28865.80466358961, 28910.710892890802, 47744.2838357418, 47782.522174777805, 48342.27486587634, 48486.272705910145, 48524.514754851996, 623191.0, 623447.8827605833, 626526.0, 626965.0, 627280.0, 26175.607365889147, 26902.461950760484, 27582.86208568944, 27602.585961210196, 28531.572026419206, 36203.81898090493, 43474.782626086664, 44926.55073449224, 44982.77508612436, 45344.0, 30464.0, 30763.230919226302, 30809.0, 31247.53128703026, 31580.684193157773, 30581.847090764404, 30945.535816962314, 31090.0, 31504.369912602077, 31607.20981975469, 35941.460878087375, 36110.63889361178, 36520.81739591285, 36742.44886326761, 36745.265094698494, 30987.380252394374, 31167.376652467276, 31168.844155779076, 31195.84402077975, 31589.52615710812, 23547.41131471727, 24480.51038979246, 24875.87562062178, 24930.75069249357, 25203.873980629978], "value": 20207.79928405179, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.1897577136471, 382.47600786921913, 395.10311592684627, 398.57949862894645, 424.14111424365655, 18657.34699285525, 20614.48463788406, 21599.568008639817, 22027.559448811033, 22045.669314960287, 20999.160033598677, 21922.89038554809, 22586.88706556469, 23335.766642333572, 23448.88275558624, 5506.972465137669, 6037.516998640121, 6153.846153846145, 6155.569110162291, 6156.630602163862, 5812.825615231529, 5979.46184843364, 5980.940190598104, 6014.4286292802335, 6076.361981991893, 5927.911081333784, 5963.433473820002, 5965.313988891268, 5979.043353063511, 5991.460768530831, 5702.173184888189, 5947.6134051286745, 5961.016432288668, 6008.158857759917, 6008.609440386361, 5235.293235413209, 5317.361916569997, 5324.92012619811, 5335.0, 5396.244525766396, 22605.43486412853, 22764.886175569183, 22901.427464313358, 22916.54166916669, 27192.72807271922, 2786.986065069682, 2847.03200911691, 2882.394697113588, 2884.307766136133, 2888.8844446222124, 15600.453984110502, 15790.605234869105, 16442.588935276595, 16647.41734039315, 16856.915715421466, 1884.9905750471296, 1889.5842914558912, 1890.914908829106, 1900.6103748731616, 1914.4639500939759, 106098.46950765197, 124197.0, 128948.71051289461, 136302.95545566923, 138942.0, 10558.366498010144, 11795.761445048318, 11822.408879555987, 11980.161388702882, 11986.101042421853, 10842.783144337069, 14283.714325713427, 15052.0, 15064.0, 15141.167235802137, 8697.304215662733, 8760.605772740115, 8970.68602598919, 8979.46123232608, 9195.172434480928, 8836.646534138563, 8866.601002954883, 8884.689035883714, 8956.596953137125, 8967.910320896837, 7469.514481558681, 7547.471676982668, 7592.126905405949, 7616.885746713804, 7620.009398778124, 1962.3033822992918, 1982.3359174676646, 1983.9504012399516, 1990.5919286546223, 1990.850686198512, 1043.7964596903682, 1055.8627378440908, 1066.6746642274027, 1078.6710053433778, 1120.1598800899326, 22871.88564057169, 23235.419114521934, 23263.06947722106, 23281.650775238384, 23314.533709326057, 944.5985456181232, 989.2391543053377, 1084.4035780320792, 1111.288775183883, 1123.9269447485888, 11575.247608905394, 12098.637040888787, 12200.51197952072, 12249.510019599295, 12309.44607492647, 649139.0, 715662.0, 744650.0, 775750.0, 789804.0, 119046.4047679756, 141801.8729719055, 142864.28567857094, 143556.0, 143651.0, 1072.4316112460408, 1081.7241603391085, 1112.593903225317, 1113.4154568851418, 1115.6597237842373, 19709.40871773849, 20100.79899200989, 20339.59320813605, 20458.69311960292, 20517.281895133598, 48041.0, 54919.725401372736, 56469.0, 58107.709461452425, 59221.0, 82985.75521367305, 84608.0, 84817.57591212004, 85240.0, 86641.40075797736, 8243.629036693243, 8391.07698153215, 8421.07368189511, 8504.0, 8758.518281494578, 13279.867201327863, 13384.531541396005, 13540.322983850965, 13806.240656763974, 13890.722185556031, 11473.655790326304, 11694.88305116972, 11781.293122412682, 11927.821082683593, 11997.520099195934, 11049.889501104886, 11071.003609675168, 11085.113190944867, 11291.717707057389, 11535.480903359537, 11843.822342664695, 12048.638540843789, 12110.152289339661, 12128.0, 12174.695632609255, 6967.0, 8212.3430125591, 8351.415400921876, 8749.0, 8766.956165219388, 10494.108000820015, 11145.49845256949, 11563.884361156617, 11876.940615296868, 12015.699607509532], "value": 10375.018881448035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1180.9055275577944, 1482.0662982321137, 1496.663250768577, 1496.7380708376036, 1503.7969874067005, 7807.843843123148, 8049.678012879493, 8282.213189746972, 8719.389642725011, 8767.956160219197, 8290.336773058156, 8548.0, 8562.058173600899, 8655.43739656922, 8673.956630216855, 1824.4253060286035, 2385.9045638174453, 2420.9273721788286, 2430.2587710748217, 2435.062500937143, 2042.765082015565, 2150.5591253859952, 2221.489057516764, 2271.1029143488313, 2399.6400539919064, 2138.9251376201837, 2210.370044537307, 2215.0475295622878, 2224.088123869214, 2233.463968647521, 2397.1969390254285, 2398.65219543167, 2421.0678888628004, 2421.4309637235237, 2430.5746494363416, 2025.6252593270292, 2413.2880800163994, 2420.0, 2443.389152711822, 2453.815963802722, 7631.503952243086, 8675.26260267878, 8698.608562614698, 8737.650493980233, 8779.078196789309, 4104.8768536943935, 4619.307103934437, 5309.548688361455, 5419.970205660912, 5527.115661494142, 3439.226174110805, 3663.1025398777206, 3671.430928206132, 3720.4233343831747, 3731.776093434403, 1214.6477521518748, 1241.2862604002735, 1268.6828292926768, 1276.0875973678865, 1305.4908585651604, 11113.444327783578, 11165.441727913652, 11189.776204475866, 11197.66407007791, 11207.551697932073, 4763.071201115818, 4874.8537543873745, 4923.212286034217, 4929.211326187793, 4935.087008903364, 9651.855222171673, 9709.757256068655, 9800.656977005914, 9832.950835245778, 9856.014398560086, 5471.753771080311, 5501.614886957955, 5504.752286147133, 5505.944940550623, 5525.834224973257, 4844.515548445127, 4948.8762780930765, 4966.379202599675, 5006.874828129326, 5059.8988020239385, 4013.150771229721, 4065.10567675111, 4137.420761093449, 4171.958280417218, 4186.769727664947, 1230.1450491908038, 1271.0, 1297.9935100324626, 1310.2924420812844, 1333.8132661427408, 927.1192367251003, 931.9301052421096, 938.3244064273712, 945.5603144537823, 976.9706908792748, 5663.631863928831, 5711.885762284731, 5957.463828255478, 6024.397560244028, 6096.908546371808, 960.6982538660154, 1013.807376598444, 1021.213665477578, 1032.6282538286212, 1075.623531763892, 3742.2702572998546, 3949.6642785363565, 4032.572313533473, 4041.656459201001, 4045.1505183911117, 9624.566894489764, 10012.098911098035, 10135.49322533885, 10150.98490150979, 10163.491825408848, 9884.65403710881, 9993.450360230258, 10107.7473063174, 10142.239332050125, 10174.796504069876, 8049.436539442183, 8140.430169888169, 8143.982002249719, 8155.388345874083, 8193.262606365455, 5627.0, 5657.321121465286, 5748.770049198152, 5823.4467725566, 5888.087346461305, 9349.953250233706, 9351.39215950961, 9460.337776355864, 9479.763005924908, 9484.430934143973, 9095.590698418719, 9368.15686588183, 9372.95313523428, 9441.669541566012, 9567.904320956979, 7367.373773229336, 7468.10382754073, 7488.026556547614, 7492.662830172546, 7495.7001719930595, 7716.074071111502, 8045.557494337868, 8094.392920530866, 8094.433389662667, 8106.797330066795, 6817.7272909083085, 7056.15326160864, 7135.322144396482, 7140.607266600179, 7264.019357386685, 6944.826379340557, 6998.650067496503, 7018.0, 7022.508424410242, 7030.437564994891, 6481.708323125565, 6602.3397660233595, 6612.900806488003, 6629.701663425061, 6630.734770609314, 4471.910561788811, 4674.74288914113, 5008.248762685626, 5054.570361519165, 5146.356705411824, 5092.134337162617, 5092.414372347227, 5181.1969144782615, 5263.499967503081, 5268.4994925482015], "value": 4540.895137337257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.7202323571867, 358.3605007092549, 360.75108175359003, 375.8459031796964, 376.1799277574887, 5338.62629615927, 5530.073647710131, 5538.7784488620455, 5621.2692349994495, 5714.285714285715, 5047.394312682474, 5380.515753582177, 5486.0, 5506.201600767887, 5583.0, 3927.803609819512, 4101.774402407881, 4357.411749413836, 4366.301391777316, 4387.780610969438, 3383.1034775784437, 3467.219875528011, 4348.934765978513, 4349.13017396522, 4392.3631073494325, 4162.43807086044, 4167.0, 4171.937420938689, 4197.0, 4211.978940105295, 4059.6346328830546, 4173.081921977145, 4188.32986722126, 4190.371444283367, 4199.517055538621, 3634.56385233771, 3643.198496330803, 3643.6902863256655, 3644.69020133289, 3664.5236119304586, 5216.5915202895, 5378.91931621026, 5403.729813509348, 5419.051665958442, 5442.591805614595, 4672.0799500312305, 4815.362776655954, 4827.348307978413, 4831.85504434864, 4837.758112094381, 4654.581087702123, 5109.872253193663, 5604.635698679614, 5877.764889404419, 5916.97041514794, 3550.1834578046937, 3782.3569993101237, 3975.8012099395205, 3979.5025621797276, 4011.1548687603736, 5416.133418652997, 5682.829515114553, 6150.108234306045, 6157.768446310756, 6211.81364559064, 3381.0, 4054.493188351456, 4071.633552980187, 4079.286124928126, 4084.223997440477, 3595.5325807645363, 3615.94576081359, 4072.063425412172, 4382.9342559861625, 4544.363789069533, 5003.874903127378, 5006.424261210008, 5026.472220416804, 5063.493650634907, 5063.9618878129895, 4539.0694907543875, 4801.18379875422, 5278.9472105278455, 5996.280446346379, 6002.849928751816, 1235.3576140406938, 1298.513202383266, 1314.59247633234, 1431.169921445559, 1457.890658200639, 864.3992425264381, 877.3814460805118, 887.0065526610109, 999.14073896449, 1017.2777328097134, 4465.910681786346, 4917.336159618406, 5162.167430562172, 5171.612129090333, 5216.295800067019, 4833.830815921426, 5347.144456886879, 5579.330480342385, 5736.77052917887, 5795.13073039039, 4652.581267685924, 4792.507895894116, 5138.073222541547, 5153.819616313411, 5188.092083885381, 2616.5944278636844, 2961.9337038666063, 2991.100651086576, 2999.820010799359, 3022.501287287617, 4591.0, 4963.478834722302, 5094.949050509522, 5967.582269241111, 5969.1495636352865, 4964.386574363274, 4999.625028122905, 5263.552598029134, 5467.535259502907, 6181.412765787243, 5284.652413634575, 5513.365962914316, 6310.958691815799, 6330.651814150266, 6357.364263573698, 5040.596752259884, 5746.224259725051, 5999.130126131774, 6086.878262434638, 6141.7543298267565, 5232.540705868236, 5962.821115366546, 5997.7404745002295, 6016.759329626766, 6043.516518678583, 5554.777808887599, 6272.052135496309, 6305.148804911279, 6316.810495685137, 6318.0414071636105, 3329.3840639481773, 3497.0208341664375, 4007.4971885542923, 4042.838286468508, 4074.5925407459017, 5606.6636001840025, 5669.809340038638, 6082.817515474543, 6088.726007329592, 6108.541859360477, 4207.873763787091, 4687.882802929954, 5382.381026182039, 5679.0, 5864.824055278348, 4708.905821883612, 5739.196512488338, 5842.211301474246, 5875.882482350415, 5916.911246331395, 5445.455454454523, 5699.857503562444, 5728.283964504437, 5738.942610573841, 5776.306843178677, 4939.308496810378, 5846.41535846412, 5853.151293062568, 5904.3210030847, 5925.466707996128, 5736.762662561688, 5759.308882933907, 5789.942100579109, 5791.9131213031, 5822.679752613647], "value": 4220.832062473472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.4987784589099, 729.6388287797541, 772.910196622762, 852.5609311204729, 860.3590325207721, 15172.165530895796, 15949.20253987299, 16077.0, 17626.559336016606, 18509.62980740388, 14166.220857852813, 16458.259378327974, 17109.716771242143, 17332.653346933053, 17629.911850440763, 854.615423059624, 871.4727589808169, 875.7460336502438, 876.97807554811, 877.9868301975475, 583.6877270660198, 698.2458944340101, 844.2865778417228, 861.3970220845401, 864.2826454043129, 923.1922068190333, 931.5388882503137, 932.8087742012905, 935.4854829843558, 936.7096200177966, 827.6854795177824, 868.4745728834059, 934.0472717827778, 936.279065119854, 936.5223735894708, 684.6097724297152, 685.8388278754488, 693.3759616345279, 693.7675878580682, 694.0214297840072, 14018.158910465405, 15972.840271597252, 16364.427245046485, 16566.337346506127, 16829.495115146565, 14294.71410571793, 14589.70820583593, 14637.853621463863, 14652.194129322883, 14656.560303190921, 11894.88105118955, 11993.700157496045, 12021.278723276631, 12038.217515861441, 12048.156629035971, 3740.532433445819, 3757.4176002719623, 3779.3764028935193, 3882.068303607114, 3885.0870045539277, 101261.4936925318, 114333.0, 115662.84337156605, 117621.0, 123275.0, 9661.613535458644, 10777.245592808586, 10880.61917832888, 11466.942665286788, 11879.524819007143, 23050.423739406648, 23464.944077516553, 23507.529849402916, 23583.0, 23584.64623030656, 7869.921300787033, 7871.763847084597, 7953.739566853949, 8004.319632831274, 8233.423660343718, 4462.843800466968, 4466.845234853497, 4490.461144662661, 4528.909421811545, 4538.500764915857, 3695.242475292612, 3725.2549490102087, 3748.381517049711, 3803.3724435468393, 3807.961920380816, 673.5588189735633, 675.9695813688396, 676.3844901140037, 684.8082536889679, 690.7858563845224, 673.5049738442241, 683.7265093962454, 686.2759788423261, 708.6500217086459, 710.7192658899705, 9726.297897867846, 9778.266630002778, 10586.629467968583, 10710.678679639623, 10782.67651970442, 689.3761146162731, 716.3409663109951, 716.3695947566213, 717.4224749076939, 723.2297603052732, 5061.5950723942, 5278.841634750964, 5282.656627319288, 5284.656497327662, 5375.3012108425655, 91751.0, 100549.99450005553, 104979.475102624, 109659.90340096496, 117816.23275650872, 75097.87353189707, 76427.23572764313, 76563.61718191374, 77412.83880741794, 79895.0, 75162.87255691279, 77346.6132669333, 78565.0, 80819.7877031845, 83285.0, 10775.838362424412, 11078.446077695922, 11158.553657853596, 11283.266587671775, 11433.714157146138, 48860.0, 49393.753031236054, 49516.75241623913, 51440.713982150744, 52910.0, 67099.0, 68470.0, 69290.65354673195, 69961.0, 70324.0, 13417.798733018817, 13621.25083120438, 13636.522721704692, 14188.574342769733, 14796.704065918837, 14503.492377766728, 14675.853241467448, 14714.0, 14926.925365373103, 15474.613134671723, 14094.0, 14301.213433260855, 14417.711645767236, 14514.491992780202, 14569.781453278421, 11613.709657258636, 14228.0, 14259.42962281497, 14530.346134424188, 15086.019408738397, 12206.084543659439, 13415.262160581262, 14416.855831441551, 14557.563273101823, 14921.253937302874, 7578.962105189439, 8447.704330348408, 8693.434926729742, 9116.4074335168, 9485.715428537154, 9240.0, 10763.784724305313, 11409.486573104396, 11519.827202592136, 11603.941980290045], "value": 7711.051035431882, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 164.0, 121.0, 119.0, 118.0, 119.0, 118.0, 118.0, 117.0, 113.0], "value": 122.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 106.0, 143.0, 162.0, 129.0, 96.0, 124.0, 140.0, 140.0, 133.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 200.0, 194.0, 202.0, 194.0, 201.0, 195.0, 198.0, 199.0, 286.0], "value": 207.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 60.0, 77.0, 87.0, 82.0, 49.0, 73.0, 92.0, 83.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 84.0, 95.0, 99.0, 94.0, 80.0, 69.0, 71.0, 81.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 88.0, 86.0, 77.0, 127.0, 134.0, 85.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 136.0, 124.0, 104.0, 165.0, 112.0, 174.0, 160.0, 98.0], "value": 126.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 86.0, 138.0, 144.0, 113.0, 95.0, 93.0, 93.0, 93.0], "value": 104.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 59.0, 61.0, 64.0, 78.0, 93.0, 88.0, 82.0], "value": 69.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 69.0, 73.0, 71.0, 67.0, 72.0, 71.0, 71.0, 71.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 83.0, 84.0, 83.0, 85.0, 85.0, 89.0, 84.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 141.0, 146.0, 148.0, 149.0, 158.0, 160.0, 185.0, 143.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 179.0, 165.0, 169.0, 164.0, 168.0, 160.0, 164.0, 166.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 69.0, 86.0, 85.0, 86.0, 85.0, 65.0, 67.0], "value": 73.9, "unit": "score"}]}]} 19:54:52 INFO - Return code: 0 19:54:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:54:52 ERROR - # TBPL SUCCESS # 19:54:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:54:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:54:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:54:52 INFO - 2017-03-29 19:54:52.647 screenresolution[1658:10342] starting screenresolution argv=screenresolution get 19:54:52 INFO - 2017-03-29 19:54:52.650 screenresolution[1658:10342] Display 0: 1600x1200x32@60 19:54:52 INFO - 2017-03-29 19:54:52.656 screenresolution[1659:10345] starting screenresolution argv=screenresolution list 19:54:52 INFO - Available Modes on Display 0 19:54:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:54:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:54:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:54:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:54:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:54:52 INFO - Intel Iris: 19:54:52 INFO - Chipset Model: Intel Iris 19:54:52 INFO - Type: GPU 19:54:52 INFO - Bus: Built-In 19:54:52 INFO - VRAM (Dynamic, Max): 1536 MB 19:54:52 INFO - Vendor: Intel (0x8086) 19:54:52 INFO - Device ID: 0x0a2e 19:54:52 INFO - Revision ID: 0x0009 19:54:52 INFO - Displays: 19:54:52 INFO - Display: 19:54:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:54:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:54:52 INFO - Display Serial Number: 1600x1200 60 19:54:52 INFO - Main Display: Yes 19:54:52 INFO - Mirror: Off 19:54:52 INFO - Online: Yes 19:54:52 INFO - Rotation: Supported 19:54:52 INFO - Return code: 0 19:54:52 INFO - Running post-action listener: _resource_record_post_action 19:54:52 INFO - [mozharness: 2017-03-30 02:54:52.890393Z] Finished run-tests step (success) 19:54:52 INFO - Running post-run listener: _resource_record_post_run 19:54:52 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 41363456; Write bytes: 424512512; Read time: 403; Write time: 1527 19:54:52 INFO - TinderboxPrint: CPU usage
54.4% 19:54:52 INFO - TinderboxPrint: I/O read bytes / time
41,363,456 / 403 19:54:52 INFO - TinderboxPrint: I/O write bytes / time
424,512,512 / 1,527 19:54:52 INFO - TinderboxPrint: CPU idle
2,173.6 (45.6%) 19:54:52 INFO - TinderboxPrint: CPU system
960.1 (20.2%) 19:54:52 INFO - TinderboxPrint: CPU user
1,627.9 (34.2%) 19:54:52 INFO - TinderboxPrint: Swap in / out
162,938,880 / 0 19:54:52 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 111892992; Write bytes: 103129088; Read time: 10029; Write time: 191 19:54:52 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 40396800; Write bytes: 301943808; Read time: 388; Write time: 1274 19:54:53 INFO - Running post-run listener: _upload_blobber_files 19:54:53 INFO - Blob upload gear active. 19:54:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:54:53 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 19:54:53 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'] 19:54:53 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 19:54:53 INFO - (blobuploader) - INFO - Open directory for files ... 19:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:54:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:54:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:54:54 INFO - (blobuploader) - INFO - Done attempting. 19:54:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:54:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:54:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:54:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:54:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:54:55 INFO - (blobuploader) - INFO - Done attempting. 19:54:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:54:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:54:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:54:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:54:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:54:56 INFO - (blobuploader) - INFO - Done attempting. 19:54:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:54:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:54:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:54:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:54:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:54:58 INFO - (blobuploader) - INFO - Done attempting. 19:54:58 INFO - (blobuploader) - INFO - Iteration through files over. 19:54:58 INFO - Return code: 0 19:54:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:54:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:54:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c81af36c87ce4ec719d9f707561238eca44a879d241b0fcb1ee5b0edde9ea280aa296adb25771e9fdf3aee465f63a4eb34a09c10fde333b1e54dcbce663a0c87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05caaf463a58491b2a3ac434400f77a417106b094bc68c8bf70a3c5b172b79c49ba6107b6ada0b7eba31d96ad7f3efa9cfa6049f240430cdfefde91ca2f23bbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccb0ae22e764f52cd46db7e43051535904bf77e4d525a18b05dbfa2c466adbb727f7b26398d173cddfa3a71e53c852058c0a5a1209e09961006d96fd2b6244c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c89e04fe2ef43546ab2de899a7aa34eedfda3840745caa6699d0ca3e8591141748f346205a78efed5be1ab41bd82b33c56afd45708bd23f1d6d4bd584620eb52"} 19:54:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:54:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:54:58 INFO - Contents: 19:54:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c81af36c87ce4ec719d9f707561238eca44a879d241b0fcb1ee5b0edde9ea280aa296adb25771e9fdf3aee465f63a4eb34a09c10fde333b1e54dcbce663a0c87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05caaf463a58491b2a3ac434400f77a417106b094bc68c8bf70a3c5b172b79c49ba6107b6ada0b7eba31d96ad7f3efa9cfa6049f240430cdfefde91ca2f23bbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccb0ae22e764f52cd46db7e43051535904bf77e4d525a18b05dbfa2c466adbb727f7b26398d173cddfa3a71e53c852058c0a5a1209e09961006d96fd2b6244c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c89e04fe2ef43546ab2de899a7aa34eedfda3840745caa6699d0ca3e8591141748f346205a78efed5be1ab41bd82b33c56afd45708bd23f1d6d4bd584620eb52"} 19:54:58 INFO - Running post-run listener: copy_logs_to_upload_dir 19:54:58 INFO - Copying logs to upload dir... 19:54:58 INFO - mkdir: /builds/slave/test/build/upload/logs 19:54:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.378474 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-29 19:54:58.984713) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 19:54:58.988153) ========= 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.i6xNEOWHos/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.ccno699742/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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/c81af36c87ce4ec719d9f707561238eca44a879d241b0fcb1ee5b0edde9ea280aa296adb25771e9fdf3aee465f63a4eb34a09c10fde333b1e54dcbce663a0c87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05caaf463a58491b2a3ac434400f77a417106b094bc68c8bf70a3c5b172b79c49ba6107b6ada0b7eba31d96ad7f3efa9cfa6049f240430cdfefde91ca2f23bbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccb0ae22e764f52cd46db7e43051535904bf77e4d525a18b05dbfa2c466adbb727f7b26398d173cddfa3a71e53c852058c0a5a1209e09961006d96fd2b6244c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c89e04fe2ef43546ab2de899a7aa34eedfda3840745caa6699d0ca3e8591141748f346205a78efed5be1ab41bd82b33c56afd45708bd23f1d6d4bd584620eb52"} build_url:https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/TXzU8tnvT3WWNxeRRou4Vg/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/c81af36c87ce4ec719d9f707561238eca44a879d241b0fcb1ee5b0edde9ea280aa296adb25771e9fdf3aee465f63a4eb34a09c10fde333b1e54dcbce663a0c87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05caaf463a58491b2a3ac434400f77a417106b094bc68c8bf70a3c5b172b79c49ba6107b6ada0b7eba31d96ad7f3efa9cfa6049f240430cdfefde91ca2f23bbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ccb0ae22e764f52cd46db7e43051535904bf77e4d525a18b05dbfa2c466adbb727f7b26398d173cddfa3a71e53c852058c0a5a1209e09961006d96fd2b6244c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c89e04fe2ef43546ab2de899a7aa34eedfda3840745caa6699d0ca3e8591141748f346205a78efed5be1ab41bd82b33c56afd45708bd23f1d6d4bd584620eb52"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 19:54:59.023378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 19:54:59.023747) ========= 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.i6xNEOWHos/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.ccno699742/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.005058 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 19:54:59.072604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 19:54:59.072945) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 19:54:59.073361) ========= ========= Total master_lag: 0.18 =========