builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0136 starttime: 1490183607.5 results: success (0) buildid: 20170322032435 builduid: bce8b34194fe4f4caa64019a6a9445e8 revision: 7b852b9750055433ba5bd46473602ba42422a045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.502472) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.502896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.503168) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.527991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.528275) ========= 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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-22 04:53:27-- 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% 143M=0s 2017-03-22 04:53:27 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084752 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.637667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.638006) ========= 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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.020519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:27.686473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 04:53:27.686828) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7b852b9750055433ba5bd46473602ba42422a045 --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 7b852b9750055433ba5bd46473602ba42422a045 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yi4UsO4HVh/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.c4zDZ9orIy/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-22 04:53:27,772 truncating revision to first 12 chars 2017-03-22 04:53:27,772 Setting DEBUG logging. 2017-03-22 04:53:27,773 attempt 1/10 2017-03-22 04:53:27,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7b852b975005?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 04:53:28,731 unpacking tar archive at: mozilla-beta-7b852b975005/testing/mozharness/ program finished with exit code 0 elapsedTime=1.215589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 04:53:28.926518) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:28.926900) ========= script_repo_revision: 7b852b9750055433ba5bd46473602ba42422a045 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:28.927440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:28.927830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 04:53:28.945933) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-22 04:53:28.946320) ========= /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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:53:29 INFO - MultiFileLogger online at 20170322 04:53:29 in /builds/slave/test 04:53:29 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 04:53:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:29 INFO - {'append_to_log': False, 04:53:29 INFO - 'base_work_dir': '/builds/slave/test', 04:53:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:53:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:29 INFO - 'branch': 'Mozilla-Beta', 04:53:29 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:29 INFO - 'config_files': ('talos/mac_config.py',), 04:53:29 INFO - 'default_actions': ('clobber', 04:53:29 INFO - 'read-buildbot-config', 04:53:29 INFO - 'download-and-extract', 04:53:29 INFO - 'populate-webroot', 04:53:29 INFO - 'create-virtualenv', 04:53:29 INFO - 'install', 04:53:29 INFO - 'run-tests'), 04:53:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:29 INFO - 'download_minidump_stackwalk': True, 04:53:29 INFO - 'download_symbols': 'ondemand', 04:53:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:29 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:29 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:29 INFO - 'installer_path': 'installer.exe', 04:53:29 INFO - 'log_level': 'info', 04:53:29 INFO - 'log_name': 'talos', 04:53:29 INFO - 'log_to_console': True, 04:53:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:53:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:53:29 INFO - 'opt_config_files': (), 04:53:29 INFO - 'pip_index': False, 04:53:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:29 INFO - 'cmd': ('bash', 04:53:29 INFO - '-c', 04:53:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:29 INFO - 'enabled': True, 04:53:29 INFO - 'halt_on_failure': False, 04:53:29 INFO - 'name': 'check_screen_resolution'},), 04:53:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:29 INFO - 'cmd': ('bash', 04:53:29 INFO - '-c', 04:53:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:29 INFO - 'enabled': True, 04:53:29 INFO - 'halt_on_failure': False, 04:53:29 INFO - 'name': 'check_screen_resolution'},), 04:53:29 INFO - 'run_cmd_checks_enabled': True, 04:53:29 INFO - 'sps_profile': False, 04:53:29 INFO - 'sps_profile_interval': 0, 04:53:29 INFO - 'suite': 'dromaeojs-e10s', 04:53:29 INFO - 'system_bits': '32', 04:53:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:29 INFO - 'title': 't-yosemite-r7-0136', 04:53:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:29 INFO - 'use_talos_json': True, 04:53:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:29 INFO - 'work_dir': 'build'} 04:53:29 INFO - [mozharness: 2017-03-22 11:53:29.158358Z] Running clobber step. 04:53:29 INFO - Running pre-action listener: _resource_record_pre_action 04:53:29 INFO - Running main action method: clobber 04:53:29 INFO - rmtree: /builds/slave/test/build 04:53:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:31 INFO - Running post-action listener: _resource_record_post_action 04:53:31 INFO - [mozharness: 2017-03-22 11:53:31.226025Z] Finished clobber step (success) 04:53:31 INFO - [mozharness: 2017-03-22 11:53:31.226176Z] Running read-buildbot-config step. 04:53:31 INFO - Running pre-action listener: _resource_record_pre_action 04:53:31 INFO - Running main action method: read_buildbot_config 04:53:31 INFO - Using buildbot properties: 04:53:31 INFO - { 04:53:31 INFO - "project": "", 04:53:31 INFO - "product": "firefox", 04:53:31 INFO - "script_repo_revision": "production", 04:53:31 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:53:31 INFO - "repository": "", 04:53:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:53:31 INFO - "buildid": "20170322032435", 04:53:31 INFO - "pgo_build": "False", 04:53:31 INFO - "basedir": "/builds/slave/test", 04:53:31 INFO - "buildnumber": 5, 04:53:31 INFO - "slavename": "t-yosemite-r7-0136", 04:53:31 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:53:31 INFO - "platform": "yosemite_r7", 04:53:31 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:53:31 INFO - "branch": "mozilla-beta", 04:53:31 INFO - "repo_path": "releases/mozilla-beta", 04:53:31 INFO - "revision": "7b852b9750055433ba5bd46473602ba42422a045", 04:53:31 INFO - "stage_platform": "macosx64", 04:53:31 INFO - "builduid": "bce8b34194fe4f4caa64019a6a9445e8", 04:53:31 INFO - "slavebuilddir": "test" 04:53:31 INFO - } 04:53:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 04:53:31 INFO - Running post-action listener: _resource_record_post_action 04:53:31 INFO - [mozharness: 2017-03-22 11:53:31.229765Z] Finished read-buildbot-config step (success) 04:53:31 INFO - [mozharness: 2017-03-22 11:53:31.229878Z] Running download-and-extract step. 04:53:31 INFO - Running pre-action listener: _resource_record_pre_action 04:53:31 INFO - Running main action method: download_and_extract 04:53:31 INFO - mkdir: /builds/slave/test/build/tests 04:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:31 INFO - trying https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 04:53:31 INFO - Downloading https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/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 04:53:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/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 04:53:32 INFO - Downloaded 1165 bytes. 04:53:32 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:53:32 INFO - Using the following test package requirements: 04:53:32 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:53:32 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:53:32 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 04:53:32 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:53:32 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 04:53:32 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:53:32 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:53:32 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 04:53:32 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:53:32 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:53:32 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 04:53:32 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:53:32 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 04:53:32 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:53:32 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 04:53:32 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:53:32 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 04:53:32 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 04:53:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:53:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:53:32 INFO - Fetch https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:53:33 INFO - Expected file size: 16108234 04:53:33 INFO - Obtained file size: 16108234 04:53:40 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 04:53:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:53:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:53:40 INFO - Fetch https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:53:40 INFO - Expected file size: 16108234 04:53:40 INFO - Obtained file size: 16108234 04:53:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 04:53:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 04:53:47 INFO - Fetch https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 04:53:48 INFO - Expected file size: 14403663 04:53:48 INFO - Obtained file size: 14403663 04:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:48 INFO - trying https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 04:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/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 04:53:50 INFO - Downloaded 58737528 bytes. 04:53:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:53:50 INFO - mkdir: /builds/slave/test/properties 04:53:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:50 INFO - Contents: 04:53:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:53:51 INFO - Running post-action listener: _resource_record_post_action 04:53:51 INFO - Running post-action listener: set_extra_try_arguments 04:53:51 INFO - [mozharness: 2017-03-22 11:53:51.340811Z] Finished download-and-extract step (success) 04:53:51 INFO - [mozharness: 2017-03-22 11:53:51.340968Z] Running populate-webroot step. 04:53:51 INFO - Running pre-action listener: _resource_record_pre_action 04:53:51 INFO - Running main action method: populate_webroot 04:53:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:51 INFO - '--tppagecycles', 04:53:51 INFO - '7'], 04:53:51 INFO - 'tests': ['tsvgm']}}, 04:53:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:53:51 INFO - 'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:53:51 INFO - 'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['damp', 'tps']}, 04:53:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:53:51 INFO - 'tests': ['damp', 'tps']}, 04:53:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['dromaeo_dom']}, 04:53:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['basic_compositor_video']}, 04:53:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:53:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['a11yr', 04:53:51 INFO - 'ts_paint', 04:53:51 INFO - 'tpaint', 04:53:51 INFO - 'sessionrestore', 04:53:51 INFO - 'sessionrestore_no_auto_restore', 04:53:51 INFO - 'tabpaint']}, 04:53:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:51 INFO - 'ts_paint', 04:53:51 INFO - 'tpaint', 04:53:51 INFO - 'sessionrestore', 04:53:51 INFO - 'sessionrestore_no_auto_restore', 04:53:51 INFO - 'tabpaint']}, 04:53:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:51 INFO - 'ts_paint', 04:53:51 INFO - 'tpaint', 04:53:51 INFO - 'sessionrestore', 04:53:51 INFO - 'sessionrestore_no_auto_restore', 04:53:51 INFO - 'tabpaint']}, 04:53:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:51 INFO - 'ts_paint', 04:53:51 INFO - 'tpaint', 04:53:51 INFO - 'sessionrestore', 04:53:51 INFO - 'sessionrestore_no_auto_restore', 04:53:51 INFO - 'tabpaint']}, 04:53:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['a11yr', 04:53:51 INFO - 'ts_paint', 04:53:51 INFO - 'tpaint', 04:53:51 INFO - 'sessionrestore', 04:53:51 INFO - 'sessionrestore_no_auto_restore', 04:53:51 INFO - 'tabpaint']}, 04:53:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['a11yr', 04:53:51 INFO - 'ts_paint', 04:53:51 INFO - 'tpaint', 04:53:51 INFO - 'sessionrestore', 04:53:51 INFO - 'sessionrestore_no_auto_restore', 04:53:51 INFO - 'tabpaint']}, 04:53:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['tsvgx', 04:53:51 INFO - 'tsvgr_opacity', 04:53:51 INFO - 'tart', 04:53:51 INFO - 'tscrollx', 04:53:51 INFO - 'cart', 04:53:51 INFO - 'tsvg_static']}, 04:53:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:51 INFO - 'tsvgr_opacity', 04:53:51 INFO - 'tart', 04:53:51 INFO - 'tscrollx', 04:53:51 INFO - 'cart', 04:53:51 INFO - 'tsvg_static']}, 04:53:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:53:51 INFO - 'talos_options': ['--disable-e10s'], 04:53:51 INFO - 'tests': ['tp5o']}, 04:53:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:53:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:53:51 INFO - 'talos_options': ['--disable-e10s', 04:53:51 INFO - '--xperf_path', 04:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:51 INFO - 'tests': ['tp5n']}, 04:53:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:53:51 INFO - 'talos_options': ['--xperf_path', 04:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:51 INFO - 'tests': ['tp5n']}}, 04:53:51 INFO - 'talos.zip': {'path': '', 04:53:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:51 INFO - Running post-action listener: _resource_record_post_action 04:53:51 INFO - [mozharness: 2017-03-22 11:53:51.359567Z] Finished populate-webroot step (success) 04:53:51 INFO - [mozharness: 2017-03-22 11:53:51.359712Z] Running create-virtualenv step. 04:53:51 INFO - Running pre-action listener: _resource_record_pre_action 04:53:51 INFO - Running main action method: create_virtualenv 04:53:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:51 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 04:53:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:51 INFO - Using real prefix '/tools/python27' 04:53:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:55 INFO - Installing pip.................done. 04:53:55 INFO - Return code: 0 04:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:53:55 INFO - Reading from file tmpfile_stdout 04:53:55 INFO - Output received: 04:53:55 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) 04:53:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:55 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')]} 04:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:55 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')]} 04:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:55 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:53:55 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 04:53:55 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 04:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:55 INFO - 'HOME': '/Users/cltbld', 04:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:55 INFO - 'LOGNAME': 'cltbld', 04:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:55 INFO - 'MOZ_NO_REMOTE': '1', 04:53:55 INFO - 'NO_EM_RESTART': '1', 04:53:55 INFO - 'PAGER': '/bin/cat', 04:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:55 INFO - 'PWD': '/builds/slave/test', 04:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:55 INFO - 'SHELL': '/bin/bash', 04:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:53:55 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:55 INFO - 'USER': 'cltbld', 04:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:55 INFO - 'XPC_FLAGS': '0x0', 04:53:55 INFO - 'XPC_SERVICE_NAME': '0', 04:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:55 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 04:53:55 INFO - Cleaning up... 04:53:55 INFO - Return code: 0 04:53:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:55 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')]} 04:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:55 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')]} 04:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:55 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:53:55 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 04:53:55 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 04:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:55 INFO - 'HOME': '/Users/cltbld', 04:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:55 INFO - 'LOGNAME': 'cltbld', 04:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:55 INFO - 'MOZ_NO_REMOTE': '1', 04:53:55 INFO - 'NO_EM_RESTART': '1', 04:53:55 INFO - 'PAGER': '/bin/cat', 04:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:55 INFO - 'PWD': '/builds/slave/test', 04:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:55 INFO - 'SHELL': '/bin/bash', 04:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:53:55 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:55 INFO - 'USER': 'cltbld', 04:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:55 INFO - 'XPC_FLAGS': '0x0', 04:53:55 INFO - 'XPC_SERVICE_NAME': '0', 04:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:55 INFO - Downloading/unpacking psutil>=3.1.1 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:55 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 04:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:59 INFO - Installing collected packages: psutil 04:53:59 INFO - Running setup.py install for psutil 04:53:59 INFO - building 'psutil._psutil_osx' extension 04:53:59 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 04:53:59 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 04:53:59 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 04:53:59 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 04:54:00 INFO - building 'psutil._psutil_posix' extension 04:54:00 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 04:54:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:54:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:54:00 INFO - ^ 04:54:00 INFO - 1 warning generated. 04:54:00 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 04:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:00 INFO - Successfully installed psutil 04:54:00 INFO - Cleaning up... 04:54:00 INFO - Return code: 0 04:54:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:00 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:00 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 04:54:00 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 04:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:00 INFO - 'HOME': '/Users/cltbld', 04:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:00 INFO - 'LOGNAME': 'cltbld', 04:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:00 INFO - 'MOZ_NO_REMOTE': '1', 04:54:00 INFO - 'NO_EM_RESTART': '1', 04:54:00 INFO - 'PAGER': '/bin/cat', 04:54:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:00 INFO - 'PWD': '/builds/slave/test', 04:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:00 INFO - 'SHELL': '/bin/bash', 04:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:00 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:00 INFO - 'USER': 'cltbld', 04:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:00 INFO - 'XPC_FLAGS': '0x0', 04:54:00 INFO - 'XPC_SERVICE_NAME': '0', 04:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:54:00 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 04:54:00 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 04:54:00 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 04:54:00 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 04:54:00 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 04:54:00 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 04:54:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:54:03 INFO - Installing collected packages: mozsystemmonitor 04:54:03 INFO - Running setup.py install for mozsystemmonitor 04:54:03 INFO - Successfully installed mozsystemmonitor 04:54:03 INFO - Cleaning up... 04:54:03 INFO - Return code: 0 04:54:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:54:03 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')]} 04:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:03 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')]} 04:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:03 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:03 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 04:54:03 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 04:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:03 INFO - 'HOME': '/Users/cltbld', 04:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:03 INFO - 'LOGNAME': 'cltbld', 04:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:03 INFO - 'MOZ_NO_REMOTE': '1', 04:54:03 INFO - 'NO_EM_RESTART': '1', 04:54:03 INFO - 'PAGER': '/bin/cat', 04:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:03 INFO - 'PWD': '/builds/slave/test', 04:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:03 INFO - 'SHELL': '/bin/bash', 04:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:03 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:03 INFO - 'USER': 'cltbld', 04:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:03 INFO - 'XPC_FLAGS': '0x0', 04:54:03 INFO - 'XPC_SERVICE_NAME': '0', 04:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:54:03 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 04:54:03 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 04:54:03 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 04:54:03 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 04:54:03 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 04:54:03 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 04:54:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:54:06 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 04:54:06 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 04:54:06 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 04:54:06 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 04:54:06 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 04:54:06 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 04:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:06 INFO - warning: no files found matching '*.txt' 04:54:06 INFO - no previously-included directories found matching 'build' 04:54:06 INFO - no previously-included directories found matching 'dist' 04:54:06 INFO - no previously-included directories found matching '.git*' 04:54:06 INFO - Installing collected packages: jsonschema, functools32 04:54:06 INFO - Running setup.py install for functools32 04:54:07 INFO - warning: no files found matching '*.txt' 04:54:07 INFO - no previously-included directories found matching 'build' 04:54:07 INFO - no previously-included directories found matching 'dist' 04:54:07 INFO - no previously-included directories found matching '.git*' 04:54:07 INFO - Successfully installed jsonschema functools32 04:54:07 INFO - Cleaning up... 04:54:07 INFO - Return code: 0 04:54:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:54:07 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')]} 04:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:07 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')]} 04:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:07 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:07 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 04:54:07 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 04:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:07 INFO - 'HOME': '/Users/cltbld', 04:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:07 INFO - 'LOGNAME': 'cltbld', 04:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:07 INFO - 'MOZ_NO_REMOTE': '1', 04:54:07 INFO - 'NO_EM_RESTART': '1', 04:54:07 INFO - 'PAGER': '/bin/cat', 04:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:07 INFO - 'PWD': '/builds/slave/test', 04:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:07 INFO - 'SHELL': '/bin/bash', 04:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:07 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:07 INFO - 'USER': 'cltbld', 04:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:07 INFO - 'XPC_FLAGS': '0x0', 04:54:07 INFO - 'XPC_SERVICE_NAME': '0', 04:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:54:07 INFO - Cleaning up... 04:54:07 INFO - Return code: 0 04:54:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54:07 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')]} 04:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:07 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')]} 04:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:07 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:07 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 04:54:07 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 04:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:07 INFO - 'HOME': '/Users/cltbld', 04:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:07 INFO - 'LOGNAME': 'cltbld', 04:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:07 INFO - 'MOZ_NO_REMOTE': '1', 04:54:07 INFO - 'NO_EM_RESTART': '1', 04:54:07 INFO - 'PAGER': '/bin/cat', 04:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:07 INFO - 'PWD': '/builds/slave/test', 04:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:07 INFO - 'SHELL': '/bin/bash', 04:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:07 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:07 INFO - 'USER': 'cltbld', 04:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:07 INFO - 'XPC_FLAGS': '0x0', 04:54:07 INFO - 'XPC_SERVICE_NAME': '0', 04:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:07 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 04:54:07 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 04:54:07 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 04:54:07 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 04:54:07 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 04:54:07 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 04:54:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:10 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 04:54:10 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 04:54:10 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 04:54:10 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 04:54:10 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 04:54:10 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 04:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:11 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 04:54:11 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 04:54:11 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 04:54:11 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 04:54:11 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 04:54:11 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 04:54:11 INFO - Downloading docopt-0.6.1.tar.gz 04:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:11 INFO - Running setup.py install for blobuploader 04:54:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:11 INFO - Running setup.py install for requests 04:54:12 INFO - Running setup.py install for docopt 04:54:12 INFO - Successfully installed blobuploader requests docopt 04:54:12 INFO - Cleaning up... 04:54:12 INFO - Return code: 0 04:54:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:12 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')]} 04:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:12 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')]} 04:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:12 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:12 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 04:54:12 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 04:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:12 INFO - 'HOME': '/Users/cltbld', 04:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:12 INFO - 'LOGNAME': 'cltbld', 04:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:12 INFO - 'MOZ_NO_REMOTE': '1', 04:54:12 INFO - 'NO_EM_RESTART': '1', 04:54:12 INFO - 'PAGER': '/bin/cat', 04:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:12 INFO - 'PWD': '/builds/slave/test', 04:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:12 INFO - 'SHELL': '/bin/bash', 04:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:12 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:12 INFO - 'USER': 'cltbld', 04:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:12 INFO - 'XPC_FLAGS': '0x0', 04:54:12 INFO - 'XPC_SERVICE_NAME': '0', 04:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:12 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-mbMy9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-MSZ2MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qyW7SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-YE4p1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-BGrLuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-LSnX6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-_wezSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4GdchX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-QrThof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-GpodV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-uWc1mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-OOGqj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-3oHrQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jvSfJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-snR72B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-3wrdSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-I845Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:14 INFO - Running setup.py install for manifestparser 04:54:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:14 INFO - Running setup.py install for mozcrash 04:54:14 INFO - Running setup.py install for mozdebug 04:54:15 INFO - Running setup.py install for mozdevice 04:54:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Running setup.py install for mozfile 04:54:15 INFO - Running setup.py install for mozhttpd 04:54:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Running setup.py install for mozinfo 04:54:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Running setup.py install for mozInstall 04:54:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:15 INFO - Running setup.py install for mozleak 04:54:16 INFO - Running setup.py install for mozlog 04:54:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:16 INFO - Running setup.py install for moznetwork 04:54:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:16 INFO - Running setup.py install for mozprocess 04:54:16 INFO - Running setup.py install for mozprofile 04:54:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:16 INFO - Running setup.py install for mozrunner 04:54:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:16 INFO - Running setup.py install for mozscreenshot 04:54:17 INFO - Running setup.py install for moztest 04:54:17 INFO - Running setup.py install for mozversion 04:54:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:17 INFO - Cleaning up... 04:54:17 INFO - Return code: 0 04:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:17 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:17 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 04:54:17 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 04:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:17 INFO - 'HOME': '/Users/cltbld', 04:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:17 INFO - 'LOGNAME': 'cltbld', 04:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:17 INFO - 'MOZ_NO_REMOTE': '1', 04:54:17 INFO - 'NO_EM_RESTART': '1', 04:54:17 INFO - 'PAGER': '/bin/cat', 04:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:17 INFO - 'PWD': '/builds/slave/test', 04:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:17 INFO - 'SHELL': '/bin/bash', 04:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:17 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:17 INFO - 'USER': 'cltbld', 04:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:17 INFO - 'XPC_FLAGS': '0x0', 04:54:17 INFO - 'XPC_SERVICE_NAME': '0', 04:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:17 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jnetpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:17 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)) 04:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:17 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-kzDjmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:17 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)) 04:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:17 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-CWkVJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:17 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)) 04:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:17 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-OkbP6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-xESLcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-cKyHfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-wCMDo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ssuWyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-nUMrO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-XwXxCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-GyILuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-kozhHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:18 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)) 04:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:18 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-WxkJNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:19 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)) 04:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-RreZ3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:19 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)) 04:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-iHrY8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:19 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)) 04:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jCXBfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:19 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)) 04:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:19 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-xLdUhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:19 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)) 04:54:19 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)) 04:54:19 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)) 04:54:19 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)) 04:54:19 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)) 04:54:19 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)) 04:54:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:21 INFO - Downloading blessings-1.6.tar.gz 04:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:22 INFO - Installing collected packages: blessings 04:54:22 INFO - Running setup.py install for blessings 04:54:22 INFO - Successfully installed blessings 04:54:22 INFO - Cleaning up... 04:54:22 INFO - Return code: 0 04:54:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:22 INFO - Reading from file tmpfile_stdout 04:54:22 INFO - Current package versions: 04:54:22 INFO - blessings == 1.6 04:54:22 INFO - blobuploader == 1.2.4 04:54:22 INFO - docopt == 0.6.1 04:54:22 INFO - functools32 == 3.2.3-2 04:54:22 INFO - jsonschema == 2.5.1 04:54:22 INFO - manifestparser == 1.1 04:54:22 INFO - mozInstall == 1.12 04:54:22 INFO - mozcrash == 1.0 04:54:22 INFO - mozdebug == 0.1 04:54:22 INFO - mozdevice == 0.49 04:54:22 INFO - mozfile == 1.2 04:54:22 INFO - mozhttpd == 0.7 04:54:22 INFO - mozinfo == 0.9 04:54:22 INFO - mozleak == 0.1 04:54:22 INFO - mozlog == 3.4 04:54:22 INFO - moznetwork == 0.27 04:54:22 INFO - mozprocess == 0.24 04:54:22 INFO - mozprofile == 0.28 04:54:22 INFO - mozrunner == 6.13 04:54:22 INFO - mozscreenshot == 0.1 04:54:22 INFO - mozsystemmonitor == 0.3 04:54:22 INFO - moztest == 0.8 04:54:22 INFO - mozversion == 1.4 04:54:22 INFO - psutil == 3.1.1 04:54:22 INFO - requests == 1.2.3 04:54:22 INFO - wsgiref == 0.1.2 04:54:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:22 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')]} 04:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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')]} 04:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:22 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 04:54:22 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 04:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:22 INFO - 'HOME': '/Users/cltbld', 04:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:22 INFO - 'LOGNAME': 'cltbld', 04:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:22 INFO - 'MOZ_NO_REMOTE': '1', 04:54:22 INFO - 'NO_EM_RESTART': '1', 04:54:22 INFO - 'PAGER': '/bin/cat', 04:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:22 INFO - 'PWD': '/builds/slave/test', 04:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:22 INFO - 'SHELL': '/bin/bash', 04:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:22 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:22 INFO - 'USER': 'cltbld', 04:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:22 INFO - 'XPC_FLAGS': '0x0', 04:54:22 INFO - 'XPC_SERVICE_NAME': '0', 04:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 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)) 04:54:22 INFO - Cleaning up... 04:54:22 INFO - Return code: 0 04:54:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:22 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')]} 04:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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')]} 04:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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 0x105a16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff759dc0b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, '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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:54:22 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 04:54:22 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 04:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:22 INFO - 'HOME': '/Users/cltbld', 04:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:22 INFO - 'LOGNAME': 'cltbld', 04:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:22 INFO - 'MOZ_NO_REMOTE': '1', 04:54:22 INFO - 'NO_EM_RESTART': '1', 04:54:22 INFO - 'PAGER': '/bin/cat', 04:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:22 INFO - 'PWD': '/builds/slave/test', 04:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:22 INFO - 'SHELL': '/bin/bash', 04:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:22 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:22 INFO - 'USER': 'cltbld', 04:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:22 INFO - 'XPC_FLAGS': '0x0', 04:54:22 INFO - 'XPC_SERVICE_NAME': '0', 04:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:54:23 INFO - Cleaning up... 04:54:23 INFO - Return code: 0 04:54:23 INFO - Running post-action listener: _resource_record_post_action 04:54:23 INFO - Running post-action listener: _start_resource_monitoring 04:54:23 INFO - Starting resource monitoring. 04:54:23 INFO - [mozharness: 2017-03-22 11:54:23.218696Z] Finished create-virtualenv step (success) 04:54:23 INFO - [mozharness: 2017-03-22 11:54:23.219710Z] Running install step. 04:54:23 INFO - Running pre-action listener: _resource_record_pre_action 04:54:23 INFO - Running main action method: install 04:54:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:23 INFO - Reading from file tmpfile_stdout 04:54:23 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:23 INFO - Reading from file tmpfile_stdout 04:54:23 INFO - Output received: 04:54:23 INFO - Usage: mozinstall [options] installer 04:54:23 INFO - Options: 04:54:23 INFO - -h, --help show this help message and exit 04:54:23 INFO - -d DEST, --destination=DEST 04:54:23 INFO - Directory to install application into. [default: 04:54:23 INFO - "/builds/slave/test"] 04:54:23 INFO - --app=APP Application being installed. [default: firefox] 04:54:23 INFO - mkdir: /builds/slave/test/build/application 04:54:23 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'] 04:54:23 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 04:54:38 INFO - Reading from file tmpfile_stdout 04:54:38 INFO - Output received: 04:54:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:54:38 INFO - Running post-action listener: _resource_record_post_action 04:54:38 INFO - [mozharness: 2017-03-22 11:54:38.348402Z] Finished install step (success) 04:54:38 INFO - [mozharness: 2017-03-22 11:54:38.348544Z] Running run-tests step. 04:54:38 INFO - Running pre-action listener: _resource_record_pre_action 04:54:38 INFO - Running main action method: run_tests 04:54:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:38 INFO - 2017-03-22 04:54:38.363 screenresolution[1955:9959] starting screenresolution argv=screenresolution get 04:54:38 INFO - 2017-03-22 04:54:38.366 screenresolution[1955:9959] Display 0: 1600x1200x32@60 04:54:38 INFO - 2017-03-22 04:54:38.372 screenresolution[1956:9961] starting screenresolution argv=screenresolution list 04:54:38 INFO - Available Modes on Display 0 04:54:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:38 INFO - Intel Iris: 04:54:38 INFO - Chipset Model: Intel Iris 04:54:38 INFO - Type: GPU 04:54:38 INFO - Bus: Built-In 04:54:38 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:38 INFO - Vendor: Intel (0x8086) 04:54:38 INFO - Device ID: 0x0a2e 04:54:38 INFO - Revision ID: 0x0009 04:54:38 INFO - Displays: 04:54:38 INFO - Display: 04:54:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:38 INFO - Display Serial Number: 1600x1200 60 04:54:38 INFO - Main Display: Yes 04:54:38 INFO - Mirror: Off 04:54:38 INFO - Online: Yes 04:54:38 INFO - Rotation: Supported 04:54:38 INFO - Return code: 0 04:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:38 INFO - Python 2.7.3 04:54:38 INFO - Return code: 0 04:54:38 INFO - grabbing minidump binary from tooltool 04:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:38 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 0x1057f4d30>, '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 0x10571bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057e9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:38 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 04:54:38 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 04:54:38 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 04:54:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:38 INFO - Return code: 0 04:54:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:54:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:54:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:38 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/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 04:54:38 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/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --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 04:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yi4UsO4HVh/Render', 04:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:38 INFO - 'HOME': '/Users/cltbld', 04:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:38 INFO - 'LOGNAME': 'cltbld', 04:54:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:38 INFO - 'MOZ_NO_REMOTE': '1', 04:54:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:38 INFO - 'NO_EM_RESTART': '1', 04:54:38 INFO - 'PAGER': '/bin/cat', 04:54:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:38 INFO - 'PWD': '/builds/slave/test', 04:54:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:38 INFO - 'SHELL': '/bin/bash', 04:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4zDZ9orIy/Listeners', 04:54:38 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:38 INFO - 'USER': 'cltbld', 04:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:38 INFO - 'XPC_FLAGS': '0x0', 04:54:38 INFO - 'XPC_SERVICE_NAME': '0', 04:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:38 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/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 04:54:38 INFO - mozversion application_buildid: 20170322032435 04:54:38 INFO - mozversion application_changeset: 7b852b9750055433ba5bd46473602ba42422a045 04:54:38 INFO - mozversion application_display_name: Firefox 04:54:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:38 INFO - mozversion application_name: Firefox 04:54:38 INFO - mozversion application_remotingname: firefox 04:54:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:54:38 INFO - mozversion application_vendor: Mozilla 04:54:38 INFO - mozversion application_version: 53.0 04:54:38 INFO - mozversion platform_buildid: 20170322032435 04:54:38 INFO - mozversion platform_changeset: 7b852b9750055433ba5bd46473602ba42422a045 04:54:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:54:38 INFO - mozversion platform_version: 53.0 04:54:38 INFO - using testdate: 1490183678 04:54:38 INFO - actual date: 1490183678 04:54:38 INFO - starting webserver on 'localhost:49338' 04:54:38 INFO - SUITE-START | Running 2 tests 04:54:38 INFO - TEST-START | dromaeo_css 04:54:38 INFO - operating with platform_type : mac_ 04:54:38 INFO - Initialising browser for dromaeo_css test... 04:54:38 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp7Gyro7/profile http://localhost:49338/getInfo.html) 04:54:41 INFO - PROCESS | 1966 | 2017-03-22 04:54:41.820 plugin-container[1968:10105] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4947, name = 'com.apple.tsm.portname' 04:54:41 INFO - PROCESS | 1966 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:41 INFO - PROCESS | 1966 | 2017-03-22 04:54:41.821 plugin-container[1968:10105] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9303, name = 'com.apple.CFPasteboardClient' 04:54:41 INFO - PROCESS | 1966 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:41 INFO - PROCESS | 1966 | 2017-03-22 04:54:41.821 plugin-container[1968:10105] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:54:41 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 04:54:41 INFO - PROCESS | 1966 | colorDepth:24 04:54:41 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 04:54:41 INFO - PROCESS | 1966 | __metrics 04:54:41 ERROR - PROCESS | 1966 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 04:54:42 INFO - TEST-INFO | 1966: exit 0 04:54:42 INFO - Browser initialized. 04:54:42 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:42 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp7Gyro7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:44 INFO - PROCESS | 1969 | 2017-03-22 04:54:44.951 plugin-container[1970:10235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.tsm.portname' 04:54:44 INFO - PROCESS | 1969 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:44 INFO - PROCESS | 1969 | 2017-03-22 04:54:44.952 plugin-container[1970:10235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4513, name = 'com.apple.CFPasteboardClient' 04:54:44 INFO - PROCESS | 1969 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:44 INFO - PROCESS | 1969 | 2017-03-22 04:54:44.952 plugin-container[1970:10235] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:54:54 INFO - PROCESS | 1969 | RSS: Main: 172937216 04:54:54 INFO - PROCESS | 1969 | 04:57:56 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49338/tests/dromaeo/cssquery-ext.html) 04:57:58 INFO - PROCESS | 1969 | RSS: Main: 188874752 04:57:58 INFO - PROCESS | 1969 | 05:01:00 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-ext.html (next: http://localhost:49338/tests/dromaeo/cssquery-jquery.html) 05:01:01 INFO - PROCESS | 1969 | RSS: Main: 202129408 05:01:01 INFO - PROCESS | 1969 | 05:04:03 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49338/tests/dromaeo/cssquery-mootools.html) 05:04:03 INFO - PROCESS | 1969 | RSS: Main: 206934016 05:04:03 INFO - PROCESS | 1969 | 05:07:05 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49338/tests/dromaeo/cssquery-prototype.html) 05:07:06 INFO - PROCESS | 1969 | RSS: Main: 212103168 05:07:06 INFO - PROCESS | 1969 | 05:10:09 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49338/tests/dromaeo/cssquery-yui.html) 05:10:09 INFO - PROCESS | 1969 | RSS: Main: 213426176 05:10:09 INFO - PROCESS | 1969 | 05:13:12 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-yui.html (next: http://localhost:49338/tests/dromaeo/cssquery-dojo.html) 05:13:13 INFO - PROCESS | 1969 | RSS: Main: 214331392 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | __start_tp_report 05:13:13 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 05:13:13 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 05:13:13 INFO - PROCESS | 1969 | |i|pagename|runs| 05:13:13 INFO - PROCESS | 1969 | |0;dojo.html;3518.050126465856;3530.3468858261217;3556.8577256909725;3560.9109772255692;3564.1624218308702;4296.291111966521;5660.9716951415285;5791.21818554495;5800.390958949308;5854.648721076738;4946.950530494694;5759.078547432412;5795.15970184324;5844.707764611774;5860.50185734212;5314.282571852808;5330.866728331784;5333.38666053403;5362.981033603623;5370.489803468664;4119.773412462313;5405.972970135163;5417.349918009824;5428.185772134172;5456.672599644034;4748.738819364934;5100.0054989277105;5229.947700523003;5257.710825904593;5387.649802762808;4147.776405960234;4999.900001999939;5336.546393556552;5397.568194544427;5440.564754819645;4646.721196728207;5119.1553393690365;5245.186996015624;5331.493508116722;5433.347998240197;5034.320366750479;5711.7715291388295;5830.533557315404;5949.405059494016;5983.012802887519;6228.750849965996;6247.344028876993;6254.7498100075945;6305.0542418637115;6339.080833279195;6279.403456671655;6299.7165127568915;6303.747850086037;6308;6334.968325158391;5982.8504287392725;6009.038553831366;6010.939890601126;6031.517478601745;6035.336113027563;6257.124002639634;6282.183316168869;6290;6302.180716506825;6356.491480681534;5408.729563521808;6249.59377640461;6292.46514046302;6319.684015799192;6327.810165695037;6179.81460556184;6259.217597800275;6303;6330.430261276507;6333.68331583419;5225.738713064332;5385.192221166778;6073.603071293627;6206.193194884636;6236.719347629368;6238.594491358138;6272.749090036439;6303.2751233607805;6304.3695630437505;6315.936840631535;5124.615653825978;5133.922991155136;5140.717260550631;5145.125328694131;5158.38099428071;4408.713433626804;4484.192845287879;4501.68488205829;4561.612262957619;4617.746023968647;5975.790847320323;6005.6997150142315;6072.605280656743;6082.847928801727;6100.664463454553;5158.871028224325;6253.96873015632;6259.593126446857;6319.494440444845;6352;4403.2734598791485;5705.773258749306;5866.208061911672;6073.453389194994;6092.908606370908;5561.527270181999;5570.192322113271;5577.191307260425;5593.049181639131;5600.103983362643;6550.967245163743;6589.242237142694;6596.241432235354;6607.3062328456745;6622.370874766986;6109.938900610937;6118.43644382056;6163.445289923929;6276.968615156895;6296.937030629635;5721.914171287351;5756.481916627524;6548.672566371758;6552.443042341454;6563.474922006132;5014.899702006012;5885.264341957255;6248.156498872594;6262.060690896402;6279.560430769802;6218.626882387071;6249.1563638908165;6264.436200741955;6265.937340626718;6286.497080233662;5143;6188.876222475616;6219.968900155471;6223.657698826427;6274.623522588477;6117.908231376444;6206.007038873759;6280.057991301159;6281;6293.527985401021;4719.858404247878;5946.226990491208;6047.123167140828;6193.102000210034;6193.628382297076;5113.284140220298;6106.023036314168;6112.0171844544475;6128.747575574743;6189.04069869171;4971.477994810638;6031.5777895548645;6100.786472473442;6103.6032657877095;6132.693365331805 05:13:13 INFO - PROCESS | 1969 | |1;ext.html;513.863826086087;518.4970578538818;524.0070067222613;534.3187436019076;570.0650932470751;40743;42272.78863605685;42312.36531452027;42358;44289.44986925458;44309.33535996963;44811.551884481145;44834.551654483446;44885.32672009923;44962;9421.858672119906;9658.517074146299;9680.564374603124;9698.078682525149;11441.313521188713;11545.134114941371;11798.646040618794;11817.936385725283;11818.940905295462;11832.290062596272;11825.586104486345;11827.526898924032;11871.821922671166;11882.108841836854;11910.583129590466;11735.11986601004;11791.11566632506;11794.233374830694;11804.763904721858;11817.35004574748;11385.601503947404;11439.771204575862;11447.771044579062;11467.36929468879;11481.540738370455;38554;38762.41856372129;38943.8052809737;38985;39158.41262381067;4031.2743706132883;4047.5345335286524;4094.1197642506704;4140.91718165635;4158.604932531404;28415.289617759514;28540.571891421645;28600.71399286001;28689.13932582005;31033.68966310353;3271.4111459937203;3428.879989200391;3451.240727040047;3475.6350583188655;3497.4404095344876;516696;519793;521832;522000;525493.7450625483;60612.393876060676;61093.38906610877;61118;61126.38873611296;61160.08259876105;62406.687966559875;62419.06371404433;62479.06281405783;62520.687396562724;62655.6867215661;16537.83462165363;16736.41422550205;16744.83255167457;16813.831861681472;16857.83142168587;11972.521099155936;12247;13051;13723.862761372258;13911.860881391056;20555.38333849987;21894;21896.671549926763;21947.561048778934;21956.89021554882;8798.560071996502;8888.688895888612;8931.19619234272;8975.461472311683;9008.459492430475;727.447140173472;763.4426868385998;869.8129902070958;906;927.6753136402206;30794.846025769726;31563.684363156535;31630.841845791085;31834.681653183634;32282.192945176088;1071.3250652089134;1074.9623763168252;1083.4041277297456;1134.2230572058168;1230.809224570193;13437.798433023512;14081.155130691986;14857.554273371816;16275.348986040426;16321.510354689379;705172;714997;715036;716182;717952;58136.127958080666;58340.12489812656;58965;59076.11385829216;59179.816403671684;1436.4469679173594;1463.0709499467914;1473.1161303218198;1475.1296734926445;1479.6374888152473;25722;28375.71624283731;30245.243868902573;30395.179232388924;30851.845740771154;42776.57223427726;48859;49598.75200623974;49655.503444965085;49845.50463486101;621241;624608;624713;625007;626878;23648.408789780395;24175.395615109763;25937;25990.220293391227;26872.925082996462;43205.351919720604;43596.474123405525;44428.55571444244;44801.32798007967;44919;35469.82265088658;35657;36484;36498;37568.62431375651;35820.10449738673;36873.63126368702;37369.43945840869;37451.81274093612;38226;37047.81476092602;37306.88079357624;37321.69374071895;38027.80986095052;38418.27117779762;31897.36205275928;31981.360372791947;34039.65960340464;34202.46088926054;34437.31125377528;20631.65894216871;23328.183513576943;24766.885490152625;25204;25664 05:13:13 INFO - PROCESS | 1969 | |2;jquery.html;345.99481007784885;400.50137578714487;402.47678018575846;405.7484359696988;433.7854008775428;20575.485612859688;21543;22065.11739530417;22097.784621845793;22190.445238869037;21939.780602193972;22241.777582224175;22457.438564035907;22628.88685556574;22802.88598557009;4679.485256621769;5989.580729348947;6023;6025.15647809307;6030.185924900148;4824.396950381202;5350.250964864922;5922.437368449991;5980.8504787380225;6028.939710602882;5879.412058794129;5925.081612350093;5929.525637948954;5945.524358051367;5948.940510594904;5648.350439699446;5835.5039821615;5919.408059194089;5919.5264378850015;5953.642781433106;5211.24436956643;5220.608454365938;5235.869103272411;5238.633295669305;5244.213367994793;26959.730402695917;26984;27007;27179.320516987234;27242.318942026606;2822.1956742328543;2861.9141425757052;2882.610847535577;2883.8269703817627;2936.8384738839354;15922.283497242652;16251.349946002145;16351.182440877908;16504.25730842103;16850.578735531588;1905.6093500832296;1906.675865102922;1917.3864363403716;1931.2178567680112;1936.2835750772304;110511.44744276308;128040;131712;134876;137377;10123.797524049478;10257.846132308021;11295.209335346612;11358.488868000959;12204.145709800407;16255.67488650244;16409.83590164107;16418.6716265674;16504.092274924995;16616.169191540375;6600.372964568358;9091.772705682411;9202.217811485965;9337.579808908615;9461.52692365379;7913.366930645535;8232.300254478316;8925.910740892637;9097.499637519868;9272.72181834546;4905.798079470553;4918.385201849769;4961.627877909171;4996.525330093636;5016.573591244785;2062.9174833006814;2063.8968051597362;2087.3007542473442;2088.9033257539913;2100.1809294375207;726.284609659485;844.7888027993001;915.5376534849859;915.9816803663889;929.869818225449;20454.181832726525;21597.784022159893;21822.78050755527;21855.487944093165;21971.80569273589;757.2994979643807;894.3203165594196;894.9931327256836;900.9954950225207;929.419113054341;9193.678221262224;10758.139348852073;11143.944280278547;11145.777084458428;11179.776404471864;376037;377804;378144;379301;709559;148593;151267;175578;178486;178881.1055944738;398.2572502283221;457.14285714285717;468.650855112943;473.3869638817739;475.9524047595282;9886.604535818487;11418.371989540656;11599;11734;12138.089643276613;53954.730226350184;56406.71796641155;61363;63915.68042159759;64198.67900660467;93448.53275733578;94340;95127;95175;96222;8532.402731808963;8563.914360856312;8649.221570058726;8990.145936136056;9078.182963533314;12602.87397126017;13522.729545409233;13544.86455135436;13739.106958047694;14097.224652644203;10887.727806804576;11445.713857153638;11631.243969141979;11883.405829708652;12145.210561313486;11547.711307217387;11571.190016699087;11635.767284654428;11679.649610511698;11898.405079746151;11820.349880756641;11832.70418239551;12056.276623402624;12173.391330433265;12185.14703970749;8838.646454141763;8876.068012858816;8906.109389061043;9040.457572545669;9107.08929107084;9803.411795292306;11784;11850.407479626158;11884.227525210834;11911.285322880654 05:13:13 INFO - PROCESS | 1969 | |3;mootools.html;1444.4150119201727;1445.4507287230851;1465.01111749569;1466.4427517543331;1467.7651575747882;7739.458237923348;7968.402369822272;8219.013718353799;8498.1501849815;8608.827823443535;8107.18928107189;8426.620802063906;8443.83112337753;8541.658333666646;8545;2387.1883559589737;2406.3984003999;2419.0686585664557;2425.563398588253;2432.635104734295;2395.149721848745;2420.552197843396;2425.223928342931;2431.683881095464;2434.7686969737847;2389.832711710181;2395.73646898841;2423.333583264599;2424.781769640732;2426.1144682191048;2331.94170145746;2355.9175428859994;2367.5620010297976;2378.7502312257225;2382.8927698253533;2364.373441038126;2364.846284991487;2430.5503481855912;2430.635404689293;2445.08309383981;8618.138186181395;8641.697540586048;8659.13408659129;8676.52279124648;8722.171393717586;5249.816256431045;5376.731163441851;5382.784688612451;5397.001554712391;5416.945830541684;3299.488579270217;3344.4983252512075;3356.9496457553155;3442.9483557746653;3557.4485954677066;1250.4685508658783;1256.886880180788;1281.7436512697404;1319.4919955816983;1324.5959982205422;10962.616308429246;11024.834627480594;11041.282316649473;11062.22564420491;11135.99776020162;4324.718893271927;4592.425946756655;4653.325267836145;4661.86014419568;4689.648276379217;7937.32532734724;8826.293896488265;8852.38033337673;8877.24543413817;8882.689105881263;4799.016201678647;4938.604911607134;5262;5278.472152784768;5342.893142137135;3252.9024129275685;4573.085382923428;4760.071786001697;4784.091022705675;4785.282207668877;3397.9320413592086;3788.242351529705;3878.204967981557;3916.3146449371247;3935.8032098394965;1004.2568499310457;1177.7644471105814;1197.9700507487382;1200.4657927222302;1201.4653479201845;775.5889378629336;932.6802574357345;935.4106912644991;940.7507010642186;969.4619486185094;4732.692374995614;5102.132637451642;5307.734613269321;5886.735096920649;5951.285845698544;559.0272925110279;583.9357670656225;586.0330454749698;592.1473078766562;595.7438301530384;3251.9593730006172;3363.512290717832;3750.0812300985885;3837.808109594509;3860.942085868714;9598.136167744937;9888.752781180528;9957.153641940371;9963.551640176209;9976.351537150062;9817.607295708234;9867.161291290176;9922.404655720535;9933.453660048623;9962.053604907667;7748.806279843049;7770.261825126604;7850.921490785133;7941.880871786928;7966.2033796621035;5505.476979686923;5514.145307477347;5601.859953501195;5625.578081643975;5757.481826635623;9194.172524472562;9206.631734730803;9313;9313.44119352841;9358.81282374335;8986.910130898606;9338.252939764667;9346.11211934865;9460.385074970105;9487.905120948702;6766.391024807791;6946.409555187865;7146.892796608159;7347.448941329529;7437.628118593941;7996.680132794623;8052.87920681202;8079.798005049921;8138.348932085537;8141.674333026849;7130.144382673905;7256.673449694671;7288.489805713762;7342.9632851835395;7389.408847292097;7125.679344429617;7139.071920650283;7160.57036577807;7250.528715633467;7285;6464.321246269074;6614.867702646016;6616.2722100567935;6629.204495460575;6652.401283884474;5100.2893922761905;5110.207917772751;5121.948780512147;5253.527182553588;5286.286351342519;4787.138315103315;5177.4822517749435;5188;5255.579553635776;5284.31303930502 05:13:13 INFO - PROCESS | 1969 | |4;prototype.html;363.30608537692996;372.6701868846071;378.292592851368;378.76138033039183;384.3120813743399;4353.934690979638;4397.384366188736;4797.234171175628;5241.08281050816;5250.107481728101;5354.2771725817;5456.817273090755;5564.944350556493;5608.327000759904;5614.747336369863;3800.714946379019;4171.770552619605;4392.8023238954165;4419.248727716296;4423.51341352451;3667;3787.163225835481;4263.637590804786;4352.717073390236;4390.670699697535;3417.8803741869037;3789.185325155091;4287.228298906196;4314.3528470729325;4391.934120988188;4085.387191921206;4094.1197642506854;4195.958040419588;4312.82748690052;4340.414044104037;3864.806759662006;3867.671247943928;3886.9028274293087;3904.5401397119917;3909.6872250219913;5249.370075590915;5316.548093412064;5374.274472946141;5401.540869026137;5459.689674478136;4954.777035033432;4981.7794640312995;5012.017849379613;5040;5098.770555325019;4944.9121193337405;5085.415177254589;5845.970770146165;5875.412458754133;5966.254218222723;3551.058969373118;4170.04089059515;4197.244495990721;4248.447701798777;4253.128108737701;5704.800331988402;5823;5944.82165535039;6091.908621370683;6116.877662446771;3747.7189210809297;3990.940135897964;4071.0229544909603;4226;4339.956600434019;3806.5051543299196;3997.9400308995387;4019.2966230909474;4048.344403935439;4089.754614723126;3994.6604538614542;4745.549172828576;4753.33453316536;4775.641826863;4788.329633851264;4957.479464656231;5858.623223542464;5861.501772349313;5865.090910908816;5872.265966754156;1156.5605070073486;1161.8896204860525;1246.4328730427633;1265.6900108387958;1298.2080930632308;809.6437567470294;835.5279267214005;872.2934423117168;892.7144911327667;913.2374467319862;4621.388915262865;5242.7640756166065;5270.7628156733035;5317;5334.786608535693;5445.618806683494;5642.85892852682;5671.177679236487;5708.429157084258;5734.39788822176;4772.331873537708;4929.014197160583;5217.50433708797;5289.338832645919;5327.600429967691;2577.587585986271;2611.4929667519013;2741.383188782508;2853.486372452937;2929.985350073279;5664.433556644385;5749.0740601898;5784.334801497797;5896.204012458349;5904.704764761745;5396.163594642837;5469.945300546943;5866.213548564483;5910.379410161871;5994.520438364921;5187.922181167285;5432.701201433959;5791.218185545066;5973.387185459815;6113.908291375633;5053.924191137063;5230.555402790806;5351.324337831084;5621.80323688669;5715.971420142872;5598.552115830642;5626.887462250814;5725.8568535786935;5730.5702072345575;5754.791493786352;5410.675359478444;5578.246936663661;5602.803901863415;6027.457528822251;6039.547033972557;3150.039238032422;3325.8004519728893;3409.6931276185264;3742.781208160925;3767.453719210754;4996.800127994839;5837.94162058374;5961.195238642727;5972.850678733066;5975.671338076274;4488.4165058542185;5166.59753214757;5354.812581559782;5643.830685079454;5793.525118762729;5294.417614062373;5638.255043564183;5722.942770572241;5749.597528172988;5751.424857514383;4682.461516925461;4843.709377437365;5487.341519017744;5759.740811663569;5781.508571771446;5367.01420474427;5806.709664516673;5809.128630705428;5826.0387036140255;5870.7945221917025;4592.747398893093;5370.785168593213;5685.772569097356;5693.4021927696995;5731.914021289767 05:13:13 INFO - PROCESS | 1969 | |5;yui.html;596.6032588328761;700.6006576251535;745.7389913530266;747.970081196752;851.5614458553846;13520.729585408286;14063.29683515824;15206.923965380185;16163.030218186917;16442.506724798244;12482.126251162423;14962;14998.475053373135;15057.17185554794;15080.396784128649;866.4541338956449;882.2721254964648;896.8340856941454;897.344938195118;898.838209122361;882.7395918204113;888.3958907942597;890.1098901098901;891.5453118909338;893.9910600894005;933.0948979489884;934.5981228071927;936.7564433247371;937.3766445313893;940.261894412886;926.1109335038371;929.4376901974276;932.8647346134807;933.6172169410543;935.873657056299;689.2762599270745;691.0360047733434;691.1844024051617;694.9679725607468;696.2098018748757;16149.03105813655;16249.106299153542;16766.497005089866;16780.748288775678;16799;14884.479043233436;14900.776488352683;14901.92549037248;14930.925345373204;14956.700865982728;11678.591249306319;11765.470553825098;11849.229800063054;11965.162438629299;12032.27806331623;3802.790846503441;3833.5399752029934;3842.1355195081164;3852.325842977468;3952.407138929155;110298;112538;114568.42715786368;115461.84538154595;116913.41543292314;11279.830802537968;11416.828747568794;11433.771324573461;11453.484593193327;11465.31208127515;23420.88289558541;24063.157789477285;24132.03471861141;24135.7586424137;24196.637050444257;7958.442908996315;8006;8027.879581806277;8069.677212911535;8095.0285965683315;4380.299152135643;4410.878240032622;4474.530174331713;4476.395686582335;4564.977175114103;3724.1434470072036;3807.124361396839;3825.196708691206;3832.597577254404;3838.7696738195796;621.641712857408;690.8445599740119;694.506900100934;702.2731472925498;726.2991213479019;696.4498046543174;703.6763088979025;705.7882635209417;716.0905649824693;756.2059837170948;9361;9887.15099985509;9903.900960990442;10329.74175645615;10518.368897866152;677.8678157759289;693.389816961071;707.564847618721;724.713738073458;735.7314580178304;4327.610515053598;5008.499150084962;5019.447860735316;5059.918787758682;5170.819021334235;106493.46753266185;111941;112596.87403126027;113092.30361544584;116003;67816.69975755464;81308.18691813125;85174.57412712897;88376.55811721028;96763;83459.99999999879;84190.15809841824;84861;86959.56520217485;87242;11085.224034317844;11130.499127539442;11243.887561124611;11492.482838272465;11551.480183391599;42216.78891605522;52832.73583632057;53276.66808329823;53495.789678598674;54081.45918540764;63924.68037659782;68585;68898.3110168912;70727;71999.64000179965;13573.049886508245;13636.723779340635;13731.862681373059;13878.514252001132;14066.156030638194;15468.226588670746;15515.922420387826;15551.222438878238;15631.609209769847;16002.759958600398;12017.699557511132;13770;13865.861341386457;14439.494617688331;14659.853401466275;12853.907417869586;13680.247586382844;14283.571492855232;14372.928135359256;14901.423658321708;12725.809112863499;13723.794143088062;13891.933987767861;14283.785743214068;14396;8906.554672266491;9960.402375857471;11489.368084755419;11556.884431155917;11560.595379161688;10923.945380273048;11283.943580282046;11637.941810290895;11675.591354302558;11788 05:13:13 INFO - PROCESS | 1969 | __end_tp_report 05:13:13 INFO - PROCESS | 1969 | __start_cc_report 05:13:13 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,388 05:13:13 INFO - PROCESS | 1969 | __end_cc_report 05:13:13 INFO - PROCESS | 1969 | __startTimestamp1490184793021__endTimestamp 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | ------- Summary: start ------- 05:13:13 INFO - PROCESS | 1969 | Number of tests: 6 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | [#0] dojo.html Cycles:165 Average:5748.52 Median:6031.58 stddev:690.94 (11.5%) stddev-sans-first:670.53 05:13:13 INFO - PROCESS | 1969 | Values: 3518.1 3530.3 3556.9 3560.9 3564.2 4296.3 5661.0 5791.2 5800.4 5854.6 4947.0 5759.1 5795.2 5844.7 5860.5 5314.3 5330.9 5333.4 5363.0 5370.5 4119.8 5406.0 5417.3 5428.2 5456.7 4748.7 5100.0 5229.9 5257.7 5387.6 4147.8 4999.9 5336.5 5397.6 5440.6 4646.7 5119.2 5245.2 5331.5 5433.3 5034.3 5711.8 5830.5 5949.4 5983.0 6228.8 6247.3 6254.7 6305.1 6339.1 6279.4 6299.7 6303.7 6308.0 6335.0 5982.9 6009.0 6010.9 6031.5 6035.3 6257.1 6282.2 6290.0 6302.2 6356.5 5408.7 6249.6 6292.5 6319.7 6327.8 6179.8 6259.2 6303.0 6330.4 6333.7 5225.7 5385.2 6073.6 6206.2 6236.7 6238.6 6272.7 6303.3 6304.4 6315.9 5124.6 5133.9 5140.7 5145.1 5158.4 4408.7 4484.2 4501.7 4561.6 4617.7 5975.8 6005.7 6072.6 6082.8 6100.7 5158.9 6254.0 6259.6 6319.5 6352.0 4403.3 5705.8 5866.2 6073.5 6092.9 5561.5 5570.2 5577.2 5593.0 5600.1 6551.0 6589.2 6596.2 6607.3 6622.4 6109.9 6118.4 6163.4 6277.0 6296.9 5721.9 5756.5 6548.7 6552.4 6563.5 5014.9 5885.3 6248.2 6262.1 6279.6 6218.6 6249.2 6264.4 6265.9 6286.5 5143.0 6188.9 6220.0 6223.7 6274.6 6117.9 6206.0 6280.1 6281.0 6293.5 4719.9 5946.2 6047.1 6193.1 6193.6 5113.3 6106.0 6112.0 6128.7 6189.0 4971.5 6031.6 6100.8 6103.6 6132.7 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | [#1] ext.html Cycles:180 Average:74644.69 Median:36685.82 stddev:167329.76 (456.1%) stddev-sans-first:167706.59 05:13:13 INFO - PROCESS | 1969 | Values: 513.9 518.5 524.0 534.3 570.1 40743.0 42272.8 42312.4 42358.0 44289.4 44309.3 44811.6 44834.6 44885.3 44962.0 9421.9 9658.5 9680.6 9698.1 11441.3 11545.1 11798.6 11817.9 11818.9 11832.3 11825.6 11827.5 11871.8 11882.1 11910.6 11735.1 11791.1 11794.2 11804.8 11817.4 11385.6 11439.8 11447.8 11467.4 11481.5 38554.0 38762.4 38943.8 38985.0 39158.4 4031.3 4047.5 4094.1 4140.9 4158.6 28415.3 28540.6 28600.7 28689.1 31033.7 3271.4 3428.9 3451.2 3475.6 3497.4 516696.0 519793.0 521832.0 522000.0 525493.7 60612.4 61093.4 61118.0 61126.4 61160.1 62406.7 62419.1 62479.1 62520.7 62655.7 16537.8 16736.4 16744.8 16813.8 16857.8 11972.5 12247.0 13051.0 13723.9 13911.9 20555.4 21894.0 21896.7 21947.6 21956.9 8798.6 8888.7 8931.2 8975.5 9008.5 727.4 763.4 869.8 906.0 927.7 30794.8 31563.7 31630.8 31834.7 32282.2 1071.3 1075.0 1083.4 1134.2 1230.8 13437.8 14081.2 14857.6 16275.3 16321.5 705172.0 714997.0 715036.0 716182.0 717952.0 58136.1 58340.1 58965.0 59076.1 59179.8 1436.4 1463.1 1473.1 1475.1 1479.6 25722.0 28375.7 30245.2 30395.2 30851.8 42776.6 48859.0 49598.8 49655.5 49845.5 621241.0 624608.0 624713.0 625007.0 626878.0 23648.4 24175.4 25937.0 25990.2 26872.9 43205.4 43596.5 44428.6 44801.3 44919.0 35469.8 35657.0 36484.0 36498.0 37568.6 35820.1 36873.6 37369.4 37451.8 38226.0 37047.8 37306.9 37321.7 38027.8 38418.3 31897.4 31981.4 34039.7 34202.5 34437.3 20631.7 23328.2 24766.9 25204.0 25664.0 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | [#2] jquery.html Cycles:180 Average:33079.86 Median:2910.33 stddev:81358.49 (2795.5%) stddev-sans-first:81549.60 05:13:13 INFO - PROCESS | 1969 | Values: 346.0 400.5 402.5 405.7 433.8 20575.5 21543.0 22065.1 22097.8 22190.4 21939.8 22241.8 22457.4 22628.9 22802.9 4679.5 5989.6 6023.0 6025.2 6030.2 4824.4 5350.3 5922.4 5980.9 6028.9 5879.4 5925.1 5929.5 5945.5 5948.9 5648.4 5835.5 5919.4 5919.5 5953.6 5211.2 5220.6 5235.9 5238.6 5244.2 26959.7 26984.0 27007.0 27179.3 27242.3 2822.2 2861.9 2882.6 2883.8 2936.8 15922.3 16251.3 16351.2 16504.3 16850.6 1905.6 1906.7 1917.4 1931.2 1936.3 110511.4 128040.0 131712.0 134876.0 137377.0 10123.8 10257.8 11295.2 11358.5 12204.1 16255.7 16409.8 16418.7 16504.1 16616.2 6600.4 9091.8 9202.2 9337.6 9461.5 7913.4 8232.3 8925.9 9097.5 9272.7 4905.8 4918.4 4961.6 4996.5 5016.6 2062.9 2063.9 2087.3 2088.9 2100.2 726.3 844.8 915.5 916.0 929.9 20454.2 21597.8 21822.8 21855.5 21971.8 757.3 894.3 895.0 901.0 929.4 9193.7 10758.1 11143.9 11145.8 11179.8 376037.0 377804.0 378144.0 379301.0 709559.0 148593.0 151267.0 175578.0 178486.0 178881.1 398.3 457.1 468.7 473.4 476.0 9886.6 11418.4 11599.0 11734.0 12138.1 53954.7 56406.7 61363.0 63915.7 64198.7 93448.5 94340.0 95127.0 95175.0 96222.0 8532.4 8563.9 8649.2 8990.1 9078.2 12602.9 13522.7 13544.9 13739.1 14097.2 10887.7 11445.7 11631.2 11883.4 12145.2 11547.7 11571.2 11635.8 11679.6 11898.4 11820.3 11832.7 12056.3 12173.4 12185.1 8838.6 8876.1 8906.1 9040.5 9107.1 9803.4 11784.0 11850.4 11884.2 11911.3 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | [#3] mootools.html Cycles:180 Average:5459.49 Median:5389.89 stddev:2974.70 (55.2%) stddev-sans-first:2967.74 05:13:13 INFO - PROCESS | 1969 | Values: 1444.4 1445.5 1465.0 1466.4 1467.8 7739.5 7968.4 8219.0 8498.2 8608.8 8107.2 8426.6 8443.8 8541.7 8545.0 2387.2 2406.4 2419.1 2425.6 2432.6 2395.1 2420.6 2425.2 2431.7 2434.8 2389.8 2395.7 2423.3 2424.8 2426.1 2331.9 2355.9 2367.6 2378.8 2382.9 2364.4 2364.8 2430.6 2430.6 2445.1 8618.1 8641.7 8659.1 8676.5 8722.2 5249.8 5376.7 5382.8 5397.0 5416.9 3299.5 3344.5 3356.9 3442.9 3557.4 1250.5 1256.9 1281.7 1319.5 1324.6 10962.6 11024.8 11041.3 11062.2 11136.0 4324.7 4592.4 4653.3 4661.9 4689.6 7937.3 8826.3 8852.4 8877.2 8882.7 4799.0 4938.6 5262.0 5278.5 5342.9 3252.9 4573.1 4760.1 4784.1 4785.3 3397.9 3788.2 3878.2 3916.3 3935.8 1004.3 1177.8 1198.0 1200.5 1201.5 775.6 932.7 935.4 940.8 969.5 4732.7 5102.1 5307.7 5886.7 5951.3 559.0 583.9 586.0 592.1 595.7 3252.0 3363.5 3750.1 3837.8 3860.9 9598.1 9888.8 9957.2 9963.6 9976.4 9817.6 9867.2 9922.4 9933.5 9962.1 7748.8 7770.3 7850.9 7941.9 7966.2 5505.5 5514.1 5601.9 5625.6 5757.5 9194.2 9206.6 9313.0 9313.4 9358.8 8986.9 9338.3 9346.1 9460.4 9487.9 6766.4 6946.4 7146.9 7347.4 7437.6 7996.7 8052.9 8079.8 8138.3 8141.7 7130.1 7256.7 7288.5 7343.0 7389.4 7125.7 7139.1 7160.6 7250.5 7285.0 6464.3 6614.9 6616.3 6629.2 6652.4 5100.3 5110.2 5121.9 5253.5 5286.3 4787.1 5177.5 5188.0 5255.6 5284.3 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | [#4] prototype.html Cycles:180 Average:4635.08 Median:5246.07 stddev:1417.91 (27.0%) stddev-sans-first:1385.17 05:13:13 INFO - PROCESS | 1969 | Values: 363.3 372.7 378.3 378.8 384.3 4353.9 4397.4 4797.2 5241.1 5250.1 5354.3 5456.8 5564.9 5608.3 5614.7 3800.7 4171.8 4392.8 4419.2 4423.5 3667.0 3787.2 4263.6 4352.7 4390.7 3417.9 3789.2 4287.2 4314.4 4391.9 4085.4 4094.1 4196.0 4312.8 4340.4 3864.8 3867.7 3886.9 3904.5 3909.7 5249.4 5316.5 5374.3 5401.5 5459.7 4954.8 4981.8 5012.0 5040.0 5098.8 4944.9 5085.4 5846.0 5875.4 5966.3 3551.1 4170.0 4197.2 4248.4 4253.1 5704.8 5823.0 5944.8 6091.9 6116.9 3747.7 3990.9 4071.0 4226.0 4340.0 3806.5 3997.9 4019.3 4048.3 4089.8 3994.7 4745.5 4753.3 4775.6 4788.3 4957.5 5858.6 5861.5 5865.1 5872.3 1156.6 1161.9 1246.4 1265.7 1298.2 809.6 835.5 872.3 892.7 913.2 4621.4 5242.8 5270.8 5317.0 5334.8 5445.6 5642.9 5671.2 5708.4 5734.4 4772.3 4929.0 5217.5 5289.3 5327.6 2577.6 2611.5 2741.4 2853.5 2930.0 5664.4 5749.1 5784.3 5896.2 5904.7 5396.2 5469.9 5866.2 5910.4 5994.5 5187.9 5432.7 5791.2 5973.4 6113.9 5053.9 5230.6 5351.3 5621.8 5716.0 5598.6 5626.9 5725.9 5730.6 5754.8 5410.7 5578.2 5602.8 6027.5 6039.5 3150.0 3325.8 3409.7 3742.8 3767.5 4996.8 5837.9 5961.2 5972.9 5975.7 4488.4 5166.6 5354.8 5643.8 5793.5 5294.4 5638.3 5722.9 5749.6 5751.4 4682.5 4843.7 5487.3 5759.7 5781.5 5367.0 5806.7 5809.1 5826.0 5870.8 4592.7 5370.8 5685.8 5693.4 5731.9 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - PROCESS | 1969 | [#5] yui.html Cycles:180 Average:21395.21 Median:3836.15 stddev:30945.66 (806.7%) stddev-sans-first:30993.06 05:13:13 INFO - PROCESS | 1969 | Values: 596.6 700.6 745.7 748.0 851.6 13520.7 14063.3 15206.9 16163.0 16442.5 12482.1 14962.0 14998.5 15057.2 15080.4 866.5 882.3 896.8 897.3 898.8 882.7 888.4 890.1 891.5 894.0 933.1 934.6 936.8 937.4 940.3 926.1 929.4 932.9 933.6 935.9 689.3 691.0 691.2 695.0 696.2 16149.0 16249.1 16766.5 16780.7 16799.0 14884.5 14900.8 14901.9 14930.9 14956.7 11678.6 11765.5 11849.2 11965.2 12032.3 3802.8 3833.5 3842.1 3852.3 3952.4 110298.0 112538.0 114568.4 115461.8 116913.4 11279.8 11416.8 11433.8 11453.5 11465.3 23420.9 24063.2 24132.0 24135.8 24196.6 7958.4 8006.0 8027.9 8069.7 8095.0 4380.3 4410.9 4474.5 4476.4 4565.0 3724.1 3807.1 3825.2 3832.6 3838.8 621.6 690.8 694.5 702.3 726.3 696.4 703.7 705.8 716.1 756.2 9361.0 9887.2 9903.9 10329.7 10518.4 677.9 693.4 707.6 724.7 735.7 4327.6 5008.5 5019.4 5059.9 5170.8 106493.5 111941.0 112596.9 113092.3 116003.0 67816.7 81308.2 85174.6 88376.6 96763.0 83460.0 84190.2 84861.0 86959.6 87242.0 11085.2 11130.5 11243.9 11492.5 11551.5 42216.8 52832.7 53276.7 53495.8 54081.5 63924.7 68585.0 68898.3 70727.0 71999.6 13573.0 13636.7 13731.9 13878.5 14066.2 15468.2 15515.9 15551.2 15631.6 16002.8 12017.7 13770.0 13865.9 14439.5 14659.9 12853.9 13680.2 14283.6 14372.9 14901.4 12725.8 13723.8 13891.9 14283.8 14396.0 8906.6 9960.4 11489.4 11556.9 11560.6 10923.9 11283.9 11637.9 11675.6 11788.0 05:13:13 INFO - PROCESS | 1969 | -------- Summary: end -------- 05:13:13 INFO - PROCESS | 1969 | 05:13:13 INFO - TEST-INFO | 1969: exit 0 05:13:13 INFO - TEST-OK | dromaeo_css | took 1114685ms 05:13:13 INFO - TEST-START | kraken 05:13:13 INFO - operating with platform_type : mac_ 05:13:13 INFO - Initialising browser for kraken test... 05:13:13 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpcpJWVe/profile http://localhost:49338/getInfo.html) 05:13:16 INFO - PROCESS | 1973 | 2017-03-22 05:13:16.112 plugin-container[1975:12055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853b, name = 'com.apple.tsm.portname' 05:13:16 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:16 INFO - PROCESS | 1973 | 2017-03-22 05:13:16.113 plugin-container[1975:12055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880b, name = 'com.apple.CFPasteboardClient' 05:13:16 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:16 INFO - PROCESS | 1973 | 2017-03-22 05:13:16.113 plugin-container[1975:12055] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:13:16 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 05:13:16 INFO - PROCESS | 1973 | colorDepth:24 05:13:16 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 05:13:16 INFO - PROCESS | 1973 | __metrics 05:13:16 ERROR - PROCESS | 1973 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 05:13:16 INFO - TEST-INFO | 1973: exit 0 05:13:16 INFO - Browser initialized. 05:13:16 INFO - Running cycle 1/1 for kraken test... 05:13:16 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpcpJWVe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:19 INFO - PROCESS | 1976 | 2017-03-22 05:13:19.402 plugin-container[1978:12201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 05:13:19 INFO - PROCESS | 1976 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:19 INFO - PROCESS | 1976 | 2017-03-22 05:13:19.403 plugin-container[1978:12201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4327, name = 'com.apple.CFPasteboardClient' 05:13:19 INFO - PROCESS | 1976 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:19 INFO - PROCESS | 1976 | 2017-03-22 05:13:19.403 plugin-container[1978:12201] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:13:29 INFO - PROCESS | 1976 | RSS: Main: 173195264 05:13:29 INFO - PROCESS | 1976 | 05:13:31 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:32 INFO - PROCESS | 1976 | RSS: Main: 186413056 05:13:32 INFO - PROCESS | 1976 | 05:13:35 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-dft) 05:13:35 INFO - PROCESS | 1976 | RSS: Main: 193843200 05:13:35 INFO - PROCESS | 1976 | 05:13:39 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-fft) 05:13:39 INFO - PROCESS | 1976 | RSS: Main: 197488640 05:13:39 INFO - PROCESS | 1976 | 05:13:41 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-oscillator) 05:13:42 INFO - PROCESS | 1976 | RSS: Main: 198074368 05:13:42 INFO - PROCESS | 1976 | 05:13:44 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:45 INFO - PROCESS | 1976 | RSS: Main: 199258112 05:13:45 INFO - PROCESS | 1976 | 05:13:47 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49338/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:48 INFO - PROCESS | 1976 | RSS: Main: 203423744 05:13:48 INFO - PROCESS | 1976 | 05:13:51 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49338/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:52 INFO - PROCESS | 1976 | RSS: Main: 203231232 05:13:52 INFO - PROCESS | 1976 | 05:13:55 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49338/tests/kraken/driver.html?testName=json-parse-financial) 05:13:55 INFO - PROCESS | 1976 | RSS: Main: 202821632 05:13:55 INFO - PROCESS | 1976 | 05:13:57 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:58 INFO - PROCESS | 1976 | RSS: Main: 201592832 05:13:58 INFO - PROCESS | 1976 | 05:14:00 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:00 INFO - PROCESS | 1976 | RSS: Main: 202125312 05:14:00 INFO - PROCESS | 1976 | 05:14:02 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:03 INFO - PROCESS | 1976 | RSS: Main: 201633792 05:14:03 INFO - PROCESS | 1976 | 05:14:06 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:07 INFO - PROCESS | 1976 | RSS: Main: 201560064 05:14:07 INFO - PROCESS | 1976 | 05:14:10 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:10 INFO - PROCESS | 1976 | RSS: Main: 201973760 05:14:10 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49338/tests/kraken/driver.html?testName=ai-astar) 05:14:12 INFO - PROCESS | 1976 | RSS: Main: 203718656 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | __start_tp_report 05:14:12 INFO - PROCESS | 1976 | _x_x_mozilla_page_load 05:14:12 INFO - PROCESS | 1976 | _x_x_mozilla_page_load_details 05:14:12 INFO - PROCESS | 1976 | |i|pagename|runs| 05:14:12 INFO - PROCESS | 1976 | |0;ai-astar;114;121;118;120;120;118;118;116;120;120 05:14:12 INFO - PROCESS | 1976 | |1;audio-beat-detection;148;112;111;155;147;94;140;145;160;125 05:14:12 INFO - PROCESS | 1976 | |2;audio-dft;198;196;196;198;203;199;199;196;198;192 05:14:12 INFO - PROCESS | 1976 | |3;audio-fft;83;58;59;87;60;59;83;82;67;80 05:14:12 INFO - PROCESS | 1976 | |4;audio-oscillator;81;73;85;98;102;96;79;73;69;80 05:14:12 INFO - PROCESS | 1976 | |5;imaging-gaussian-blur;91;134;121;88;91;88;93;99;91;88 05:14:12 INFO - PROCESS | 1976 | |6;imaging-darkroom;101;103;101;102;103;101;112;134;100;102 05:14:12 INFO - PROCESS | 1976 | |7;imaging-desaturate;95;146;144;100;93;102;93;94;93;95 05:14:12 INFO - PROCESS | 1976 | |8;json-parse-financial;58;60;83;52;53;68;97;96;57;56 05:14:12 INFO - PROCESS | 1976 | |9;json-stringify-tinderbox;67;68;85;80;64;86;64;77;61;68 05:14:12 INFO - PROCESS | 1976 | |10;stanford-crypto-aes;86;84;82;82;84;88;86;84;92;90 05:14:12 INFO - PROCESS | 1976 | |11;stanford-crypto-ccm;136;133;132;131;143;120;139;150;199;164 05:14:12 INFO - PROCESS | 1976 | |12;stanford-crypto-pbkdf2;160;201;169;164;168;167;231;166;166;163 05:14:12 INFO - PROCESS | 1976 | |13;stanford-crypto-sha256-iterative;65;68;65;66;83;86;82;87;90;84 05:14:12 INFO - PROCESS | 1976 | __end_tp_report 05:14:12 INFO - PROCESS | 1976 | __start_cc_report 05:14:12 INFO - PROCESS | 1976 | _x_x_mozilla_cycle_collect,937 05:14:12 INFO - PROCESS | 1976 | __end_cc_report 05:14:12 INFO - PROCESS | 1976 | __startTimestamp1490184852710__endTimestamp 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | ------- Summary: start ------- 05:14:12 INFO - PROCESS | 1976 | Number of tests: 14 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#0] ai-astar Cycles:10 Average:118.50 Median:120.00 stddev:2.17 (1.8%) stddev-sans-first:1.58 05:14:12 INFO - PROCESS | 1976 | Values: 114.0 121.0 118.0 120.0 120.0 118.0 118.0 116.0 120.0 120.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:147.50 stddev:21.94 (14.9%) stddev-sans-first:22.65 05:14:12 INFO - PROCESS | 1976 | Values: 148.0 112.0 111.0 155.0 147.0 94.0 140.0 145.0 160.0 125.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#2] audio-dft Cycles:10 Average:197.50 Median:198.00 stddev:2.84 (1.4%) stddev-sans-first:3.00 05:14:12 INFO - PROCESS | 1976 | Values: 198.0 196.0 196.0 198.0 203.0 199.0 199.0 196.0 198.0 192.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#3] audio-fft Cycles:10 Average:71.80 Median:81.00 stddev:12.17 (15.0%) stddev-sans-first:12.22 05:14:12 INFO - PROCESS | 1976 | Values: 83.0 58.0 59.0 87.0 60.0 59.0 83.0 82.0 67.0 80.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:80.50 stddev:11.45 (14.2%) stddev-sans-first:12.11 05:14:12 INFO - PROCESS | 1976 | Values: 81.0 73.0 85.0 98.0 102.0 96.0 79.0 73.0 69.0 80.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#5] imaging-gaussian-blur Cycles:10 Average:98.40 Median:91.00 stddev:15.97 (17.6%) stddev-sans-first:16.72 05:14:12 INFO - PROCESS | 1976 | Values: 91.0 134.0 121.0 88.0 91.0 88.0 93.0 99.0 91.0 88.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:102.50 stddev:10.44 (10.2%) stddev-sans-first:10.92 05:14:12 INFO - PROCESS | 1976 | Values: 101.0 103.0 101.0 102.0 103.0 101.0 112.0 134.0 100.0 102.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:93.00 stddev:21.05 (22.6%) stddev-sans-first:21.98 05:14:12 INFO - PROCESS | 1976 | Values: 95.0 146.0 144.0 100.0 93.0 102.0 93.0 94.0 93.0 95.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:64.00 stddev:17.51 (27.4%) stddev-sans-first:18.20 05:14:12 INFO - PROCESS | 1976 | Values: 58.0 60.0 83.0 52.0 53.0 68.0 97.0 96.0 57.0 56.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.50 stddev:9.19 (12.7%) stddev-sans-first:9.57 05:14:12 INFO - PROCESS | 1976 | Values: 67.0 68.0 85.0 80.0 64.0 86.0 64.0 77.0 61.0 68.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:3.33 (3.9%) stddev-sans-first:3.53 05:14:12 INFO - PROCESS | 1976 | Values: 86.0 84.0 82.0 82.0 84.0 88.0 86.0 84.0 92.0 90.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:141.00 stddev:22.50 (16.0%) stddev-sans-first:23.64 05:14:12 INFO - PROCESS | 1976 | Values: 136.0 133.0 132.0 131.0 143.0 120.0 139.0 150.0 199.0 164.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:167.50 stddev:22.63 (13.5%) stddev-sans-first:23.30 05:14:12 INFO - PROCESS | 1976 | Values: 160.0 201.0 169.0 164.0 168.0 167.0 231.0 166.0 166.0 163.0 05:14:12 INFO - PROCESS | 1976 | 05:14:12 INFO - PROCESS | 1976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.60 Median:83.50 stddev:10.25 (12.3%) stddev-sans-first:9.81 05:14:12 INFO - PROCESS | 1976 | Values: 65.0 68.0 65.0 66.0 83.0 86.0 82.0 87.0 90.0 84.0 05:14:12 INFO - PROCESS | 1976 | -------- Summary: end -------- 05:14:12 INFO - PROCESS | 1976 | 05:14:13 INFO - TEST-INFO | 1976: exit 0 05:14:13 INFO - TEST-OK | kraken | took 60004ms 05:14:13 INFO - SUITE-END | took 1174s 05:14:13 INFO - Completed test suite (00:19:34) 05:14:13 INFO - javascript benchmark 05:14:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7417.638285811642, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3518.050126465856, 3530.3468858261217, 3556.8577256909725, 3560.9109772255692, 3564.1624218308702, 4296.291111966521, 5660.9716951415285, 5791.21818554495, 5800.390958949308, 5854.648721076738, 4946.950530494694, 5759.078547432412, 5795.15970184324, 5844.707764611774, 5860.50185734212, 5314.282571852808, 5330.866728331784, 5333.38666053403, 5362.981033603623, 5370.489803468664, 4119.773412462313, 5405.972970135163, 5417.349918009824, 5428.185772134172, 5456.672599644034, 4748.738819364934, 5100.0054989277105, 5229.947700523003, 5257.710825904593, 5387.649802762808, 4147.776405960234, 4999.900001999939, 5336.546393556552, 5397.568194544427, 5440.564754819645, 4646.721196728207, 5119.1553393690365, 5245.186996015624, 5331.493508116722, 5433.347998240197, 5034.320366750479, 5711.7715291388295, 5830.533557315404, 5949.405059494016, 5983.012802887519, 6228.750849965996, 6247.344028876993, 6254.7498100075945, 6305.0542418637115, 6339.080833279195, 6279.403456671655, 6299.7165127568915, 6303.747850086037, 6308.0, 6334.968325158391, 5982.8504287392725, 6009.038553831366, 6010.939890601126, 6031.517478601745, 6035.336113027563, 6257.124002639634, 6282.183316168869, 6290.0, 6302.180716506825, 6356.491480681534, 5408.729563521808, 6249.59377640461, 6292.46514046302, 6319.684015799192, 6327.810165695037, 6179.81460556184, 6259.217597800275, 6303.0, 6330.430261276507, 6333.68331583419, 5225.738713064332, 5385.192221166778, 6073.603071293627, 6206.193194884636, 6236.719347629368, 6238.594491358138, 6272.749090036439, 6303.2751233607805, 6304.3695630437505, 6315.936840631535, 5124.615653825978, 5133.922991155136, 5140.717260550631, 5145.125328694131, 5158.38099428071, 4408.713433626804, 4484.192845287879, 4501.68488205829, 4561.612262957619, 4617.746023968647, 5975.790847320323, 6005.6997150142315, 6072.605280656743, 6082.847928801727, 6100.664463454553, 5158.871028224325, 6253.96873015632, 6259.593126446857, 6319.494440444845, 6352.0, 4403.2734598791485, 5705.773258749306, 5866.208061911672, 6073.453389194994, 6092.908606370908, 5561.527270181999, 5570.192322113271, 5577.191307260425, 5593.049181639131, 5600.103983362643, 6550.967245163743, 6589.242237142694, 6596.241432235354, 6607.3062328456745, 6622.370874766986, 6109.938900610937, 6118.43644382056, 6163.445289923929, 6276.968615156895, 6296.937030629635, 5721.914171287351, 5756.481916627524, 6548.672566371758, 6552.443042341454, 6563.474922006132, 5014.899702006012, 5885.264341957255, 6248.156498872594, 6262.060690896402, 6279.560430769802, 6218.626882387071, 6249.1563638908165, 6264.436200741955, 6265.937340626718, 6286.497080233662, 5143.0, 6188.876222475616, 6219.968900155471, 6223.657698826427, 6274.623522588477, 6117.908231376444, 6206.007038873759, 6280.057991301159, 6281.0, 6293.527985401021, 4719.858404247878, 5946.226990491208, 6047.123167140828, 6193.102000210034, 6193.628382297076, 5113.284140220298, 6106.023036314168, 6112.0171844544475, 6128.747575574743, 6189.04069869171, 4971.477994810638, 6031.5777895548645, 6100.786472473442, 6103.6032657877095, 6132.693365331805], "value": 5711.269037376149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.863826086087, 518.4970578538818, 524.0070067222613, 534.3187436019076, 570.0650932470751, 40743.0, 42272.78863605685, 42312.36531452027, 42358.0, 44289.44986925458, 44309.33535996963, 44811.551884481145, 44834.551654483446, 44885.32672009923, 44962.0, 9421.858672119906, 9658.517074146299, 9680.564374603124, 9698.078682525149, 11441.313521188713, 11545.134114941371, 11798.646040618794, 11817.936385725283, 11818.940905295462, 11832.290062596272, 11825.586104486345, 11827.526898924032, 11871.821922671166, 11882.108841836854, 11910.583129590466, 11735.11986601004, 11791.11566632506, 11794.233374830694, 11804.763904721858, 11817.35004574748, 11385.601503947404, 11439.771204575862, 11447.771044579062, 11467.36929468879, 11481.540738370455, 38554.0, 38762.41856372129, 38943.8052809737, 38985.0, 39158.41262381067, 4031.2743706132883, 4047.5345335286524, 4094.1197642506704, 4140.91718165635, 4158.604932531404, 28415.289617759514, 28540.571891421645, 28600.71399286001, 28689.13932582005, 31033.68966310353, 3271.4111459937203, 3428.879989200391, 3451.240727040047, 3475.6350583188655, 3497.4404095344876, 516696.0, 519793.0, 521832.0, 522000.0, 525493.7450625483, 60612.393876060676, 61093.38906610877, 61118.0, 61126.38873611296, 61160.08259876105, 62406.687966559875, 62419.06371404433, 62479.06281405783, 62520.687396562724, 62655.6867215661, 16537.83462165363, 16736.41422550205, 16744.83255167457, 16813.831861681472, 16857.83142168587, 11972.521099155936, 12247.0, 13051.0, 13723.862761372258, 13911.860881391056, 20555.38333849987, 21894.0, 21896.671549926763, 21947.561048778934, 21956.89021554882, 8798.560071996502, 8888.688895888612, 8931.19619234272, 8975.461472311683, 9008.459492430475, 727.447140173472, 763.4426868385998, 869.8129902070958, 906.0, 927.6753136402206, 30794.846025769726, 31563.684363156535, 31630.841845791085, 31834.681653183634, 32282.192945176088, 1071.3250652089134, 1074.9623763168252, 1083.4041277297456, 1134.2230572058168, 1230.809224570193, 13437.798433023512, 14081.155130691986, 14857.554273371816, 16275.348986040426, 16321.510354689379, 705172.0, 714997.0, 715036.0, 716182.0, 717952.0, 58136.127958080666, 58340.12489812656, 58965.0, 59076.11385829216, 59179.816403671684, 1436.4469679173594, 1463.0709499467914, 1473.1161303218198, 1475.1296734926445, 1479.6374888152473, 25722.0, 28375.71624283731, 30245.243868902573, 30395.179232388924, 30851.845740771154, 42776.57223427726, 48859.0, 49598.75200623974, 49655.503444965085, 49845.50463486101, 621241.0, 624608.0, 624713.0, 625007.0, 626878.0, 23648.408789780395, 24175.395615109763, 25937.0, 25990.220293391227, 26872.925082996462, 43205.351919720604, 43596.474123405525, 44428.55571444244, 44801.32798007967, 44919.0, 35469.82265088658, 35657.0, 36484.0, 36498.0, 37568.62431375651, 35820.10449738673, 36873.63126368702, 37369.43945840869, 37451.81274093612, 38226.0, 37047.81476092602, 37306.88079357624, 37321.69374071895, 38027.80986095052, 38418.27117779762, 31897.36205275928, 31981.360372791947, 34039.65960340464, 34202.46088926054, 34437.31125377528, 20631.65894216871, 23328.183513576943, 24766.885490152625, 25204.0, 25664.0], "value": 20781.482742907912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.99481007784885, 400.50137578714487, 402.47678018575846, 405.7484359696988, 433.7854008775428, 20575.485612859688, 21543.0, 22065.11739530417, 22097.784621845793, 22190.445238869037, 21939.780602193972, 22241.777582224175, 22457.438564035907, 22628.88685556574, 22802.88598557009, 4679.485256621769, 5989.580729348947, 6023.0, 6025.15647809307, 6030.185924900148, 4824.396950381202, 5350.250964864922, 5922.437368449991, 5980.8504787380225, 6028.939710602882, 5879.412058794129, 5925.081612350093, 5929.525637948954, 5945.524358051367, 5948.940510594904, 5648.350439699446, 5835.5039821615, 5919.408059194089, 5919.5264378850015, 5953.642781433106, 5211.24436956643, 5220.608454365938, 5235.869103272411, 5238.633295669305, 5244.213367994793, 26959.730402695917, 26984.0, 27007.0, 27179.320516987234, 27242.318942026606, 2822.1956742328543, 2861.9141425757052, 2882.610847535577, 2883.8269703817627, 2936.8384738839354, 15922.283497242652, 16251.349946002145, 16351.182440877908, 16504.25730842103, 16850.578735531588, 1905.6093500832296, 1906.675865102922, 1917.3864363403716, 1931.2178567680112, 1936.2835750772304, 110511.44744276308, 128040.0, 131712.0, 134876.0, 137377.0, 10123.797524049478, 10257.846132308021, 11295.209335346612, 11358.488868000959, 12204.145709800407, 16255.67488650244, 16409.83590164107, 16418.6716265674, 16504.092274924995, 16616.169191540375, 6600.372964568358, 9091.772705682411, 9202.217811485965, 9337.579808908615, 9461.52692365379, 7913.366930645535, 8232.300254478316, 8925.910740892637, 9097.499637519868, 9272.72181834546, 4905.798079470553, 4918.385201849769, 4961.627877909171, 4996.525330093636, 5016.573591244785, 2062.9174833006814, 2063.8968051597362, 2087.3007542473442, 2088.9033257539913, 2100.1809294375207, 726.284609659485, 844.7888027993001, 915.5376534849859, 915.9816803663889, 929.869818225449, 20454.181832726525, 21597.784022159893, 21822.78050755527, 21855.487944093165, 21971.80569273589, 757.2994979643807, 894.3203165594196, 894.9931327256836, 900.9954950225207, 929.419113054341, 9193.678221262224, 10758.139348852073, 11143.944280278547, 11145.777084458428, 11179.776404471864, 376037.0, 377804.0, 378144.0, 379301.0, 709559.0, 148593.0, 151267.0, 175578.0, 178486.0, 178881.1055944738, 398.2572502283221, 457.14285714285717, 468.650855112943, 473.3869638817739, 475.9524047595282, 9886.604535818487, 11418.371989540656, 11599.0, 11734.0, 12138.089643276613, 53954.730226350184, 56406.71796641155, 61363.0, 63915.68042159759, 64198.67900660467, 93448.53275733578, 94340.0, 95127.0, 95175.0, 96222.0, 8532.402731808963, 8563.914360856312, 8649.221570058726, 8990.145936136056, 9078.182963533314, 12602.87397126017, 13522.729545409233, 13544.86455135436, 13739.106958047694, 14097.224652644203, 10887.727806804576, 11445.713857153638, 11631.243969141979, 11883.405829708652, 12145.210561313486, 11547.711307217387, 11571.190016699087, 11635.767284654428, 11679.649610511698, 11898.405079746151, 11820.349880756641, 11832.70418239551, 12056.276623402624, 12173.391330433265, 12185.14703970749, 8838.646454141763, 8876.068012858816, 8906.109389061043, 9040.457572545669, 9107.08929107084, 9803.411795292306, 11784.0, 11850.407479626158, 11884.227525210834, 11911.285322880654], "value": 9736.606868304134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.4150119201727, 1445.4507287230851, 1465.01111749569, 1466.4427517543331, 1467.7651575747882, 7739.458237923348, 7968.402369822272, 8219.013718353799, 8498.1501849815, 8608.827823443535, 8107.18928107189, 8426.620802063906, 8443.83112337753, 8541.658333666646, 8545.0, 2387.1883559589737, 2406.3984003999, 2419.0686585664557, 2425.563398588253, 2432.635104734295, 2395.149721848745, 2420.552197843396, 2425.223928342931, 2431.683881095464, 2434.7686969737847, 2389.832711710181, 2395.73646898841, 2423.333583264599, 2424.781769640732, 2426.1144682191048, 2331.94170145746, 2355.9175428859994, 2367.5620010297976, 2378.7502312257225, 2382.8927698253533, 2364.373441038126, 2364.846284991487, 2430.5503481855912, 2430.635404689293, 2445.08309383981, 8618.138186181395, 8641.697540586048, 8659.13408659129, 8676.52279124648, 8722.171393717586, 5249.816256431045, 5376.731163441851, 5382.784688612451, 5397.001554712391, 5416.945830541684, 3299.488579270217, 3344.4983252512075, 3356.9496457553155, 3442.9483557746653, 3557.4485954677066, 1250.4685508658783, 1256.886880180788, 1281.7436512697404, 1319.4919955816983, 1324.5959982205422, 10962.616308429246, 11024.834627480594, 11041.282316649473, 11062.22564420491, 11135.99776020162, 4324.718893271927, 4592.425946756655, 4653.325267836145, 4661.86014419568, 4689.648276379217, 7937.32532734724, 8826.293896488265, 8852.38033337673, 8877.24543413817, 8882.689105881263, 4799.016201678647, 4938.604911607134, 5262.0, 5278.472152784768, 5342.893142137135, 3252.9024129275685, 4573.085382923428, 4760.071786001697, 4784.091022705675, 4785.282207668877, 3397.9320413592086, 3788.242351529705, 3878.204967981557, 3916.3146449371247, 3935.8032098394965, 1004.2568499310457, 1177.7644471105814, 1197.9700507487382, 1200.4657927222302, 1201.4653479201845, 775.5889378629336, 932.6802574357345, 935.4106912644991, 940.7507010642186, 969.4619486185094, 4732.692374995614, 5102.132637451642, 5307.734613269321, 5886.735096920649, 5951.285845698544, 559.0272925110279, 583.9357670656225, 586.0330454749698, 592.1473078766562, 595.7438301530384, 3251.9593730006172, 3363.512290717832, 3750.0812300985885, 3837.808109594509, 3860.942085868714, 9598.136167744937, 9888.752781180528, 9957.153641940371, 9963.551640176209, 9976.351537150062, 9817.607295708234, 9867.161291290176, 9922.404655720535, 9933.453660048623, 9962.053604907667, 7748.806279843049, 7770.261825126604, 7850.921490785133, 7941.880871786928, 7966.2033796621035, 5505.476979686923, 5514.145307477347, 5601.859953501195, 5625.578081643975, 5757.481826635623, 9194.172524472562, 9206.631734730803, 9313.0, 9313.44119352841, 9358.81282374335, 8986.910130898606, 9338.252939764667, 9346.11211934865, 9460.385074970105, 9487.905120948702, 6766.391024807791, 6946.409555187865, 7146.892796608159, 7347.448941329529, 7437.628118593941, 7996.680132794623, 8052.87920681202, 8079.798005049921, 8138.348932085537, 8141.674333026849, 7130.144382673905, 7256.673449694671, 7288.489805713762, 7342.9632851835395, 7389.408847292097, 7125.679344429617, 7139.071920650283, 7160.57036577807, 7250.528715633467, 7285.0, 6464.321246269074, 6614.867702646016, 6616.2722100567935, 6629.204495460575, 6652.401283884474, 5100.2893922761905, 5110.207917772751, 5121.948780512147, 5253.527182553588, 5286.286351342519, 4787.138315103315, 5177.4822517749435, 5188.0, 5255.579553635776, 5284.31303930502], "value": 4400.514827279212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.30608537692996, 372.6701868846071, 378.292592851368, 378.76138033039183, 384.3120813743399, 4353.934690979638, 4397.384366188736, 4797.234171175628, 5241.08281050816, 5250.107481728101, 5354.2771725817, 5456.817273090755, 5564.944350556493, 5608.327000759904, 5614.747336369863, 3800.714946379019, 4171.770552619605, 4392.8023238954165, 4419.248727716296, 4423.51341352451, 3667.0, 3787.163225835481, 4263.637590804786, 4352.717073390236, 4390.670699697535, 3417.8803741869037, 3789.185325155091, 4287.228298906196, 4314.3528470729325, 4391.934120988188, 4085.387191921206, 4094.1197642506854, 4195.958040419588, 4312.82748690052, 4340.414044104037, 3864.806759662006, 3867.671247943928, 3886.9028274293087, 3904.5401397119917, 3909.6872250219913, 5249.370075590915, 5316.548093412064, 5374.274472946141, 5401.540869026137, 5459.689674478136, 4954.777035033432, 4981.7794640312995, 5012.017849379613, 5040.0, 5098.770555325019, 4944.9121193337405, 5085.415177254589, 5845.970770146165, 5875.412458754133, 5966.254218222723, 3551.058969373118, 4170.04089059515, 4197.244495990721, 4248.447701798777, 4253.128108737701, 5704.800331988402, 5823.0, 5944.82165535039, 6091.908621370683, 6116.877662446771, 3747.7189210809297, 3990.940135897964, 4071.0229544909603, 4226.0, 4339.956600434019, 3806.5051543299196, 3997.9400308995387, 4019.2966230909474, 4048.344403935439, 4089.754614723126, 3994.6604538614542, 4745.549172828576, 4753.33453316536, 4775.641826863, 4788.329633851264, 4957.479464656231, 5858.623223542464, 5861.501772349313, 5865.090910908816, 5872.265966754156, 1156.5605070073486, 1161.8896204860525, 1246.4328730427633, 1265.6900108387958, 1298.2080930632308, 809.6437567470294, 835.5279267214005, 872.2934423117168, 892.7144911327667, 913.2374467319862, 4621.388915262865, 5242.7640756166065, 5270.7628156733035, 5317.0, 5334.786608535693, 5445.618806683494, 5642.85892852682, 5671.177679236487, 5708.429157084258, 5734.39788822176, 4772.331873537708, 4929.014197160583, 5217.50433708797, 5289.338832645919, 5327.600429967691, 2577.587585986271, 2611.4929667519013, 2741.383188782508, 2853.486372452937, 2929.985350073279, 5664.433556644385, 5749.0740601898, 5784.334801497797, 5896.204012458349, 5904.704764761745, 5396.163594642837, 5469.945300546943, 5866.213548564483, 5910.379410161871, 5994.520438364921, 5187.922181167285, 5432.701201433959, 5791.218185545066, 5973.387185459815, 6113.908291375633, 5053.924191137063, 5230.555402790806, 5351.324337831084, 5621.80323688669, 5715.971420142872, 5598.552115830642, 5626.887462250814, 5725.8568535786935, 5730.5702072345575, 5754.791493786352, 5410.675359478444, 5578.246936663661, 5602.803901863415, 6027.457528822251, 6039.547033972557, 3150.039238032422, 3325.8004519728893, 3409.6931276185264, 3742.781208160925, 3767.453719210754, 4996.800127994839, 5837.94162058374, 5961.195238642727, 5972.850678733066, 5975.671338076274, 4488.4165058542185, 5166.59753214757, 5354.812581559782, 5643.830685079454, 5793.525118762729, 5294.417614062373, 5638.255043564183, 5722.942770572241, 5749.597528172988, 5751.424857514383, 4682.461516925461, 4843.709377437365, 5487.341519017744, 5759.740811663569, 5781.508571771446, 5367.01420474427, 5806.709664516673, 5809.128630705428, 5826.0387036140255, 5870.7945221917025, 4592.747398893093, 5370.785168593213, 5685.772569097356, 5693.4021927696995, 5731.914021289767], "value": 4189.300534163157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6032588328761, 700.6006576251535, 745.7389913530266, 747.970081196752, 851.5614458553846, 13520.729585408286, 14063.29683515824, 15206.923965380185, 16163.030218186917, 16442.506724798244, 12482.126251162423, 14962.0, 14998.475053373135, 15057.17185554794, 15080.396784128649, 866.4541338956449, 882.2721254964648, 896.8340856941454, 897.344938195118, 898.838209122361, 882.7395918204113, 888.3958907942597, 890.1098901098901, 891.5453118909338, 893.9910600894005, 933.0948979489884, 934.5981228071927, 936.7564433247371, 937.3766445313893, 940.261894412886, 926.1109335038371, 929.4376901974276, 932.8647346134807, 933.6172169410543, 935.873657056299, 689.2762599270745, 691.0360047733434, 691.1844024051617, 694.9679725607468, 696.2098018748757, 16149.03105813655, 16249.106299153542, 16766.497005089866, 16780.748288775678, 16799.0, 14884.479043233436, 14900.776488352683, 14901.92549037248, 14930.925345373204, 14956.700865982728, 11678.591249306319, 11765.470553825098, 11849.229800063054, 11965.162438629299, 12032.27806331623, 3802.790846503441, 3833.5399752029934, 3842.1355195081164, 3852.325842977468, 3952.407138929155, 110298.0, 112538.0, 114568.42715786368, 115461.84538154595, 116913.41543292314, 11279.830802537968, 11416.828747568794, 11433.771324573461, 11453.484593193327, 11465.31208127515, 23420.88289558541, 24063.157789477285, 24132.03471861141, 24135.7586424137, 24196.637050444257, 7958.442908996315, 8006.0, 8027.879581806277, 8069.677212911535, 8095.0285965683315, 4380.299152135643, 4410.878240032622, 4474.530174331713, 4476.395686582335, 4564.977175114103, 3724.1434470072036, 3807.124361396839, 3825.196708691206, 3832.597577254404, 3838.7696738195796, 621.641712857408, 690.8445599740119, 694.506900100934, 702.2731472925498, 726.2991213479019, 696.4498046543174, 703.6763088979025, 705.7882635209417, 716.0905649824693, 756.2059837170948, 9361.0, 9887.15099985509, 9903.900960990442, 10329.74175645615, 10518.368897866152, 677.8678157759289, 693.389816961071, 707.564847618721, 724.713738073458, 735.7314580178304, 4327.610515053598, 5008.499150084962, 5019.447860735316, 5059.918787758682, 5170.819021334235, 106493.46753266185, 111941.0, 112596.87403126027, 113092.30361544584, 116003.0, 67816.69975755464, 81308.18691813125, 85174.57412712897, 88376.55811721028, 96763.0, 83459.99999999879, 84190.15809841824, 84861.0, 86959.56520217485, 87242.0, 11085.224034317844, 11130.499127539442, 11243.887561124611, 11492.482838272465, 11551.480183391599, 42216.78891605522, 52832.73583632057, 53276.66808329823, 53495.789678598674, 54081.45918540764, 63924.68037659782, 68585.0, 68898.3110168912, 70727.0, 71999.64000179965, 13573.049886508245, 13636.723779340635, 13731.862681373059, 13878.514252001132, 14066.156030638194, 15468.226588670746, 15515.922420387826, 15551.222438878238, 15631.609209769847, 16002.759958600398, 12017.699557511132, 13770.0, 13865.861341386457, 14439.494617688331, 14659.853401466275, 12853.907417869586, 13680.247586382844, 14283.571492855232, 14372.928135359256, 14901.423658321708, 12725.809112863499, 13723.794143088062, 13891.933987767861, 14283.785743214068, 14396.0, 8906.554672266491, 9960.402375857471, 11489.368084755419, 11556.884431155917, 11560.595379161688, 10923.945380273048, 11283.943580282046, 11637.941810290895, 11675.591354302558, 11788.0], "value": 7817.78944788535, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 118.0, 120.0, 120.0, 118.0, 118.0, 116.0, 120.0, 120.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 111.0, 155.0, 147.0, 94.0, 140.0, 145.0, 160.0, 125.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 196.0, 198.0, 203.0, 199.0, 199.0, 196.0, 198.0, 192.0], "value": 197.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 87.0, 60.0, 59.0, 83.0, 82.0, 67.0, 80.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 85.0, 98.0, 102.0, 96.0, 79.0, 73.0, 69.0, 80.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 134.0, 121.0, 88.0, 91.0, 88.0, 93.0, 99.0, 91.0, 88.0], "value": 98.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 103.0, 101.0, 102.0, 103.0, 101.0, 112.0, 134.0, 100.0, 102.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 146.0, 144.0, 100.0, 93.0, 102.0, 93.0, 94.0, 93.0, 95.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 83.0, 52.0, 53.0, 68.0, 97.0, 96.0, 57.0, 56.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 85.0, 80.0, 64.0, 86.0, 64.0, 77.0, 61.0, 68.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 82.0, 82.0, 84.0, 88.0, 86.0, 84.0, 92.0, 90.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 132.0, 131.0, 143.0, 120.0, 139.0, 150.0, 199.0, 164.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 201.0, 169.0, 164.0, 168.0, 167.0, 231.0, 166.0, 166.0, 163.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 66.0, 83.0, 86.0, 82.0, 87.0, 90.0, 84.0], "value": 77.6, "unit": "score"}]}]} 05:14:13 INFO - Return code: 0 05:14:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:14:13 ERROR - # TBPL SUCCESS # 05:14:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:14 INFO - 2017-03-22 05:14:14.014 screenresolution[1982:12591] starting screenresolution argv=screenresolution get 05:14:14 INFO - 2017-03-22 05:14:14.018 screenresolution[1982:12591] Display 0: 1600x1200x32@60 05:14:14 INFO - 2017-03-22 05:14:14.025 screenresolution[1983:12594] starting screenresolution argv=screenresolution list 05:14:14 INFO - Available Modes on Display 0 05:14:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:14 INFO - Intel Iris: 05:14:14 INFO - Chipset Model: Intel Iris 05:14:14 INFO - Type: GPU 05:14:14 INFO - Bus: Built-In 05:14:14 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:14 INFO - Vendor: Intel (0x8086) 05:14:14 INFO - Device ID: 0x0a2e 05:14:14 INFO - Revision ID: 0x0009 05:14:14 INFO - Displays: 05:14:14 INFO - Display: 05:14:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:14 INFO - Display Serial Number: 1600x1200 60 05:14:14 INFO - Main Display: Yes 05:14:14 INFO - Mirror: Off 05:14:14 INFO - Online: Yes 05:14:14 INFO - Rotation: Supported 05:14:14 INFO - Return code: 0 05:14:14 INFO - Running post-action listener: _resource_record_post_action 05:14:14 INFO - [mozharness: 2017-03-22 12:14:14.272138Z] Finished run-tests step (success) 05:14:14 INFO - Running post-run listener: _resource_record_post_run 05:14:14 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 1692672; Write bytes: 425959424; Read time: 19; Write time: 1771 05:14:14 INFO - TinderboxPrint: CPU usage
54.4% 05:14:14 INFO - TinderboxPrint: I/O read bytes / time
1,692,672 / 19 05:14:14 INFO - TinderboxPrint: I/O write bytes / time
425,959,424 / 1,771 05:14:14 INFO - TinderboxPrint: CPU idle
2,173.5 (45.6%) 05:14:14 INFO - TinderboxPrint: CPU system
965.4 (20.3%) 05:14:14 INFO - TinderboxPrint: CPU user
1,622.8 (34.1%) 05:14:14 INFO - TinderboxPrint: Swap in / out
123,940,864 / 0 05:14:14 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122614272; Write bytes: 114008064; Read time: 11080; Write time: 267 05:14:14 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1655808; Write bytes: 301924352; Read time: 19; Write time: 1473 05:14:14 INFO - Running post-run listener: _upload_blobber_files 05:14:14 INFO - Blob upload gear active. 05:14:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:14 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 05:14:14 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'] 05:14:14 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 05:14:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:16 INFO - (blobuploader) - INFO - Done attempting. 05:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:17 INFO - (blobuploader) - INFO - Done attempting. 05:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:18 INFO - (blobuploader) - INFO - Done attempting. 05:14:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:14:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:20 INFO - (blobuploader) - INFO - Done attempting. 05:14:20 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:20 INFO - Return code: 0 05:14:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59492074cf60ce59e35b2da06357195c07e881c52395a751106827f87180ba563761e1c664f84ab345200c370b2dc293627bc6c22a27c4d7fb3e1ac7ffb700d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b92c5dfe582d5ee228f6deeeff645c343da6f0bceebbdc2990869b4c12bca2d15c5c3bb103b89f9aa2048516484e1d8414df0134009c784d3a60f32f5094025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f92066cae8f85d857f3928c0578da743659587bced2713e344e227a7899d05ba7fe724458a49a7d48ad1e3f5f827230a1d936967aeb7c03979ada8293a85da35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d77ad2068eb0cf55f455a53a87282cd26fb6d0a79c7ca7fc0ffe4c4592f4697c9b66700592644a22d536c9370e1a98211d0974acda3c760e5e6a255aebe1a297"} 05:14:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:20 INFO - Contents: 05:14:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59492074cf60ce59e35b2da06357195c07e881c52395a751106827f87180ba563761e1c664f84ab345200c370b2dc293627bc6c22a27c4d7fb3e1ac7ffb700d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b92c5dfe582d5ee228f6deeeff645c343da6f0bceebbdc2990869b4c12bca2d15c5c3bb103b89f9aa2048516484e1d8414df0134009c784d3a60f32f5094025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f92066cae8f85d857f3928c0578da743659587bced2713e344e227a7899d05ba7fe724458a49a7d48ad1e3f5f827230a1d936967aeb7c03979ada8293a85da35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d77ad2068eb0cf55f455a53a87282cd26fb6d0a79c7ca7fc0ffe4c4592f4697c9b66700592644a22d536c9370e1a98211d0974acda3c760e5e6a255aebe1a297"} 05:14:20 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:20 INFO - Copying logs to upload dir... 05:14:20 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.429255 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-22 05:14:20.416243) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 05:14:20.420272) ========= 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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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/59492074cf60ce59e35b2da06357195c07e881c52395a751106827f87180ba563761e1c664f84ab345200c370b2dc293627bc6c22a27c4d7fb3e1ac7ffb700d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b92c5dfe582d5ee228f6deeeff645c343da6f0bceebbdc2990869b4c12bca2d15c5c3bb103b89f9aa2048516484e1d8414df0134009c784d3a60f32f5094025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f92066cae8f85d857f3928c0578da743659587bced2713e344e227a7899d05ba7fe724458a49a7d48ad1e3f5f827230a1d936967aeb7c03979ada8293a85da35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d77ad2068eb0cf55f455a53a87282cd26fb6d0a79c7ca7fc0ffe4c4592f4697c9b66700592644a22d536c9370e1a98211d0974acda3c760e5e6a255aebe1a297"} build_url:https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/DsFJX1OBRZWbYkEgRsLWAA/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/59492074cf60ce59e35b2da06357195c07e881c52395a751106827f87180ba563761e1c664f84ab345200c370b2dc293627bc6c22a27c4d7fb3e1ac7ffb700d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b92c5dfe582d5ee228f6deeeff645c343da6f0bceebbdc2990869b4c12bca2d15c5c3bb103b89f9aa2048516484e1d8414df0134009c784d3a60f32f5094025", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f92066cae8f85d857f3928c0578da743659587bced2713e344e227a7899d05ba7fe724458a49a7d48ad1e3f5f827230a1d936967aeb7c03979ada8293a85da35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d77ad2068eb0cf55f455a53a87282cd26fb6d0a79c7ca7fc0ffe4c4592f4697c9b66700592644a22d536c9370e1a98211d0974acda3c760e5e6a255aebe1a297"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 05:14:20.455992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:14:20.456354) ========= 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.yi4UsO4HVh/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.c4zDZ9orIy/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005177 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:14:20.505911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 05:14:20.506239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 05:14:20.506568) ========= ========= Total master_lag: 0.19 =========