builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0309 starttime: 1489697100.6 results: success (0) buildid: 20170316114621 builduid: 1679883721a2448694ad7bcf234977a8 revision: 5674d54cd39e3b37ae8ab8bcff53981bed292995 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:00.601013) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:00.601769) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:00.602237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:00.632483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:00.633049) ========= 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.pfJhlH8hod/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.FfVtx5yYGj/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-16 13:45:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.3M=0.001s 2017-03-16 13:45:01 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.365632 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:01.024080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:01.024413) ========= 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.pfJhlH8hod/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.FfVtx5yYGj/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.027441 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:01.073402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 13:45:01.073777) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5674d54cd39e3b37ae8ab8bcff53981bed292995 --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 5674d54cd39e3b37ae8ab8bcff53981bed292995 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pfJhlH8hod/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.FfVtx5yYGj/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-16 13:45:01,183 truncating revision to first 12 chars 2017-03-16 13:45:01,183 Setting DEBUG logging. 2017-03-16 13:45:01,183 attempt 1/10 2017-03-16 13:45:01,183 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5674d54cd39e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 13:45:02,348 unpacking tar archive at: mozilla-beta-5674d54cd39e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.427155 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 13:45:02.524063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:02.524399) ========= script_repo_revision: 5674d54cd39e3b37ae8ab8bcff53981bed292995 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:02.524778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:02.525087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 13:45:02.544816) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-16 13:45:02.545129) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.pfJhlH8hod/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.FfVtx5yYGj/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:02 INFO - MultiFileLogger online at 20170316 13:45:02 in /builds/slave/test 13:45:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:45:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:45:02 INFO - {'append_to_log': False, 13:45:02 INFO - 'base_work_dir': '/builds/slave/test', 13:45:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:45:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:45:02 INFO - 'branch': 'Mozilla-Beta', 13:45:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:45:02 INFO - 'config_files': ('talos/mac_config.py',), 13:45:02 INFO - 'default_actions': ('clobber', 13:45:02 INFO - 'read-buildbot-config', 13:45:02 INFO - 'download-and-extract', 13:45:02 INFO - 'populate-webroot', 13:45:02 INFO - 'create-virtualenv', 13:45:02 INFO - 'install', 13:45:02 INFO - 'run-tests'), 13:45:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:45:02 INFO - 'download_minidump_stackwalk': True, 13:45:02 INFO - 'download_symbols': 'ondemand', 13:45:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:45:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:45:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:45:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:45:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:45:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:45:02 INFO - 'installer_path': 'installer.exe', 13:45:02 INFO - 'log_level': 'info', 13:45:02 INFO - 'log_name': 'talos', 13:45:02 INFO - 'log_to_console': True, 13:45:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:45:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:45:02 INFO - 'opt_config_files': (), 13:45:02 INFO - 'pip_index': False, 13:45:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:45:02 INFO - 'cmd': ('bash', 13:45:02 INFO - '-c', 13:45:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:45:02 INFO - 'enabled': True, 13:45:02 INFO - 'halt_on_failure': False, 13:45:02 INFO - 'name': 'check_screen_resolution'},), 13:45:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:45:02 INFO - 'cmd': ('bash', 13:45:02 INFO - '-c', 13:45:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:45:02 INFO - 'enabled': True, 13:45:02 INFO - 'halt_on_failure': False, 13:45:02 INFO - 'name': 'check_screen_resolution'},), 13:45:02 INFO - 'run_cmd_checks_enabled': True, 13:45:02 INFO - 'sps_profile': False, 13:45:02 INFO - 'sps_profile_interval': 0, 13:45:02 INFO - 'suite': 'dromaeojs', 13:45:02 INFO - 'system_bits': '32', 13:45:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:45:02 INFO - 'title': 't-yosemite-r7-0309', 13:45:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:45:02 INFO - 'use_talos_json': True, 13:45:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:45:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:45:02 INFO - 'work_dir': 'build'} 13:45:02 INFO - [mozharness: 2017-03-16 20:45:02.761720Z] Running clobber step. 13:45:02 INFO - Running pre-action listener: _resource_record_pre_action 13:45:02 INFO - Running main action method: clobber 13:45:02 INFO - rmtree: /builds/slave/test/build 13:45:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:45:05 INFO - Running post-action listener: _resource_record_post_action 13:45:05 INFO - [mozharness: 2017-03-16 20:45:05.091056Z] Finished clobber step (success) 13:45:05 INFO - [mozharness: 2017-03-16 20:45:05.091180Z] Running read-buildbot-config step. 13:45:05 INFO - Running pre-action listener: _resource_record_pre_action 13:45:05 INFO - Running main action method: read_buildbot_config 13:45:05 INFO - Using buildbot properties: 13:45:05 INFO - { 13:45:05 INFO - "project": "", 13:45:05 INFO - "product": "firefox", 13:45:05 INFO - "script_repo_revision": "production", 13:45:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:45:05 INFO - "repository": "", 13:45:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:45:05 INFO - "buildid": "20170316114621", 13:45:05 INFO - "pgo_build": "False", 13:45:05 INFO - "basedir": "/builds/slave/test", 13:45:05 INFO - "buildnumber": 3, 13:45:05 INFO - "slavename": "t-yosemite-r7-0309", 13:45:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:45:05 INFO - "platform": "yosemite_r7", 13:45:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:45:05 INFO - "branch": "mozilla-beta", 13:45:05 INFO - "repo_path": "releases/mozilla-beta", 13:45:05 INFO - "revision": "5674d54cd39e3b37ae8ab8bcff53981bed292995", 13:45:05 INFO - "stage_platform": "macosx64", 13:45:05 INFO - "builduid": "1679883721a2448694ad7bcf234977a8", 13:45:05 INFO - "slavebuilddir": "test" 13:45:05 INFO - } 13:45:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 13:45:05 INFO - Running post-action listener: _resource_record_post_action 13:45:05 INFO - [mozharness: 2017-03-16 20:45:05.094425Z] Finished read-buildbot-config step (success) 13:45:05 INFO - [mozharness: 2017-03-16 20:45:05.094577Z] Running download-and-extract step. 13:45:05 INFO - Running pre-action listener: _resource_record_pre_action 13:45:05 INFO - Running main action method: download_and_extract 13:45:05 INFO - mkdir: /builds/slave/test/build/tests 13:45:05 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')]} 13:45:05 INFO - trying https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 13:45:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/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 13:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/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 13:45:06 INFO - Downloaded 1165 bytes. 13:45:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 13:45:06 INFO - Using the following test package requirements: 13:45:06 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:45:06 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:45:06 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 13:45:06 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:45:06 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 13:45:06 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:45:06 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:45:06 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 13:45:06 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:45:06 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:45:06 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 13:45:06 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:45:06 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 13:45:06 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:45:06 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 13:45:06 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:45:06 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 13:45:06 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 13:45:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:45:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:45:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:45:07 INFO - Expected file size: 16106627 13:45:07 INFO - Obtained file size: 16106627 13:45:13 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 13:45:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:45:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:45:13 INFO - Fetch https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:45:14 INFO - Expected file size: 16106627 13:45:14 INFO - Obtained file size: 16106627 13:45:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 13:45:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 13:45:21 INFO - Fetch https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 13:45:22 INFO - Expected file size: 14403650 13:45:22 INFO - Obtained file size: 14403650 13:45: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')]} 13:45:22 INFO - trying https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:45:22 INFO - Downloading https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 13:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/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 13:45:24 INFO - Downloaded 58703501 bytes. 13:45:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:45:24 INFO - mkdir: /builds/slave/test/properties 13:45:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:45:24 INFO - Writing to file /builds/slave/test/properties/build_url 13:45:24 INFO - Contents: 13:45:24 INFO - build_url:https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:45:24 INFO - Running post-action listener: _resource_record_post_action 13:45:24 INFO - Running post-action listener: set_extra_try_arguments 13:45:24 INFO - [mozharness: 2017-03-16 20:45:24.981139Z] Finished download-and-extract step (success) 13:45:24 INFO - [mozharness: 2017-03-16 20:45:24.981266Z] Running populate-webroot step. 13:45:24 INFO - Running pre-action listener: _resource_record_pre_action 13:45:24 INFO - Running main action method: populate_webroot 13:45:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:24 INFO - '--tppagecycles', 13:45:24 INFO - '7'], 13:45:24 INFO - 'tests': ['tsvgm']}}, 13:45:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:45:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:45:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:45:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:45:24 INFO - 'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:45:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:45:24 INFO - 'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['damp', 'tps']}, 13:45:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:45:24 INFO - 'tests': ['damp', 'tps']}, 13:45:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['dromaeo_dom']}, 13:45:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['basic_compositor_video']}, 13:45:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:45:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['a11yr', 13:45:24 INFO - 'ts_paint', 13:45:24 INFO - 'tpaint', 13:45:24 INFO - 'sessionrestore', 13:45:24 INFO - 'sessionrestore_no_auto_restore', 13:45:24 INFO - 'tabpaint']}, 13:45:24 INFO - 'other-e10s': {'tests': ['a11yr', 13:45:24 INFO - 'ts_paint', 13:45:24 INFO - 'tpaint', 13:45:24 INFO - 'sessionrestore', 13:45:24 INFO - 'sessionrestore_no_auto_restore', 13:45:24 INFO - 'tabpaint']}, 13:45:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:45:24 INFO - 'ts_paint', 13:45:24 INFO - 'tpaint', 13:45:24 INFO - 'sessionrestore', 13:45:24 INFO - 'sessionrestore_no_auto_restore', 13:45:24 INFO - 'tabpaint']}, 13:45:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:45:24 INFO - 'ts_paint', 13:45:24 INFO - 'tpaint', 13:45:24 INFO - 'sessionrestore', 13:45:24 INFO - 'sessionrestore_no_auto_restore', 13:45:24 INFO - 'tabpaint']}, 13:45:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['a11yr', 13:45:24 INFO - 'ts_paint', 13:45:24 INFO - 'tpaint', 13:45:24 INFO - 'sessionrestore', 13:45:24 INFO - 'sessionrestore_no_auto_restore', 13:45:24 INFO - 'tabpaint']}, 13:45:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['a11yr', 13:45:24 INFO - 'ts_paint', 13:45:24 INFO - 'tpaint', 13:45:24 INFO - 'sessionrestore', 13:45:24 INFO - 'sessionrestore_no_auto_restore', 13:45:24 INFO - 'tabpaint']}, 13:45:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['tsvgx', 13:45:24 INFO - 'tsvgr_opacity', 13:45:24 INFO - 'tart', 13:45:24 INFO - 'tscrollx', 13:45:24 INFO - 'cart', 13:45:24 INFO - 'tsvg_static']}, 13:45:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:45:24 INFO - 'tsvgr_opacity', 13:45:24 INFO - 'tart', 13:45:24 INFO - 'tscrollx', 13:45:24 INFO - 'cart', 13:45:24 INFO - 'tsvg_static']}, 13:45:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:45:24 INFO - 'talos_options': ['--disable-e10s'], 13:45:24 INFO - 'tests': ['tp5o']}, 13:45:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:45:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:45:25 INFO - 'talos_options': ['--disable-e10s', 13:45:25 INFO - '--xperf_path', 13:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:25 INFO - 'tests': ['tp5n']}, 13:45:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:45:25 INFO - 'talos_options': ['--xperf_path', 13:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:25 INFO - 'tests': ['tp5n']}}, 13:45:25 INFO - 'talos.zip': {'path': '', 13:45:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:25 INFO - Running post-action listener: _resource_record_post_action 13:45:25 INFO - [mozharness: 2017-03-16 20:45:25.001508Z] Finished populate-webroot step (success) 13:45:25 INFO - [mozharness: 2017-03-16 20:45:25.001638Z] Running create-virtualenv step. 13:45:25 INFO - Running pre-action listener: _resource_record_pre_action 13:45:25 INFO - Running main action method: create_virtualenv 13:45:25 INFO - Creating virtualenv /builds/slave/test/build/venv 13:45:25 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 13:45:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:45:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:25 INFO - Using real prefix '/tools/python27' 13:45:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:45:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:28 INFO - Installing pip.................done. 13:45:28 INFO - Return code: 0 13:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:45:28 INFO - Reading from file tmpfile_stdout 13:45:28 INFO - Output received: 13:45:28 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) 13:45:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:28 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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:28 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 13:45:28 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 13:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:28 INFO - 'HOME': '/Users/cltbld', 13:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:28 INFO - 'LOGNAME': 'cltbld', 13:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:28 INFO - 'MOZ_NO_REMOTE': '1', 13:45:28 INFO - 'NO_EM_RESTART': '1', 13:45:28 INFO - 'PAGER': '/bin/cat', 13:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:28 INFO - 'PWD': '/builds/slave/test', 13:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:28 INFO - 'SHELL': '/bin/bash', 13:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:28 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:28 INFO - 'USER': 'cltbld', 13:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:28 INFO - 'XPC_FLAGS': '0x0', 13:45:28 INFO - 'XPC_SERVICE_NAME': '0', 13:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:29 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 13:45:29 INFO - Cleaning up... 13:45:29 INFO - Return code: 0 13:45:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:29 INFO - 'HOME': '/Users/cltbld', 13:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:29 INFO - 'LOGNAME': 'cltbld', 13:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:29 INFO - 'MOZ_NO_REMOTE': '1', 13:45:29 INFO - 'NO_EM_RESTART': '1', 13:45:29 INFO - 'PAGER': '/bin/cat', 13:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:29 INFO - 'PWD': '/builds/slave/test', 13:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:29 INFO - 'SHELL': '/bin/bash', 13:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:29 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:29 INFO - 'USER': 'cltbld', 13:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:29 INFO - 'XPC_FLAGS': '0x0', 13:45:29 INFO - 'XPC_SERVICE_NAME': '0', 13:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:29 INFO - Downloading/unpacking psutil>=3.1.1 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:33 INFO - Installing collected packages: psutil 13:45:33 INFO - Running setup.py install for psutil 13:45:33 INFO - building 'psutil._psutil_osx' extension 13:45:33 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 13:45:33 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 13:45:33 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 13:45:33 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 13:45:33 INFO - building 'psutil._psutil_posix' extension 13:45:33 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 13:45:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:45:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:45:33 INFO - ^ 13:45:34 INFO - 1 warning generated. 13:45:34 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 13:45:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:34 INFO - Successfully installed psutil 13:45:34 INFO - Cleaning up... 13:45:34 INFO - Return code: 0 13:45:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:34 INFO - 'HOME': '/Users/cltbld', 13:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:34 INFO - 'LOGNAME': 'cltbld', 13:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:34 INFO - 'MOZ_NO_REMOTE': '1', 13:45:34 INFO - 'NO_EM_RESTART': '1', 13:45:34 INFO - 'PAGER': '/bin/cat', 13:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:34 INFO - 'PWD': '/builds/slave/test', 13:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:34 INFO - 'SHELL': '/bin/bash', 13:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:34 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:34 INFO - 'USER': 'cltbld', 13:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:34 INFO - 'XPC_FLAGS': '0x0', 13:45:34 INFO - 'XPC_SERVICE_NAME': '0', 13:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:45:37 INFO - Installing collected packages: mozsystemmonitor 13:45:37 INFO - Running setup.py install for mozsystemmonitor 13:45:37 INFO - Successfully installed mozsystemmonitor 13:45:37 INFO - Cleaning up... 13:45:37 INFO - Return code: 0 13:45:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:37 INFO - 'HOME': '/Users/cltbld', 13:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:37 INFO - 'LOGNAME': 'cltbld', 13:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:37 INFO - 'MOZ_NO_REMOTE': '1', 13:45:37 INFO - 'NO_EM_RESTART': '1', 13:45:37 INFO - 'PAGER': '/bin/cat', 13:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:37 INFO - 'PWD': '/builds/slave/test', 13:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:37 INFO - 'SHELL': '/bin/bash', 13:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:37 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:37 INFO - 'USER': 'cltbld', 13:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:37 INFO - 'XPC_FLAGS': '0x0', 13:45:37 INFO - 'XPC_SERVICE_NAME': '0', 13:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:37 INFO - Downloading/unpacking jsonschema==2.5.1 13:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:45:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:45:40 INFO - warning: no files found matching '*.txt' 13:45:40 INFO - no previously-included directories found matching 'build' 13:45:40 INFO - no previously-included directories found matching 'dist' 13:45:40 INFO - no previously-included directories found matching '.git*' 13:45:40 INFO - Installing collected packages: jsonschema, functools32 13:45:40 INFO - Running setup.py install for functools32 13:45:41 INFO - warning: no files found matching '*.txt' 13:45:41 INFO - no previously-included directories found matching 'build' 13:45:41 INFO - no previously-included directories found matching 'dist' 13:45:41 INFO - no previously-included directories found matching '.git*' 13:45:41 INFO - Successfully installed jsonschema functools32 13:45:41 INFO - Cleaning up... 13:45:41 INFO - Return code: 0 13:45:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:41 INFO - 'HOME': '/Users/cltbld', 13:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:41 INFO - 'LOGNAME': 'cltbld', 13:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:41 INFO - 'MOZ_NO_REMOTE': '1', 13:45:41 INFO - 'NO_EM_RESTART': '1', 13:45:41 INFO - 'PAGER': '/bin/cat', 13:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:41 INFO - 'PWD': '/builds/slave/test', 13:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:41 INFO - 'SHELL': '/bin/bash', 13:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:41 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:41 INFO - 'USER': 'cltbld', 13:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:41 INFO - 'XPC_FLAGS': '0x0', 13:45:41 INFO - 'XPC_SERVICE_NAME': '0', 13:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:45:41 INFO - Cleaning up... 13:45:41 INFO - Return code: 0 13:45:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:41 INFO - 'HOME': '/Users/cltbld', 13:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:41 INFO - 'LOGNAME': 'cltbld', 13:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:41 INFO - 'MOZ_NO_REMOTE': '1', 13:45:41 INFO - 'NO_EM_RESTART': '1', 13:45:41 INFO - 'PAGER': '/bin/cat', 13:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:41 INFO - 'PWD': '/builds/slave/test', 13:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:41 INFO - 'SHELL': '/bin/bash', 13:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:41 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:41 INFO - 'USER': 'cltbld', 13:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:41 INFO - 'XPC_FLAGS': '0x0', 13:45:41 INFO - 'XPC_SERVICE_NAME': '0', 13:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:44 INFO - Downloading blobuploader-1.2.4.tar.gz 13:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:45:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:45:44 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 13:45:44 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 13:45:44 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 13:45:44 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 13:45:44 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 13:45:44 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 13:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:45:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:45 INFO - Downloading docopt-0.6.1.tar.gz 13:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:45 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:45 INFO - Running setup.py install for blobuploader 13:45:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:45:45 INFO - Running setup.py install for requests 13:45:46 INFO - Running setup.py install for docopt 13:45:46 INFO - Successfully installed blobuploader requests docopt 13:45:46 INFO - Cleaning up... 13:45:46 INFO - Return code: 0 13:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:46 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')]} 13:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:46 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')]} 13:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:46 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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:46 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 13:45:46 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 13:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:46 INFO - 'HOME': '/Users/cltbld', 13:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:46 INFO - 'LOGNAME': 'cltbld', 13:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:46 INFO - 'MOZ_NO_REMOTE': '1', 13:45:46 INFO - 'NO_EM_RESTART': '1', 13:45:46 INFO - 'PAGER': '/bin/cat', 13:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:46 INFO - 'PWD': '/builds/slave/test', 13:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:46 INFO - 'SHELL': '/bin/bash', 13:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:46 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:46 INFO - 'USER': 'cltbld', 13:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:46 INFO - 'XPC_FLAGS': '0x0', 13:45:46 INFO - 'XPC_SERVICE_NAME': '0', 13:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:46 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-BylSZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:46 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-M33GZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:46 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-GgvOy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-fIwgya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UmLT7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-zs5v9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-lLBLHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Ih0c3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-intfYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-TDDaNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-72wqRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:47 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UG0QuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:48 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-DOOyYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:48 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Q5vz4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:48 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-_VOGsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:48 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Uzk48r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:48 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-bFP5UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:48 INFO - Running setup.py install for manifestparser 13:45:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:45:48 INFO - Running setup.py install for mozcrash 13:45:48 INFO - Running setup.py install for mozdebug 13:45:48 INFO - Running setup.py install for mozdevice 13:45:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Running setup.py install for mozfile 13:45:49 INFO - Running setup.py install for mozhttpd 13:45:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Running setup.py install for mozinfo 13:45:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Running setup.py install for mozInstall 13:45:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Running setup.py install for mozleak 13:45:49 INFO - Running setup.py install for mozlog 13:45:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for moznetwork 13:45:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for mozprocess 13:45:50 INFO - Running setup.py install for mozprofile 13:45:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for mozrunner 13:45:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for mozscreenshot 13:45:50 INFO - Running setup.py install for moztest 13:45:50 INFO - Running setup.py install for mozversion 13:45:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:45:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:51 INFO - Cleaning up... 13:45:51 INFO - Return code: 0 13:45:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:51 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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:51 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 13:45:51 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 13:45:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:51 INFO - 'HOME': '/Users/cltbld', 13:45:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:51 INFO - 'LOGNAME': 'cltbld', 13:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:51 INFO - 'MOZ_NO_REMOTE': '1', 13:45:51 INFO - 'NO_EM_RESTART': '1', 13:45:51 INFO - 'PAGER': '/bin/cat', 13:45:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:51 INFO - 'PWD': '/builds/slave/test', 13:45:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:51 INFO - 'SHELL': '/bin/bash', 13:45:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:51 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:51 INFO - 'USER': 'cltbld', 13:45:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:51 INFO - 'XPC_FLAGS': '0x0', 13:45:51 INFO - 'XPC_SERVICE_NAME': '0', 13:45:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:51 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-3HLO8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:51 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)) 13:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:51 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-7_ZliW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:51 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)) 13:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:51 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-10qXf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:51 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)) 13:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:51 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-MPkHBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:51 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)) 13:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:51 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-fdKIMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:51 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)) 13:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:51 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-XqkVgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-EzBoGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-XSWvhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-3acIez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-AQVQ18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-DQzNfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ieov1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UCmAec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ol8Vkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-li1Huq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:52 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-g1yCtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:53 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-LYgCph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:53 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)) 13:45:53 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)) 13:45:53 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)) 13:45:53 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)) 13:45:53 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)) 13:45:53 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)) 13:45:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45:53 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 13:45:53 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 13:45:53 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 13:45:53 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 13:45:53 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 13:45:53 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 13:45:55 INFO - Downloading blessings-1.6.tar.gz 13:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:55 INFO - Installing collected packages: blessings 13:45:55 INFO - Running setup.py install for blessings 13:45:56 INFO - Successfully installed blessings 13:45:56 INFO - Cleaning up... 13:45:56 INFO - Return code: 0 13:45:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:56 INFO - Reading from file tmpfile_stdout 13:45:56 INFO - Current package versions: 13:45:56 INFO - blessings == 1.6 13:45:56 INFO - blobuploader == 1.2.4 13:45:56 INFO - docopt == 0.6.1 13:45:56 INFO - functools32 == 3.2.3-2 13:45:56 INFO - jsonschema == 2.5.1 13:45:56 INFO - manifestparser == 1.1 13:45:56 INFO - mozInstall == 1.12 13:45:56 INFO - mozcrash == 1.0 13:45:56 INFO - mozdebug == 0.1 13:45:56 INFO - mozdevice == 0.49 13:45:56 INFO - mozfile == 1.2 13:45:56 INFO - mozhttpd == 0.7 13:45:56 INFO - mozinfo == 0.9 13:45:56 INFO - mozleak == 0.1 13:45:56 INFO - mozlog == 3.4 13:45:56 INFO - moznetwork == 0.27 13:45:56 INFO - mozprocess == 0.24 13:45:56 INFO - mozprofile == 0.28 13:45:56 INFO - mozrunner == 6.13 13:45:56 INFO - mozscreenshot == 0.1 13:45:56 INFO - mozsystemmonitor == 0.3 13:45:56 INFO - moztest == 0.8 13:45:56 INFO - mozversion == 1.4 13:45:56 INFO - psutil == 3.1.1 13:45:56 INFO - requests == 1.2.3 13:45:56 INFO - wsgiref == 0.1.2 13:45:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:56 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')]} 13:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:56 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')]} 13:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:57 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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:57 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 13:45:57 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 13:45:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:57 INFO - 'HOME': '/Users/cltbld', 13:45:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:57 INFO - 'LOGNAME': 'cltbld', 13:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:57 INFO - 'MOZ_NO_REMOTE': '1', 13:45:57 INFO - 'NO_EM_RESTART': '1', 13:45:57 INFO - 'PAGER': '/bin/cat', 13:45:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:57 INFO - 'PWD': '/builds/slave/test', 13:45:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:57 INFO - 'SHELL': '/bin/bash', 13:45:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:57 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:57 INFO - 'USER': 'cltbld', 13:45:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:57 INFO - 'XPC_FLAGS': '0x0', 13:45:57 INFO - 'XPC_SERVICE_NAME': '0', 13:45:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 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)) 13:45:57 INFO - Cleaning up... 13:45:57 INFO - Return code: 0 13:45:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45:57 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')]} 13:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:57 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')]} 13:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:58 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 0x109a85b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a88768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd26b4deb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, '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.pfJhlH8hod/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.FfVtx5yYGj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 13:45:58 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 13:45:58 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 13:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:58 INFO - 'HOME': '/Users/cltbld', 13:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:58 INFO - 'LOGNAME': 'cltbld', 13:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:58 INFO - 'MOZ_NO_REMOTE': '1', 13:45:58 INFO - 'NO_EM_RESTART': '1', 13:45:58 INFO - 'PAGER': '/bin/cat', 13:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:58 INFO - 'PWD': '/builds/slave/test', 13:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:58 INFO - 'SHELL': '/bin/bash', 13:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:45:58 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:58 INFO - 'USER': 'cltbld', 13:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:58 INFO - 'XPC_FLAGS': '0x0', 13:45:58 INFO - 'XPC_SERVICE_NAME': '0', 13:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:45:58 INFO - Cleaning up... 13:45:58 INFO - Return code: 0 13:45:58 INFO - Running post-action listener: _resource_record_post_action 13:45:58 INFO - Running post-action listener: _start_resource_monitoring 13:45:58 INFO - Starting resource monitoring. 13:45:58 INFO - [mozharness: 2017-03-16 20:45:58.641345Z] Finished create-virtualenv step (success) 13:45:58 INFO - [mozharness: 2017-03-16 20:45:58.642284Z] Running install step. 13:45:58 INFO - Running pre-action listener: _resource_record_pre_action 13:45:58 INFO - Running main action method: install 13:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:58 INFO - Reading from file tmpfile_stdout 13:45:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:59 INFO - Reading from file tmpfile_stdout 13:45:59 INFO - Output received: 13:45:59 INFO - Usage: mozinstall [options] installer 13:45:59 INFO - Options: 13:45:59 INFO - -h, --help show this help message and exit 13:45:59 INFO - -d DEST, --destination=DEST 13:45:59 INFO - Directory to install application into. [default: 13:45:59 INFO - "/builds/slave/test"] 13:45:59 INFO - --app=APP Application being installed. [default: firefox] 13:45:59 INFO - mkdir: /builds/slave/test/build/application 13:45:59 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'] 13:45:59 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 13:46:13 INFO - Reading from file tmpfile_stdout 13:46:13 INFO - Output received: 13:46:13 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:46:13 INFO - Running post-action listener: _resource_record_post_action 13:46:13 INFO - [mozharness: 2017-03-16 20:46:13.699703Z] Finished install step (success) 13:46:13 INFO - [mozharness: 2017-03-16 20:46:13.699879Z] Running run-tests step. 13:46:13 INFO - Running pre-action listener: _resource_record_pre_action 13:46:13 INFO - Running main action method: run_tests 13:46:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:13 INFO - 2017-03-16 13:46:13.714 screenresolution[1629:7274] starting screenresolution argv=screenresolution get 13:46:13 INFO - 2017-03-16 13:46:13.717 screenresolution[1629:7274] Display 0: 1600x1200x32@60 13:46:13 INFO - 2017-03-16 13:46:13.722 screenresolution[1630:7276] starting screenresolution argv=screenresolution list 13:46:13 INFO - Available Modes on Display 0 13:46:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:13 INFO - Intel Iris: 13:46:13 INFO - Chipset Model: Intel Iris 13:46:13 INFO - Type: GPU 13:46:13 INFO - Bus: Built-In 13:46:13 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:13 INFO - Vendor: Intel (0x8086) 13:46:13 INFO - Device ID: 0x0a2e 13:46:13 INFO - Revision ID: 0x0009 13:46:13 INFO - Displays: 13:46:13 INFO - Display: 13:46:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:13 INFO - Display Serial Number: 1600x1200 60 13:46:13 INFO - Main Display: Yes 13:46:13 INFO - Mirror: Off 13:46:13 INFO - Online: Yes 13:46:13 INFO - Rotation: Supported 13:46:13 INFO - Return code: 0 13:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:46:13 INFO - Python 2.7.3 13:46:13 INFO - Return code: 0 13:46:13 INFO - grabbing minidump binary from tooltool 13:46:13 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')]} 13:46:13 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 0x109863d30>, '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 0x10978adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109858be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:46:13 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 13:46:13 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 13:46:13 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 13:46:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:14 INFO - Return code: 0 13:46:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:46:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:46:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:46:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:46:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:46:14 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:46:14 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pfJhlH8hod/Render', 13:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:46:14 INFO - 'HOME': '/Users/cltbld', 13:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:46:14 INFO - 'LOGNAME': 'cltbld', 13:46:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:46:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:14 INFO - 'MOZ_NO_REMOTE': '1', 13:46:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:46:14 INFO - 'NO_EM_RESTART': '1', 13:46:14 INFO - 'PAGER': '/bin/cat', 13:46:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:14 INFO - 'PWD': '/builds/slave/test', 13:46:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:46:14 INFO - 'SHELL': '/bin/bash', 13:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfVtx5yYGj/Listeners', 13:46:14 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 13:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:46:14 INFO - 'USER': 'cltbld', 13:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:14 INFO - 'XPC_FLAGS': '0x0', 13:46:14 INFO - 'XPC_SERVICE_NAME': '0', 13:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:46:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:46:14 INFO - mozversion application_buildid: 20170316114621 13:46:14 INFO - mozversion application_changeset: 5674d54cd39e3b37ae8ab8bcff53981bed292995 13:46:14 INFO - mozversion application_display_name: Firefox 13:46:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:14 INFO - mozversion application_name: Firefox 13:46:14 INFO - mozversion application_remotingname: firefox 13:46:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:46:14 INFO - mozversion application_vendor: Mozilla 13:46:14 INFO - mozversion application_version: 53.0 13:46:14 INFO - mozversion platform_buildid: 20170316114621 13:46:14 INFO - mozversion platform_changeset: 5674d54cd39e3b37ae8ab8bcff53981bed292995 13:46:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:46:14 INFO - mozversion platform_version: 53.0 13:46:14 INFO - using testdate: 1489697174 13:46:14 INFO - actual date: 1489697174 13:46:14 INFO - starting webserver on 'localhost:49250' 13:46:14 INFO - SUITE-START | Running 2 tests 13:46:14 INFO - TEST-START | dromaeo_css 13:46:14 INFO - operating with platform_type : mac_ 13:46:14 INFO - Initialising browser for dromaeo_css test... 13:46:14 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpYFjgeg/profile http://localhost:49250/getInfo.html) 13:46:16 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 13:46:16 INFO - PROCESS | 1640 | colorDepth:24 13:46:16 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 13:46:16 INFO - PROCESS | 1640 | __metrics 13:46:16 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:46:16 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:17 INFO - TEST-INFO | 1640: exit 0 13:46:17 INFO - Browser initialized. 13:46:17 INFO - Running cycle 1/1 for dromaeo_css test... 13:46:17 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpYFjgeg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:29 INFO - PROCESS | 1643 | RSS: Main: 166821888 13:46:29 INFO - PROCESS | 1643 | 13:49:32 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 13:49:33 INFO - PROCESS | 1643 | RSS: Main: 292343808 13:49:33 INFO - PROCESS | 1643 | 13:52:36 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 13:52:37 INFO - PROCESS | 1643 | RSS: Main: 306511872 13:52:37 INFO - PROCESS | 1643 | 13:55:39 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 13:55:40 INFO - PROCESS | 1643 | RSS: Main: 282443776 13:55:40 INFO - PROCESS | 1643 | 13:58:42 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 13:58:43 INFO - PROCESS | 1643 | RSS: Main: 289165312 13:58:43 INFO - PROCESS | 1643 | 14:01:46 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 14:01:47 INFO - PROCESS | 1643 | RSS: Main: 268582912 14:01:47 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 14:04:50 INFO - PROCESS | 1643 | RSS: Main: 428621824 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | __start_tp_report 14:04:50 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:04:50 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:04:50 INFO - PROCESS | 1643 | |i|pagename|runs| 14:04:50 INFO - PROCESS | 1643 | |0;dojo.html;3150.4171728230276;3435.278591495787;3442.9827850860743;3448.155201975513;3503.3693935091687;5779.450952159544;5822.534197264219;5831.766729330832;5845.678487683176;5872.882542349156;5681.23303354047;5694.914576281349;5745.368009518949;5766.135079738041;5770.04794208955;4739.909820741232;4913.631477639191;5183.118869792135;5228.947710522903;5259.158534634459;3993.261246669361;4373.322135069054;5216.087184742674;5289.20661900716;5300.310959575249;4936.777844996984;5293.444188360225;5306.814261500848;5314.388845282803;5347.144456886899;5276.762545685434;5319.760610772524;5328.147496400557;5346.224797404393;5352.197170424429;5203.609729270282;5257.263983042377;5283.339582552181;5323.893522129574;5345.65253258537;5651.124075768263;5677.829665110054;5709.115087161496;5717.656940583537;5733.369329373765;6273.278572964122;6278.6860656966965;6326.398992095744;6329.651869147195;6342.207224096988;5881.647101173943;6306.49548036156;6329.778457754002;6363.109164716943;6367.235931688181;5727;5841.065429531254;5857.853553661193;5972.193753843262;5990.910136348002;6293.779717709858;6318.273398559132;6344.746210151635;6404.967975160094;6406.583572067801;6295.213098362705;6303.558750887486;6309.3690630936535;6311.684415779193;6328.810135695937;6176.567640265228;6241.75032998684;6346.4605508532295;6354.491640668735;6358.809235722936;6150.077488376779;6187.752489900444;6226.439620434092;6237;6246.406591373812;6205.503559715212;6247.125402443661;6279.843003924847;6280.9685951569945;6292.433680968643;4437.866863994085;4489.1021795641;4989.351384320088;5032.446430892599;5060.443351231362;4505.481869584974;4514.119746649372;4515.367848501212;4517.909641807211;4533.614642755403;5800.4489573490455;5826.388229235869;5859.121131830259;5883.14694369314;5936.614120082181;6283.8114856554375;6304.306526282106;6314.021326694278;6317.305096439388;6330.050492426173;5851.912221316684;5888.293404791452;5895.263092113486;5902.940970590239;5924.318703349084;5419.187121931663;5437.374701909252;5470.8085217017215;5474.42518535556;5522.144067669517;6277.340879207617;6279.811605651837;6282.465990390868;6288.308286088618;6298.212723409574;6265.060240963892;6272.8118156455375;6274.937250627435;6294.15028971083;6297.590656607306;6315.210598675166;6357.110004599453;6379.617222966637;6407.743690252338;6409.647469389229;6324.241091068917;6326.082718005955;6334.429901308904;6337.683115844282;6339.873202535831;6217.222847144107;6261.749530018748;6288.088227207121;6318.020706790455;6320.367963203643;6243.781467648792;6265.091561723433;6280;6289.433950944437;6292.52806039558;6266.185395898504;6272.529560282906;6278.937210628018;6281.748730050929;6286.088517164894;5839.970800145972;5933.2880054393745;6001.639901605918;6010.128531363015;6145.72344244519;5151.484851514819;6268.216472940882;6279.215098112736;6285.5600107992;6286.6856657166045;6160.845978850385;6162.445379915829;6164.352742961924;6164.938350616437;6180.165677633462 14:04:50 INFO - PROCESS | 1643 | |1;ext.html;471.73347058911713;506.5162769555075;544.3984397241046;571.434280062738;604.3835288006234;31674.84162579187;42733.57266427335;42761;42800;43001.569984300186;44304.89237769057;44929.55070449295;44945.550544494545;44962.55037449625;44992;9091.136342047528;9290.442573445582;9568.186704130158;9818.803623927517;9834.852477212848;11839.112066594997;12078.335691536962;12084.57703980361;12210.389480525982;12240.143189976705;11964.521419143224;12045.457954392074;12059.276443413379;12065.457054432527;12154;11992.280463172194;12057.698557536043;12066.457009434596;12069.456874440672;12075.275483470976;12064.879351206464;12124.757504849853;12136.271823690608;12137.817932731015;12149.696257593543;43233.35149972753;43486.782566086964;43510.564894350966;43546.91132721676;43555.56444435547;4095.651869591088;4113.856015039489;4135.1316223593085;4156.667466602695;4168.979155104205;31368.37263254745;32268;33094.3381132376;33596.16009599755;33862.322753545035;3346.880705192945;3358.1101008232836;3394.439917413624;3417.9145521362166;3524.947125793115;392906;392975;393398.99999999715;393975;394078.0592194099;68024.6598767003;68301.65849170722;68361.65819170872;68412;68591.65704171547;70728;70757.64621176862;70804.2919570808;70810.64594676993;70820.64589677121;17983;18191.727124093148;18194.999275039736;18212.908935455238;18247.17887695057;12644.620661380173;12909.031822613342;13478.797818032737;13623.455061797615;14128.505502307575;18791.530211744815;18898.338558150397;18944.621107577772;18953.715694264596;19132.043397830053;7622;7706.451275356344;7710.383169346439;7778.844423111506;7808.297253247235;894.3247847874943;898.1736802142045;905.0813424374265;932.077243528915;936.8875734911854;30604.54093188604;31154;31306.440114068046;31620.841895790374;31970.442364610775;1004.57305645102;1031.4584842957506;1080.3895798873612;1132.043423307304;1210.9101808372536;13906.582802515739;15325.540233793005;15510.84489155094;15598.3205038488;15617.453389131553;427205;429590;431794;432223.67776322464;432255.67744322785;59269;59503.40496595065;59545.70227148923;59549.40450595525;59775;1262.2489618677057;1281.4810001949224;1296.6758310422395;1479.0312345413772;1498.6478177628248;29805;31668.683313167494;31687.683123168474;31699.841500792347;32405.513917290788;54686;55375.72312138414;55395.72302138625;55487.44512554823;55493.72253138709;340630;343138;344168;345354;346208;35678.821605891804;39052.6094739049;40840.978975525846;41679;41714.165716686104;43029.225712271626;43279.9180020502;44473.92479529344;44857.327140092275;45002.77498612486;34566;36652.26695466129;36710.44934325934;37200;38477.42283865688;29230;33426.832865836484;33738.662613373555;35318.70428422247;37504.81247593745;36184.276314473034;36204.81897590495;37168.814155929045;37398.252034959696;37530;22666.093356266225;30243.546346804374;30716.232094197825;32867;32903;24198.51602967966;24350.634740478552;24525.38686532851;24952.875235623706;25060.874695626404 14:04:50 INFO - PROCESS | 1643 | |2;jquery.html;406.5527919288782;408.12457279136254;411.321319822293;422.44659496060154;438.89247134452063;20439.284625038108;21525.784742152595;22193.11227550896;22289;22338.10647574097;21967.670484942737;22490.775092249074;22640.20759273426;22874.771252287515;23135.72753498557;5521.116621340576;5717.685527295997;5721.570882183832;5722.284714410699;5723.799667011655;5686.573506986972;6027.276726792791;6302.779402720906;6344.777932772354;6420.357964203589;6187.938120618781;6381.968090159566;6422.839429014265;6428.935710642881;6439.742410303582;5929.6145750526075;5950.1372301016545;6376.968115159418;6392.3927226913365;6407.903881441759;6072.240969878765;6224.408681175281;6286.277078135981;6290.465310448617;6310.495160387158;14283.35724892372;14292;14368;14465.78301325481;14513.492027778977;2611.4124322027583;2702.337927207827;2732.398872248102;2752.0367871245103;2795.888164473439;10665.733356666067;11181.608643697513;11225.943870280596;12635.368231588383;15367;1574.9752823279855;1828.3235202974852;1875.7561517002703;1876.8780029298189;1883.6044430669576;138107.30946345205;145621.27189363985;155458;156074;158852.8229435405;12047.939760301142;12048.337341446304;12253.203541769757;12272.815907761391;12385.256884586954;16740.49778506647;16746.49760507187;16753.413630522875;16760.748588771177;16765.329386824633;8912.108789121166;9183.448993060438;9203.76990575241;9301.674441394518;9323.440593564408;8960.596773145224;8993.730188094367;9030.232430243503;9164.6792362267;9202.90797092034;4932.630052746058;4989.525995030466;4992.525710057539;5036.647434679538;5064.924026139611;2036.745406824147;2045.202371075282;2081.9687704684443;2084.6768750843644;2090.393785802131;922.9893266872764;1036.3212096077082;1051.8211903976342;1060.1042119409087;1068.2468859454066;21747.13011479555;22201.666974995387;22235.666465003036;22291.3312600619;22355;1058.730023843915;1069.572171131538;1073.8872418396113;1076.5639915833942;1088.6842815583393;10679;11542.94228528852;11573.132015098901;11586.826197607043;11615.186936914335;736282;741000;758631;767692;784705;111517.44241278742;116751.41624291825;120126.69764384258;138518;144727;983.3362480325751;998.9550470228858;1035.2597892506894;1040.3549799124592;1040.6149724601946;19104.617907641492;19985.100670470154;20436.978151092684;20840.665493520963;20913.37259882206;50340;51735.48264517307;57191.428085720276;62775.058374125336;63009.739805204554;89035;90023;90899.63650545116;91404.08595913956;92960;6931.68807403658;8424.62089205975;8617.138286171332;8814.691485797966;8984.32617553673;9893.554790034323;13145.145565538209;13171.736565268833;13576.728465430833;13782.793258100935;11447.542098315975;11522.42387880586;11641.767164656829;11735.706607334885;11866.940665296619;10098.798024039625;11447.656570302572;11468.082553395541;11471.369074700971;11959.76080478403;11631.557372951775;11666.416679166177;11834.46744896499;11927.343996080299;12164.330961796832;8324.167583241628;8682.305415566865;8732.57666268424;8832.955835220782;8846.55767211624;10213.33613315132;11295.717607059889;11518.712032199262;11636.12729045342;11987.700307492034 14:04:50 INFO - PROCESS | 1643 | |3;mootools.html;1458.8978771485993;1460.050966871534;1480.3856399594165;1484.1317829070001;1487.3232679130992;8137.796555086125;8529.53087580183;8536.231739143468;8537.103604121563;8544.48733076016;7553.660085296161;7816.570088645122;8096.91903080969;8268.545230012347;8291.419600627958;2381.6070348392495;2388.355144111089;2416.4442178299;2420.6248031555137;2423.442608200115;2393.5571919195004;2420.056178090546;2427.3567504611206;2431.3556907419547;2432.9635055474096;2019.545602239499;2394.162043284854;2396.4128788446856;2414.8430352027062;2422.515496900618;2330.650402439639;2343.379004563792;2347.8473899196583;2369.9052037918464;2374.608189648723;2298.241580278504;2335.848169868953;2353.7646235376496;2357.210334537932;2364.231624721955;8388.454750441202;8400.285975692012;8468.110848360895;8479.576021198915;8497.660093596249;5139.537441630271;5299.894002119936;5300.1519756838725;5305.204219367087;5307.469253074701;3555.5022296878456;3559.501669766235;3587.157018100744;3616.4936908832783;3641.8543258269638;1252.0922331309819;1260.4706023470073;1288.8324517812625;1309.18830325199;1316.2892038299403;10794.73013174677;10849.620263290746;10850.29473084247;10869.945650271698;10876.18428617849;4708.105459962596;4741.762911854394;4747.433346995484;4828.782704778293;4856.028794241166;9567.330286879991;9649.276304277208;9651.806963860683;9651.938286788447;9674.70975870725;5142.04872098663;5219.712915789592;5225.947740522623;5231.8168864089575;5255.106631872591;4224.302990006615;4421.358902959053;4453.799579018887;4791.904161916812;4856.417229932431;3879.1271963807917;3974.4833171687496;3979.9602003980167;4026.3960405939342;4060.9390859136547;1300.14840279617;1309.8690130987015;1311.4360824845216;1323.0275747325709;1323.4904561743797;906.5739102621757;925.9212966897754;925.9768505787274;932.2355668351886;959.9808003839884;5583.3858275589655;5783;5943.58394912352;5995.730192141364;6059.091136329585;854.8632218845079;970.7767213540925;985.4235272365603;1006.1347241372414;1023.6161439460202;3833.865814696528;3840.846366145323;3845.288621605012;3894.1432884765304;3951.940720889189;9745.658901938397;10090.899091008996;10091.394516329045;10104.444255565868;10127.189824813997;10013.098821106136;10017.098461138532;10037.397756134655;10037.69886903394;10052.849207261897;7522.548647081302;7858.882116768253;8012.599370031592;8021.2379823916635;8037.557934313669;5789.1895134680335;5873.060310350324;5911.881762364815;5949;5964;8989.730308090768;8995.685151019683;9188.310876684409;9232.492212928084;9332.30007749408;9079.228265597498;9337.533123343941;9400;9520.809583808423;9537.189338906272;6752.987051942248;6909.861802764017;6928;7231.8553628928175;7389.926100738924;7300.379467745089;7926.365890728613;7997.640106195119;8076;8080;6968.338007889445;7097.183823860322;7107.182673992557;7148.964255178691;7223.313785190398;6934.16789985205;6989.30106989297;7044.788656340318;7123.679434425567;7193.892091618525;6395.968020159869;6420;6505.41451269388;6509.804705858832;6519.022146678036;4297.8495752648505;4962.900741985068;4997.450280469073;5077.162268225701;5085.4406015337545;4971.701697897993;4985.900281994413;5061.190209566452;5148.510891465305;5162.767675454538 14:04:50 INFO - PROCESS | 1643 | |4;prototype.html;371.4391269183533;375.81960658883736;382.18785081701395;389.27011852776064;390.41048017493574;4452.619687896746;5345.518903298707;5370.18716711135;5403.297571315724;5417.485338892809;5008.424031236409;5038.647294689373;5233.607479439048;5300.257963885049;5376.51611354978;3628.183658676803;3918.9614752090574;3959.6040395960317;4171.311733563966;4184.686148538856;3287.6547962463956;3603.729720270977;3755.4179102239195;3887.9805600971954;4116.053307739222;2916.912492625225;3962.325430334527;4123.072308730527;4128.814203360841;4146.460960075186;3577.123604716848;4029.979850100731;4045.8179381927885;4050.8784736457956;4071.6742660587083;3051.6643169251365;3413.84637691302;3523.841427135785;3527.3121741260466;3529.2764983178386;4316.503602085769;4771.232685042667;5268.762905669254;5275.573236311301;5290.365156181244;4231.830726770925;4503.4145561077175;4601.562851529099;4636.281376386665;4668.5564871337165;4203.55862634422;5634.3802181759975;5642.605017648766;5660.490555849952;5667.846218437009;3888.18106872518;3904.8438062477467;3905.628965248297;3906.570277269498;3918;5119.462456442057;5269.525742683139;5558.86102847428;5728.7110400160045;5953.583249172516;3743.326201283795;3899.863504777376;3910.648041676263;3950.585188555218;3962.980185099114;4012.598740125964;4019.8191081401405;4028;4032.516098068251;4037.8182981765303;4018.537868145142;4348.869533913988;4352.869413917588;4558.33904083906;4608.331791890158;4684.81260749573;5619.971900140555;5625.578081643893;5637.520810731134;5664.320281566238;1134.7347707306294;1153.1985270237271;1191.5114802930757;1309.1359702596242;1310.4103153580736;791.5211297165247;838.446625227347;861.29804209569;870.2863651805585;894.6242578117207;4226.598473145046;4790.377250957354;4915.9508404916205;5006.89986200274;5050.070958843862;4546.52261512543;5489.533389661923;5514.80698175562;5517.393086760453;5517.531009864127;4357.3899654048455;4699.882502937454;4987.600991920638;5144.710603781356;5242.449542798027;2563.4488584954324;2678.116221646852;2743.986280068587;2846.644169478815;2863.2698661841514;5216.556592689664;5642.830715078554;5736.627119237236;5773.6431938494425;5780.797672081457;4883.413990321184;4889.310879016598;5061.063703214917;5109.744512774347;5649.548036157097;4704.999999999932;5009.599232061426;5072.188449848007;5527.39198688144;5705.572082093777;5176.049651698496;5463.672179669233;5531.7234138293725;5588.524975377139;5589.860253493695;4709.481956984798;5331.693735034942;5389.652586853286;5404.864878378072;5460.754266058117;5029.874253143701;5594.20985284705;5621.931832951726;5723.399043100415;5747.51146152565;3651.6713495785507;3671.70626349886;3689.5019172412453;3702.629737026276;3749.2126653403093;4708.458527269408;4996.650234483552;5465.617406781487;5781.29451811725;5785.884282314414;4887.364642596582;5046.6719663221775;5199.974000129975;5318.920216196838;5596.272484576979;4270.722403043792;4683.695559788603;4986.202207646759;5611.80358687444;5632.7183640816975;4660.324252983366;5243.456923392076;5252.422233554383;5483.479069488392;5491.4349410417835;4693.624510039121;5516.613837031369;5572.219889215594;5589.273394458857;5602.635828671123;4819.373481447389;5505.449455054622;5509.3664228614225;5518.668879867221;5523.917141242965 14:04:50 INFO - PROCESS | 1643 | |5;yui.html;756.5158298688837;784.7096574267522;827.2017503109499;840.2647683277131;844.94085414021;13286.933565332172;15700.013493995177;15917.44288949887;17651.55871103223;18546.907265463688;16431.1245532032;16601.252943617535;16760.83239167608;16807.83192168078;16816.990980541144;912.8630705394178;937.4094320578026;939.4269495607674;940.6190492850372;941.580996456577;733.6295170938669;936.9953150234273;937.4796987671839;937.5827756648295;939.2157548447055;796.2873228460525;802.3180296747776;803.9035315762117;804.5534728225832;946.1957336264155;970.5438443931376;973.124188230591;974.995754372997;976.1458723616835;976.8876579193342;725.905632267807;726.23019599225;727.5707332673747;728.5555810955314;730.0436428278972;15854.524364269091;16195.595110122342;16265.349386024545;16311.673766524604;16596.921200121953;14364.138151710931;14448.78326825088;14491.944766963798;14491.985561010733;14593.70812583753;10756.408397538133;12261.693457663541;12505.187162834387;12524.436400362005;12861.935690321488;4373.912521749579;4612.630989520864;4641.234196357597;4711.505291944365;4832.903341933142;83180;85066.14933850644;85262.14737852605;89348;114697.5446595977;10735.892641073646;11201.271917325348;11250.324980501196;11262.324260544394;11278.323300601991;21738.913054347537;22140.2250921217;22202.88985550716;22209.888950555145;22595.322140335815;7799.220077992155;7896.960515197502;7898.407619428451;7921.841563168704;7926.445148839526;4366.410534577855;4415.977920110443;4455.086707225011;4582.747948862844;4672.766361681903;3598.694111000542;3637.108908317426;3701.0747313171705;3701.3522633539023;3982.980085099556;751.7218629107265;754.1327473405518;754.1930134755759;768.3008462299392;770.5184259837602;685.533836990841;708.9326513981164;710.5807573531641;732.5201992694793;761.9657115429819;10293;10536.525856336484;10630.840537391945;11008.559657613767;11018.614348497764;713.1050531582933;719.6536107102017;745.5154149802563;753.6721526136148;753.7776355975001;4454.732716037048;5082.923756143661;5223.947760522422;5239.240310155006;5247.658902171346;94503.58244626336;116664;118547;122302;123314.5337093253;78308;95805;96355;96575.55136672956;97413;80315.59842200752;81372;82739.5863020693;83146.674133034;84516.57741711252;8304.87542686848;8960.417572857743;10052.748681282734;10099.091081802673;10106.747331316776;48528.786780330774;50047.499525004285;56729.71635141798;57120.42879571151;59265.11102333382;69247.30752692408;69897.40820734228;71650.64174679093;71794.56410871648;74167.62916185385;13134;13685.726285474035;13733.137013013204;14279.571612851216;14640;14445.34995925207;15163.772543412078;15469.845301547291;15899.602509937344;16038.67922641564;13204.112707631706;13808.723825523633;14196.432142714175;14357.56927292183;14361.752542863238;13271.004674649246;14133.575992720234;14322.355494003003;14323.57029289123;14553.636159095684;12962.80555791645;13669.316534173451;13930.233837139054;14410.495632652806;14484.275786210437;11011.333005703886;11130;11215.214934954474;11272.210945234083;11287.43562821872;10067.748306292402;10918.23572349928;11199.776004480027;11253.7749245013;11272.323660580392 14:04:50 INFO - PROCESS | 1643 | __end_tp_report 14:04:50 INFO - PROCESS | 1643 | __start_cc_report 14:04:50 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1587 14:04:50 INFO - PROCESS | 1643 | __end_cc_report 14:04:50 INFO - PROCESS | 1643 | __startTimestamp1489698290535__endTimestamp 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:04:50 INFO - PROCESS | 1643 | Number of tests: 6 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5800.87 Median:6150.08 stddev:687.36 (11.2%) stddev-sans-first:657.27 14:04:50 INFO - PROCESS | 1643 | Values: 3150.4 3435.3 3443.0 3448.2 3503.4 5779.5 5822.5 5831.8 5845.7 5872.9 5681.2 5694.9 5745.4 5766.1 5770.0 4739.9 4913.6 5183.1 5228.9 5259.2 3993.3 4373.3 5216.1 5289.2 5300.3 4936.8 5293.4 5306.8 5314.4 5347.1 5276.8 5319.8 5328.1 5346.2 5352.2 5203.6 5257.3 5283.3 5323.9 5345.7 5651.1 5677.8 5709.1 5717.7 5733.4 6273.3 6278.7 6326.4 6329.7 6342.2 5881.6 6306.5 6329.8 6363.1 6367.2 5727.0 5841.1 5857.9 5972.2 5990.9 6293.8 6318.3 6344.7 6405.0 6406.6 6295.2 6303.6 6309.4 6311.7 6328.8 6176.6 6241.8 6346.5 6354.5 6358.8 6150.1 6187.8 6226.4 6237.0 6246.4 6205.5 6247.1 6279.8 6281.0 6292.4 4437.9 4489.1 4989.4 5032.4 5060.4 4505.5 4514.1 4515.4 4517.9 4533.6 5800.4 5826.4 5859.1 5883.1 5936.6 6283.8 6304.3 6314.0 6317.3 6330.1 5851.9 5888.3 5895.3 5902.9 5924.3 5419.2 5437.4 5470.8 5474.4 5522.1 6277.3 6279.8 6282.5 6288.3 6298.2 6265.1 6272.8 6274.9 6294.2 6297.6 6315.2 6357.1 6379.6 6407.7 6409.6 6324.2 6326.1 6334.4 6337.7 6339.9 6217.2 6261.7 6288.1 6318.0 6320.4 6243.8 6265.1 6280.0 6289.4 6292.5 6266.2 6272.5 6278.9 6281.7 6286.1 5840.0 5933.3 6001.6 6010.1 6145.7 5151.5 6268.2 6279.2 6285.6 6286.7 6160.8 6162.4 6164.4 6164.9 6180.2 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:56527.46 Median:35498.76 stddev:102913.60 (289.9%) stddev-sans-first:103116.24 14:04:50 INFO - PROCESS | 1643 | Values: 471.7 506.5 544.4 571.4 604.4 31674.8 42733.6 42761.0 42800.0 43001.6 44304.9 44929.6 44945.6 44962.6 44992.0 9091.1 9290.4 9568.2 9818.8 9834.9 11839.1 12078.3 12084.6 12210.4 12240.1 11964.5 12045.5 12059.3 12065.5 12154.0 11992.3 12057.7 12066.5 12069.5 12075.3 12064.9 12124.8 12136.3 12137.8 12149.7 43233.4 43486.8 43510.6 43546.9 43555.6 4095.7 4113.9 4135.1 4156.7 4169.0 31368.4 32268.0 33094.3 33596.2 33862.3 3346.9 3358.1 3394.4 3417.9 3524.9 392906.0 392975.0 393399.0 393975.0 394078.1 68024.7 68301.7 68361.7 68412.0 68591.7 70728.0 70757.6 70804.3 70810.6 70820.6 17983.0 18191.7 18195.0 18212.9 18247.2 12644.6 12909.0 13478.8 13623.5 14128.5 18791.5 18898.3 18944.6 18953.7 19132.0 7622.0 7706.5 7710.4 7778.8 7808.3 894.3 898.2 905.1 932.1 936.9 30604.5 31154.0 31306.4 31620.8 31970.4 1004.6 1031.5 1080.4 1132.0 1210.9 13906.6 15325.5 15510.8 15598.3 15617.5 427205.0 429590.0 431794.0 432223.7 432255.7 59269.0 59503.4 59545.7 59549.4 59775.0 1262.2 1281.5 1296.7 1479.0 1498.6 29805.0 31668.7 31687.7 31699.8 32405.5 54686.0 55375.7 55395.7 55487.4 55493.7 340630.0 343138.0 344168.0 345354.0 346208.0 35678.8 39052.6 40841.0 41679.0 41714.2 43029.2 43279.9 44473.9 44857.3 45002.8 34566.0 36652.3 36710.4 37200.0 38477.4 29230.0 33426.8 33738.7 35318.7 37504.8 36184.3 36204.8 37168.8 37398.3 37530.0 22666.1 30243.5 30716.2 32867.0 32903.0 24198.5 24350.6 24525.4 24952.9 25060.9 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:41009.77 Median:22197.39 stddev:125997.48 (567.6%) stddev-sans-first:126314.05 14:04:50 INFO - PROCESS | 1643 | Values: 406.6 408.1 411.3 422.4 438.9 20439.3 21525.8 22193.1 22289.0 22338.1 21967.7 22490.8 22640.2 22874.8 23135.7 5521.1 5717.7 5721.6 5722.3 5723.8 5686.6 6027.3 6302.8 6344.8 6420.4 6187.9 6382.0 6422.8 6428.9 6439.7 5929.6 5950.1 6377.0 6392.4 6407.9 6072.2 6224.4 6286.3 6290.5 6310.5 14283.4 14292.0 14368.0 14465.8 14513.5 2611.4 2702.3 2732.4 2752.0 2795.9 10665.7 11181.6 11225.9 12635.4 15367.0 1575.0 1828.3 1875.8 1876.9 1883.6 138107.3 145621.3 155458.0 156074.0 158852.8 12047.9 12048.3 12253.2 12272.8 12385.3 16740.5 16746.5 16753.4 16760.7 16765.3 8912.1 9183.4 9203.8 9301.7 9323.4 8960.6 8993.7 9030.2 9164.7 9202.9 4932.6 4989.5 4992.5 5036.6 5064.9 2036.7 2045.2 2082.0 2084.7 2090.4 923.0 1036.3 1051.8 1060.1 1068.2 21747.1 22201.7 22235.7 22291.3 22355.0 1058.7 1069.6 1073.9 1076.6 1088.7 10679.0 11542.9 11573.1 11586.8 11615.2 736282.0 741000.0 758631.0 767692.0 784705.0 111517.4 116751.4 120126.7 138518.0 144727.0 983.3 999.0 1035.3 1040.4 1040.6 19104.6 19985.1 20437.0 20840.7 20913.4 50340.0 51735.5 57191.4 62775.1 63009.7 89035.0 90023.0 90899.6 91404.1 92960.0 6931.7 8424.6 8617.1 8814.7 8984.3 9893.6 13145.1 13171.7 13576.7 13782.8 11447.5 11522.4 11641.8 11735.7 11866.9 10098.8 11447.7 11468.1 11471.4 11959.8 11631.6 11666.4 11834.5 11927.3 12164.3 8324.2 8682.3 8732.6 8833.0 8846.6 10213.3 11295.7 11518.7 11636.1 11987.7 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5506.46 Median:5145.28 stddev:2952.31 (57.4%) stddev-sans-first:2944.92 14:04:50 INFO - PROCESS | 1643 | Values: 1458.9 1460.1 1480.4 1484.1 1487.3 8137.8 8529.5 8536.2 8537.1 8544.5 7553.7 7816.6 8096.9 8268.5 8291.4 2381.6 2388.4 2416.4 2420.6 2423.4 2393.6 2420.1 2427.4 2431.4 2433.0 2019.5 2394.2 2396.4 2414.8 2422.5 2330.7 2343.4 2347.8 2369.9 2374.6 2298.2 2335.8 2353.8 2357.2 2364.2 8388.5 8400.3 8468.1 8479.6 8497.7 5139.5 5299.9 5300.2 5305.2 5307.5 3555.5 3559.5 3587.2 3616.5 3641.9 1252.1 1260.5 1288.8 1309.2 1316.3 10794.7 10849.6 10850.3 10869.9 10876.2 4708.1 4741.8 4747.4 4828.8 4856.0 9567.3 9649.3 9651.8 9651.9 9674.7 5142.0 5219.7 5225.9 5231.8 5255.1 4224.3 4421.4 4453.8 4791.9 4856.4 3879.1 3974.5 3980.0 4026.4 4060.9 1300.1 1309.9 1311.4 1323.0 1323.5 906.6 925.9 926.0 932.2 960.0 5583.4 5783.0 5943.6 5995.7 6059.1 854.9 970.8 985.4 1006.1 1023.6 3833.9 3840.8 3845.3 3894.1 3951.9 9745.7 10090.9 10091.4 10104.4 10127.2 10013.1 10017.1 10037.4 10037.7 10052.8 7522.5 7858.9 8012.6 8021.2 8037.6 5789.2 5873.1 5911.9 5949.0 5964.0 8989.7 8995.7 9188.3 9232.5 9332.3 9079.2 9337.5 9400.0 9520.8 9537.2 6753.0 6909.9 6928.0 7231.9 7389.9 7300.4 7926.4 7997.6 8076.0 8080.0 6968.3 7097.2 7107.2 7149.0 7223.3 6934.2 6989.3 7044.8 7123.7 7193.9 6396.0 6420.0 6505.4 6509.8 6519.0 4297.8 4962.9 4997.5 5077.2 5085.4 4971.7 4985.9 5061.2 5148.5 5162.8 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4418.42 Median:4902.63 stddev:1341.42 (27.4%) stddev-sans-first:1310.34 14:04:50 INFO - PROCESS | 1643 | Values: 371.4 375.8 382.2 389.3 390.4 4452.6 5345.5 5370.2 5403.3 5417.5 5008.4 5038.6 5233.6 5300.3 5376.5 3628.2 3919.0 3959.6 4171.3 4184.7 3287.7 3603.7 3755.4 3888.0 4116.1 2916.9 3962.3 4123.1 4128.8 4146.5 3577.1 4030.0 4045.8 4050.9 4071.7 3051.7 3413.8 3523.8 3527.3 3529.3 4316.5 4771.2 5268.8 5275.6 5290.4 4231.8 4503.4 4601.6 4636.3 4668.6 4203.6 5634.4 5642.6 5660.5 5667.8 3888.2 3904.8 3905.6 3906.6 3918.0 5119.5 5269.5 5558.9 5728.7 5953.6 3743.3 3899.9 3910.6 3950.6 3963.0 4012.6 4019.8 4028.0 4032.5 4037.8 4018.5 4348.9 4352.9 4558.3 4608.3 4684.8 5620.0 5625.6 5637.5 5664.3 1134.7 1153.2 1191.5 1309.1 1310.4 791.5 838.4 861.3 870.3 894.6 4226.6 4790.4 4916.0 5006.9 5050.1 4546.5 5489.5 5514.8 5517.4 5517.5 4357.4 4699.9 4987.6 5144.7 5242.4 2563.4 2678.1 2744.0 2846.6 2863.3 5216.6 5642.8 5736.6 5773.6 5780.8 4883.4 4889.3 5061.1 5109.7 5649.5 4705.0 5009.6 5072.2 5527.4 5705.6 5176.0 5463.7 5531.7 5588.5 5589.9 4709.5 5331.7 5389.7 5404.9 5460.8 5029.9 5594.2 5621.9 5723.4 5747.5 3651.7 3671.7 3689.5 3702.6 3749.2 4708.5 4996.7 5465.6 5781.3 5785.9 4887.4 5046.7 5200.0 5318.9 5596.3 4270.7 4683.7 4986.2 5611.8 5632.7 4660.3 5243.5 5252.4 5483.5 5491.4 4693.6 5516.6 5572.2 5589.3 5602.6 4819.4 5505.4 5509.4 5518.7 5523.9 14:04:50 INFO - PROCESS | 1643 | 14:04:50 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:21208.87 Median:4435.36 stddev:30183.75 (680.5%) stddev-sans-first:30229.35 14:04:50 INFO - PROCESS | 1643 | Values: 756.5 784.7 827.2 840.3 844.9 13286.9 15700.0 15917.4 17651.6 18546.9 16431.1 16601.3 16760.8 16807.8 16817.0 912.9 937.4 939.4 940.6 941.6 733.6 937.0 937.5 937.6 939.2 796.3 802.3 803.9 804.6 946.2 970.5 973.1 975.0 976.1 976.9 725.9 726.2 727.6 728.6 730.0 15854.5 16195.6 16265.3 16311.7 16596.9 14364.1 14448.8 14491.9 14492.0 14593.7 10756.4 12261.7 12505.2 12524.4 12861.9 4373.9 4612.6 4641.2 4711.5 4832.9 83180.0 85066.1 85262.1 89348.0 114697.5 10735.9 11201.3 11250.3 11262.3 11278.3 21738.9 22140.2 22202.9 22209.9 22595.3 7799.2 7897.0 7898.4 7921.8 7926.4 4366.4 4416.0 4455.1 4582.7 4672.8 3598.7 3637.1 3701.1 3701.4 3983.0 751.7 754.1 754.2 768.3 770.5 685.5 708.9 710.6 732.5 762.0 10293.0 10536.5 10630.8 11008.6 11018.6 713.1 719.7 745.5 753.7 753.8 4454.7 5082.9 5223.9 5239.2 5247.7 94503.6 116664.0 118547.0 122302.0 123314.5 78308.0 95805.0 96355.0 96575.6 97413.0 80315.6 81372.0 82739.6 83146.7 84516.6 8304.9 8960.4 10052.7 10099.1 10106.7 48528.8 50047.5 56729.7 57120.4 59265.1 69247.3 69897.4 71650.6 71794.6 74167.6 13134.0 13685.7 13733.1 14279.6 14640.0 14445.3 15163.8 15469.8 15899.6 16038.7 13204.1 13808.7 14196.4 14357.6 14361.8 13271.0 14133.6 14322.4 14323.6 14553.6 12962.8 13669.3 13930.2 14410.5 14484.3 11011.3 11130.0 11215.2 11272.2 11287.4 10067.7 10918.2 11199.8 11253.8 11272.3 14:04:50 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:04:50 INFO - PROCESS | 1643 | 14:04:51 INFO - TEST-INFO | 1643: exit 0 14:04:51 INFO - TEST-OK | dromaeo_css | took 1116829ms 14:04:51 INFO - TEST-START | kraken 14:04:51 INFO - operating with platform_type : mac_ 14:04:51 INFO - Initialising browser for kraken test... 14:04:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmp2M2w80/profile http://localhost:49250/getInfo.html) 14:04:53 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 14:04:53 INFO - PROCESS | 1653 | colorDepth:24 14:04:53 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 14:04:53 INFO - PROCESS | 1653 | __metrics 14:04:53 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:04:53 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:04:54 INFO - TEST-INFO | 1653: exit 0 14:04:54 INFO - Browser initialized. 14:04:54 INFO - Running cycle 1/1 for kraken test... 14:04:54 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmp2M2w80/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:06 INFO - PROCESS | 1655 | RSS: Main: 166465536 14:05:06 INFO - PROCESS | 1655 | 14:05:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:09 INFO - PROCESS | 1655 | RSS: Main: 214716416 14:05:09 INFO - PROCESS | 1655 | 14:05:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 14:05:12 INFO - PROCESS | 1655 | RSS: Main: 228487168 14:05:12 INFO - PROCESS | 1655 | 14:05:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 14:05:16 INFO - PROCESS | 1655 | RSS: Main: 324628480 14:05:16 INFO - PROCESS | 1655 | 14:05:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 14:05:18 INFO - PROCESS | 1655 | RSS: Main: 227422208 14:05:18 INFO - PROCESS | 1655 | 14:05:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:21 INFO - PROCESS | 1655 | RSS: Main: 227581952 14:05:21 INFO - PROCESS | 1655 | 14:05:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:25 INFO - PROCESS | 1655 | RSS: Main: 268668928 14:05:25 INFO - PROCESS | 1655 | 14:05:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:28 INFO - PROCESS | 1655 | RSS: Main: 269578240 14:05:28 INFO - PROCESS | 1655 | 14:05:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 14:05:31 INFO - PROCESS | 1655 | RSS: Main: 268451840 14:05:31 INFO - PROCESS | 1655 | 14:05:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:34 INFO - PROCESS | 1655 | RSS: Main: 245604352 14:05:34 INFO - PROCESS | 1655 | 14:05:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:36 INFO - PROCESS | 1655 | RSS: Main: 249937920 14:05:36 INFO - PROCESS | 1655 | 14:05:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:39 INFO - PROCESS | 1655 | RSS: Main: 255926272 14:05:39 INFO - PROCESS | 1655 | 14:05:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:05:42 INFO - PROCESS | 1655 | RSS: Main: 269824000 14:05:42 INFO - PROCESS | 1655 | 14:05:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:05:46 INFO - PROCESS | 1655 | RSS: Main: 264060928 14:05:46 INFO - PROCESS | 1655 | 14:05:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 14:05:48 INFO - PROCESS | 1655 | RSS: Main: 308547584 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | __start_tp_report 14:05:48 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 14:05:48 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 14:05:48 INFO - PROCESS | 1655 | |i|pagename|runs| 14:05:48 INFO - PROCESS | 1655 | |0;ai-astar;112;112;111;111;112;112;112;111;112;112 14:05:48 INFO - PROCESS | 1655 | |1;audio-beat-detection;143;110;107;141;107;108;106;107;127;106 14:05:48 INFO - PROCESS | 1655 | |2;audio-dft;181;179;182;178;180;180;181;183;182;181 14:05:48 INFO - PROCESS | 1655 | |3;audio-fft;79;58;58;88;57;60;58;58;71;58 14:05:48 INFO - PROCESS | 1655 | |4;audio-oscillator;86;69;87;69;68;69;81;67;77;97 14:05:48 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;87;104;135;84;87;84;87;85;86;84 14:05:48 INFO - PROCESS | 1655 | |6;imaging-darkroom;97;96;96;96;96;97;96;95;96;108 14:05:48 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;84;84;85;83;84;83;85;85;84 14:05:48 INFO - PROCESS | 1655 | |8;json-parse-financial;52;52;54;52;54;56;56;54;55;56 14:05:48 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;69;74;70;72;78;72;70;71;71;72 14:05:48 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;80;80;83;82;79;79;82;84;88 14:05:48 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;134;131;131;132;131;130;149;144;165;142 14:05:48 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;158;221;187;161;163;163;160;163;162;161 14:05:48 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;64;64;64;64;64;63;63;65;64;63 14:05:48 INFO - PROCESS | 1655 | __end_tp_report 14:05:48 INFO - PROCESS | 1655 | __start_cc_report 14:05:48 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1916 14:05:48 INFO - PROCESS | 1655 | __end_cc_report 14:05:48 INFO - PROCESS | 1655 | __startTimestamp1489698348208__endTimestamp 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | ------- Summary: start ------- 14:05:48 INFO - PROCESS | 1655 | Number of tests: 14 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:05:48 INFO - PROCESS | 1655 | Values: 112.0 112.0 111.0 111.0 112.0 112.0 112.0 111.0 112.0 112.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:116.20 Median:109.00 stddev:14.97 (13.7%) stddev-sans-first:12.35 14:05:48 INFO - PROCESS | 1655 | Values: 143.0 110.0 107.0 141.0 107.0 108.0 106.0 107.0 127.0 106.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:180.70 Median:181.00 stddev:1.49 (0.8%) stddev-sans-first:1.58 14:05:48 INFO - PROCESS | 1655 | Values: 181.0 179.0 182.0 178.0 180.0 180.0 181.0 183.0 182.0 181.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:64.50 Median:59.00 stddev:11.02 (18.7%) stddev-sans-first:10.36 14:05:48 INFO - PROCESS | 1655 | Values: 79.0 58.0 58.0 88.0 57.0 60.0 58.0 58.0 71.0 58.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.00 stddev:10.38 (13.1%) stddev-sans-first:10.49 14:05:48 INFO - PROCESS | 1655 | Values: 86.0 69.0 87.0 69.0 68.0 69.0 81.0 67.0 77.0 97.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:85.50 stddev:16.14 (18.9%) stddev-sans-first:17.00 14:05:48 INFO - PROCESS | 1655 | Values: 87.0 104.0 135.0 84.0 87.0 84.0 87.0 85.0 86.0 84.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:96.00 stddev:3.80 (4.0%) stddev-sans-first:4.03 14:05:48 INFO - PROCESS | 1655 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 96.0 108.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:0.95 (1.1%) stddev-sans-first:0.78 14:05:48 INFO - PROCESS | 1655 | Values: 86.0 84.0 84.0 85.0 83.0 84.0 83.0 85.0 85.0 84.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.66 (3.1%) stddev-sans-first:1.58 14:05:48 INFO - PROCESS | 1655 | Values: 52.0 52.0 54.0 52.0 54.0 56.0 56.0 54.0 55.0 56.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:2.56 (3.6%) stddev-sans-first:2.49 14:05:48 INFO - PROCESS | 1655 | Values: 69.0 74.0 70.0 72.0 78.0 72.0 70.0 71.0 71.0 72.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.50 stddev:2.81 (3.4%) stddev-sans-first:2.89 14:05:48 INFO - PROCESS | 1655 | Values: 84.0 80.0 80.0 83.0 82.0 79.0 79.0 82.0 84.0 88.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:138.00 stddev:11.34 (8.2%) stddev-sans-first:11.89 14:05:48 INFO - PROCESS | 1655 | Values: 134.0 131.0 131.0 132.0 131.0 130.0 149.0 144.0 165.0 142.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:163.00 stddev:19.74 (12.1%) stddev-sans-first:20.46 14:05:48 INFO - PROCESS | 1655 | Values: 158.0 221.0 187.0 161.0 163.0 163.0 160.0 163.0 162.0 161.0 14:05:48 INFO - PROCESS | 1655 | 14:05:48 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 14:05:48 INFO - PROCESS | 1655 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 63.0 65.0 64.0 63.0 14:05:48 INFO - PROCESS | 1655 | -------- Summary: end -------- 14:05:48 INFO - PROCESS | 1655 | 14:05:49 INFO - TEST-INFO | 1655: exit 0 14:05:49 INFO - TEST-OK | kraken | took 57926ms 14:05:49 INFO - SUITE-END | took 1174s 14:05:49 INFO - Completed test suite (00:19:35) 14:05:49 INFO - javascript benchmark 14:05:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.4171728230276, 3435.278591495787, 3442.9827850860743, 3448.155201975513, 3503.3693935091687, 5779.450952159544, 5822.534197264219, 5831.766729330832, 5845.678487683176, 5872.882542349156, 5681.23303354047, 5694.914576281349, 5745.368009518949, 5766.135079738041, 5770.04794208955, 4739.909820741232, 4913.631477639191, 5183.118869792135, 5228.947710522903, 5259.158534634459, 3993.261246669361, 4373.322135069054, 5216.087184742674, 5289.20661900716, 5300.310959575249, 4936.777844996984, 5293.444188360225, 5306.814261500848, 5314.388845282803, 5347.144456886899, 5276.762545685434, 5319.760610772524, 5328.147496400557, 5346.224797404393, 5352.197170424429, 5203.609729270282, 5257.263983042377, 5283.339582552181, 5323.893522129574, 5345.65253258537, 5651.124075768263, 5677.829665110054, 5709.115087161496, 5717.656940583537, 5733.369329373765, 6273.278572964122, 6278.6860656966965, 6326.398992095744, 6329.651869147195, 6342.207224096988, 5881.647101173943, 6306.49548036156, 6329.778457754002, 6363.109164716943, 6367.235931688181, 5727.0, 5841.065429531254, 5857.853553661193, 5972.193753843262, 5990.910136348002, 6293.779717709858, 6318.273398559132, 6344.746210151635, 6404.967975160094, 6406.583572067801, 6295.213098362705, 6303.558750887486, 6309.3690630936535, 6311.684415779193, 6328.810135695937, 6176.567640265228, 6241.75032998684, 6346.4605508532295, 6354.491640668735, 6358.809235722936, 6150.077488376779, 6187.752489900444, 6226.439620434092, 6237.0, 6246.406591373812, 6205.503559715212, 6247.125402443661, 6279.843003924847, 6280.9685951569945, 6292.433680968643, 4437.866863994085, 4489.1021795641, 4989.351384320088, 5032.446430892599, 5060.443351231362, 4505.481869584974, 4514.119746649372, 4515.367848501212, 4517.909641807211, 4533.614642755403, 5800.4489573490455, 5826.388229235869, 5859.121131830259, 5883.14694369314, 5936.614120082181, 6283.8114856554375, 6304.306526282106, 6314.021326694278, 6317.305096439388, 6330.050492426173, 5851.912221316684, 5888.293404791452, 5895.263092113486, 5902.940970590239, 5924.318703349084, 5419.187121931663, 5437.374701909252, 5470.8085217017215, 5474.42518535556, 5522.144067669517, 6277.340879207617, 6279.811605651837, 6282.465990390868, 6288.308286088618, 6298.212723409574, 6265.060240963892, 6272.8118156455375, 6274.937250627435, 6294.15028971083, 6297.590656607306, 6315.210598675166, 6357.110004599453, 6379.617222966637, 6407.743690252338, 6409.647469389229, 6324.241091068917, 6326.082718005955, 6334.429901308904, 6337.683115844282, 6339.873202535831, 6217.222847144107, 6261.749530018748, 6288.088227207121, 6318.020706790455, 6320.367963203643, 6243.781467648792, 6265.091561723433, 6280.0, 6289.433950944437, 6292.52806039558, 6266.185395898504, 6272.529560282906, 6278.937210628018, 6281.748730050929, 6286.088517164894, 5839.970800145972, 5933.2880054393745, 6001.639901605918, 6010.128531363015, 6145.72344244519, 5151.484851514819, 6268.216472940882, 6279.215098112736, 6285.5600107992, 6286.6856657166045, 6160.845978850385, 6162.445379915829, 6164.352742961924, 6164.938350616437, 6180.165677633462], "value": 5755.21656944843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.73347058911713, 506.5162769555075, 544.3984397241046, 571.434280062738, 604.3835288006234, 31674.84162579187, 42733.57266427335, 42761.0, 42800.0, 43001.569984300186, 44304.89237769057, 44929.55070449295, 44945.550544494545, 44962.55037449625, 44992.0, 9091.136342047528, 9290.442573445582, 9568.186704130158, 9818.803623927517, 9834.852477212848, 11839.112066594997, 12078.335691536962, 12084.57703980361, 12210.389480525982, 12240.143189976705, 11964.521419143224, 12045.457954392074, 12059.276443413379, 12065.457054432527, 12154.0, 11992.280463172194, 12057.698557536043, 12066.457009434596, 12069.456874440672, 12075.275483470976, 12064.879351206464, 12124.757504849853, 12136.271823690608, 12137.817932731015, 12149.696257593543, 43233.35149972753, 43486.782566086964, 43510.564894350966, 43546.91132721676, 43555.56444435547, 4095.651869591088, 4113.856015039489, 4135.1316223593085, 4156.667466602695, 4168.979155104205, 31368.37263254745, 32268.0, 33094.3381132376, 33596.16009599755, 33862.322753545035, 3346.880705192945, 3358.1101008232836, 3394.439917413624, 3417.9145521362166, 3524.947125793115, 392906.0, 392975.0, 393398.99999999715, 393975.0, 394078.0592194099, 68024.6598767003, 68301.65849170722, 68361.65819170872, 68412.0, 68591.65704171547, 70728.0, 70757.64621176862, 70804.2919570808, 70810.64594676993, 70820.64589677121, 17983.0, 18191.727124093148, 18194.999275039736, 18212.908935455238, 18247.17887695057, 12644.620661380173, 12909.031822613342, 13478.797818032737, 13623.455061797615, 14128.505502307575, 18791.530211744815, 18898.338558150397, 18944.621107577772, 18953.715694264596, 19132.043397830053, 7622.0, 7706.451275356344, 7710.383169346439, 7778.844423111506, 7808.297253247235, 894.3247847874943, 898.1736802142045, 905.0813424374265, 932.077243528915, 936.8875734911854, 30604.54093188604, 31154.0, 31306.440114068046, 31620.841895790374, 31970.442364610775, 1004.57305645102, 1031.4584842957506, 1080.3895798873612, 1132.043423307304, 1210.9101808372536, 13906.582802515739, 15325.540233793005, 15510.84489155094, 15598.3205038488, 15617.453389131553, 427205.0, 429590.0, 431794.0, 432223.67776322464, 432255.67744322785, 59269.0, 59503.40496595065, 59545.70227148923, 59549.40450595525, 59775.0, 1262.2489618677057, 1281.4810001949224, 1296.6758310422395, 1479.0312345413772, 1498.6478177628248, 29805.0, 31668.683313167494, 31687.683123168474, 31699.841500792347, 32405.513917290788, 54686.0, 55375.72312138414, 55395.72302138625, 55487.44512554823, 55493.72253138709, 340630.0, 343138.0, 344168.0, 345354.0, 346208.0, 35678.821605891804, 39052.6094739049, 40840.978975525846, 41679.0, 41714.165716686104, 43029.225712271626, 43279.9180020502, 44473.92479529344, 44857.327140092275, 45002.77498612486, 34566.0, 36652.26695466129, 36710.44934325934, 37200.0, 38477.42283865688, 29230.0, 33426.832865836484, 33738.662613373555, 35318.70428422247, 37504.81247593745, 36184.276314473034, 36204.81897590495, 37168.814155929045, 37398.252034959696, 37530.0, 22666.093356266225, 30243.546346804374, 30716.232094197825, 32867.0, 32903.0, 24198.51602967966, 24350.634740478552, 24525.38686532851, 24952.875235623706, 25060.874695626404], "value": 20474.483245747277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.5527919288782, 408.12457279136254, 411.321319822293, 422.44659496060154, 438.89247134452063, 20439.284625038108, 21525.784742152595, 22193.11227550896, 22289.0, 22338.10647574097, 21967.670484942737, 22490.775092249074, 22640.20759273426, 22874.771252287515, 23135.72753498557, 5521.116621340576, 5717.685527295997, 5721.570882183832, 5722.284714410699, 5723.799667011655, 5686.573506986972, 6027.276726792791, 6302.779402720906, 6344.777932772354, 6420.357964203589, 6187.938120618781, 6381.968090159566, 6422.839429014265, 6428.935710642881, 6439.742410303582, 5929.6145750526075, 5950.1372301016545, 6376.968115159418, 6392.3927226913365, 6407.903881441759, 6072.240969878765, 6224.408681175281, 6286.277078135981, 6290.465310448617, 6310.495160387158, 14283.35724892372, 14292.0, 14368.0, 14465.78301325481, 14513.492027778977, 2611.4124322027583, 2702.337927207827, 2732.398872248102, 2752.0367871245103, 2795.888164473439, 10665.733356666067, 11181.608643697513, 11225.943870280596, 12635.368231588383, 15367.0, 1574.9752823279855, 1828.3235202974852, 1875.7561517002703, 1876.8780029298189, 1883.6044430669576, 138107.30946345205, 145621.27189363985, 155458.0, 156074.0, 158852.8229435405, 12047.939760301142, 12048.337341446304, 12253.203541769757, 12272.815907761391, 12385.256884586954, 16740.49778506647, 16746.49760507187, 16753.413630522875, 16760.748588771177, 16765.329386824633, 8912.108789121166, 9183.448993060438, 9203.76990575241, 9301.674441394518, 9323.440593564408, 8960.596773145224, 8993.730188094367, 9030.232430243503, 9164.6792362267, 9202.90797092034, 4932.630052746058, 4989.525995030466, 4992.525710057539, 5036.647434679538, 5064.924026139611, 2036.745406824147, 2045.202371075282, 2081.9687704684443, 2084.6768750843644, 2090.393785802131, 922.9893266872764, 1036.3212096077082, 1051.8211903976342, 1060.1042119409087, 1068.2468859454066, 21747.13011479555, 22201.666974995387, 22235.666465003036, 22291.3312600619, 22355.0, 1058.730023843915, 1069.572171131538, 1073.8872418396113, 1076.5639915833942, 1088.6842815583393, 10679.0, 11542.94228528852, 11573.132015098901, 11586.826197607043, 11615.186936914335, 736282.0, 741000.0, 758631.0, 767692.0, 784705.0, 111517.44241278742, 116751.41624291825, 120126.69764384258, 138518.0, 144727.0, 983.3362480325751, 998.9550470228858, 1035.2597892506894, 1040.3549799124592, 1040.6149724601946, 19104.617907641492, 19985.100670470154, 20436.978151092684, 20840.665493520963, 20913.37259882206, 50340.0, 51735.48264517307, 57191.428085720276, 62775.058374125336, 63009.739805204554, 89035.0, 90023.0, 90899.63650545116, 91404.08595913956, 92960.0, 6931.68807403658, 8424.62089205975, 8617.138286171332, 8814.691485797966, 8984.32617553673, 9893.554790034323, 13145.145565538209, 13171.736565268833, 13576.728465430833, 13782.793258100935, 11447.542098315975, 11522.42387880586, 11641.767164656829, 11735.706607334885, 11866.940665296619, 10098.798024039625, 11447.656570302572, 11468.082553395541, 11471.369074700971, 11959.76080478403, 11631.557372951775, 11666.416679166177, 11834.46744896499, 11927.343996080299, 12164.330961796832, 8324.167583241628, 8682.305415566865, 8732.57666268424, 8832.955835220782, 8846.55767211624, 10213.33613315132, 11295.717607059889, 11518.712032199262, 11636.12729045342, 11987.700307492034], "value": 10180.237429792176, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.8978771485993, 1460.050966871534, 1480.3856399594165, 1484.1317829070001, 1487.3232679130992, 8137.796555086125, 8529.53087580183, 8536.231739143468, 8537.103604121563, 8544.48733076016, 7553.660085296161, 7816.570088645122, 8096.91903080969, 8268.545230012347, 8291.419600627958, 2381.6070348392495, 2388.355144111089, 2416.4442178299, 2420.6248031555137, 2423.442608200115, 2393.5571919195004, 2420.056178090546, 2427.3567504611206, 2431.3556907419547, 2432.9635055474096, 2019.545602239499, 2394.162043284854, 2396.4128788446856, 2414.8430352027062, 2422.515496900618, 2330.650402439639, 2343.379004563792, 2347.8473899196583, 2369.9052037918464, 2374.608189648723, 2298.241580278504, 2335.848169868953, 2353.7646235376496, 2357.210334537932, 2364.231624721955, 8388.454750441202, 8400.285975692012, 8468.110848360895, 8479.576021198915, 8497.660093596249, 5139.537441630271, 5299.894002119936, 5300.1519756838725, 5305.204219367087, 5307.469253074701, 3555.5022296878456, 3559.501669766235, 3587.157018100744, 3616.4936908832783, 3641.8543258269638, 1252.0922331309819, 1260.4706023470073, 1288.8324517812625, 1309.18830325199, 1316.2892038299403, 10794.73013174677, 10849.620263290746, 10850.29473084247, 10869.945650271698, 10876.18428617849, 4708.105459962596, 4741.762911854394, 4747.433346995484, 4828.782704778293, 4856.028794241166, 9567.330286879991, 9649.276304277208, 9651.806963860683, 9651.938286788447, 9674.70975870725, 5142.04872098663, 5219.712915789592, 5225.947740522623, 5231.8168864089575, 5255.106631872591, 4224.302990006615, 4421.358902959053, 4453.799579018887, 4791.904161916812, 4856.417229932431, 3879.1271963807917, 3974.4833171687496, 3979.9602003980167, 4026.3960405939342, 4060.9390859136547, 1300.14840279617, 1309.8690130987015, 1311.4360824845216, 1323.0275747325709, 1323.4904561743797, 906.5739102621757, 925.9212966897754, 925.9768505787274, 932.2355668351886, 959.9808003839884, 5583.3858275589655, 5783.0, 5943.58394912352, 5995.730192141364, 6059.091136329585, 854.8632218845079, 970.7767213540925, 985.4235272365603, 1006.1347241372414, 1023.6161439460202, 3833.865814696528, 3840.846366145323, 3845.288621605012, 3894.1432884765304, 3951.940720889189, 9745.658901938397, 10090.899091008996, 10091.394516329045, 10104.444255565868, 10127.189824813997, 10013.098821106136, 10017.098461138532, 10037.397756134655, 10037.69886903394, 10052.849207261897, 7522.548647081302, 7858.882116768253, 8012.599370031592, 8021.2379823916635, 8037.557934313669, 5789.1895134680335, 5873.060310350324, 5911.881762364815, 5949.0, 5964.0, 8989.730308090768, 8995.685151019683, 9188.310876684409, 9232.492212928084, 9332.30007749408, 9079.228265597498, 9337.533123343941, 9400.0, 9520.809583808423, 9537.189338906272, 6752.987051942248, 6909.861802764017, 6928.0, 7231.8553628928175, 7389.926100738924, 7300.379467745089, 7926.365890728613, 7997.640106195119, 8076.0, 8080.0, 6968.338007889445, 7097.183823860322, 7107.182673992557, 7148.964255178691, 7223.313785190398, 6934.16789985205, 6989.30106989297, 7044.788656340318, 7123.679434425567, 7193.892091618525, 6395.968020159869, 6420.0, 6505.41451269388, 6509.804705858832, 6519.022146678036, 4297.8495752648505, 4962.900741985068, 4997.450280469073, 5077.162268225701, 5085.4406015337545, 4971.701697897993, 4985.900281994413, 5061.190209566452, 5148.510891465305, 5162.767675454538], "value": 4508.047804797345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.4391269183533, 375.81960658883736, 382.18785081701395, 389.27011852776064, 390.41048017493574, 4452.619687896746, 5345.518903298707, 5370.18716711135, 5403.297571315724, 5417.485338892809, 5008.424031236409, 5038.647294689373, 5233.607479439048, 5300.257963885049, 5376.51611354978, 3628.183658676803, 3918.9614752090574, 3959.6040395960317, 4171.311733563966, 4184.686148538856, 3287.6547962463956, 3603.729720270977, 3755.4179102239195, 3887.9805600971954, 4116.053307739222, 2916.912492625225, 3962.325430334527, 4123.072308730527, 4128.814203360841, 4146.460960075186, 3577.123604716848, 4029.979850100731, 4045.8179381927885, 4050.8784736457956, 4071.6742660587083, 3051.6643169251365, 3413.84637691302, 3523.841427135785, 3527.3121741260466, 3529.2764983178386, 4316.503602085769, 4771.232685042667, 5268.762905669254, 5275.573236311301, 5290.365156181244, 4231.830726770925, 4503.4145561077175, 4601.562851529099, 4636.281376386665, 4668.5564871337165, 4203.55862634422, 5634.3802181759975, 5642.605017648766, 5660.490555849952, 5667.846218437009, 3888.18106872518, 3904.8438062477467, 3905.628965248297, 3906.570277269498, 3918.0, 5119.462456442057, 5269.525742683139, 5558.86102847428, 5728.7110400160045, 5953.583249172516, 3743.326201283795, 3899.863504777376, 3910.648041676263, 3950.585188555218, 3962.980185099114, 4012.598740125964, 4019.8191081401405, 4028.0, 4032.516098068251, 4037.8182981765303, 4018.537868145142, 4348.869533913988, 4352.869413917588, 4558.33904083906, 4608.331791890158, 4684.81260749573, 5619.971900140555, 5625.578081643893, 5637.520810731134, 5664.320281566238, 1134.7347707306294, 1153.1985270237271, 1191.5114802930757, 1309.1359702596242, 1310.4103153580736, 791.5211297165247, 838.446625227347, 861.29804209569, 870.2863651805585, 894.6242578117207, 4226.598473145046, 4790.377250957354, 4915.9508404916205, 5006.89986200274, 5050.070958843862, 4546.52261512543, 5489.533389661923, 5514.80698175562, 5517.393086760453, 5517.531009864127, 4357.3899654048455, 4699.882502937454, 4987.600991920638, 5144.710603781356, 5242.449542798027, 2563.4488584954324, 2678.116221646852, 2743.986280068587, 2846.644169478815, 2863.2698661841514, 5216.556592689664, 5642.830715078554, 5736.627119237236, 5773.6431938494425, 5780.797672081457, 4883.413990321184, 4889.310879016598, 5061.063703214917, 5109.744512774347, 5649.548036157097, 4704.999999999932, 5009.599232061426, 5072.188449848007, 5527.39198688144, 5705.572082093777, 5176.049651698496, 5463.672179669233, 5531.7234138293725, 5588.524975377139, 5589.860253493695, 4709.481956984798, 5331.693735034942, 5389.652586853286, 5404.864878378072, 5460.754266058117, 5029.874253143701, 5594.20985284705, 5621.931832951726, 5723.399043100415, 5747.51146152565, 3651.6713495785507, 3671.70626349886, 3689.5019172412453, 3702.629737026276, 3749.2126653403093, 4708.458527269408, 4996.650234483552, 5465.617406781487, 5781.29451811725, 5785.884282314414, 4887.364642596582, 5046.6719663221775, 5199.974000129975, 5318.920216196838, 5596.272484576979, 4270.722403043792, 4683.695559788603, 4986.202207646759, 5611.80358687444, 5632.7183640816975, 4660.324252983366, 5243.456923392076, 5252.422233554383, 5483.479069488392, 5491.4349410417835, 4693.624510039121, 5516.613837031369, 5572.219889215594, 5589.273394458857, 5602.635828671123, 4819.373481447389, 5505.449455054622, 5509.3664228614225, 5518.668879867221, 5523.917141242965], "value": 4010.1457708865046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.5158298688837, 784.7096574267522, 827.2017503109499, 840.2647683277131, 844.94085414021, 13286.933565332172, 15700.013493995177, 15917.44288949887, 17651.55871103223, 18546.907265463688, 16431.1245532032, 16601.252943617535, 16760.83239167608, 16807.83192168078, 16816.990980541144, 912.8630705394178, 937.4094320578026, 939.4269495607674, 940.6190492850372, 941.580996456577, 733.6295170938669, 936.9953150234273, 937.4796987671839, 937.5827756648295, 939.2157548447055, 796.2873228460525, 802.3180296747776, 803.9035315762117, 804.5534728225832, 946.1957336264155, 970.5438443931376, 973.124188230591, 974.995754372997, 976.1458723616835, 976.8876579193342, 725.905632267807, 726.23019599225, 727.5707332673747, 728.5555810955314, 730.0436428278972, 15854.524364269091, 16195.595110122342, 16265.349386024545, 16311.673766524604, 16596.921200121953, 14364.138151710931, 14448.78326825088, 14491.944766963798, 14491.985561010733, 14593.70812583753, 10756.408397538133, 12261.693457663541, 12505.187162834387, 12524.436400362005, 12861.935690321488, 4373.912521749579, 4612.630989520864, 4641.234196357597, 4711.505291944365, 4832.903341933142, 83180.0, 85066.14933850644, 85262.14737852605, 89348.0, 114697.5446595977, 10735.892641073646, 11201.271917325348, 11250.324980501196, 11262.324260544394, 11278.323300601991, 21738.913054347537, 22140.2250921217, 22202.88985550716, 22209.888950555145, 22595.322140335815, 7799.220077992155, 7896.960515197502, 7898.407619428451, 7921.841563168704, 7926.445148839526, 4366.410534577855, 4415.977920110443, 4455.086707225011, 4582.747948862844, 4672.766361681903, 3598.694111000542, 3637.108908317426, 3701.0747313171705, 3701.3522633539023, 3982.980085099556, 751.7218629107265, 754.1327473405518, 754.1930134755759, 768.3008462299392, 770.5184259837602, 685.533836990841, 708.9326513981164, 710.5807573531641, 732.5201992694793, 761.9657115429819, 10293.0, 10536.525856336484, 10630.840537391945, 11008.559657613767, 11018.614348497764, 713.1050531582933, 719.6536107102017, 745.5154149802563, 753.6721526136148, 753.7776355975001, 4454.732716037048, 5082.923756143661, 5223.947760522422, 5239.240310155006, 5247.658902171346, 94503.58244626336, 116664.0, 118547.0, 122302.0, 123314.5337093253, 78308.0, 95805.0, 96355.0, 96575.55136672956, 97413.0, 80315.59842200752, 81372.0, 82739.5863020693, 83146.674133034, 84516.57741711252, 8304.87542686848, 8960.417572857743, 10052.748681282734, 10099.091081802673, 10106.747331316776, 48528.786780330774, 50047.499525004285, 56729.71635141798, 57120.42879571151, 59265.11102333382, 69247.30752692408, 69897.40820734228, 71650.64174679093, 71794.56410871648, 74167.62916185385, 13134.0, 13685.726285474035, 13733.137013013204, 14279.571612851216, 14640.0, 14445.34995925207, 15163.772543412078, 15469.845301547291, 15899.602509937344, 16038.67922641564, 13204.112707631706, 13808.723825523633, 14196.432142714175, 14357.56927292183, 14361.752542863238, 13271.004674649246, 14133.575992720234, 14322.355494003003, 14323.57029289123, 14553.636159095684, 12962.80555791645, 13669.316534173451, 13930.233837139054, 14410.495632652806, 14484.275786210437, 11011.333005703886, 11130.0, 11215.214934954474, 11272.210945234083, 11287.43562821872, 10067.748306292402, 10918.23572349928, 11199.776004480027, 11253.7749245013, 11272.323660580392], "value": 7914.40802076453, "unit": "score"}], "name": "dromaeo_css", "value": 7454.894264274969, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 111.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 107.0, 141.0, 107.0, 108.0, 106.0, 107.0, 127.0, 106.0], "value": 116.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 182.0, 178.0, 180.0, 180.0, 181.0, 183.0, 182.0, 181.0], "value": 180.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 88.0, 57.0, 60.0, 58.0, 58.0, 71.0, 58.0], "value": 64.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 87.0, 69.0, 68.0, 69.0, 81.0, 67.0, 77.0, 97.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 104.0, 135.0, 84.0, 87.0, 84.0, 87.0, 85.0, 86.0, 84.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 108.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 83.0, 84.0, 83.0, 85.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 52.0, 54.0, 56.0, 56.0, 54.0, 55.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 70.0, 72.0, 78.0, 72.0, 70.0, 71.0, 71.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 80.0, 83.0, 82.0, 79.0, 79.0, 82.0, 84.0, 88.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 131.0, 132.0, 131.0, 130.0, 149.0, 144.0, 165.0, 142.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 221.0, 187.0, 161.0, 163.0, 163.0, 160.0, 163.0, 162.0, 161.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 65.0, 64.0, 63.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1404.7, "alertThreshold": 2.0}]} 14:05:49 INFO - Return code: 0 14:05:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:05:49 INFO - # TBPL SUCCESS # 14:05:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:05:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:05:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:05:49 INFO - 2017-03-16 14:05:49.543 screenresolution[1659:9717] starting screenresolution argv=screenresolution get 14:05:49 INFO - 2017-03-16 14:05:49.545 screenresolution[1659:9717] Display 0: 1600x1200x32@60 14:05:49 INFO - 2017-03-16 14:05:49.551 screenresolution[1660:9721] starting screenresolution argv=screenresolution list 14:05:49 INFO - Available Modes on Display 0 14:05:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:05:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:05:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:05:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:05:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:05:49 INFO - Intel Iris: 14:05:49 INFO - Chipset Model: Intel Iris 14:05:49 INFO - Type: GPU 14:05:49 INFO - Bus: Built-In 14:05:49 INFO - VRAM (Dynamic, Max): 1536 MB 14:05:49 INFO - Vendor: Intel (0x8086) 14:05:49 INFO - Device ID: 0x0a2e 14:05:49 INFO - Revision ID: 0x0009 14:05:49 INFO - Displays: 14:05:49 INFO - Display: 14:05:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:05:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:05:49 INFO - Display Serial Number: 1600x1200 60 14:05:49 INFO - Main Display: Yes 14:05:49 INFO - Mirror: Off 14:05:49 INFO - Online: Yes 14:05:49 INFO - Rotation: Supported 14:05:49 INFO - Return code: 0 14:05:49 INFO - Running post-action listener: _resource_record_post_action 14:05:49 INFO - [mozharness: 2017-03-16 21:05:49.787135Z] Finished run-tests step (success) 14:05:49 INFO - Running post-run listener: _resource_record_post_run 14:05:49 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 37921792; Write bytes: 424915968; Read time: 244; Write time: 1428 14:05:49 INFO - TinderboxPrint: CPU usage
53.5% 14:05:49 INFO - TinderboxPrint: I/O read bytes / time
37,921,792 / 244 14:05:49 INFO - TinderboxPrint: I/O write bytes / time
424,915,968 / 1,428 14:05:49 INFO - TinderboxPrint: CPU idle
2,214.0 (46.5%) 14:05:49 INFO - TinderboxPrint: CPU system
946.3 (19.9%) 14:05:49 INFO - TinderboxPrint: CPU user
1,601.3 (33.6%) 14:05:49 INFO - TinderboxPrint: Swap in / out
159,932,416 / 0 14:05:49 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122960384; Write bytes: 126543872; Read time: 11282; Write time: 302 14:05:49 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 34276352; Write bytes: 297155584; Read time: 220; Write time: 1120 14:05:50 INFO - Running post-run listener: _upload_blobber_files 14:05:50 INFO - Blob upload gear active. 14:05:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:05:50 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 14:05:50 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'] 14:05:50 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 14:05:50 INFO - (blobuploader) - INFO - Open directory for files ... 14:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:05:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:53 INFO - (blobuploader) - INFO - Done attempting. 14:05:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:05:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:05:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:53 INFO - (blobuploader) - INFO - Done attempting. 14:05:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:05:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:05:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:54 INFO - (blobuploader) - INFO - Done attempting. 14:05:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:05:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:05:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:56 INFO - (blobuploader) - INFO - Done attempting. 14:05:56 INFO - (blobuploader) - INFO - Iteration through files over. 14:05:56 INFO - Return code: 0 14:05:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:05:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:05:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bdf0207c1b904ff818c0d835f5d525bda1e993353e33bd97f17af48c2aa08aa4ab1eb1e9f011610fa61eba35e4d3908b23e6f84327724b148af09dbd45ad3d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffcec4e3fe457c5da6517ce242b0df9f018bd6a9f1998738d2125f42a95881a3f19f8fff89200e3a12a91b5de79fe2c5cb3c6500310108d3fe51900f8a15d235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3cf1d928910fa843020bd0567089ca513c8ea1d50d60e98a6a220ef5f45039f67a7f055cc38fde1fa60b34eab0ba4e6e686ef8ec744c41c6d1453608e44d5ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4b8f36a329f20c9d47a1869f09a877f472a3b2e4cb9331da6c29edb754341b48a0ea2de250a529eddd8219ef49ae1bb4a92b7edf1725efc87836e5cbd64e061"} 14:05:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:05:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:05:56 INFO - Contents: 14:05:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bdf0207c1b904ff818c0d835f5d525bda1e993353e33bd97f17af48c2aa08aa4ab1eb1e9f011610fa61eba35e4d3908b23e6f84327724b148af09dbd45ad3d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffcec4e3fe457c5da6517ce242b0df9f018bd6a9f1998738d2125f42a95881a3f19f8fff89200e3a12a91b5de79fe2c5cb3c6500310108d3fe51900f8a15d235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3cf1d928910fa843020bd0567089ca513c8ea1d50d60e98a6a220ef5f45039f67a7f055cc38fde1fa60b34eab0ba4e6e686ef8ec744c41c6d1453608e44d5ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4b8f36a329f20c9d47a1869f09a877f472a3b2e4cb9331da6c29edb754341b48a0ea2de250a529eddd8219ef49ae1bb4a92b7edf1725efc87836e5cbd64e061"} 14:05:56 INFO - Running post-run listener: copy_logs_to_upload_dir 14:05:56 INFO - Copying logs to upload dir... 14:05:56 INFO - mkdir: /builds/slave/test/build/upload/logs 14:05:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.372924 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-16 14:05:56.957688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 14:05:56.960790) ========= 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.pfJhlH8hod/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.FfVtx5yYGj/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bdf0207c1b904ff818c0d835f5d525bda1e993353e33bd97f17af48c2aa08aa4ab1eb1e9f011610fa61eba35e4d3908b23e6f84327724b148af09dbd45ad3d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffcec4e3fe457c5da6517ce242b0df9f018bd6a9f1998738d2125f42a95881a3f19f8fff89200e3a12a91b5de79fe2c5cb3c6500310108d3fe51900f8a15d235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3cf1d928910fa843020bd0567089ca513c8ea1d50d60e98a6a220ef5f45039f67a7f055cc38fde1fa60b34eab0ba4e6e686ef8ec744c41c6d1453608e44d5ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4b8f36a329f20c9d47a1869f09a877f472a3b2e4cb9331da6c29edb754341b48a0ea2de250a529eddd8219ef49ae1bb4a92b7edf1725efc87836e5cbd64e061"} build_url:https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/MscSDUdtRume9nX4kq4glg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bdf0207c1b904ff818c0d835f5d525bda1e993353e33bd97f17af48c2aa08aa4ab1eb1e9f011610fa61eba35e4d3908b23e6f84327724b148af09dbd45ad3d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffcec4e3fe457c5da6517ce242b0df9f018bd6a9f1998738d2125f42a95881a3f19f8fff89200e3a12a91b5de79fe2c5cb3c6500310108d3fe51900f8a15d235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3cf1d928910fa843020bd0567089ca513c8ea1d50d60e98a6a220ef5f45039f67a7f055cc38fde1fa60b34eab0ba4e6e686ef8ec744c41c6d1453608e44d5ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4b8f36a329f20c9d47a1869f09a877f472a3b2e4cb9331da6c29edb754341b48a0ea2de250a529eddd8219ef49ae1bb4a92b7edf1725efc87836e5cbd64e061"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 14:05:56.994885) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 14:05:56.995175) ========= 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.pfJhlH8hod/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.FfVtx5yYGj/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.005278 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 14:05:57.044077) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 14:05:57.044397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 14:05:57.044701) ========= ========= Total master_lag: 0.18 =========