builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0086 starttime: 1490710916.64 results: success (0) buildid: 20170328060322 builduid: 2c460e0b30a94cff874aad87df1d2370 revision: 54fff8f71f6040a2e6290854e7b104cc4ab369a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.639092) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.639554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.639906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.665182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.665591) ========= 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.0THbogJs0f/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.N24pHTSwtZ/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-28 07:21:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.01M=0.001s 2017-03-28 07:21:56 (9.01 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.809190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.809531) ========= 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.0THbogJs0f/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.N24pHTSwtZ/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.020758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.858302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:56.858671) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 54fff8f71f6040a2e6290854e7b104cc4ab369a8 --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 54fff8f71f6040a2e6290854e7b104cc4ab369a8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0THbogJs0f/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.N24pHTSwtZ/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-28 07:21:56,948 truncating revision to first 12 chars 2017-03-28 07:21:56,948 Setting DEBUG logging. 2017-03-28 07:21:56,948 attempt 1/10 2017-03-28 07:21:56,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/54fff8f71f60?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 07:21:57,556 unpacking tar archive at: mozilla-beta-54fff8f71f60/testing/mozharness/ program finished with exit code 0 elapsedTime=0.865073 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:57.750563) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:57.751273) ========= script_repo_revision: 54fff8f71f6040a2e6290854e7b104cc4ab369a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:57.751985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:57.752467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 07:21:57.776929) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-28 07:21:57.780608) ========= /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.0THbogJs0f/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.N24pHTSwtZ/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:21:57 INFO - MultiFileLogger online at 20170328 07:21:57 in /builds/slave/test 07:21:57 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 07:21:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:21:57 INFO - {'append_to_log': False, 07:21:57 INFO - 'base_work_dir': '/builds/slave/test', 07:21:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:21:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:21:57 INFO - 'branch': 'Mozilla-Beta', 07:21:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:21:57 INFO - 'config_files': ('talos/mac_config.py',), 07:21:57 INFO - 'default_actions': ('clobber', 07:21:57 INFO - 'read-buildbot-config', 07:21:57 INFO - 'download-and-extract', 07:21:57 INFO - 'populate-webroot', 07:21:57 INFO - 'create-virtualenv', 07:21:57 INFO - 'install', 07:21:57 INFO - 'run-tests'), 07:21:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:21:57 INFO - 'download_minidump_stackwalk': True, 07:21:57 INFO - 'download_symbols': 'ondemand', 07:21:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:21:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:21:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:21:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:21:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:21:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:21:57 INFO - 'installer_path': 'installer.exe', 07:21:57 INFO - 'log_level': 'info', 07:21:57 INFO - 'log_name': 'talos', 07:21:57 INFO - 'log_to_console': True, 07:21:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:21:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:21:57 INFO - 'opt_config_files': (), 07:21:57 INFO - 'pip_index': False, 07:21:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:21:57 INFO - 'cmd': ('bash', 07:21:57 INFO - '-c', 07:21:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:21:57 INFO - 'enabled': True, 07:21:57 INFO - 'halt_on_failure': False, 07:21:57 INFO - 'name': 'check_screen_resolution'},), 07:21:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:21:57 INFO - 'cmd': ('bash', 07:21:57 INFO - '-c', 07:21:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:21:57 INFO - 'enabled': True, 07:21:57 INFO - 'halt_on_failure': False, 07:21:57 INFO - 'name': 'check_screen_resolution'},), 07:21:57 INFO - 'run_cmd_checks_enabled': True, 07:21:57 INFO - 'sps_profile': False, 07:21:57 INFO - 'sps_profile_interval': 0, 07:21:57 INFO - 'suite': 'dromaeojs', 07:21:57 INFO - 'system_bits': '32', 07:21:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:21:57 INFO - 'title': 't-yosemite-r7-0086', 07:21:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:21:57 INFO - 'use_talos_json': True, 07:21:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:21:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:21:57 INFO - 'work_dir': 'build'} 07:21:57 INFO - [mozharness: 2017-03-28 14:21:57.998628Z] Running clobber step. 07:21:57 INFO - Running pre-action listener: _resource_record_pre_action 07:21:57 INFO - Running main action method: clobber 07:21:57 INFO - rmtree: /builds/slave/test/build 07:21:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:21:58 INFO - Running post-action listener: _resource_record_post_action 07:21:58 INFO - [mozharness: 2017-03-28 14:21:58.669224Z] Finished clobber step (success) 07:21:58 INFO - [mozharness: 2017-03-28 14:21:58.669381Z] Running read-buildbot-config step. 07:21:58 INFO - Running pre-action listener: _resource_record_pre_action 07:21:58 INFO - Running main action method: read_buildbot_config 07:21:58 INFO - Using buildbot properties: 07:21:58 INFO - { 07:21:58 INFO - "project": "", 07:21:58 INFO - "product": "firefox", 07:21:58 INFO - "script_repo_revision": "production", 07:21:58 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:21:58 INFO - "repository": "", 07:21:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:21:58 INFO - "buildid": "20170328060322", 07:21:58 INFO - "pgo_build": "False", 07:21:58 INFO - "basedir": "/builds/slave/test", 07:21:58 INFO - "buildnumber": 10, 07:21:58 INFO - "slavename": "t-yosemite-r7-0086", 07:21:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:21:58 INFO - "platform": "yosemite_r7", 07:21:58 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:21:58 INFO - "branch": "mozilla-beta", 07:21:58 INFO - "repo_path": "releases/mozilla-beta", 07:21:58 INFO - "revision": "54fff8f71f6040a2e6290854e7b104cc4ab369a8", 07:21:58 INFO - "stage_platform": "macosx64", 07:21:58 INFO - "builduid": "2c460e0b30a94cff874aad87df1d2370", 07:21:58 INFO - "slavebuilddir": "test" 07:21:58 INFO - } 07:21:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 07:21:58 INFO - Running post-action listener: _resource_record_post_action 07:21:58 INFO - [mozharness: 2017-03-28 14:21:58.672749Z] Finished read-buildbot-config step (success) 07:21:58 INFO - [mozharness: 2017-03-28 14:21:58.672878Z] Running download-and-extract step. 07:21:58 INFO - Running pre-action listener: _resource_record_pre_action 07:21:58 INFO - Running main action method: download_and_extract 07:21:58 INFO - mkdir: /builds/slave/test/build/tests 07:21:58 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')]} 07:21:58 INFO - trying https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 07:21:58 INFO - Downloading https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/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 07:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/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 07:21:59 INFO - Downloaded 1165 bytes. 07:21:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 07:21:59 INFO - Using the following test package requirements: 07:21:59 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 07:21:59 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:21:59 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 07:21:59 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:21:59 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 07:21:59 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:21:59 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:21:59 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 07:21:59 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 07:21:59 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:21:59 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 07:21:59 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:21:59 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 07:21:59 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:21:59 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 07:21:59 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:21:59 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 07:21:59 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 07:21:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 07:21:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 07:21:59 INFO - Fetch https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 07:22:00 INFO - Expected file size: 16108540 07:22:00 INFO - Obtained file size: 16108540 07:22:07 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 07:22:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 07:22:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 07:22:07 INFO - Fetch https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 07:22:08 INFO - Expected file size: 16108540 07:22:08 INFO - Obtained file size: 16108540 07:22:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 07:22:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 07:22:14 INFO - Fetch https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 07:22:16 INFO - Expected file size: 14403663 07:22:16 INFO - Obtained file size: 14403663 07:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:16 INFO - trying https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:22:16 INFO - Downloading https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 07:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/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 07:22:18 INFO - Downloaded 58681615 bytes. 07:22:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:22:18 INFO - mkdir: /builds/slave/test/properties 07:22:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:22:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:22:18 INFO - Contents: 07:22:18 INFO - build_url:https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:22:18 INFO - Running post-action listener: _resource_record_post_action 07:22:18 INFO - Running post-action listener: set_extra_try_arguments 07:22:18 INFO - [mozharness: 2017-03-28 14:22:18.858154Z] Finished download-and-extract step (success) 07:22:18 INFO - [mozharness: 2017-03-28 14:22:18.858274Z] Running populate-webroot step. 07:22:18 INFO - Running pre-action listener: _resource_record_pre_action 07:22:18 INFO - Running main action method: populate_webroot 07:22:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:22:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:22:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:22:18 INFO - '--tppagecycles', 07:22:18 INFO - '7'], 07:22:18 INFO - 'tests': ['tsvgm']}}, 07:22:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:22:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:22:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:22:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:22:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:22:18 INFO - 'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:22:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:22:18 INFO - 'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['damp', 'tps']}, 07:22:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:22:18 INFO - 'tests': ['damp', 'tps']}, 07:22:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['dromaeo_dom']}, 07:22:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:22:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['basic_compositor_video']}, 07:22:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:22:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['a11yr', 07:22:18 INFO - 'ts_paint', 07:22:18 INFO - 'tpaint', 07:22:18 INFO - 'sessionrestore', 07:22:18 INFO - 'sessionrestore_no_auto_restore', 07:22:18 INFO - 'tabpaint']}, 07:22:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:22:18 INFO - 'ts_paint', 07:22:18 INFO - 'tpaint', 07:22:18 INFO - 'sessionrestore', 07:22:18 INFO - 'sessionrestore_no_auto_restore', 07:22:18 INFO - 'tabpaint']}, 07:22:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:22:18 INFO - 'ts_paint', 07:22:18 INFO - 'tpaint', 07:22:18 INFO - 'sessionrestore', 07:22:18 INFO - 'sessionrestore_no_auto_restore', 07:22:18 INFO - 'tabpaint']}, 07:22:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:22:18 INFO - 'ts_paint', 07:22:18 INFO - 'tpaint', 07:22:18 INFO - 'sessionrestore', 07:22:18 INFO - 'sessionrestore_no_auto_restore', 07:22:18 INFO - 'tabpaint']}, 07:22:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['a11yr', 07:22:18 INFO - 'ts_paint', 07:22:18 INFO - 'tpaint', 07:22:18 INFO - 'sessionrestore', 07:22:18 INFO - 'sessionrestore_no_auto_restore', 07:22:18 INFO - 'tabpaint']}, 07:22:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['a11yr', 07:22:18 INFO - 'ts_paint', 07:22:18 INFO - 'tpaint', 07:22:18 INFO - 'sessionrestore', 07:22:18 INFO - 'sessionrestore_no_auto_restore', 07:22:18 INFO - 'tabpaint']}, 07:22:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['tsvgx', 07:22:18 INFO - 'tsvgr_opacity', 07:22:18 INFO - 'tart', 07:22:18 INFO - 'tscrollx', 07:22:18 INFO - 'cart', 07:22:18 INFO - 'tsvg_static']}, 07:22:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:22:18 INFO - 'tsvgr_opacity', 07:22:18 INFO - 'tart', 07:22:18 INFO - 'tscrollx', 07:22:18 INFO - 'cart', 07:22:18 INFO - 'tsvg_static']}, 07:22:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:22:18 INFO - 'talos_options': ['--disable-e10s'], 07:22:18 INFO - 'tests': ['tp5o']}, 07:22:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:22:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:22:18 INFO - 'talos_options': ['--disable-e10s', 07:22:18 INFO - '--xperf_path', 07:22:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:18 INFO - 'tests': ['tp5n']}, 07:22:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:22:18 INFO - 'talos_options': ['--xperf_path', 07:22:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:18 INFO - 'tests': ['tp5n']}}, 07:22:18 INFO - 'talos.zip': {'path': '', 07:22:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:22:18 INFO - Running post-action listener: _resource_record_post_action 07:22:18 INFO - [mozharness: 2017-03-28 14:22:18.876392Z] Finished populate-webroot step (success) 07:22:18 INFO - [mozharness: 2017-03-28 14:22:18.876528Z] Running create-virtualenv step. 07:22:18 INFO - Running pre-action listener: _resource_record_pre_action 07:22:18 INFO - Running main action method: create_virtualenv 07:22:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:22:18 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 07:22:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:22:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:22:18 INFO - Using real prefix '/tools/python27' 07:22:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:22:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:22:22 INFO - Installing pip.................done. 07:22:22 INFO - Return code: 0 07:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:22:22 INFO - Reading from file tmpfile_stdout 07:22:22 INFO - Output received: 07:22:22 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) 07:22:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:22 INFO - 'HOME': '/Users/cltbld', 07:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:22 INFO - 'LOGNAME': 'cltbld', 07:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:22 INFO - 'MOZ_NO_REMOTE': '1', 07:22:22 INFO - 'NO_EM_RESTART': '1', 07:22:22 INFO - 'PAGER': '/bin/cat', 07:22:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:22 INFO - 'PWD': '/builds/slave/test', 07:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:22 INFO - 'SHELL': '/bin/bash', 07:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:22 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:22 INFO - 'USER': 'cltbld', 07:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:22 INFO - 'XPC_FLAGS': '0x0', 07:22:22 INFO - 'XPC_SERVICE_NAME': '0', 07:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:23 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 07:22:23 INFO - Cleaning up... 07:22:23 INFO - Return code: 0 07:22:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:22:23 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')]} 07:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:23 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')]} 07:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:23 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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:23 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 07:22:23 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 07:22:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:23 INFO - 'HOME': '/Users/cltbld', 07:22:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:23 INFO - 'LOGNAME': 'cltbld', 07:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:23 INFO - 'MOZ_NO_REMOTE': '1', 07:22:23 INFO - 'NO_EM_RESTART': '1', 07:22:23 INFO - 'PAGER': '/bin/cat', 07:22:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:23 INFO - 'PWD': '/builds/slave/test', 07:22:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:23 INFO - 'SHELL': '/bin/bash', 07:22:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:23 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:23 INFO - 'USER': 'cltbld', 07:22:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:23 INFO - 'XPC_FLAGS': '0x0', 07:22:23 INFO - 'XPC_SERVICE_NAME': '0', 07:22:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:23 INFO - Downloading/unpacking psutil>=3.1.1 07:22:23 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 07:22:23 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 07:22:23 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 07:22:23 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 07:22:23 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 07:22:23 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 07:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:22:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:26 INFO - Installing collected packages: psutil 07:22:26 INFO - Running setup.py install for psutil 07:22:26 INFO - building 'psutil._psutil_osx' extension 07:22:26 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 07:22:27 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 07:22:27 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 07:22:27 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 07:22:27 INFO - building 'psutil._psutil_posix' extension 07:22:27 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 07:22:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:22:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:22:27 INFO - ^ 07:22:27 INFO - 1 warning generated. 07:22:27 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 07:22:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:27 INFO - Successfully installed psutil 07:22:27 INFO - Cleaning up... 07:22:27 INFO - Return code: 0 07:22:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:22:27 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')]} 07:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:27 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')]} 07:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:27 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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:27 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 07:22:27 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 07:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:27 INFO - 'HOME': '/Users/cltbld', 07:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:27 INFO - 'LOGNAME': 'cltbld', 07:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:27 INFO - 'MOZ_NO_REMOTE': '1', 07:22:27 INFO - 'NO_EM_RESTART': '1', 07:22:27 INFO - 'PAGER': '/bin/cat', 07:22:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:27 INFO - 'PWD': '/builds/slave/test', 07:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:27 INFO - 'SHELL': '/bin/bash', 07:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:27 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:27 INFO - 'USER': 'cltbld', 07:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:27 INFO - 'XPC_FLAGS': '0x0', 07:22:27 INFO - 'XPC_SERVICE_NAME': '0', 07:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:22:28 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 07:22:28 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 07:22:28 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 07:22:28 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 07:22:28 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 07:22:28 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 07:22:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:22:30 INFO - Installing collected packages: mozsystemmonitor 07:22:30 INFO - Running setup.py install for mozsystemmonitor 07:22:30 INFO - Successfully installed mozsystemmonitor 07:22:30 INFO - Cleaning up... 07:22:30 INFO - Return code: 0 07:22:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:22:30 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')]} 07:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:30 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')]} 07:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:30 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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:30 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 07:22:30 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 07:22:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:30 INFO - 'HOME': '/Users/cltbld', 07:22:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:30 INFO - 'LOGNAME': 'cltbld', 07:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:30 INFO - 'MOZ_NO_REMOTE': '1', 07:22:30 INFO - 'NO_EM_RESTART': '1', 07:22:30 INFO - 'PAGER': '/bin/cat', 07:22:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:30 INFO - 'PWD': '/builds/slave/test', 07:22:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:30 INFO - 'SHELL': '/bin/bash', 07:22:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:30 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:30 INFO - 'USER': 'cltbld', 07:22:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:30 INFO - 'XPC_FLAGS': '0x0', 07:22:30 INFO - 'XPC_SERVICE_NAME': '0', 07:22:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:22:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:22:34 INFO - warning: no files found matching '*.txt' 07:22:34 INFO - no previously-included directories found matching 'build' 07:22:34 INFO - no previously-included directories found matching 'dist' 07:22:34 INFO - no previously-included directories found matching '.git*' 07:22:34 INFO - Installing collected packages: jsonschema, functools32 07:22:34 INFO - Running setup.py install for functools32 07:22:34 INFO - warning: no files found matching '*.txt' 07:22:34 INFO - no previously-included directories found matching 'build' 07:22:34 INFO - no previously-included directories found matching 'dist' 07:22:34 INFO - no previously-included directories found matching '.git*' 07:22:34 INFO - Successfully installed jsonschema functools32 07:22:34 INFO - Cleaning up... 07:22:34 INFO - Return code: 0 07:22:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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', '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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:22: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 functools32==3.2.3-2 07:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:34 INFO - 'HOME': '/Users/cltbld', 07:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:34 INFO - 'LOGNAME': 'cltbld', 07:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:34 INFO - 'MOZ_NO_REMOTE': '1', 07:22:34 INFO - 'NO_EM_RESTART': '1', 07:22:34 INFO - 'PAGER': '/bin/cat', 07:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:34 INFO - 'PWD': '/builds/slave/test', 07:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:34 INFO - 'SHELL': '/bin/bash', 07:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:34 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:34 INFO - 'USER': 'cltbld', 07:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:34 INFO - 'XPC_FLAGS': '0x0', 07:22:34 INFO - 'XPC_SERVICE_NAME': '0', 07:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:22:34 INFO - Cleaning up... 07:22:34 INFO - Return code: 0 07:22:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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', '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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:22: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 blobuploader==1.2.4 07:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:34 INFO - 'HOME': '/Users/cltbld', 07:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:34 INFO - 'LOGNAME': 'cltbld', 07:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:34 INFO - 'MOZ_NO_REMOTE': '1', 07:22:34 INFO - 'NO_EM_RESTART': '1', 07:22:34 INFO - 'PAGER': '/bin/cat', 07:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:34 INFO - 'PWD': '/builds/slave/test', 07:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:34 INFO - 'SHELL': '/bin/bash', 07:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:34 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:34 INFO - 'USER': 'cltbld', 07:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:34 INFO - 'XPC_FLAGS': '0x0', 07:22:34 INFO - 'XPC_SERVICE_NAME': '0', 07:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:35 INFO - Downloading/unpacking blobuploader==1.2.4 07:22:35 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 07:22:35 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 07:22:35 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 07:22:35 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 07:22:35 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 07:22:35 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 07:22:37 INFO - Downloading blobuploader-1.2.4.tar.gz 07:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:22:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:22:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:38 INFO - Downloading docopt-0.6.1.tar.gz 07:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:22:39 INFO - Installing collected packages: blobuploader, requests, docopt 07:22:39 INFO - Running setup.py install for blobuploader 07:22:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:22:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:22:39 INFO - Running setup.py install for requests 07:22:39 INFO - Running setup.py install for docopt 07:22:39 INFO - Successfully installed blobuploader requests docopt 07:22:39 INFO - Cleaning up... 07:22:39 INFO - Return code: 0 07:22:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:40 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')]} 07:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:40 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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:40 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 07:22:40 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 07:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:40 INFO - 'HOME': '/Users/cltbld', 07:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:40 INFO - 'LOGNAME': 'cltbld', 07:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:40 INFO - 'MOZ_NO_REMOTE': '1', 07:22:40 INFO - 'NO_EM_RESTART': '1', 07:22:40 INFO - 'PAGER': '/bin/cat', 07:22:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:40 INFO - 'PWD': '/builds/slave/test', 07:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:40 INFO - 'SHELL': '/bin/bash', 07:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:40 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:40 INFO - 'USER': 'cltbld', 07:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:40 INFO - 'XPC_FLAGS': '0x0', 07:22:40 INFO - 'XPC_SERVICE_NAME': '0', 07:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-DZL19v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8V0SpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-HpW61k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-WJgi5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8zhQVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-1_VBrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ddeZBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:41 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-c3k6V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-FtHabU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kLt6O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ilKDRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-UGWhgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-dIkyvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-KVYdv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-CmTOVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Tb7TVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:42 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-1ZTCB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:22:42 INFO - Running setup.py install for manifestparser 07:22:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:22:43 INFO - Running setup.py install for mozcrash 07:22:43 INFO - Running setup.py install for mozdebug 07:22:43 INFO - Running setup.py install for mozdevice 07:22:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:22:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:22:43 INFO - Running setup.py install for mozfile 07:22:43 INFO - Running setup.py install for mozhttpd 07:22:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:22:43 INFO - Running setup.py install for mozinfo 07:22:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Running setup.py install for mozInstall 07:22:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Running setup.py install for mozleak 07:22:44 INFO - Running setup.py install for mozlog 07:22:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Running setup.py install for moznetwork 07:22:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Running setup.py install for mozprocess 07:22:44 INFO - Running setup.py install for mozprofile 07:22:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:22:44 INFO - Running setup.py install for mozrunner 07:22:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:22:45 INFO - Running setup.py install for mozscreenshot 07:22:45 INFO - Running setup.py install for moztest 07:22:45 INFO - Running setup.py install for mozversion 07:22:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:22:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:22:45 INFO - Cleaning up... 07:22:45 INFO - Return code: 0 07:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:46 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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:46 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 07:22:46 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 07:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:46 INFO - 'HOME': '/Users/cltbld', 07:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:46 INFO - 'LOGNAME': 'cltbld', 07:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:46 INFO - 'MOZ_NO_REMOTE': '1', 07:22:46 INFO - 'NO_EM_RESTART': '1', 07:22:46 INFO - 'PAGER': '/bin/cat', 07:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:46 INFO - 'PWD': '/builds/slave/test', 07:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:46 INFO - 'SHELL': '/bin/bash', 07:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:46 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:46 INFO - 'USER': 'cltbld', 07:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:46 INFO - 'XPC_FLAGS': '0x0', 07:22:46 INFO - 'XPC_SERVICE_NAME': '0', 07:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:46 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-O1gPAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:46 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)) 07:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:46 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-n1Bzyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:46 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)) 07:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:46 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Ds3Xvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:46 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)) 07:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:46 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-TRaC8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:46 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)) 07:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:46 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kz0xdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:46 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)) 07:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:46 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-oOiRoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:46 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)) 07:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:46 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-JzolP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-98y8ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-363fjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ZqvvKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-6lEnQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-vGkv7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-zWH09l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-_zOPzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-1pPqpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:47 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)) 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:47 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-3OnZlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:48 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)) 07:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-t3c5ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:48 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)) 07:22:48 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)) 07:22:48 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)) 07:22:48 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)) 07:22:48 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)) 07:22:48 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)) 07:22:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:50 INFO - Downloading blessings-1.6.tar.gz 07:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:22:50 INFO - Installing collected packages: blessings 07:22:50 INFO - Running setup.py install for blessings 07:22:51 INFO - Successfully installed blessings 07:22:51 INFO - Cleaning up... 07:22:51 INFO - Return code: 0 07:22:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:51 INFO - Reading from file tmpfile_stdout 07:22:51 INFO - Current package versions: 07:22:51 INFO - blessings == 1.6 07:22:51 INFO - blobuploader == 1.2.4 07:22:51 INFO - docopt == 0.6.1 07:22:51 INFO - functools32 == 3.2.3-2 07:22:51 INFO - jsonschema == 2.5.1 07:22:51 INFO - manifestparser == 1.1 07:22:51 INFO - mozInstall == 1.12 07:22:51 INFO - mozcrash == 1.0 07:22:51 INFO - mozdebug == 0.1 07:22:51 INFO - mozdevice == 0.49 07:22:51 INFO - mozfile == 1.2 07:22:51 INFO - mozhttpd == 0.7 07:22:51 INFO - mozinfo == 0.9 07:22:51 INFO - mozleak == 0.1 07:22:51 INFO - mozlog == 3.4 07:22:51 INFO - moznetwork == 0.27 07:22:51 INFO - mozprocess == 0.24 07:22:51 INFO - mozprofile == 0.28 07:22:51 INFO - mozrunner == 6.13 07:22:51 INFO - mozscreenshot == 0.1 07:22:51 INFO - mozsystemmonitor == 0.3 07:22:51 INFO - moztest == 0.8 07:22:51 INFO - mozversion == 1.4 07:22:51 INFO - psutil == 3.1.1 07:22:51 INFO - requests == 1.2.3 07:22:51 INFO - wsgiref == 0.1.2 07:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:51 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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:51 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 07:22:51 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 07:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:51 INFO - 'HOME': '/Users/cltbld', 07:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:51 INFO - 'LOGNAME': 'cltbld', 07:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:51 INFO - 'MOZ_NO_REMOTE': '1', 07:22:51 INFO - 'NO_EM_RESTART': '1', 07:22:51 INFO - 'PAGER': '/bin/cat', 07:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:51 INFO - 'PWD': '/builds/slave/test', 07:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:51 INFO - 'SHELL': '/bin/bash', 07:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:51 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:51 INFO - 'USER': 'cltbld', 07:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:51 INFO - 'XPC_FLAGS': '0x0', 07:22:51 INFO - 'XPC_SERVICE_NAME': '0', 07:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 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)) 07:22:51 INFO - Cleaning up... 07:22:51 INFO - Return code: 0 07:22:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:51 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 0x10a93eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a941768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80de3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, '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.0THbogJs0f/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.N24pHTSwtZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 07:22:51 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 07:22:51 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 07:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:51 INFO - 'HOME': '/Users/cltbld', 07:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:51 INFO - 'LOGNAME': 'cltbld', 07:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:51 INFO - 'MOZ_NO_REMOTE': '1', 07:22:51 INFO - 'NO_EM_RESTART': '1', 07:22:51 INFO - 'PAGER': '/bin/cat', 07:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:51 INFO - 'PWD': '/builds/slave/test', 07:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:51 INFO - 'SHELL': '/bin/bash', 07:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:22:51 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:51 INFO - 'USER': 'cltbld', 07:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:51 INFO - 'XPC_FLAGS': '0x0', 07:22:51 INFO - 'XPC_SERVICE_NAME': '0', 07:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:22:52 INFO - Cleaning up... 07:22:52 INFO - Return code: 0 07:22:52 INFO - Running post-action listener: _resource_record_post_action 07:22:52 INFO - Running post-action listener: _start_resource_monitoring 07:22:52 INFO - Starting resource monitoring. 07:22:52 INFO - [mozharness: 2017-03-28 14:22:52.048570Z] Finished create-virtualenv step (success) 07:22:52 INFO - [mozharness: 2017-03-28 14:22:52.049540Z] Running install step. 07:22:52 INFO - Running pre-action listener: _resource_record_pre_action 07:22:52 INFO - Running main action method: install 07:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:52 INFO - Reading from file tmpfile_stdout 07:22:52 INFO - Detecting whether we're running mozinstall >=1.0... 07:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:22:52 INFO - Reading from file tmpfile_stdout 07:22:52 INFO - Output received: 07:22:52 INFO - Usage: mozinstall [options] installer 07:22:52 INFO - Options: 07:22:52 INFO - -h, --help show this help message and exit 07:22:52 INFO - -d DEST, --destination=DEST 07:22:52 INFO - Directory to install application into. [default: 07:22:52 INFO - "/builds/slave/test"] 07:22:52 INFO - --app=APP Application being installed. [default: firefox] 07:22:52 INFO - mkdir: /builds/slave/test/build/application 07:22:52 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'] 07:22:52 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 07:23:07 INFO - Reading from file tmpfile_stdout 07:23:07 INFO - Output received: 07:23:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:23:07 INFO - Running post-action listener: _resource_record_post_action 07:23:07 INFO - [mozharness: 2017-03-28 14:23:07.249042Z] Finished install step (success) 07:23:07 INFO - [mozharness: 2017-03-28 14:23:07.249180Z] Running run-tests step. 07:23:07 INFO - Running pre-action listener: _resource_record_pre_action 07:23:07 INFO - Running main action method: run_tests 07:23:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:23:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:23:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:23:07 INFO - 2017-03-28 07:23:07.264 screenresolution[6603:121207] starting screenresolution argv=screenresolution get 07:23:07 INFO - 2017-03-28 07:23:07.266 screenresolution[6603:121207] Display 0: 1600x1200x32@60 07:23:07 INFO - 2017-03-28 07:23:07.272 screenresolution[6604:121209] starting screenresolution argv=screenresolution list 07:23:07 INFO - Available Modes on Display 0 07:23:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:23:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:23:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:23:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:23:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:23:07 INFO - Intel Iris: 07:23:07 INFO - Chipset Model: Intel Iris 07:23:07 INFO - Type: GPU 07:23:07 INFO - Bus: Built-In 07:23:07 INFO - VRAM (Dynamic, Max): 1536 MB 07:23:07 INFO - Vendor: Intel (0x8086) 07:23:07 INFO - Device ID: 0x0a2e 07:23:07 INFO - Revision ID: 0x0009 07:23:07 INFO - Displays: 07:23:07 INFO - Display: 07:23:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:23:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:23:07 INFO - Display Serial Number: 1600x1200 60 07:23:07 INFO - Main Display: Yes 07:23:07 INFO - Mirror: Off 07:23:07 INFO - Online: Yes 07:23:07 INFO - Rotation: Supported 07:23:07 INFO - Return code: 0 07:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:23:07 INFO - Python 2.7.3 07:23:07 INFO - Return code: 0 07:23:07 INFO - grabbing minidump binary from tooltool 07:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:07 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 0x10a71cd30>, '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 0x10a643db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a711be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:23:07 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 07:23:07 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 07:23:07 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 07:23:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:23:07 INFO - Return code: 0 07:23:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:23:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:23:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:23:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:23:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:23:07 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/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 07:23:07 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/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 07:23:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0THbogJs0f/Render', 07:23:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:07 INFO - 'HOME': '/Users/cltbld', 07:23:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:07 INFO - 'LOGNAME': 'cltbld', 07:23:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:07 INFO - 'MOZ_NO_REMOTE': '1', 07:23:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:07 INFO - 'NO_EM_RESTART': '1', 07:23:07 INFO - 'PAGER': '/bin/cat', 07:23:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:07 INFO - 'PWD': '/builds/slave/test', 07:23:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:07 INFO - 'SHELL': '/bin/bash', 07:23:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N24pHTSwtZ/Listeners', 07:23:07 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 07:23:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:07 INFO - 'USER': 'cltbld', 07:23:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:07 INFO - 'XPC_FLAGS': '0x0', 07:23:07 INFO - 'XPC_SERVICE_NAME': '0', 07:23:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:07 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/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 07:23:07 INFO - mozversion application_buildid: 20170328060322 07:23:07 INFO - mozversion application_changeset: 54fff8f71f6040a2e6290854e7b104cc4ab369a8 07:23:07 INFO - mozversion application_display_name: Firefox 07:23:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:23:07 INFO - mozversion application_name: Firefox 07:23:07 INFO - mozversion application_remotingname: firefox 07:23:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:23:07 INFO - mozversion application_vendor: Mozilla 07:23:07 INFO - mozversion application_version: 53.0 07:23:07 INFO - mozversion platform_buildid: 20170328060322 07:23:07 INFO - mozversion platform_changeset: 54fff8f71f6040a2e6290854e7b104cc4ab369a8 07:23:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:23:07 INFO - mozversion platform_version: 53.0 07:23:07 INFO - using testdate: 1490710987 07:23:07 INFO - actual date: 1490710987 07:23:07 INFO - starting webserver on 'localhost:57979' 07:23:07 INFO - SUITE-START | Running 2 tests 07:23:07 INFO - TEST-START | dromaeo_css 07:23:07 INFO - operating with platform_type : mac_ 07:23:07 INFO - Initialising browser for dromaeo_css test... 07:23:07 INFO - TEST-INFO | started process 6614 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpwuS31l/profile http://localhost:57979/getInfo.html) 07:23:10 INFO - PROCESS | 6614 | __metrics Screen width/height:1600/1200 07:23:10 INFO - PROCESS | 6614 | colorDepth:24 07:23:10 INFO - PROCESS | 6614 | Browser inner width/height: 1024/689 07:23:10 INFO - PROCESS | 6614 | __metrics 07:23:10 INFO - PROCESS | 6614 | 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" 07:23:10 INFO - PROCESS | 6614 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:11 INFO - TEST-INFO | 6614: exit 0 07:23:11 INFO - Browser initialized. 07:23:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:23:11 INFO - TEST-INFO | started process 6618 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpwuS31l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:23 INFO - PROCESS | 6618 | RSS: Main: 163524608 07:23:23 INFO - PROCESS | 6618 | 07:26:25 INFO - PROCESS | 6618 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57979/tests/dromaeo/cssquery-ext.html) 07:26:27 INFO - PROCESS | 6618 | RSS: Main: 294154240 07:26:27 INFO - PROCESS | 6618 | 07:29:30 INFO - PROCESS | 6618 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-ext.html (next: http://localhost:57979/tests/dromaeo/cssquery-jquery.html) 07:29:30 INFO - PROCESS | 6618 | RSS: Main: 307023872 07:29:30 INFO - PROCESS | 6618 | 07:32:33 INFO - PROCESS | 6618 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57979/tests/dromaeo/cssquery-mootools.html) 07:32:33 INFO - PROCESS | 6618 | RSS: Main: 300261376 07:32:33 INFO - PROCESS | 6618 | 07:35:35 INFO - PROCESS | 6618 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57979/tests/dromaeo/cssquery-prototype.html) 07:35:36 INFO - PROCESS | 6618 | RSS: Main: 284815360 07:35:36 INFO - PROCESS | 6618 | 07:38:39 INFO - PROCESS | 6618 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57979/tests/dromaeo/cssquery-yui.html) 07:38:40 INFO - PROCESS | 6618 | RSS: Main: 269656064 07:38:40 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | Cycle 1(1): loaded http://localhost:57979/tests/dromaeo/cssquery-yui.html (next: http://localhost:57979/tests/dromaeo/cssquery-dojo.html) 07:41:43 INFO - PROCESS | 6618 | RSS: Main: 427200512 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | __start_tp_report 07:41:43 INFO - PROCESS | 6618 | _x_x_mozilla_page_load 07:41:43 INFO - PROCESS | 6618 | _x_x_mozilla_page_load_details 07:41:43 INFO - PROCESS | 6618 | |i|pagename|runs| 07:41:43 INFO - PROCESS | 6618 | |0;dojo.html;3211.582494275744;3385.08602677277;3404.4893266010095;3440.7591468597207;3446.1556918554957;5061.342025536685;5578.995780759462;5769.971150144253;5778.65328080315;5821.796237131702;5781.884362312751;5840.649561026341;5841.474267315941;5848.853778655525;5885.735141918613;5216.321878155834;5285.524302812746;5322.0686379883555;5346.6791992480385;5389.326334208224;5253.842384728464;5278.47215278471;5370.248165256867;5390.91913621294;5448.972755136238;5268.5521730652945;5320.733963301839;5321.175217841241;5337.786488540453;5395.838124856241;5374.247605335257;5375.032494151052;5388;5404.108322126884;5414.729263536808;5162;5286.392064912546;5292.841214763564;5297.947020529784;5350.224217488481;5671.404502527216;5699.287589051369;5718.342390625048;5782.479576838063;5821.2141360916585;6104.428839602322;6139.017757158833;6139.631622102688;6143.078538219303;6144.139820425144;6134.663092688834;6142.570020098595;6145.3547377525165;6171.6297022178815;6176.104464852571;5002.89994200114;5867.76528938842;5936.643801371888;5949.553783466214;5965.880682386328;6284.4344009039405;6298.370162983757;6298.811035668938;6309.684515774193;6309.684515774193;6020.638761674226;6111.84720381994;6115.816525504242;6184.412480814315;6188.690565471708;5285.894282114336;6206.782762603287;6260.812175634647;6261.530385221126;6266.122742816009;6281.560290779602;6283.6858157091965;6286.528510361742;6286.842828929313;6296.43332100104;6283.214598175228;6295.087212354275;6304.306526282106;6304.842378940563;6318.810435686937;4951.554360107608;4999.150144475375;4999.675021123615;5008.6744361616375;5041.873953151201;4475.597196252353;4524.343970124313;4526.117407105583;4527.253003254426;4558.8632341029825;5023.547880690755;5823.155642431909;5836.066229403275;5861.677607731615;5866.090755932837;6204;6205.5345849061505;6212.378762123842;6257.092721555349;6290.150829638032;5789.9867523183275;5859.677717725566;5860.824175274749;5888.793892213752;5899.380565040695;5456.645318054314;5515.338159420895;5529.142982837667;5531.640443371249;5532.612717109763;6212.285587157535;6272.341404152498;6339.049142628643;6343.143675603735;6345.238571371465;6204.534659900616;6213.00591905293;6222.12890195364;6270.6551139685935;6272.780452684134;6333.936660633519;6344.397282258178;6358.078078678658;6360.268569114426;6444.9355506444335;6136.365905528278;6294.8111556653375;6302.306746257999;6308.053791931247;6336.968315158395;6214.533909956681;6228.844278893064;6248.125262463168;6251.6561589113035;6317.30509643948;6077.24034495688;6245.6252624842655;6260.217472815898;6276.278228003655;6276.905846412399;6138.631682099089;6216.627002379872;6264.906026409699;6272.843178920563;6277.340879207617;5933.465988061095;5950.077737950624;6047.183630209865;6093.268807743099;6096.177016102769;6208.81373558794;6241.063840423973;6248.4688801452385;6271.749130034747;6286.968565157145;5908.9954707698935;5945.34601193877;6073.423024812636;6083.66539840313;6099.664518451527 07:41:43 INFO - PROCESS | 6618 | |1;ext.html;470.9450830140482;499.8827620268701;509.21580765620945;510.3365624687905;528.8334174734958;34710;42174.78912605436;44711;44836.3274550882;47152.76423617886;46357.76821115898;46595.534044659544;46597.53402465974;46620;46881.29678054832;9200.631974721036;9657.17913977311;9881.20950323976;9884;9891.851622225637;9165.266778657724;12020.398980050963;12286.754264914696;12312.445939932724;12483.500659973635;10750.462476876124;12213.694657633541;12317.384130793469;12319;12324.32216228107;12097.818532722016;12161.635150945485;12167;12181.878181218162;12182.964448021929;11949.22330048544;12019.459124339426;12047.096467764954;12076.21504602198;12087.274763514217;42815.35776963317;42983.35524967128;43022.139557208684;43031.78484107591;43064.56935430637;3948.4274780157;4093.6111069448357;4095.058136628592;4111.691623128248;4139.503259608866;31099.533506997413;32128;32973.83513082443;33386.833065834755;33656.83171584151;3042.4523585754555;3246.469501658506;3406.6423025582203;3449.5170676105367;3493.8602455901732;441878;446975.7651211723;450349.99999999674;450649.74675126415;451881.7405912982;68219;68674.65662671755;68737.31262687308;68774.31225687779;68832;71451.92822107673;71997.2800272001;72075;72211.638941806;72280.63859680668;15064.246787660573;18258.087095645165;18260;18275.63448731018;18282.62880283984;12672.873271267354;12963.287019214034;13914.51299204523;14012.019158658795;14015.789763153562;16983.74524382135;18883.809744242597;23639.527209456057;23673.526529469313;23701.407464813172;8127.2279133482225;9055.68305109318;9257.90742092584;9283.953580232055;9291.953540232256;760.9809754756176;886.6877022007465;896.5562046786882;897.838389089957;942.830290547708;30508.237294067825;31223.687763122078;31433.528497072562;31517.36965260682;32026;975.7024107647094;1078.6979645699216;1100.944952752359;1122.2705241592867;1181.6218809980724;15758.76361854573;16217.918910405608;16366.099864507329;16370.590735231477;16427.91786041086;654136;660989;662249;662506;662533;60791.39208607946;61158;61191.69404152951;61231.387686122565;61434.69282653558;1366.2895294446832;1408.9718205636034;1462.5739903594335;1510.8035955325956;1522.9695406091816;30697;31798.523022154222;32922.34155316928;33122.83438582792;33565.66434335723;53639.46360536501;54607.90784184215;54638.72680636571;54690.72654636701;54711.17933230925;452372;513424;515992.62040588126;518843;519686;36551.287862562174;37603.623963760016;38359.61640383561;43948.780256098515;44565.777171113936;45871.31193032041;50470;50844.74577627088;51645.48354516557;51732.48267517277;31042.84478577683;31816.204594884388;31883.20291992719;33481.497777532866;33874.983750487525;26381.868090659424;31584.684153158174;32010.35979280355;32577.511337329484;32792.67207327896;36547.81726091352;37258;37388;37603.24793504169;37898.242035159696;31962;32003.519947200344;32080.839595802805;32091.839540802146;32893.67106329002;23526.882365588062;24961.50076998486;25037.244413338143;25432.491350173263;25433.364165896 07:41:43 INFO - PROCESS | 6618 | |2;jquery.html;349.6643222506394;357.3870811558179;411.2433123053582;412.0954504861829;437.3308837478657;21027.579448411023;22149.446263843412;22174.55650886983;22301.776982230174;22799.772002279973;22483;22545.549089018208;22938.853057347107;23233.535329293405;23236.65145022826;5671.8014869479475;6199.690015499207;6202.2867370252325;6205.255369355684;6209.6895155242055;5747.482726554609;5933.48186186846;5980.700964951757;6090.756369745205;6114.816555503342;6011.699415029253;6024.307204671475;6029.668368239745;6040.546958978094;6041.305249896274;5757.337906140785;5956.821295361146;6021.548383871227;6037.667928263966;6051.878962420727;5147.996140752554;5288.206768984683;5320.733963301819;5328.280682107905;5329;27004.324891877663;27515;27533.449331013468;27788.30529236765;27869.442611147664;2607.1526753805088;2786.2616406652255;2812.8874845006176;2843.9289017774513;2861.799674022819;10392.948035259775;10503.054725074704;10571.312864663772;10816.567337306498;10942.507587158598;1858.27527264367;1916.5017095555118;1924.8267655910895;1927.6626590346773;1945.4455480188078;150282;150777;154313.22843385712;155900;158347;10222.6422075227;12157;12328.568500102454;12360.629181124581;12421;16535.586610334598;16590.50228493147;16609.83390166083;16615.833841661428;16616.25226864794;8072.515649061075;8962.311306608122;9292.953535232416;9296.953515232515;9453.905460945303;9044.954775226213;9120.407173533698;9140.908590914005;9324.207442367338;9328.813423731488;4840.443349014838;4927.90144197114;4936.679115857458;4951.5048495150195;5008.348914641073;2037.0527704617425;2076.4912596413674;2078.511549785799;2082.7708952015264;2083.427057559153;1016.4511163971373;1052.7157667429751;1066.328213225663;1084.311462221495;1113.7828123516;22523;23031.309060728207;23039.078436862674;23063.654045189334;23095.422614434436;926.6617684545228;978.6707635826829;998.3161534348849;1012.5747186181821;1108.51225460797;7179.712811487587;7203.38771204443;7291.708331666674;7432.033835601337;7457.216992215847;733369;744098;744480;747603;749699;139450.30274848765;164287;164884.3511564893;166725;171803;1131.2590253384046;1148.2077366617007;1175.506287359294;1175.6179241746468;1176.9117316201318;12567.748645027232;12704.6823829405;12855.678608034874;13031.413586388824;13150;50572.24141637952;51251.718707031134;51485.7425712869;59090.704546478715;60349.69825150846;87875;90951;91579.54210228907;93169;93553;7188.388986936169;8438.535880526384;8693.826123477369;8708.258348330486;8947.552622368985;13393.732125357634;13408.664783380493;13417.66455838612;13871.72256554843;14001.5099471518;10982.835257471304;11549.42252887369;11802.586909458129;11931.940340298243;11973.042156627624;10810.837837432602;10851.837222441512;11117.11063114965;11142.554297827995;11288.43557822122;10871.836922446011;11416;11683.824742628698;12104.93947530292;12108.818367724314;7610.315071643578;8530.402871798915;8673.306135509018;8691.782705432415;8862;8648.610812513578;10627;11691.356975366436;11727.765444690887;11877.524899003944 07:41:43 INFO - PROCESS | 6618 | |3;mootools.html;1356.9389377478012;1455.7015811758583;1474.1965628732346;1476.475851072869;1476.5570328901333;7686.5772382518935;8347.833043339137;8443;8595.742127736177;8730.432521886089;8500.149985001497;8564.486130832154;8566.229039386453;8566.742997710078;8588.012378576466;2148.5488047510044;2386.4033991502124;2420.419099416145;2425.575524283252;2426.4783071639595;2226.8329875259337;2369;2449.3754092706336;2451.632255161731;2454.141050632273;2400.975990240093;2411.963820542693;2414.5895197816326;2415.3961509622595;2423.200343886513;2334.614788559894;2355.3993731598503;2362.9409264768346;2363.0665886974634;2368.301351101429;2382.3448551648435;2389.414593424622;2398.8080953523677;2419.334682962182;2423.87880605969;8618.741437756877;8686.56567171639;8688.565571721389;8690.652373905035;8694.565271736388;5229.320188375525;5379.67721936685;5380.2736630555155;5382.4886635769535;5403.675779453245;3425.6231814500634;3578.3022310649435;3635.5273814404222;3635.9454608180636;3643.052806270389;1216.2033867816594;1249.6813312605318;1264.102487234065;1303.055284918436;1312.9934350328188;11037.337759734442;11040.613578524793;11106.111511079174;11126.721831954184;11146.721331966684;4691.7053180771745;4736.5973892219545;4793.352897358882;4837.32277481153;4858.319835223072;9795.461249631338;9798.510074496247;9810.705678829647;9818.80362392748;9828.361156524947;5368;5459.8362049137795;5463.071277882769;5467.6719396836315;5477.370102438191;4464.196444639931;4782.880427989258;4890.290907818347;4996.175631020841;5010.574101201366;3719.4606782017;3987.2424239394422;4107.589241075928;4126.154138401621;4127.814248358831;1130.4517309105242;1304.276126749663;1331.8801307882336;1332.4004198110888;1343.6909510812372;949.1931857920712;964.9517524123765;982.4498280962683;998.9800203995879;999.4153420249236;5568.192612071227;5665.801696940587;5724.914126288109;5820.214271073351;5829.621074630136;1011.9241056920761;1030.6444276724667;1031.3244824639874;1055.1347894726405;1065.648336049102;3780.1872597391693;3872.728908976401;3908.6482216600643;3983.5618082010956;4004.2391945530258;9717.368371055858;9988.550515226832;10056.949715251378;10067.043630855058;10068.993100690019;9845.901540984642;9864.95067524672;9953.153981911619;10014.998500150072;10023.298369114093;6588.73645054202;8005.479643823133;8009.679612815422;8009.799755006172;8019.198080191934;5440.156775699773;5557.305336832896;5594.916076258778;5737.139429085671;5809.099589563624;7963.522188668699;9146.405483643543;9217.170454659114;9285.582148803454;9287.349885507949;8105.635246414044;9050.18548330627;9233.353665243369;9348.25213982866;9434.48110353937;7049.400800931773;7279.4540409468445;7301.08736407949;7376.520526165782;7402.29678180572;7486.4759466836795;7663.693452261847;7707.576083315472;7828.138904720362;8138.470999385021;6535.215774107138;6948.444124470131;7070.257622949516;7150.892736608851;7177.138743350832;6956;7021.473389495706;7026.789196324118;7055.435565154878;7084.752033678797;6459.806205813833;6561.1470508835455;6566.8358291043105;6567.605943643397;6574.112494813139;4946.431160416454;4963.925541116814;4967.503249675004;5081.288619593334;5224.085784987536;5030.673006254582;5050.84847454577;5064.366954130734;5089.491050894881;5148.794048238028 07:41:43 INFO - PROCESS | 6618 | |4;prototype.html;364.4660572261637;364.96897763690083;377.29069349622716;387.1521368203636;387.9747816391933;4718.315844202589;5106.41276253231;5163.690178589282;5248.973755131224;5253.088362381176;5086.92369614456;5116.360454943132;5153.0885049946755;5226.92159617606;5233.293505376773;4115.176964607075;4171.8539851105215;4185.351270553054;4185.74885506869;4218.641415479688;3996.780177090259;4029.97985010076;4175.791210439481;4227.239096962546;4230.7250028748185;3343.732501399882;4125.257453658341;4162.458880345566;4165.33354663254;4196.832126714928;3359.277755282626;3442.4836274558893;4120.662263566521;4136.875893723193;4157.355609880473;3183.1564635371647;3516.1912760065075;3680;3716.646918542734;3716.981415092934;4428.759947214785;4971.403431588196;5087.923681144785;5158.871028224325;5231.267622532849;4546.704464209815;4641.605463535603;4805.711657300573;4811.230203167476;4848.636352273594;5566.832995010116;5569.192467092249;5571.554275657978;5595.916061259044;5628.437156284339;3879.8254078566533;4078.653314468274;4094.242565125461;4100.65144462718;4125.66994640428;5740.741666625012;5750.511206547449;5751.367349591542;5751.396103409165;5798.652080875161;3781.565120011179;3905.7656540607654;4179.561146079679;4192.538820729717;4208.116295577963;4038.7237121215526;4200.726952748061;4227.070044590185;4242.215190189825;4262.722923009995;4014.374178457729;4703.212779143972;4734.644901632322;4749.24012158053;4763.856674398119;5590;5593.440655934374;5610;5613.270274864323;5648.4633959773755;1256.9685757856128;1301.9934900325627;1337.7024286442136;1341.9060665753498;1362.1486570893192;858.2704701004096;928.9860652090224;963.4700914496999;967.7725734452398;975.3952549419264;4158.792060396968;4280.966540893113;4929.309896614477;4929.954069061299;4932.161532539405;5010.515588548229;5336.973315133477;5421.566274698093;5446.887599862079;5454.936287423993;4203.789810509462;4702.506236845151;4834.419869615669;4898.975505122452;4915.459299477055;2544.389346556813;2709.0718458235638;2769.986150069237;2835.1365121227295;2848.629678141828;4544.386507821468;5193.350831146106;5308.761105750251;5628.283373571018;5633.492985631313;4589.655775816827;4857.595490232357;5110.693358398508;5458.754356053987;5491.787304426875;4875.951670390812;5294.8941021180135;5502.642328248731;5566.693831839207;5585.944140558542;5126.79492820283;5334.546563542142;5381.354237491526;5386.649867758583;5401.702906340189;5172.663776854492;5235.712035838065;5239.816606418757;5260.238374853079;5345.438728933562;5038.798448062036;5044.899102018013;5440.727963601883;5458.235846981346;5498.422665620053;3502.509648649242;3902.239063382613;3910.941335879907;3918.9418856909047;3927.3716205407;4647.488776234679;4795.214771098856;5316.6012549058205;5320.600954928474;5323.77553162767;4583.656225783013;4815.879603009953;4865.9756701216265;4891.51084891508;5079.16193828029;5566.582506312124;5567.638103523258;5576.33084029919;5579.218909352775;5611.046122159161;4208.726432781859;4634.675572710013;5126.487351264844;5353.982743278764;5465.398806131243;4590.70768831144;5405.783628712366;5495.368032676293;5533.363663178625;5567.944320556905;4671.85984420468;5439.700816455133;5476.561875049907;5483.698396588226;5557.832855100312 07:41:43 INFO - PROCESS | 6618 | |5;yui.html;655.1286788571199;712.7113519024794;721.1670520548766;756.5007095317088;764.3006648916241;14867.925660371697;16093.597660058504;16391.59021024475;16392.508224753277;16424.260908259126;14683.706325873476;14769.483068092619;14896.404143834234;15023.549293521184;15046.322915468803;847.1189962439072;903.1781079217913;905.108468158863;905.8143080668447;906.6328137104483;724.5906063074373;747.484235877243;859.0807835615893;891.17121077398;891.3804905590617;948.3977674176913;950.6102497975832;951.2627713522006;959.4147569982305;959.8080383923208;952.1240458777941;955.5270141280041;959.0936564946163;960.4429430930113;964.8118616869713;710.4387533848305;711.2460791560962;711.352669071148;711.6477343714843;711.9644017799089;15754.13352265625;15965.760513592306;16100.355985760556;16143.596410089724;16478.42325518601;14863.33115009827;15007.324670389859;15301.387944482207;15381.846181538152;15482.30329635169;10721.892781072245;11938.104642151786;12002.939985300105;12181.756364872654;12196.573119940847;3744.2885851688093;3745.906352341186;3760.4735337052834;3830.3871380579253;3914.256291304643;93467;115485.4225728866;115893.99999999916;118006.40996794961;118159.81840181487;10500.789984200273;10989.560417583207;11378.601748938747;11700.2979821211;11878.821817672742;21987.890060549915;22292.66561001586;22381.104755809585;22403.775962240496;22490.775092249194;7828.569428681477;7890.566018869017;7893.921060789434;7945.64244608994;7999.240072193249;4411.117776444724;4415.735055896656;4426.690131690815;4524.5701658342405;4666.69666471685;3711.6102809205186;3765.1528406108955;3785.7539259948016;3787.3750831112557;3822.445745366962;654.1953397321322;661.2131563439492;661.4443867151616;673.3670349871105;677.6679427080695;572.2017785189637;593.7684303121786;598.7724664627414;607.2561112637072;614.658864330301;10293.433861137559;10693.679189624323;10737.51681174349;10805.513751881184;11152.386618736047;693.7537174303151;704.2886684448744;759.5366826235992;764.0411283838747;766.8121310279017;4386.627136693417;4792.424909010941;5157.252198431206;5196.4803519648485;5206.088934436459;100195.99804002013;101475;112203;112615.4369228165;115366;78344.60827695826;79791;94617.52691236637;95843.52078239564;98584.09911306282;74500.25499745042;78898.6055069721;79430.60284698539;80199;82838.58580707057;10782.622608208674;10810.891891080988;11035.779284414428;11415.143864210384;11457.59898403552;46916.765416172704;46943.29585056158;48879.511204887494;48943;49638.759031024514;61120;65266.673666631366;65453.672731636034;68032.6598367005;68817.65591172013;13307;13451.798223026859;13559.86440135586;13955.441782328593;13972.091814032055;12875.905548028522;13857.930710346383;14734.852651473348;15009.774853377427;15050.322735476711;13960.860391395956;14071.296435177996;14456.710865782836;14491.565253042425;14911;13612.25132617676;14196.503122390666;14284.500042498463;14449;14742.484013059491;13758.449662013407;13868.72262554723;13890.58328250154;14109.506167284097;14193.148411095368;8927.241184499131;9273.397229180351;9757.853632195382;9797.06927841854;9981.251406144424;10307.793844123225;10927;11168.1065514757;11174.994250517493;11316 07:41:43 INFO - PROCESS | 6618 | __end_tp_report 07:41:43 INFO - PROCESS | 6618 | __start_cc_report 07:41:43 INFO - PROCESS | 6618 | _x_x_mozilla_cycle_collect,1331 07:41:43 INFO - PROCESS | 6618 | __end_cc_report 07:41:43 INFO - PROCESS | 6618 | __startTimestamp1490712103832__endTimestamp 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | ------- Summary: start ------- 07:41:43 INFO - PROCESS | 6618 | Number of tests: 6 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | [#0] dojo.html Cycles:165 Average:5797.68 Median:6073.42 stddev:632.94 (10.4%) stddev-sans-first:601.49 07:41:43 INFO - PROCESS | 6618 | Values: 3211.6 3385.1 3404.5 3440.8 3446.2 5061.3 5579.0 5770.0 5778.7 5821.8 5781.9 5840.6 5841.5 5848.9 5885.7 5216.3 5285.5 5322.1 5346.7 5389.3 5253.8 5278.5 5370.2 5390.9 5449.0 5268.6 5320.7 5321.2 5337.8 5395.8 5374.2 5375.0 5388.0 5404.1 5414.7 5162.0 5286.4 5292.8 5297.9 5350.2 5671.4 5699.3 5718.3 5782.5 5821.2 6104.4 6139.0 6139.6 6143.1 6144.1 6134.7 6142.6 6145.4 6171.6 6176.1 5002.9 5867.8 5936.6 5949.6 5965.9 6284.4 6298.4 6298.8 6309.7 6309.7 6020.6 6111.8 6115.8 6184.4 6188.7 5285.9 6206.8 6260.8 6261.5 6266.1 6281.6 6283.7 6286.5 6286.8 6296.4 6283.2 6295.1 6304.3 6304.8 6318.8 4951.6 4999.2 4999.7 5008.7 5041.9 4475.6 4524.3 4526.1 4527.3 4558.9 5023.5 5823.2 5836.1 5861.7 5866.1 6204.0 6205.5 6212.4 6257.1 6290.2 5790.0 5859.7 5860.8 5888.8 5899.4 5456.6 5515.3 5529.1 5531.6 5532.6 6212.3 6272.3 6339.0 6343.1 6345.2 6204.5 6213.0 6222.1 6270.7 6272.8 6333.9 6344.4 6358.1 6360.3 6444.9 6136.4 6294.8 6302.3 6308.1 6337.0 6214.5 6228.8 6248.1 6251.7 6317.3 6077.2 6245.6 6260.2 6276.3 6276.9 6138.6 6216.6 6264.9 6272.8 6277.3 5933.5 5950.1 6047.2 6093.3 6096.2 6208.8 6241.1 6248.5 6271.7 6287.0 5909.0 5945.3 6073.4 6083.7 6099.7 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | [#1] ext.html Cycles:180 Average:69242.70 Median:36904.64 stddev:145338.89 (393.8%) stddev-sans-first:145654.88 07:41:43 INFO - PROCESS | 6618 | Values: 470.9 499.9 509.2 510.3 528.8 34710.0 42174.8 44711.0 44836.3 47152.8 46357.8 46595.5 46597.5 46620.0 46881.3 9200.6 9657.2 9881.2 9884.0 9891.9 9165.3 12020.4 12286.8 12312.4 12483.5 10750.5 12213.7 12317.4 12319.0 12324.3 12097.8 12161.6 12167.0 12181.9 12183.0 11949.2 12019.5 12047.1 12076.2 12087.3 42815.4 42983.4 43022.1 43031.8 43064.6 3948.4 4093.6 4095.1 4111.7 4139.5 31099.5 32128.0 32973.8 33386.8 33656.8 3042.5 3246.5 3406.6 3449.5 3493.9 441878.0 446975.8 450350.0 450649.7 451881.7 68219.0 68674.7 68737.3 68774.3 68832.0 71451.9 71997.3 72075.0 72211.6 72280.6 15064.2 18258.1 18260.0 18275.6 18282.6 12672.9 12963.3 13914.5 14012.0 14015.8 16983.7 18883.8 23639.5 23673.5 23701.4 8127.2 9055.7 9257.9 9284.0 9292.0 761.0 886.7 896.6 897.8 942.8 30508.2 31223.7 31433.5 31517.4 32026.0 975.7 1078.7 1100.9 1122.3 1181.6 15758.8 16217.9 16366.1 16370.6 16427.9 654136.0 660989.0 662249.0 662506.0 662533.0 60791.4 61158.0 61191.7 61231.4 61434.7 1366.3 1409.0 1462.6 1510.8 1523.0 30697.0 31798.5 32922.3 33122.8 33565.7 53639.5 54607.9 54638.7 54690.7 54711.2 452372.0 513424.0 515992.6 518843.0 519686.0 36551.3 37603.6 38359.6 43948.8 44565.8 45871.3 50470.0 50844.7 51645.5 51732.5 31042.8 31816.2 31883.2 33481.5 33875.0 26381.9 31584.7 32010.4 32577.5 32792.7 36547.8 37258.0 37388.0 37603.2 37898.2 31962.0 32003.5 32080.8 32091.8 32893.7 23526.9 24961.5 25037.2 25432.5 25433.4 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | [#2] jquery.html Cycles:180 Average:41627.09 Median:12921.90 stddev:124676.26 (964.8%) stddev-sans-first:124987.49 07:41:43 INFO - PROCESS | 6618 | Values: 349.7 357.4 411.2 412.1 437.3 21027.6 22149.4 22174.6 22301.8 22799.8 22483.0 22545.5 22938.9 23233.5 23236.7 5671.8 6199.7 6202.3 6205.3 6209.7 5747.5 5933.5 5980.7 6090.8 6114.8 6011.7 6024.3 6029.7 6040.5 6041.3 5757.3 5956.8 6021.5 6037.7 6051.9 5148.0 5288.2 5320.7 5328.3 5329.0 27004.3 27515.0 27533.4 27788.3 27869.4 2607.2 2786.3 2812.9 2843.9 2861.8 10392.9 10503.1 10571.3 10816.6 10942.5 1858.3 1916.5 1924.8 1927.7 1945.4 150282.0 150777.0 154313.2 155900.0 158347.0 10222.6 12157.0 12328.6 12360.6 12421.0 16535.6 16590.5 16609.8 16615.8 16616.3 8072.5 8962.3 9293.0 9297.0 9453.9 9045.0 9120.4 9140.9 9324.2 9328.8 4840.4 4927.9 4936.7 4951.5 5008.3 2037.1 2076.5 2078.5 2082.8 2083.4 1016.5 1052.7 1066.3 1084.3 1113.8 22523.0 23031.3 23039.1 23063.7 23095.4 926.7 978.7 998.3 1012.6 1108.5 7179.7 7203.4 7291.7 7432.0 7457.2 733369.0 744098.0 744480.0 747603.0 749699.0 139450.3 164287.0 164884.4 166725.0 171803.0 1131.3 1148.2 1175.5 1175.6 1176.9 12567.7 12704.7 12855.7 13031.4 13150.0 50572.2 51251.7 51485.7 59090.7 60349.7 87875.0 90951.0 91579.5 93169.0 93553.0 7188.4 8438.5 8693.8 8708.3 8947.6 13393.7 13408.7 13417.7 13871.7 14001.5 10982.8 11549.4 11802.6 11931.9 11973.0 10810.8 10851.8 11117.1 11142.6 11288.4 10871.8 11416.0 11683.8 12104.9 12108.8 7610.3 8530.4 8673.3 8691.8 8862.0 8648.6 10627.0 11691.4 11727.8 11877.5 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | [#3] mootools.html Cycles:180 Average:5530.21 Median:5298.66 stddev:2955.51 (55.8%) stddev-sans-first:2947.16 07:41:43 INFO - PROCESS | 6618 | Values: 1356.9 1455.7 1474.2 1476.5 1476.6 7686.6 8347.8 8443.0 8595.7 8730.4 8500.1 8564.5 8566.2 8566.7 8588.0 2148.5 2386.4 2420.4 2425.6 2426.5 2226.8 2369.0 2449.4 2451.6 2454.1 2401.0 2412.0 2414.6 2415.4 2423.2 2334.6 2355.4 2362.9 2363.1 2368.3 2382.3 2389.4 2398.8 2419.3 2423.9 8618.7 8686.6 8688.6 8690.7 8694.6 5229.3 5379.7 5380.3 5382.5 5403.7 3425.6 3578.3 3635.5 3635.9 3643.1 1216.2 1249.7 1264.1 1303.1 1313.0 11037.3 11040.6 11106.1 11126.7 11146.7 4691.7 4736.6 4793.4 4837.3 4858.3 9795.5 9798.5 9810.7 9818.8 9828.4 5368.0 5459.8 5463.1 5467.7 5477.4 4464.2 4782.9 4890.3 4996.2 5010.6 3719.5 3987.2 4107.6 4126.2 4127.8 1130.5 1304.3 1331.9 1332.4 1343.7 949.2 965.0 982.4 999.0 999.4 5568.2 5665.8 5724.9 5820.2 5829.6 1011.9 1030.6 1031.3 1055.1 1065.6 3780.2 3872.7 3908.6 3983.6 4004.2 9717.4 9988.6 10056.9 10067.0 10069.0 9845.9 9865.0 9953.2 10015.0 10023.3 6588.7 8005.5 8009.7 8009.8 8019.2 5440.2 5557.3 5594.9 5737.1 5809.1 7963.5 9146.4 9217.2 9285.6 9287.3 8105.6 9050.2 9233.4 9348.3 9434.5 7049.4 7279.5 7301.1 7376.5 7402.3 7486.5 7663.7 7707.6 7828.1 8138.5 6535.2 6948.4 7070.3 7150.9 7177.1 6956.0 7021.5 7026.8 7055.4 7084.8 6459.8 6561.1 6566.8 6567.6 6574.1 4946.4 4963.9 4967.5 5081.3 5224.1 5030.7 5050.8 5064.4 5089.5 5148.8 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | [#4] prototype.html Cycles:180 Average:4448.49 Median:4895.24 stddev:1294.02 (26.4%) stddev-sans-first:1260.82 07:41:43 INFO - PROCESS | 6618 | Values: 364.5 365.0 377.3 387.2 388.0 4718.3 5106.4 5163.7 5249.0 5253.1 5086.9 5116.4 5153.1 5226.9 5233.3 4115.2 4171.9 4185.4 4185.7 4218.6 3996.8 4030.0 4175.8 4227.2 4230.7 3343.7 4125.3 4162.5 4165.3 4196.8 3359.3 3442.5 4120.7 4136.9 4157.4 3183.2 3516.2 3680.0 3716.6 3717.0 4428.8 4971.4 5087.9 5158.9 5231.3 4546.7 4641.6 4805.7 4811.2 4848.6 5566.8 5569.2 5571.6 5595.9 5628.4 3879.8 4078.7 4094.2 4100.7 4125.7 5740.7 5750.5 5751.4 5751.4 5798.7 3781.6 3905.8 4179.6 4192.5 4208.1 4038.7 4200.7 4227.1 4242.2 4262.7 4014.4 4703.2 4734.6 4749.2 4763.9 5590.0 5593.4 5610.0 5613.3 5648.5 1257.0 1302.0 1337.7 1341.9 1362.1 858.3 929.0 963.5 967.8 975.4 4158.8 4281.0 4929.3 4930.0 4932.2 5010.5 5337.0 5421.6 5446.9 5454.9 4203.8 4702.5 4834.4 4899.0 4915.5 2544.4 2709.1 2770.0 2835.1 2848.6 4544.4 5193.4 5308.8 5628.3 5633.5 4589.7 4857.6 5110.7 5458.8 5491.8 4876.0 5294.9 5502.6 5566.7 5585.9 5126.8 5334.5 5381.4 5386.6 5401.7 5172.7 5235.7 5239.8 5260.2 5345.4 5038.8 5044.9 5440.7 5458.2 5498.4 3502.5 3902.2 3910.9 3918.9 3927.4 4647.5 4795.2 5316.6 5320.6 5323.8 4583.7 4815.9 4866.0 4891.5 5079.2 5566.6 5567.6 5576.3 5579.2 5611.0 4208.7 4634.7 5126.5 5354.0 5465.4 4590.7 5405.8 5495.4 5533.4 5567.9 4671.9 5439.7 5476.6 5483.7 5557.8 07:41:43 INFO - PROCESS | 6618 | 07:41:43 INFO - PROCESS | 6618 | [#5] yui.html Cycles:180 Average:20991.94 Median:3804.91 stddev:30328.43 (797.1%) stddev-sans-first:30375.07 07:41:43 INFO - PROCESS | 6618 | Values: 655.1 712.7 721.2 756.5 764.3 14867.9 16093.6 16391.6 16392.5 16424.3 14683.7 14769.5 14896.4 15023.5 15046.3 847.1 903.2 905.1 905.8 906.6 724.6 747.5 859.1 891.2 891.4 948.4 950.6 951.3 959.4 959.8 952.1 955.5 959.1 960.4 964.8 710.4 711.2 711.4 711.6 712.0 15754.1 15965.8 16100.4 16143.6 16478.4 14863.3 15007.3 15301.4 15381.8 15482.3 10721.9 11938.1 12002.9 12181.8 12196.6 3744.3 3745.9 3760.5 3830.4 3914.3 93467.0 115485.4 115894.0 118006.4 118159.8 10500.8 10989.6 11378.6 11700.3 11878.8 21987.9 22292.7 22381.1 22403.8 22490.8 7828.6 7890.6 7893.9 7945.6 7999.2 4411.1 4415.7 4426.7 4524.6 4666.7 3711.6 3765.2 3785.8 3787.4 3822.4 654.2 661.2 661.4 673.4 677.7 572.2 593.8 598.8 607.3 614.7 10293.4 10693.7 10737.5 10805.5 11152.4 693.8 704.3 759.5 764.0 766.8 4386.6 4792.4 5157.3 5196.5 5206.1 100196.0 101475.0 112203.0 112615.4 115366.0 78344.6 79791.0 94617.5 95843.5 98584.1 74500.3 78898.6 79430.6 80199.0 82838.6 10782.6 10810.9 11035.8 11415.1 11457.6 46916.8 46943.3 48879.5 48943.0 49638.8 61120.0 65266.7 65453.7 68032.7 68817.7 13307.0 13451.8 13559.9 13955.4 13972.1 12875.9 13857.9 14734.9 15009.8 15050.3 13960.9 14071.3 14456.7 14491.6 14911.0 13612.3 14196.5 14284.5 14449.0 14742.5 13758.4 13868.7 13890.6 14109.5 14193.1 8927.2 9273.4 9757.9 9797.1 9981.3 10307.8 10927.0 11168.1 11175.0 11316.0 07:41:43 INFO - PROCESS | 6618 | -------- Summary: end -------- 07:41:43 INFO - PROCESS | 6618 | 07:41:44 INFO - TEST-INFO | 6618: exit 0 07:41:44 INFO - TEST-OK | dromaeo_css | took 1116555ms 07:41:44 INFO - TEST-START | kraken 07:41:44 INFO - operating with platform_type : mac_ 07:41:44 INFO - Initialising browser for kraken test... 07:41:44 INFO - TEST-INFO | started process 6621 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp6jjGSx/profile http://localhost:57979/getInfo.html) 07:41:46 INFO - PROCESS | 6621 | __metrics Screen width/height:1600/1200 07:41:46 INFO - PROCESS | 6621 | colorDepth:24 07:41:46 INFO - PROCESS | 6621 | Browser inner width/height: 1024/689 07:41:46 INFO - PROCESS | 6621 | __metrics 07:41:46 INFO - PROCESS | 6621 | 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" 07:41:46 INFO - PROCESS | 6621 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:41:47 INFO - TEST-INFO | 6621: exit 0 07:41:47 INFO - Browser initialized. 07:41:47 INFO - Running cycle 1/1 for kraken test... 07:41:47 INFO - TEST-INFO | started process 6623 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp6jjGSx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:59 INFO - PROCESS | 6623 | RSS: Main: 167600128 07:41:59 INFO - PROCESS | 6623 | 07:42:02 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-beat-detection) 07:42:03 INFO - PROCESS | 6623 | RSS: Main: 217010176 07:42:03 INFO - PROCESS | 6623 | 07:42:05 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-dft) 07:42:06 INFO - PROCESS | 6623 | RSS: Main: 227184640 07:42:06 INFO - PROCESS | 6623 | 07:42:09 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-fft) 07:42:10 INFO - PROCESS | 6623 | RSS: Main: 324485120 07:42:10 INFO - PROCESS | 6623 | 07:42:11 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57979/tests/kraken/driver.html?testName=audio-oscillator) 07:42:12 INFO - PROCESS | 6623 | RSS: Main: 226795520 07:42:12 INFO - PROCESS | 6623 | 07:42:14 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57979/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:42:15 INFO - PROCESS | 6623 | RSS: Main: 228651008 07:42:15 INFO - PROCESS | 6623 | 07:42:18 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57979/tests/kraken/driver.html?testName=imaging-darkroom) 07:42:18 INFO - PROCESS | 6623 | RSS: Main: 267558912 07:42:18 INFO - PROCESS | 6623 | 07:42:21 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57979/tests/kraken/driver.html?testName=imaging-desaturate) 07:42:22 INFO - PROCESS | 6623 | RSS: Main: 271126528 07:42:22 INFO - PROCESS | 6623 | 07:42:25 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57979/tests/kraken/driver.html?testName=json-parse-financial) 07:42:25 INFO - PROCESS | 6623 | RSS: Main: 267079680 07:42:25 INFO - PROCESS | 6623 | 07:42:27 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57979/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:42:27 INFO - PROCESS | 6623 | RSS: Main: 245391360 07:42:27 INFO - PROCESS | 6623 | 07:42:29 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:42:30 INFO - PROCESS | 6623 | RSS: Main: 250163200 07:42:30 INFO - PROCESS | 6623 | 07:42:32 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:42:33 INFO - PROCESS | 6623 | RSS: Main: 255668224 07:42:33 INFO - PROCESS | 6623 | 07:42:36 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:42:36 INFO - PROCESS | 6623 | RSS: Main: 272130048 07:42:36 INFO - PROCESS | 6623 | 07:42:39 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:42:40 INFO - PROCESS | 6623 | RSS: Main: 265641984 07:42:40 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | Cycle 1(1): loaded http://localhost:57979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57979/tests/kraken/driver.html?testName=ai-astar) 07:42:42 INFO - PROCESS | 6623 | RSS: Main: 310136832 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | __start_tp_report 07:42:42 INFO - PROCESS | 6623 | _x_x_mozilla_page_load 07:42:42 INFO - PROCESS | 6623 | _x_x_mozilla_page_load_details 07:42:42 INFO - PROCESS | 6623 | |i|pagename|runs| 07:42:42 INFO - PROCESS | 6623 | |0;ai-astar;115;115;117;115;115;115;115;114;114;116 07:42:42 INFO - PROCESS | 6623 | |1;audio-beat-detection;138;99;131;145;105;107;105;105;124;105 07:42:42 INFO - PROCESS | 6623 | |2;audio-dft;185;182;184;183;184;182;184;183;182;185 07:42:42 INFO - PROCESS | 6623 | |3;audio-fft;84;57;60;90;57;59;57;59;72;56 07:42:42 INFO - PROCESS | 6623 | |4;audio-oscillator;84;71;85;69;68;68;81;69;68;82 07:42:42 INFO - PROCESS | 6623 | |5;imaging-gaussian-blur;91;88;91;86;129;124;94;87;91;88 07:42:42 INFO - PROCESS | 6623 | |6;imaging-darkroom;95;95;94;95;94;94;95;94;95;95 07:42:42 INFO - PROCESS | 6623 | |7;imaging-desaturate;138;87;87;87;82;86;99;138;130;84 07:42:42 INFO - PROCESS | 6623 | |8;json-parse-financial;54;52;51;52;55;58;56;57;55;56 07:42:42 INFO - PROCESS | 6623 | |9;json-stringify-tinderbox;70;66;79;74;71;68;71;87;95;68 07:42:42 INFO - PROCESS | 6623 | |10;stanford-crypto-aes;84;81;83;84;80;80;83;79;87;82 07:42:42 INFO - PROCESS | 6623 | |11;stanford-crypto-ccm;134;134;136;146;142;143;135;135;206;158 07:42:42 INFO - PROCESS | 6623 | |12;stanford-crypto-pbkdf2;162;165;166;208;200;163;169;162;162;172 07:42:42 INFO - PROCESS | 6623 | |13;stanford-crypto-sha256-iterative;64;65;65;64;62;65;67;81;78;80 07:42:42 INFO - PROCESS | 6623 | __end_tp_report 07:42:42 INFO - PROCESS | 6623 | __start_cc_report 07:42:42 INFO - PROCESS | 6623 | _x_x_mozilla_cycle_collect,1969 07:42:42 INFO - PROCESS | 6623 | __end_cc_report 07:42:42 INFO - PROCESS | 6623 | __startTimestamp1490712162428__endTimestamp 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | ------- Summary: start ------- 07:42:42 INFO - PROCESS | 6623 | Number of tests: 14 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 07:42:42 INFO - PROCESS | 6623 | Values: 115.0 115.0 117.0 115.0 115.0 115.0 115.0 114.0 114.0 116.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:127.50 stddev:16.55 (13.0%) stddev-sans-first:15.60 07:42:42 INFO - PROCESS | 6623 | Values: 138.0 99.0 131.0 145.0 105.0 107.0 105.0 105.0 124.0 105.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.17 (0.6%) stddev-sans-first:1.09 07:42:42 INFO - PROCESS | 6623 | Values: 185.0 182.0 184.0 183.0 184.0 182.0 184.0 183.0 182.0 185.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#3] audio-fft Cycles:10 Average:65.10 Median:59.50 stddev:12.49 (21.0%) stddev-sans-first:11.22 07:42:42 INFO - PROCESS | 6623 | Values: 84.0 57.0 60.0 90.0 57.0 59.0 57.0 59.0 72.0 56.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:76.00 stddev:7.44 (9.8%) stddev-sans-first:7.06 07:42:42 INFO - PROCESS | 6623 | Values: 84.0 71.0 85.0 69.0 68.0 68.0 81.0 69.0 68.0 82.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:89.50 stddev:15.82 (17.7%) stddev-sans-first:16.64 07:42:42 INFO - PROCESS | 6623 | Values: 91.0 88.0 91.0 86.0 129.0 124.0 94.0 87.0 91.0 88.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:42:42 INFO - PROCESS | 6623 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#7] imaging-desaturate Cycles:10 Average:101.80 Median:86.50 stddev:23.66 (27.4%) stddev-sans-first:21.16 07:42:42 INFO - PROCESS | 6623 | Values: 138.0 87.0 87.0 87.0 82.0 86.0 99.0 138.0 130.0 84.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.50 stddev:2.32 (4.2%) stddev-sans-first:2.45 07:42:42 INFO - PROCESS | 6623 | Values: 54.0 52.0 51.0 52.0 55.0 58.0 56.0 57.0 55.0 56.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#9] json-stringify-tinderbox Cycles:10 Average:74.90 Median:72.50 stddev:9.41 (13.0%) stddev-sans-first:9.81 07:42:42 INFO - PROCESS | 6623 | Values: 70.0 66.0 79.0 74.0 71.0 68.0 71.0 87.0 95.0 68.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:2.41 (2.9%) stddev-sans-first:2.47 07:42:42 INFO - PROCESS | 6623 | Values: 84.0 81.0 83.0 84.0 80.0 80.0 83.0 79.0 87.0 82.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:142.50 stddev:22.09 (15.5%) stddev-sans-first:22.93 07:42:42 INFO - PROCESS | 6623 | Values: 134.0 134.0 136.0 146.0 142.0 143.0 135.0 135.0 206.0 158.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:167.50 stddev:16.82 (10.0%) stddev-sans-first:17.37 07:42:42 INFO - PROCESS | 6623 | Values: 162.0 165.0 166.0 208.0 200.0 163.0 169.0 162.0 162.0 172.0 07:42:42 INFO - PROCESS | 6623 | 07:42:42 INFO - PROCESS | 6623 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:66.00 stddev:7.43 (11.3%) stddev-sans-first:7.65 07:42:42 INFO - PROCESS | 6623 | Values: 64.0 65.0 65.0 64.0 62.0 65.0 67.0 81.0 78.0 80.0 07:42:42 INFO - PROCESS | 6623 | -------- Summary: end -------- 07:42:42 INFO - PROCESS | 6623 | 07:42:43 INFO - TEST-INFO | 6623: exit 0 07:42:43 INFO - TEST-OK | kraken | took 58864ms 07:42:43 INFO - SUITE-END | took 1175s 07:42:43 INFO - Completed test suite (00:19:35) 07:42:43 INFO - javascript benchmark 07:42:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.582494275744, 3385.08602677277, 3404.4893266010095, 3440.7591468597207, 3446.1556918554957, 5061.342025536685, 5578.995780759462, 5769.971150144253, 5778.65328080315, 5821.796237131702, 5781.884362312751, 5840.649561026341, 5841.474267315941, 5848.853778655525, 5885.735141918613, 5216.321878155834, 5285.524302812746, 5322.0686379883555, 5346.6791992480385, 5389.326334208224, 5253.842384728464, 5278.47215278471, 5370.248165256867, 5390.91913621294, 5448.972755136238, 5268.5521730652945, 5320.733963301839, 5321.175217841241, 5337.786488540453, 5395.838124856241, 5374.247605335257, 5375.032494151052, 5388.0, 5404.108322126884, 5414.729263536808, 5162.0, 5286.392064912546, 5292.841214763564, 5297.947020529784, 5350.224217488481, 5671.404502527216, 5699.287589051369, 5718.342390625048, 5782.479576838063, 5821.2141360916585, 6104.428839602322, 6139.017757158833, 6139.631622102688, 6143.078538219303, 6144.139820425144, 6134.663092688834, 6142.570020098595, 6145.3547377525165, 6171.6297022178815, 6176.104464852571, 5002.89994200114, 5867.76528938842, 5936.643801371888, 5949.553783466214, 5965.880682386328, 6284.4344009039405, 6298.370162983757, 6298.811035668938, 6309.684515774193, 6309.684515774193, 6020.638761674226, 6111.84720381994, 6115.816525504242, 6184.412480814315, 6188.690565471708, 5285.894282114336, 6206.782762603287, 6260.812175634647, 6261.530385221126, 6266.122742816009, 6281.560290779602, 6283.6858157091965, 6286.528510361742, 6286.842828929313, 6296.43332100104, 6283.214598175228, 6295.087212354275, 6304.306526282106, 6304.842378940563, 6318.810435686937, 4951.554360107608, 4999.150144475375, 4999.675021123615, 5008.6744361616375, 5041.873953151201, 4475.597196252353, 4524.343970124313, 4526.117407105583, 4527.253003254426, 4558.8632341029825, 5023.547880690755, 5823.155642431909, 5836.066229403275, 5861.677607731615, 5866.090755932837, 6204.0, 6205.5345849061505, 6212.378762123842, 6257.092721555349, 6290.150829638032, 5789.9867523183275, 5859.677717725566, 5860.824175274749, 5888.793892213752, 5899.380565040695, 5456.645318054314, 5515.338159420895, 5529.142982837667, 5531.640443371249, 5532.612717109763, 6212.285587157535, 6272.341404152498, 6339.049142628643, 6343.143675603735, 6345.238571371465, 6204.534659900616, 6213.00591905293, 6222.12890195364, 6270.6551139685935, 6272.780452684134, 6333.936660633519, 6344.397282258178, 6358.078078678658, 6360.268569114426, 6444.9355506444335, 6136.365905528278, 6294.8111556653375, 6302.306746257999, 6308.053791931247, 6336.968315158395, 6214.533909956681, 6228.844278893064, 6248.125262463168, 6251.6561589113035, 6317.30509643948, 6077.24034495688, 6245.6252624842655, 6260.217472815898, 6276.278228003655, 6276.905846412399, 6138.631682099089, 6216.627002379872, 6264.906026409699, 6272.843178920563, 6277.340879207617, 5933.465988061095, 5950.077737950624, 6047.183630209865, 6093.268807743099, 6096.177016102769, 6208.81373558794, 6241.063840423973, 6248.4688801452385, 6271.749130034747, 6286.968565157145, 5908.9954707698935, 5945.34601193877, 6073.423024812636, 6083.66539840313, 6099.664518451527], "value": 5757.953197865768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.9450830140482, 499.8827620268701, 509.21580765620945, 510.3365624687905, 528.8334174734958, 34710.0, 42174.78912605436, 44711.0, 44836.3274550882, 47152.76423617886, 46357.76821115898, 46595.534044659544, 46597.53402465974, 46620.0, 46881.29678054832, 9200.631974721036, 9657.17913977311, 9881.20950323976, 9884.0, 9891.851622225637, 9165.266778657724, 12020.398980050963, 12286.754264914696, 12312.445939932724, 12483.500659973635, 10750.462476876124, 12213.694657633541, 12317.384130793469, 12319.0, 12324.32216228107, 12097.818532722016, 12161.635150945485, 12167.0, 12181.878181218162, 12182.964448021929, 11949.22330048544, 12019.459124339426, 12047.096467764954, 12076.21504602198, 12087.274763514217, 42815.35776963317, 42983.35524967128, 43022.139557208684, 43031.78484107591, 43064.56935430637, 3948.4274780157, 4093.6111069448357, 4095.058136628592, 4111.691623128248, 4139.503259608866, 31099.533506997413, 32128.0, 32973.83513082443, 33386.833065834755, 33656.83171584151, 3042.4523585754555, 3246.469501658506, 3406.6423025582203, 3449.5170676105367, 3493.8602455901732, 441878.0, 446975.7651211723, 450349.99999999674, 450649.74675126415, 451881.7405912982, 68219.0, 68674.65662671755, 68737.31262687308, 68774.31225687779, 68832.0, 71451.92822107673, 71997.2800272001, 72075.0, 72211.638941806, 72280.63859680668, 15064.246787660573, 18258.087095645165, 18260.0, 18275.63448731018, 18282.62880283984, 12672.873271267354, 12963.287019214034, 13914.51299204523, 14012.019158658795, 14015.789763153562, 16983.74524382135, 18883.809744242597, 23639.527209456057, 23673.526529469313, 23701.407464813172, 8127.2279133482225, 9055.68305109318, 9257.90742092584, 9283.953580232055, 9291.953540232256, 760.9809754756176, 886.6877022007465, 896.5562046786882, 897.838389089957, 942.830290547708, 30508.237294067825, 31223.687763122078, 31433.528497072562, 31517.36965260682, 32026.0, 975.7024107647094, 1078.6979645699216, 1100.944952752359, 1122.2705241592867, 1181.6218809980724, 15758.76361854573, 16217.918910405608, 16366.099864507329, 16370.590735231477, 16427.91786041086, 654136.0, 660989.0, 662249.0, 662506.0, 662533.0, 60791.39208607946, 61158.0, 61191.69404152951, 61231.387686122565, 61434.69282653558, 1366.2895294446832, 1408.9718205636034, 1462.5739903594335, 1510.8035955325956, 1522.9695406091816, 30697.0, 31798.523022154222, 32922.34155316928, 33122.83438582792, 33565.66434335723, 53639.46360536501, 54607.90784184215, 54638.72680636571, 54690.72654636701, 54711.17933230925, 452372.0, 513424.0, 515992.62040588126, 518843.0, 519686.0, 36551.287862562174, 37603.623963760016, 38359.61640383561, 43948.780256098515, 44565.777171113936, 45871.31193032041, 50470.0, 50844.74577627088, 51645.48354516557, 51732.48267517277, 31042.84478577683, 31816.204594884388, 31883.20291992719, 33481.497777532866, 33874.983750487525, 26381.868090659424, 31584.684153158174, 32010.35979280355, 32577.511337329484, 32792.67207327896, 36547.81726091352, 37258.0, 37388.0, 37603.24793504169, 37898.242035159696, 31962.0, 32003.519947200344, 32080.839595802805, 32091.839540802146, 32893.67106329002, 23526.882365588062, 24961.50076998486, 25037.244413338143, 25432.491350173263, 25433.364165896], "value": 21238.90177672106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.6643222506394, 357.3870811558179, 411.2433123053582, 412.0954504861829, 437.3308837478657, 21027.579448411023, 22149.446263843412, 22174.55650886983, 22301.776982230174, 22799.772002279973, 22483.0, 22545.549089018208, 22938.853057347107, 23233.535329293405, 23236.65145022826, 5671.8014869479475, 6199.690015499207, 6202.2867370252325, 6205.255369355684, 6209.6895155242055, 5747.482726554609, 5933.48186186846, 5980.700964951757, 6090.756369745205, 6114.816555503342, 6011.699415029253, 6024.307204671475, 6029.668368239745, 6040.546958978094, 6041.305249896274, 5757.337906140785, 5956.821295361146, 6021.548383871227, 6037.667928263966, 6051.878962420727, 5147.996140752554, 5288.206768984683, 5320.733963301819, 5328.280682107905, 5329.0, 27004.324891877663, 27515.0, 27533.449331013468, 27788.30529236765, 27869.442611147664, 2607.1526753805088, 2786.2616406652255, 2812.8874845006176, 2843.9289017774513, 2861.799674022819, 10392.948035259775, 10503.054725074704, 10571.312864663772, 10816.567337306498, 10942.507587158598, 1858.27527264367, 1916.5017095555118, 1924.8267655910895, 1927.6626590346773, 1945.4455480188078, 150282.0, 150777.0, 154313.22843385712, 155900.0, 158347.0, 10222.6422075227, 12157.0, 12328.568500102454, 12360.629181124581, 12421.0, 16535.586610334598, 16590.50228493147, 16609.83390166083, 16615.833841661428, 16616.25226864794, 8072.515649061075, 8962.311306608122, 9292.953535232416, 9296.953515232515, 9453.905460945303, 9044.954775226213, 9120.407173533698, 9140.908590914005, 9324.207442367338, 9328.813423731488, 4840.443349014838, 4927.90144197114, 4936.679115857458, 4951.5048495150195, 5008.348914641073, 2037.0527704617425, 2076.4912596413674, 2078.511549785799, 2082.7708952015264, 2083.427057559153, 1016.4511163971373, 1052.7157667429751, 1066.328213225663, 1084.311462221495, 1113.7828123516, 22523.0, 23031.309060728207, 23039.078436862674, 23063.654045189334, 23095.422614434436, 926.6617684545228, 978.6707635826829, 998.3161534348849, 1012.5747186181821, 1108.51225460797, 7179.712811487587, 7203.38771204443, 7291.708331666674, 7432.033835601337, 7457.216992215847, 733369.0, 744098.0, 744480.0, 747603.0, 749699.0, 139450.30274848765, 164287.0, 164884.3511564893, 166725.0, 171803.0, 1131.2590253384046, 1148.2077366617007, 1175.506287359294, 1175.6179241746468, 1176.9117316201318, 12567.748645027232, 12704.6823829405, 12855.678608034874, 13031.413586388824, 13150.0, 50572.24141637952, 51251.718707031134, 51485.7425712869, 59090.704546478715, 60349.69825150846, 87875.0, 90951.0, 91579.54210228907, 93169.0, 93553.0, 7188.388986936169, 8438.535880526384, 8693.826123477369, 8708.258348330486, 8947.552622368985, 13393.732125357634, 13408.664783380493, 13417.66455838612, 13871.72256554843, 14001.5099471518, 10982.835257471304, 11549.42252887369, 11802.586909458129, 11931.940340298243, 11973.042156627624, 10810.837837432602, 10851.837222441512, 11117.11063114965, 11142.554297827995, 11288.43557822122, 10871.836922446011, 11416.0, 11683.824742628698, 12104.93947530292, 12108.818367724314, 7610.315071643578, 8530.402871798915, 8673.306135509018, 8691.782705432415, 8862.0, 8648.610812513578, 10627.0, 11691.356975366436, 11727.765444690887, 11877.524899003944], "value": 10097.532977628209, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.9389377478012, 1455.7015811758583, 1474.1965628732346, 1476.475851072869, 1476.5570328901333, 7686.5772382518935, 8347.833043339137, 8443.0, 8595.742127736177, 8730.432521886089, 8500.149985001497, 8564.486130832154, 8566.229039386453, 8566.742997710078, 8588.012378576466, 2148.5488047510044, 2386.4033991502124, 2420.419099416145, 2425.575524283252, 2426.4783071639595, 2226.8329875259337, 2369.0, 2449.3754092706336, 2451.632255161731, 2454.141050632273, 2400.975990240093, 2411.963820542693, 2414.5895197816326, 2415.3961509622595, 2423.200343886513, 2334.614788559894, 2355.3993731598503, 2362.9409264768346, 2363.0665886974634, 2368.301351101429, 2382.3448551648435, 2389.414593424622, 2398.8080953523677, 2419.334682962182, 2423.87880605969, 8618.741437756877, 8686.56567171639, 8688.565571721389, 8690.652373905035, 8694.565271736388, 5229.320188375525, 5379.67721936685, 5380.2736630555155, 5382.4886635769535, 5403.675779453245, 3425.6231814500634, 3578.3022310649435, 3635.5273814404222, 3635.9454608180636, 3643.052806270389, 1216.2033867816594, 1249.6813312605318, 1264.102487234065, 1303.055284918436, 1312.9934350328188, 11037.337759734442, 11040.613578524793, 11106.111511079174, 11126.721831954184, 11146.721331966684, 4691.7053180771745, 4736.5973892219545, 4793.352897358882, 4837.32277481153, 4858.319835223072, 9795.461249631338, 9798.510074496247, 9810.705678829647, 9818.80362392748, 9828.361156524947, 5368.0, 5459.8362049137795, 5463.071277882769, 5467.6719396836315, 5477.370102438191, 4464.196444639931, 4782.880427989258, 4890.290907818347, 4996.175631020841, 5010.574101201366, 3719.4606782017, 3987.2424239394422, 4107.589241075928, 4126.154138401621, 4127.814248358831, 1130.4517309105242, 1304.276126749663, 1331.8801307882336, 1332.4004198110888, 1343.6909510812372, 949.1931857920712, 964.9517524123765, 982.4498280962683, 998.9800203995879, 999.4153420249236, 5568.192612071227, 5665.801696940587, 5724.914126288109, 5820.214271073351, 5829.621074630136, 1011.9241056920761, 1030.6444276724667, 1031.3244824639874, 1055.1347894726405, 1065.648336049102, 3780.1872597391693, 3872.728908976401, 3908.6482216600643, 3983.5618082010956, 4004.2391945530258, 9717.368371055858, 9988.550515226832, 10056.949715251378, 10067.043630855058, 10068.993100690019, 9845.901540984642, 9864.95067524672, 9953.153981911619, 10014.998500150072, 10023.298369114093, 6588.73645054202, 8005.479643823133, 8009.679612815422, 8009.799755006172, 8019.198080191934, 5440.156775699773, 5557.305336832896, 5594.916076258778, 5737.139429085671, 5809.099589563624, 7963.522188668699, 9146.405483643543, 9217.170454659114, 9285.582148803454, 9287.349885507949, 8105.635246414044, 9050.18548330627, 9233.353665243369, 9348.25213982866, 9434.48110353937, 7049.400800931773, 7279.4540409468445, 7301.08736407949, 7376.520526165782, 7402.29678180572, 7486.4759466836795, 7663.693452261847, 7707.576083315472, 7828.138904720362, 8138.470999385021, 6535.215774107138, 6948.444124470131, 7070.257622949516, 7150.892736608851, 7177.138743350832, 6956.0, 7021.473389495706, 7026.789196324118, 7055.435565154878, 7084.752033678797, 6459.806205813833, 6561.1470508835455, 6566.8358291043105, 6567.605943643397, 6574.112494813139, 4946.431160416454, 4963.925541116814, 4967.503249675004, 5081.288619593334, 5224.085784987536, 5030.673006254582, 5050.84847454577, 5064.366954130734, 5089.491050894881, 5148.794048238028], "value": 4537.78245069668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.4660572261637, 364.96897763690083, 377.29069349622716, 387.1521368203636, 387.9747816391933, 4718.315844202589, 5106.41276253231, 5163.690178589282, 5248.973755131224, 5253.088362381176, 5086.92369614456, 5116.360454943132, 5153.0885049946755, 5226.92159617606, 5233.293505376773, 4115.176964607075, 4171.8539851105215, 4185.351270553054, 4185.74885506869, 4218.641415479688, 3996.780177090259, 4029.97985010076, 4175.791210439481, 4227.239096962546, 4230.7250028748185, 3343.732501399882, 4125.257453658341, 4162.458880345566, 4165.33354663254, 4196.832126714928, 3359.277755282626, 3442.4836274558893, 4120.662263566521, 4136.875893723193, 4157.355609880473, 3183.1564635371647, 3516.1912760065075, 3680.0, 3716.646918542734, 3716.981415092934, 4428.759947214785, 4971.403431588196, 5087.923681144785, 5158.871028224325, 5231.267622532849, 4546.704464209815, 4641.605463535603, 4805.711657300573, 4811.230203167476, 4848.636352273594, 5566.832995010116, 5569.192467092249, 5571.554275657978, 5595.916061259044, 5628.437156284339, 3879.8254078566533, 4078.653314468274, 4094.242565125461, 4100.65144462718, 4125.66994640428, 5740.741666625012, 5750.511206547449, 5751.367349591542, 5751.396103409165, 5798.652080875161, 3781.565120011179, 3905.7656540607654, 4179.561146079679, 4192.538820729717, 4208.116295577963, 4038.7237121215526, 4200.726952748061, 4227.070044590185, 4242.215190189825, 4262.722923009995, 4014.374178457729, 4703.212779143972, 4734.644901632322, 4749.24012158053, 4763.856674398119, 5590.0, 5593.440655934374, 5610.0, 5613.270274864323, 5648.4633959773755, 1256.9685757856128, 1301.9934900325627, 1337.7024286442136, 1341.9060665753498, 1362.1486570893192, 858.2704701004096, 928.9860652090224, 963.4700914496999, 967.7725734452398, 975.3952549419264, 4158.792060396968, 4280.966540893113, 4929.309896614477, 4929.954069061299, 4932.161532539405, 5010.515588548229, 5336.973315133477, 5421.566274698093, 5446.887599862079, 5454.936287423993, 4203.789810509462, 4702.506236845151, 4834.419869615669, 4898.975505122452, 4915.459299477055, 2544.389346556813, 2709.0718458235638, 2769.986150069237, 2835.1365121227295, 2848.629678141828, 4544.386507821468, 5193.350831146106, 5308.761105750251, 5628.283373571018, 5633.492985631313, 4589.655775816827, 4857.595490232357, 5110.693358398508, 5458.754356053987, 5491.787304426875, 4875.951670390812, 5294.8941021180135, 5502.642328248731, 5566.693831839207, 5585.944140558542, 5126.79492820283, 5334.546563542142, 5381.354237491526, 5386.649867758583, 5401.702906340189, 5172.663776854492, 5235.712035838065, 5239.816606418757, 5260.238374853079, 5345.438728933562, 5038.798448062036, 5044.899102018013, 5440.727963601883, 5458.235846981346, 5498.422665620053, 3502.509648649242, 3902.239063382613, 3910.941335879907, 3918.9418856909047, 3927.3716205407, 4647.488776234679, 4795.214771098856, 5316.6012549058205, 5320.600954928474, 5323.77553162767, 4583.656225783013, 4815.879603009953, 4865.9756701216265, 4891.51084891508, 5079.16193828029, 5566.582506312124, 5567.638103523258, 5576.33084029919, 5579.218909352775, 5611.046122159161, 4208.726432781859, 4634.675572710013, 5126.487351264844, 5353.982743278764, 5465.398806131243, 4590.70768831144, 5405.783628712366, 5495.368032676293, 5533.363663178625, 5567.944320556905, 4671.85984420468, 5439.700816455133, 5476.561875049907, 5483.698396588226, 5557.832855100312], "value": 4057.6359375756674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.1286788571199, 712.7113519024794, 721.1670520548766, 756.5007095317088, 764.3006648916241, 14867.925660371697, 16093.597660058504, 16391.59021024475, 16392.508224753277, 16424.260908259126, 14683.706325873476, 14769.483068092619, 14896.404143834234, 15023.549293521184, 15046.322915468803, 847.1189962439072, 903.1781079217913, 905.108468158863, 905.8143080668447, 906.6328137104483, 724.5906063074373, 747.484235877243, 859.0807835615893, 891.17121077398, 891.3804905590617, 948.3977674176913, 950.6102497975832, 951.2627713522006, 959.4147569982305, 959.8080383923208, 952.1240458777941, 955.5270141280041, 959.0936564946163, 960.4429430930113, 964.8118616869713, 710.4387533848305, 711.2460791560962, 711.352669071148, 711.6477343714843, 711.9644017799089, 15754.13352265625, 15965.760513592306, 16100.355985760556, 16143.596410089724, 16478.42325518601, 14863.33115009827, 15007.324670389859, 15301.387944482207, 15381.846181538152, 15482.30329635169, 10721.892781072245, 11938.104642151786, 12002.939985300105, 12181.756364872654, 12196.573119940847, 3744.2885851688093, 3745.906352341186, 3760.4735337052834, 3830.3871380579253, 3914.256291304643, 93467.0, 115485.4225728866, 115893.99999999916, 118006.40996794961, 118159.81840181487, 10500.789984200273, 10989.560417583207, 11378.601748938747, 11700.2979821211, 11878.821817672742, 21987.890060549915, 22292.66561001586, 22381.104755809585, 22403.775962240496, 22490.775092249194, 7828.569428681477, 7890.566018869017, 7893.921060789434, 7945.64244608994, 7999.240072193249, 4411.117776444724, 4415.735055896656, 4426.690131690815, 4524.5701658342405, 4666.69666471685, 3711.6102809205186, 3765.1528406108955, 3785.7539259948016, 3787.3750831112557, 3822.445745366962, 654.1953397321322, 661.2131563439492, 661.4443867151616, 673.3670349871105, 677.6679427080695, 572.2017785189637, 593.7684303121786, 598.7724664627414, 607.2561112637072, 614.658864330301, 10293.433861137559, 10693.679189624323, 10737.51681174349, 10805.513751881184, 11152.386618736047, 693.7537174303151, 704.2886684448744, 759.5366826235992, 764.0411283838747, 766.8121310279017, 4386.627136693417, 4792.424909010941, 5157.252198431206, 5196.4803519648485, 5206.088934436459, 100195.99804002013, 101475.0, 112203.0, 112615.4369228165, 115366.0, 78344.60827695826, 79791.0, 94617.52691236637, 95843.52078239564, 98584.09911306282, 74500.25499745042, 78898.6055069721, 79430.60284698539, 80199.0, 82838.58580707057, 10782.622608208674, 10810.891891080988, 11035.779284414428, 11415.143864210384, 11457.59898403552, 46916.765416172704, 46943.29585056158, 48879.511204887494, 48943.0, 49638.759031024514, 61120.0, 65266.673666631366, 65453.672731636034, 68032.6598367005, 68817.65591172013, 13307.0, 13451.798223026859, 13559.86440135586, 13955.441782328593, 13972.091814032055, 12875.905548028522, 13857.930710346383, 14734.852651473348, 15009.774853377427, 15050.322735476711, 13960.860391395956, 14071.296435177996, 14456.710865782836, 14491.565253042425, 14911.0, 13612.25132617676, 14196.503122390666, 14284.500042498463, 14449.0, 14742.484013059491, 13758.449662013407, 13868.72262554723, 13890.58328250154, 14109.506167284097, 14193.148411095368, 8927.241184499131, 9273.397229180351, 9757.853632195382, 9797.06927841854, 9981.251406144424, 10307.793844123225, 10927.0, 11168.1065514757, 11174.994250517493, 11316.0], "value": 7708.507204501827, "unit": "score"}], "name": "dromaeo_css", "value": 7480.98334679092, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 117.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 99.0, 131.0, 145.0, 105.0, 107.0, 105.0, 105.0, 124.0, 105.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 184.0, 183.0, 184.0, 182.0, 184.0, 183.0, 182.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 60.0, 90.0, 57.0, 59.0, 57.0, 59.0, 72.0, 56.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 85.0, 69.0, 68.0, 68.0, 81.0, 69.0, 68.0, 82.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 86.0, 129.0, 124.0, 94.0, 87.0, 91.0, 88.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 87.0, 87.0, 87.0, 82.0, 86.0, 99.0, 138.0, 130.0, 84.0], "value": 101.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 52.0, 55.0, 58.0, 56.0, 57.0, 55.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 79.0, 74.0, 71.0, 68.0, 71.0, 87.0, 95.0, 68.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 84.0, 80.0, 80.0, 83.0, 79.0, 87.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 136.0, 146.0, 142.0, 143.0, 135.0, 135.0, 206.0, 158.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 166.0, 208.0, 200.0, 163.0, 169.0, 162.0, 162.0, 172.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 62.0, 65.0, 67.0, 81.0, 78.0, 80.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1448.5, "alertThreshold": 2.0}]} 07:42:43 INFO - Return code: 0 07:42:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:42:43 INFO - # TBPL SUCCESS # 07:42:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:43 INFO - 2017-03-28 07:42:43.716 screenresolution[6627:123324] starting screenresolution argv=screenresolution get 07:42:43 INFO - 2017-03-28 07:42:43.719 screenresolution[6627:123324] Display 0: 1600x1200x32@60 07:42:43 INFO - 2017-03-28 07:42:43.725 screenresolution[6628:123327] starting screenresolution argv=screenresolution list 07:42:43 INFO - Available Modes on Display 0 07:42:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:43 INFO - Intel Iris: 07:42:43 INFO - Chipset Model: Intel Iris 07:42:43 INFO - Type: GPU 07:42:43 INFO - Bus: Built-In 07:42:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:43 INFO - Vendor: Intel (0x8086) 07:42:43 INFO - Device ID: 0x0a2e 07:42:43 INFO - Revision ID: 0x0009 07:42:43 INFO - Displays: 07:42:43 INFO - Display: 07:42:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:43 INFO - Display Serial Number: 1600x1200 60 07:42:43 INFO - Main Display: Yes 07:42:43 INFO - Mirror: Off 07:42:43 INFO - Online: Yes 07:42:43 INFO - Rotation: Supported 07:42:43 INFO - Return code: 0 07:42:43 INFO - Running post-action listener: _resource_record_post_action 07:42:43 INFO - [mozharness: 2017-03-28 14:42:43.961478Z] Finished run-tests step (success) 07:42:43 INFO - Running post-run listener: _resource_record_post_run 07:42:44 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 1539072; Write bytes: 423299584; Read time: 19; Write time: 1767 07:42:44 INFO - TinderboxPrint: CPU usage
54.0% 07:42:44 INFO - TinderboxPrint: I/O read bytes / time
1,539,072 / 19 07:42:44 INFO - TinderboxPrint: I/O write bytes / time
423,299,584 / 1,767 07:42:44 INFO - TinderboxPrint: CPU idle
2,193.4 (46.0%) 07:42:44 INFO - TinderboxPrint: CPU system
956.1 (20.1%) 07:42:44 INFO - TinderboxPrint: CPU user
1,616.2 (33.9%) 07:42:44 INFO - TinderboxPrint: Swap in / out
123,572,224 / 0 07:42:44 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121233920; Write bytes: 113840128; Read time: 11146; Write time: 331 07:42:44 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1420288; Write bytes: 299399680; Read time: 17; Write time: 1390 07:42:44 INFO - Running post-run listener: _upload_blobber_files 07:42:44 INFO - Blob upload gear active. 07:42:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:42:44 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 07:42:44 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'] 07:42:44 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 07:42:44 INFO - (blobuploader) - INFO - Open directory for files ... 07:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:45 INFO - (blobuploader) - INFO - Done attempting. 07:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:46 INFO - (blobuploader) - INFO - Done attempting. 07:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:47 INFO - (blobuploader) - INFO - Done attempting. 07:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:42:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:50 INFO - (blobuploader) - INFO - Done attempting. 07:42:50 INFO - (blobuploader) - INFO - Iteration through files over. 07:42:50 INFO - Return code: 0 07:42:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:42:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:42:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50e7cee196b95c6c8d6ba7d933e2a04c88949ec4c23daa620452ee66b6b3acb8a345004b25fd0695f987ec46a223e4dba9dd491986b34ac838033533019b138b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d28383e4583d44c970509bc003298ad858c96e20168334c2a2993eed0116816fa7ff67238a37729b7360772e84a9d8a5fbc1da6ab58d152b5f50a7d86df42a95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81b87b1f6b725d7f3b327e072d78f08d5ab7080435857d2dbc0cf3f591d8d78f343a8be9ba0f45966be98b029cb27a6ed6233666e414ce90b9c52bda9d81b37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6fdb9d1d91ba24caf16e1e2a9f6b660a2e58c0b2bc8342df55efade682bc7203e355c41970e7f870e51e5fc33264ebe0abcd8ab8f4396b970b0a26b7790d2"} 07:42:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:42:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:42:50 INFO - Contents: 07:42:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50e7cee196b95c6c8d6ba7d933e2a04c88949ec4c23daa620452ee66b6b3acb8a345004b25fd0695f987ec46a223e4dba9dd491986b34ac838033533019b138b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d28383e4583d44c970509bc003298ad858c96e20168334c2a2993eed0116816fa7ff67238a37729b7360772e84a9d8a5fbc1da6ab58d152b5f50a7d86df42a95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81b87b1f6b725d7f3b327e072d78f08d5ab7080435857d2dbc0cf3f591d8d78f343a8be9ba0f45966be98b029cb27a6ed6233666e414ce90b9c52bda9d81b37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6fdb9d1d91ba24caf16e1e2a9f6b660a2e58c0b2bc8342df55efade682bc7203e355c41970e7f870e51e5fc33264ebe0abcd8ab8f4396b970b0a26b7790d2"} 07:42:50 INFO - Running post-run listener: copy_logs_to_upload_dir 07:42:50 INFO - Copying logs to upload dir... 07:42:50 INFO - mkdir: /builds/slave/test/build/upload/logs 07:42:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.259620 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-28 07:42:50.076917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 07:42:50.082182) ========= 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.0THbogJs0f/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.N24pHTSwtZ/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/50e7cee196b95c6c8d6ba7d933e2a04c88949ec4c23daa620452ee66b6b3acb8a345004b25fd0695f987ec46a223e4dba9dd491986b34ac838033533019b138b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d28383e4583d44c970509bc003298ad858c96e20168334c2a2993eed0116816fa7ff67238a37729b7360772e84a9d8a5fbc1da6ab58d152b5f50a7d86df42a95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81b87b1f6b725d7f3b327e072d78f08d5ab7080435857d2dbc0cf3f591d8d78f343a8be9ba0f45966be98b029cb27a6ed6233666e414ce90b9c52bda9d81b37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6fdb9d1d91ba24caf16e1e2a9f6b660a2e58c0b2bc8342df55efade682bc7203e355c41970e7f870e51e5fc33264ebe0abcd8ab8f4396b970b0a26b7790d2"} build_url:https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010152 build_url: 'https://queue.taskcluster.net/v1/task/XzhyoxeNS8qC0Uqo0ZjqJg/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/50e7cee196b95c6c8d6ba7d933e2a04c88949ec4c23daa620452ee66b6b3acb8a345004b25fd0695f987ec46a223e4dba9dd491986b34ac838033533019b138b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d28383e4583d44c970509bc003298ad858c96e20168334c2a2993eed0116816fa7ff67238a37729b7360772e84a9d8a5fbc1da6ab58d152b5f50a7d86df42a95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81b87b1f6b725d7f3b327e072d78f08d5ab7080435857d2dbc0cf3f591d8d78f343a8be9ba0f45966be98b029cb27a6ed6233666e414ce90b9c52bda9d81b37b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf6fdb9d1d91ba24caf16e1e2a9f6b660a2e58c0b2bc8342df55efade682bc7203e355c41970e7f870e51e5fc33264ebe0abcd8ab8f4396b970b0a26b7790d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 07:42:50.114395) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:42:50.114729) ========= 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.0THbogJs0f/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.N24pHTSwtZ/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.004471 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:42:50.163220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 07:42:50.163543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 07:42:50.163856) ========= ========= Total master_lag: 0.18 =========