builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1490024537.04 results: success (0) buildid: 20170320065841 builduid: 0f6c18e28c764c3f815874a8b92ac039 revision: ab5725326239e69217d16e48df1e2661b5820833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.042341) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.042774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.043045) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.070962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.071447) ========= 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.WxpS22w7x4/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.DaHUa7UKIs/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-20 08:42:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.6M=0.001s 2017-03-20 08:42:17 (21.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124584 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.219738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.220062) ========= 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.WxpS22w7x4/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.DaHUa7UKIs/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.026989 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:17.268336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 08:42:17.268680) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ab5725326239e69217d16e48df1e2661b5820833 --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 ab5725326239e69217d16e48df1e2661b5820833 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WxpS22w7x4/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.DaHUa7UKIs/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-20 08:42:17,355 truncating revision to first 12 chars 2017-03-20 08:42:17,355 Setting DEBUG logging. 2017-03-20 08:42:17,355 attempt 1/10 2017-03-20 08:42:17,355 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ab5725326239?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 08:42:18,702 unpacking tar archive at: mozilla-beta-ab5725326239/testing/mozharness/ program finished with exit code 0 elapsedTime=1.610505 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 08:42:18.902165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:18.903665) ========= script_repo_revision: ab5725326239e69217d16e48df1e2661b5820833 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:18.904067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:18.904352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 08:42:18.924693) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-20 08:42:18.925013) ========= /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.WxpS22w7x4/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.DaHUa7UKIs/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:42:19 INFO - MultiFileLogger online at 20170320 08:42:19 in /builds/slave/test 08:42:19 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 08:42:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:19 INFO - {'append_to_log': False, 08:42:19 INFO - 'base_work_dir': '/builds/slave/test', 08:42:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:42:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:19 INFO - 'branch': 'Mozilla-Beta', 08:42:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:19 INFO - 'config_files': ('talos/mac_config.py',), 08:42:19 INFO - 'default_actions': ('clobber', 08:42:19 INFO - 'read-buildbot-config', 08:42:19 INFO - 'download-and-extract', 08:42:19 INFO - 'populate-webroot', 08:42:19 INFO - 'create-virtualenv', 08:42:19 INFO - 'install', 08:42:19 INFO - 'run-tests'), 08:42:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:19 INFO - 'download_minidump_stackwalk': True, 08:42:19 INFO - 'download_symbols': 'ondemand', 08:42:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:19 INFO - 'installer_path': 'installer.exe', 08:42:19 INFO - 'log_level': 'info', 08:42:19 INFO - 'log_name': 'talos', 08:42:19 INFO - 'log_to_console': True, 08:42:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:42:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:42:19 INFO - 'opt_config_files': (), 08:42:19 INFO - 'pip_index': False, 08:42:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:19 INFO - 'cmd': ('bash', 08:42:19 INFO - '-c', 08:42:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:19 INFO - 'enabled': True, 08:42:19 INFO - 'halt_on_failure': False, 08:42:19 INFO - 'name': 'check_screen_resolution'},), 08:42:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:19 INFO - 'cmd': ('bash', 08:42:19 INFO - '-c', 08:42:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:19 INFO - 'enabled': True, 08:42:19 INFO - 'halt_on_failure': False, 08:42:19 INFO - 'name': 'check_screen_resolution'},), 08:42:19 INFO - 'run_cmd_checks_enabled': True, 08:42:19 INFO - 'sps_profile': False, 08:42:19 INFO - 'sps_profile_interval': 0, 08:42:19 INFO - 'suite': 'dromaeojs', 08:42:19 INFO - 'system_bits': '32', 08:42:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:19 INFO - 'title': 't-yosemite-r7-0321', 08:42:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:19 INFO - 'use_talos_json': True, 08:42:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:19 INFO - 'work_dir': 'build'} 08:42:19 INFO - [mozharness: 2017-03-20 15:42:19.119686Z] Running clobber step. 08:42:19 INFO - Running pre-action listener: _resource_record_pre_action 08:42:19 INFO - Running main action method: clobber 08:42:19 INFO - rmtree: /builds/slave/test/build 08:42:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:21 INFO - Running post-action listener: _resource_record_post_action 08:42:21 INFO - [mozharness: 2017-03-20 15:42:21.596552Z] Finished clobber step (success) 08:42:21 INFO - [mozharness: 2017-03-20 15:42:21.596758Z] Running read-buildbot-config step. 08:42:21 INFO - Running pre-action listener: _resource_record_pre_action 08:42:21 INFO - Running main action method: read_buildbot_config 08:42:21 INFO - Using buildbot properties: 08:42:21 INFO - { 08:42:21 INFO - "project": "", 08:42:21 INFO - "product": "firefox", 08:42:21 INFO - "script_repo_revision": "production", 08:42:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:42:21 INFO - "repository": "", 08:42:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:42:21 INFO - "buildid": "20170320065841", 08:42:21 INFO - "pgo_build": "False", 08:42:21 INFO - "basedir": "/builds/slave/test", 08:42:21 INFO - "buildnumber": 1, 08:42:21 INFO - "slavename": "t-yosemite-r7-0321", 08:42:21 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:42:21 INFO - "platform": "yosemite_r7", 08:42:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:42:21 INFO - "branch": "mozilla-beta", 08:42:21 INFO - "repo_path": "releases/mozilla-beta", 08:42:21 INFO - "revision": "ab5725326239e69217d16e48df1e2661b5820833", 08:42:21 INFO - "stage_platform": "macosx64", 08:42:21 INFO - "builduid": "0f6c18e28c764c3f815874a8b92ac039", 08:42:21 INFO - "slavebuilddir": "test" 08:42:21 INFO - } 08:42:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 08:42:21 INFO - Running post-action listener: _resource_record_post_action 08:42:21 INFO - [mozharness: 2017-03-20 15:42:21.602284Z] Finished read-buildbot-config step (success) 08:42:21 INFO - [mozharness: 2017-03-20 15:42:21.602456Z] Running download-and-extract step. 08:42:21 INFO - Running pre-action listener: _resource_record_pre_action 08:42:21 INFO - Running main action method: download_and_extract 08:42:21 INFO - mkdir: /builds/slave/test/build/tests 08:42:21 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')]} 08:42:21 INFO - trying https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 08:42:21 INFO - Downloading https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/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 08:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/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 08:42:22 INFO - Downloaded 1165 bytes. 08:42:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:42:22 INFO - Using the following test package requirements: 08:42:22 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:42:22 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:42:22 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 08:42:22 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:42:22 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 08:42:22 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:42:22 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:42:22 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 08:42:22 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:42:22 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:42:22 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 08:42:22 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:42:22 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 08:42:22 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:42:22 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 08:42:22 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:42:22 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 08:42:22 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 08:42:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:42:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:42:22 INFO - Fetch https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:42:23 INFO - Expected file size: 16108263 08:42:23 INFO - Obtained file size: 16108263 08:42:30 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 08:42:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:42:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:42:30 INFO - Fetch https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:42:31 INFO - Expected file size: 16108263 08:42:31 INFO - Obtained file size: 16108263 08:42:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 08:42:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 08:42:37 INFO - Fetch https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 08:42:38 INFO - Expected file size: 14403663 08:42:38 INFO - Obtained file size: 14403663 08:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:38 INFO - trying https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:42:38 INFO - Downloading https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 08:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/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 08:42:40 INFO - Downloaded 58726595 bytes. 08:42:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:42:40 INFO - mkdir: /builds/slave/test/properties 08:42:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:40 INFO - Contents: 08:42:40 INFO - build_url:https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:42:41 INFO - Running post-action listener: _resource_record_post_action 08:42:41 INFO - Running post-action listener: set_extra_try_arguments 08:42:41 INFO - [mozharness: 2017-03-20 15:42:41.033677Z] Finished download-and-extract step (success) 08:42:41 INFO - [mozharness: 2017-03-20 15:42:41.033791Z] Running populate-webroot step. 08:42:41 INFO - Running pre-action listener: _resource_record_pre_action 08:42:41 INFO - Running main action method: populate_webroot 08:42:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:41 INFO - '--tppagecycles', 08:42:41 INFO - '7'], 08:42:41 INFO - 'tests': ['tsvgm']}}, 08:42:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['damp', 'tps']}, 08:42:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:42:41 INFO - 'tests': ['damp', 'tps']}, 08:42:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['dromaeo_dom']}, 08:42:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['basic_compositor_video']}, 08:42:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['a11yr', 08:42:41 INFO - 'ts_paint', 08:42:41 INFO - 'tpaint', 08:42:41 INFO - 'sessionrestore', 08:42:41 INFO - 'sessionrestore_no_auto_restore', 08:42:41 INFO - 'tabpaint']}, 08:42:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tsvgx', 08:42:41 INFO - 'tsvgr_opacity', 08:42:41 INFO - 'tart', 08:42:41 INFO - 'tscrollx', 08:42:41 INFO - 'cart', 08:42:41 INFO - 'tsvg_static']}, 08:42:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:41 INFO - 'tsvgr_opacity', 08:42:41 INFO - 'tart', 08:42:41 INFO - 'tscrollx', 08:42:41 INFO - 'cart', 08:42:41 INFO - 'tsvg_static']}, 08:42:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s'], 08:42:41 INFO - 'tests': ['tp5o']}, 08:42:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:42:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:42:41 INFO - 'talos_options': ['--disable-e10s', 08:42:41 INFO - '--xperf_path', 08:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:41 INFO - 'tests': ['tp5n']}, 08:42:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:42:41 INFO - 'talos_options': ['--xperf_path', 08:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:41 INFO - 'tests': ['tp5n']}}, 08:42:41 INFO - 'talos.zip': {'path': '', 08:42:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:41 INFO - Running post-action listener: _resource_record_post_action 08:42:41 INFO - [mozharness: 2017-03-20 15:42:41.052127Z] Finished populate-webroot step (success) 08:42:41 INFO - [mozharness: 2017-03-20 15:42:41.052238Z] Running create-virtualenv step. 08:42:41 INFO - Running pre-action listener: _resource_record_pre_action 08:42:41 INFO - Running main action method: create_virtualenv 08:42:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:41 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 08:42:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:41 INFO - Using real prefix '/tools/python27' 08:42:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:44 INFO - Installing pip.................done. 08:42:44 INFO - Return code: 0 08:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:42:45 INFO - Reading from file tmpfile_stdout 08:42:45 INFO - Output received: 08:42:45 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) 08:42:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:45 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:42:45 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 08:42:45 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 08:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:45 INFO - 'HOME': '/Users/cltbld', 08:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:45 INFO - 'LOGNAME': 'cltbld', 08:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:45 INFO - 'MOZ_NO_REMOTE': '1', 08:42:45 INFO - 'NO_EM_RESTART': '1', 08:42:45 INFO - 'PAGER': '/bin/cat', 08:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:45 INFO - 'PWD': '/builds/slave/test', 08:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:45 INFO - 'SHELL': '/bin/bash', 08:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:42:45 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:45 INFO - 'USER': 'cltbld', 08:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:45 INFO - 'XPC_FLAGS': '0x0', 08:42:45 INFO - 'XPC_SERVICE_NAME': '0', 08:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:45 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 08:42:45 INFO - Cleaning up... 08:42:45 INFO - Return code: 0 08:42:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:45 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:42:45 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 08:42:45 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 08:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:45 INFO - 'HOME': '/Users/cltbld', 08:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:45 INFO - 'LOGNAME': 'cltbld', 08:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:45 INFO - 'MOZ_NO_REMOTE': '1', 08:42:45 INFO - 'NO_EM_RESTART': '1', 08:42:45 INFO - 'PAGER': '/bin/cat', 08:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:45 INFO - 'PWD': '/builds/slave/test', 08:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:45 INFO - 'SHELL': '/bin/bash', 08:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:42:45 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:45 INFO - 'USER': 'cltbld', 08:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:45 INFO - 'XPC_FLAGS': '0x0', 08:42:45 INFO - 'XPC_SERVICE_NAME': '0', 08:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:45 INFO - Downloading/unpacking psutil>=3.1.1 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:49 INFO - Installing collected packages: psutil 08:42:49 INFO - Running setup.py install for psutil 08:42:49 INFO - building 'psutil._psutil_osx' extension 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 INFO - building 'psutil._psutil_posix' extension 08:42:49 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 08:42:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:49 INFO - ^ 08:42:49 INFO - 1 warning generated. 08:42:49 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 08:42:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:50 INFO - Successfully installed psutil 08:42:50 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:42:50 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 08:42:50 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 08:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:50 INFO - 'HOME': '/Users/cltbld', 08:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:50 INFO - 'LOGNAME': 'cltbld', 08:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:50 INFO - 'MOZ_NO_REMOTE': '1', 08:42:50 INFO - 'NO_EM_RESTART': '1', 08:42:50 INFO - 'PAGER': '/bin/cat', 08:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:50 INFO - 'PWD': '/builds/slave/test', 08:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:50 INFO - 'SHELL': '/bin/bash', 08:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:42:50 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:50 INFO - 'USER': 'cltbld', 08:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:50 INFO - 'XPC_FLAGS': '0x0', 08:42:50 INFO - 'XPC_SERVICE_NAME': '0', 08:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:50 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 08:42:50 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 08:42:50 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 08:42:50 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 08:42:50 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 08:42:50 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 08:42:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:53 INFO - Installing collected packages: mozsystemmonitor 08:42:53 INFO - Running setup.py install for mozsystemmonitor 08:42:53 INFO - Successfully installed mozsystemmonitor 08:42:53 INFO - Cleaning up... 08:42:53 INFO - Return code: 0 08:42:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:53 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:42:53 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 08:42:53 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 08:42:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:42:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:53 INFO - 'HOME': '/Users/cltbld', 08:42:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:53 INFO - 'LOGNAME': 'cltbld', 08:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:53 INFO - 'MOZ_NO_REMOTE': '1', 08:42:53 INFO - 'NO_EM_RESTART': '1', 08:42:53 INFO - 'PAGER': '/bin/cat', 08:42:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:53 INFO - 'PWD': '/builds/slave/test', 08:42:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:53 INFO - 'SHELL': '/bin/bash', 08:42:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:42:53 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:42:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:53 INFO - 'USER': 'cltbld', 08:42:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:53 INFO - 'XPC_FLAGS': '0x0', 08:42:53 INFO - 'XPC_SERVICE_NAME': '0', 08:42:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:56 INFO - warning: no files found matching '*.txt' 08:42:56 INFO - no previously-included directories found matching 'build' 08:42:56 INFO - no previously-included directories found matching 'dist' 08:42:56 INFO - no previously-included directories found matching '.git*' 08:42:56 INFO - Installing collected packages: jsonschema, functools32 08:42:56 INFO - Running setup.py install for functools32 08:42:56 INFO - warning: no files found matching '*.txt' 08:42:56 INFO - no previously-included directories found matching 'build' 08:42:56 INFO - no previously-included directories found matching 'dist' 08:42:56 INFO - no previously-included directories found matching '.git*' 08:42:56 INFO - Successfully installed jsonschema functools32 08:42:56 INFO - Cleaning up... 08:42:56 INFO - Return code: 0 08:42:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:56 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:42:56 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 08:42:56 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 08:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:56 INFO - 'HOME': '/Users/cltbld', 08:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:56 INFO - 'LOGNAME': 'cltbld', 08:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:56 INFO - 'MOZ_NO_REMOTE': '1', 08:42:56 INFO - 'NO_EM_RESTART': '1', 08:42:56 INFO - 'PAGER': '/bin/cat', 08:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:56 INFO - 'PWD': '/builds/slave/test', 08:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:56 INFO - 'SHELL': '/bin/bash', 08:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:42:56 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:56 INFO - 'USER': 'cltbld', 08:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:56 INFO - 'XPC_FLAGS': '0x0', 08:42:56 INFO - 'XPC_SERVICE_NAME': '0', 08:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:57 INFO - Cleaning up... 08:42:57 INFO - Return code: 0 08:42:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:42:57 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 08:42:57 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 08:42:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:42:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:57 INFO - 'HOME': '/Users/cltbld', 08:42:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:57 INFO - 'LOGNAME': 'cltbld', 08:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:57 INFO - 'MOZ_NO_REMOTE': '1', 08:42:57 INFO - 'NO_EM_RESTART': '1', 08:42:57 INFO - 'PAGER': '/bin/cat', 08:42:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:57 INFO - 'PWD': '/builds/slave/test', 08:42:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:57 INFO - 'SHELL': '/bin/bash', 08:42:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:42:57 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:42:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:57 INFO - 'USER': 'cltbld', 08:42:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:57 INFO - 'XPC_FLAGS': '0x0', 08:42:57 INFO - 'XPC_SERVICE_NAME': '0', 08:42:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:57 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 08:42:57 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 08:42:57 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 08:42:57 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 08:42:57 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 08:42:57 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 08:42:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:01 INFO - Downloading docopt-0.6.1.tar.gz 08:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:01 INFO - Running setup.py install for blobuploader 08:43:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:01 INFO - Running setup.py install for requests 08:43:01 INFO - Running setup.py install for docopt 08:43:02 INFO - Successfully installed blobuploader requests docopt 08:43:02 INFO - Cleaning up... 08:43:02 INFO - Return code: 0 08:43:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:02 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')]} 08:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 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')]} 08:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:02 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:43:02 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 08:43:02 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 08:43:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:43:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:02 INFO - 'HOME': '/Users/cltbld', 08:43:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:02 INFO - 'LOGNAME': 'cltbld', 08:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:02 INFO - 'MOZ_NO_REMOTE': '1', 08:43:02 INFO - 'NO_EM_RESTART': '1', 08:43:02 INFO - 'PAGER': '/bin/cat', 08:43:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:02 INFO - 'PWD': '/builds/slave/test', 08:43:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:02 INFO - 'SHELL': '/bin/bash', 08:43:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:43:02 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:43:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:02 INFO - 'USER': 'cltbld', 08:43:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:02 INFO - 'XPC_FLAGS': '0x0', 08:43:02 INFO - 'XPC_SERVICE_NAME': '0', 08:43:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6rb8Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-fDyfZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-g8vnK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-jXeTAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-OaVL7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-j9OYPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-8bt9Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-EJurUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZXlqOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-t9Q1Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Fyr0Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-PYNJHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-kFCBvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-KoauvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-zTsKfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:04 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-j8DhPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:04 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Az76Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:04 INFO - Running setup.py install for manifestparser 08:43:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:04 INFO - Running setup.py install for mozcrash 08:43:04 INFO - Running setup.py install for mozdebug 08:43:04 INFO - Running setup.py install for mozdevice 08:43:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:04 INFO - Running setup.py install for mozfile 08:43:04 INFO - Running setup.py install for mozhttpd 08:43:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Running setup.py install for mozinfo 08:43:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Running setup.py install for mozInstall 08:43:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Running setup.py install for mozleak 08:43:05 INFO - Running setup.py install for mozlog 08:43:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Running setup.py install for moznetwork 08:43:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:05 INFO - Running setup.py install for mozprocess 08:43:06 INFO - Running setup.py install for mozprofile 08:43:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:06 INFO - Running setup.py install for mozrunner 08:43:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:06 INFO - Running setup.py install for mozscreenshot 08:43:06 INFO - Running setup.py install for moztest 08:43:06 INFO - Running setup.py install for mozversion 08:43:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:06 INFO - Cleaning up... 08:43:06 INFO - Return code: 0 08:43:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:06 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')]} 08:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 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')]} 08:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:43:06 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 08:43:06 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 08:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:06 INFO - 'HOME': '/Users/cltbld', 08:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:06 INFO - 'LOGNAME': 'cltbld', 08:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:06 INFO - 'MOZ_NO_REMOTE': '1', 08:43:06 INFO - 'NO_EM_RESTART': '1', 08:43:06 INFO - 'PAGER': '/bin/cat', 08:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:06 INFO - 'PWD': '/builds/slave/test', 08:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:06 INFO - 'SHELL': '/bin/bash', 08:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:43:06 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:06 INFO - 'USER': 'cltbld', 08:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:06 INFO - 'XPC_FLAGS': '0x0', 08:43:06 INFO - 'XPC_SERVICE_NAME': '0', 08:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-OqSXdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-85iPbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ls5v_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-j3Fty8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-omBaXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-SM_4or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZQNmkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-E9z_16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:07 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)) 08:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-bl9iNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Zt5KYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-T6HQtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-bp2igg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-8WZnnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-oe_SWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_1IPhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CTrjNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:08 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)) 08:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-yMTNcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:08 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)) 08:43:08 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)) 08:43:08 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)) 08:43:08 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)) 08:43:08 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)) 08:43:08 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)) 08:43:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:08 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 08:43:08 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 08:43:08 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 08:43:08 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 08:43:08 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 08:43:08 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 08:43:11 INFO - Downloading blessings-1.6.tar.gz 08:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:11 INFO - Installing collected packages: blessings 08:43:11 INFO - Running setup.py install for blessings 08:43:11 INFO - Successfully installed blessings 08:43:11 INFO - Cleaning up... 08:43:11 INFO - Return code: 0 08:43:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:12 INFO - Reading from file tmpfile_stdout 08:43:12 INFO - Current package versions: 08:43:12 INFO - blessings == 1.6 08:43:12 INFO - blobuploader == 1.2.4 08:43:12 INFO - docopt == 0.6.1 08:43:12 INFO - functools32 == 3.2.3-2 08:43:12 INFO - jsonschema == 2.5.1 08:43:12 INFO - manifestparser == 1.1 08:43:12 INFO - mozInstall == 1.12 08:43:12 INFO - mozcrash == 1.0 08:43:12 INFO - mozdebug == 0.1 08:43:12 INFO - mozdevice == 0.49 08:43:12 INFO - mozfile == 1.2 08:43:12 INFO - mozhttpd == 0.7 08:43:12 INFO - mozinfo == 0.9 08:43:12 INFO - mozleak == 0.1 08:43:12 INFO - mozlog == 3.4 08:43:12 INFO - moznetwork == 0.27 08:43:12 INFO - mozprocess == 0.24 08:43:12 INFO - mozprofile == 0.28 08:43:12 INFO - mozrunner == 6.13 08:43:12 INFO - mozscreenshot == 0.1 08:43:12 INFO - mozsystemmonitor == 0.3 08:43:12 INFO - moztest == 0.8 08:43:12 INFO - mozversion == 1.4 08:43:12 INFO - psutil == 3.1.1 08:43:12 INFO - requests == 1.2.3 08:43:12 INFO - wsgiref == 0.1.2 08:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:43:12 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 08:43:12 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 08:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:12 INFO - 'HOME': '/Users/cltbld', 08:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:12 INFO - 'LOGNAME': 'cltbld', 08:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:12 INFO - 'MOZ_NO_REMOTE': '1', 08:43:12 INFO - 'NO_EM_RESTART': '1', 08:43:12 INFO - 'PAGER': '/bin/cat', 08:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:12 INFO - 'PWD': '/builds/slave/test', 08:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:12 INFO - 'SHELL': '/bin/bash', 08:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:43:12 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:12 INFO - 'USER': 'cltbld', 08:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:12 INFO - 'XPC_FLAGS': '0x0', 08:43:12 INFO - 'XPC_SERVICE_NAME': '0', 08:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 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)) 08:43:13 INFO - Cleaning up... 08:43:13 INFO - Return code: 0 08:43:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:13 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 0x10ad4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc58155b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, '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.WxpS22w7x4/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.DaHUa7UKIs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 08:43:13 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 08:43:13 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 08:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:13 INFO - 'HOME': '/Users/cltbld', 08:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:13 INFO - 'LOGNAME': 'cltbld', 08:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:13 INFO - 'MOZ_NO_REMOTE': '1', 08:43:13 INFO - 'NO_EM_RESTART': '1', 08:43:13 INFO - 'PAGER': '/bin/cat', 08:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:13 INFO - 'PWD': '/builds/slave/test', 08:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:13 INFO - 'SHELL': '/bin/bash', 08:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:43:13 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:13 INFO - 'USER': 'cltbld', 08:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:13 INFO - 'XPC_FLAGS': '0x0', 08:43:13 INFO - 'XPC_SERVICE_NAME': '0', 08:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:43:13 INFO - Cleaning up... 08:43:13 INFO - Return code: 0 08:43:13 INFO - Running post-action listener: _resource_record_post_action 08:43:13 INFO - Running post-action listener: _start_resource_monitoring 08:43:13 INFO - Starting resource monitoring. 08:43:13 INFO - [mozharness: 2017-03-20 15:43:13.819117Z] Finished create-virtualenv step (success) 08:43:13 INFO - [mozharness: 2017-03-20 15:43:13.820157Z] Running install step. 08:43:13 INFO - Running pre-action listener: _resource_record_pre_action 08:43:13 INFO - Running main action method: install 08:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:14 INFO - Reading from file tmpfile_stdout 08:43:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:14 INFO - Reading from file tmpfile_stdout 08:43:14 INFO - Output received: 08:43:14 INFO - Usage: mozinstall [options] installer 08:43:14 INFO - Options: 08:43:14 INFO - -h, --help show this help message and exit 08:43:14 INFO - -d DEST, --destination=DEST 08:43:14 INFO - Directory to install application into. [default: 08:43:14 INFO - "/builds/slave/test"] 08:43:14 INFO - --app=APP Application being installed. [default: firefox] 08:43:14 INFO - mkdir: /builds/slave/test/build/application 08:43:14 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'] 08:43:14 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 08:43:28 INFO - Reading from file tmpfile_stdout 08:43:28 INFO - Output received: 08:43:28 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:43:28 INFO - Running post-action listener: _resource_record_post_action 08:43:28 INFO - [mozharness: 2017-03-20 15:43:28.853918Z] Finished install step (success) 08:43:28 INFO - [mozharness: 2017-03-20 15:43:28.854045Z] Running run-tests step. 08:43:28 INFO - Running pre-action listener: _resource_record_pre_action 08:43:28 INFO - Running main action method: run_tests 08:43:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:28 INFO - 2017-03-20 08:43:28.868 screenresolution[1619:7295] starting screenresolution argv=screenresolution get 08:43:28 INFO - 2017-03-20 08:43:28.871 screenresolution[1619:7295] Display 0: 1600x1200x32@60 08:43:28 INFO - 2017-03-20 08:43:28.877 screenresolution[1620:7297] starting screenresolution argv=screenresolution list 08:43:28 INFO - Available Modes on Display 0 08:43:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:29 INFO - Intel Iris: 08:43:29 INFO - Chipset Model: Intel Iris 08:43:29 INFO - Type: GPU 08:43:29 INFO - Bus: Built-In 08:43:29 INFO - VRAM (Dynamic, Max): 1536 MB 08:43:29 INFO - Vendor: Intel (0x8086) 08:43:29 INFO - Device ID: 0x0a2e 08:43:29 INFO - Revision ID: 0x0009 08:43:29 INFO - Displays: 08:43:29 INFO - Display: 08:43:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:29 INFO - Display Serial Number: 1600x1200 60 08:43:29 INFO - Main Display: Yes 08:43:29 INFO - Mirror: Off 08:43:29 INFO - Online: Yes 08:43:29 INFO - Rotation: Supported 08:43:29 INFO - Return code: 0 08:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:29 INFO - Python 2.7.3 08:43:29 INFO - Return code: 0 08:43:29 INFO - grabbing minidump binary from tooltool 08:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:29 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 0x10ab2dd30>, '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 0x10aa54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab22be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:29 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 08:43:29 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 08:43:29 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 08:43:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:29 INFO - Return code: 0 08:43:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:43:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:43:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:29 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/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 08:43:29 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/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 08:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WxpS22w7x4/Render', 08:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:29 INFO - 'HOME': '/Users/cltbld', 08:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:29 INFO - 'LOGNAME': 'cltbld', 08:43:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:29 INFO - 'MOZ_NO_REMOTE': '1', 08:43:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:29 INFO - 'NO_EM_RESTART': '1', 08:43:29 INFO - 'PAGER': '/bin/cat', 08:43:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:29 INFO - 'PWD': '/builds/slave/test', 08:43:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:29 INFO - 'SHELL': '/bin/bash', 08:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DaHUa7UKIs/Listeners', 08:43:29 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 08:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:29 INFO - 'USER': 'cltbld', 08:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:29 INFO - 'XPC_FLAGS': '0x0', 08:43:29 INFO - 'XPC_SERVICE_NAME': '0', 08:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:29 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/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 08:43:29 INFO - mozversion application_buildid: 20170320065841 08:43:29 INFO - mozversion application_changeset: ab5725326239e69217d16e48df1e2661b5820833 08:43:29 INFO - mozversion application_display_name: Firefox 08:43:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:29 INFO - mozversion application_name: Firefox 08:43:29 INFO - mozversion application_remotingname: firefox 08:43:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:29 INFO - mozversion application_vendor: Mozilla 08:43:29 INFO - mozversion application_version: 53.0 08:43:29 INFO - mozversion platform_buildid: 20170320065841 08:43:29 INFO - mozversion platform_changeset: ab5725326239e69217d16e48df1e2661b5820833 08:43:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:29 INFO - mozversion platform_version: 53.0 08:43:29 INFO - using testdate: 1490024609 08:43:29 INFO - actual date: 1490024609 08:43:29 INFO - starting webserver on 'localhost:49242' 08:43:29 INFO - SUITE-START | Running 2 tests 08:43:29 INFO - TEST-START | dromaeo_css 08:43:29 INFO - operating with platform_type : mac_ 08:43:29 INFO - Initialising browser for dromaeo_css test... 08:43:29 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmppoD0fa/profile http://localhost:49242/getInfo.html) 08:43:31 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 08:43:31 INFO - PROCESS | 1630 | colorDepth:24 08:43:31 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 08:43:31 INFO - PROCESS | 1630 | __metrics 08:43:31 INFO - PROCESS | 1630 | 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" 08:43:31 INFO - PROCESS | 1630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:32 INFO - TEST-INFO | 1630: exit 0 08:43:32 INFO - Browser initialized. 08:43:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:32 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmppoD0fa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:44 INFO - PROCESS | 1633 | RSS: Main: 163385344 08:43:44 INFO - PROCESS | 1633 | 08:46:47 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 08:46:48 INFO - PROCESS | 1633 | RSS: Main: 308989952 08:46:48 INFO - PROCESS | 1633 | 08:49:51 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 08:49:52 INFO - PROCESS | 1633 | RSS: Main: 308559872 08:49:52 INFO - PROCESS | 1633 | 08:52:54 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 08:52:55 INFO - PROCESS | 1633 | RSS: Main: 291889152 08:52:55 INFO - PROCESS | 1633 | 08:55:57 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 08:55:58 INFO - PROCESS | 1633 | RSS: Main: 296927232 08:55:58 INFO - PROCESS | 1633 | 08:59:01 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 08:59:02 INFO - PROCESS | 1633 | RSS: Main: 269922304 08:59:02 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 09:02:05 INFO - PROCESS | 1633 | RSS: Main: 362078208 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | __start_tp_report 09:02:05 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 09:02:05 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 09:02:05 INFO - PROCESS | 1633 | |i|pagename|runs| 09:02:05 INFO - PROCESS | 1633 | |0;dojo.html;3479.1476088358354;3511.8770843020484;3534.522839416678;3563.8574457021714;3574.356615809155;5971.283445986483;6034.788782392618;6036.788712395067;6068.484178844804;6071.7267722952465;6013.518918486521;6074.240719910012;6083.239595050619;6085.604435711675;6089;5360.088784906566;5363.973180134094;5410.215518749779;5429.239906413105;5486.396496385394;4235.53409124996;5210.270562121306;5360.356757189143;5485.122380419134;5543.1408131739445;4460.464744230697;5438.456154384569;5455.563554915617;5467.6719396836315;5488.53347465464;5447.809326673548;5455.754491047913;5457.345118585776;5471.124620060811;5476.315460567429;5336.226247194174;5397.8380648580605;5432.6468779529205;5451.454854514556;5483.506484416422;6180.2892667343385;6188.566800323979;6191.195144631214;6192.783252586138;6202.689865506707;6196.597221180609;6363.872722545523;6369.36306369364;6371.904421433682;6392.105105285264;5314.73426328682;6320.020396838451;6367.172267605228;6402.13571167891;6440.066190402412;6212.068189771525;6215.844603884939;6219.284782250099;6227.595206311576;6229.314775374705;6610.2398224204835;6624.668766561749;6630.668466576652;6635.2037755469655;6641.734330626818;6201.162843016225;6230.252369715572;6286.842828929313;6303.180586523723;6304.968475157595;6460.450861676716;6472.805815825533;6473.158489396443;6477.481801455872;6482.675866206765;6243.594166379262;6344.302126766052;6363.936360636427;6384.48924086072;6395.936040639627;6227.252729672377;6267.780627678009;6269.435750782452;6396.776112836028;6409.230892292861;5166.819161329336;5183.937292854956;5189.870253243624;5191.091558977164;5231.267622532849;4627.676062675648;4630.305454181899;4642.3500709900645;4662.4405071390975;4668.066386722669;5932.822015339547;6126.632402055891;6127.387261273837;6149.569530132848;6152.415520525543;6305.306416294204;6358.77744278948;6373.5857169283845;6409.359064093646;6422.582532135396;5167.457416971164;5671.97904377216;6108.827782940766;6127.372786728385;6151.96924015377;5661.773529058792;5671.2060311556415;5676.120201368794;5686.0333743263745;5693.800716974969;6399.328070552618;6512.511561632991;6560.147180866456;6608.240052394036;6650.70071846768;5914.201582786269;6412.647304398116;6433.099366088845;6441.1626488556185;6448.806535803933;6594.076829243813;6643.169603799525;6643.667816609247;6644.435223006099;6665.066890635412;6238.844028899314;6281.654509002049;6282.780102696383;6307.369263073656;6351.428371446592;6286.811395658137;6334.429901308904;6441.484681225397;6453.967730161319;6463.3213512580505;6281.371862813682;6282.623042617458;6287.905681414874;6293.748250070129;6295;6195.938040619536;6235.407636274546;6240.438360547572;6257.843553911189;6297.52768542352;6226.1905952225925;6241.31345551998;6269.185005949197;6269.216347956505;6284.025975973731;6301.0863424804065;6303;6308.211473565804;6311.053341998737;6313.526485513513;6172.074188871526;6180.876382472416;6207.441330280297;6218.036204388327;6261.96869015652 09:02:05 INFO - PROCESS | 1633 | |1;ext.html;522.2218893848166;530.6921985248558;532.0556013076788;534.1480338859518;589.6491587505433;33123.50314745281;42175.156496870084;43928.56071439285;43995.34006989898;45664;38488.03779905504;45700.94345754441;45951.31073033907;46516.06967860641;46625;8289.626966786478;9773.045390921845;9774.462404567728;10004.399736015863;10007.799844003115;9272.629094836198;12130.45412956419;12365.07261955357;12399.070069744761;12527.874721252807;10149.847752283722;12269.263844169334;12273.263604183732;12289.446974886107;12290.815637765441;12182.390880455941;12249.755004899942;12264.38678066102;12265.509379624804;12272.325022123825;12135.93932030343;12212.450439730233;12236.81644775329;12241.32672703001;12242.938785306105;43559;43852.12295754067;43917.560824391665;43969.34045989313;44065;3571.4107172316535;4113.609207125318;4170.374443833419;4185.832566697329;4206.26390381682;31310.84344578285;32486.512702309483;33201;33801;33813.661863381545;3290.226796702773;3331.3004269103517;3488.1105318143964;3558.6085530591613;3564.465330200465;476520;477333;477427;477636.22363776265;478233;68985.65507172432;69340;69389.30610693828;69456.61086778236;72710.27289727035;72224.63887680633;72305;72416.91374629385;72424.63787681027;72425.63787181031;17912.373066942593;18239.36162234342;18241.087945602667;18263.269469221348;18267.72598411025;12633;12890.677733056562;13696.65758356029;13806.378712957941;13861.029727918949;15966.458458115923;17011.31954721822;18912.621747564972;19298.035098245033;19317.227310907405;7681.884771728429;7685.7309994151055;7721.498102623312;7745.095589154067;7756.1468238494845;889.1197714262962;890.4212262029603;905.44767691708;923.736735030513;945.2438049560325;31531.527027094613;31905;32016.199595009846;32311.676883231336;32320.030399088064;995.6764051683232;1090.836374543809;1131.7000994736402;1232.9938350308191;1245.2777389114474;16298;16571;16634.75047874283;16645.667086658443;17019.659606807796;605400;609562;610009;610131;610691;66291.33708662851;66475.33524664788;66564;66703.99832007571;66859.66570167118;1308.385059022296;1436.920969346675;1486.947956821506;1503.1582313904248;1514.2882845062802;29276.853615731787;29841;30917;31643.89246376458;31746.365072697954;55546.44453555575;55836.44163558475;55841;55965.44034559765;56112.43887561235;519124;520687;522076.3896180495;522866;523133;27213.86393068022;28261.57607635846;28266.717332826407;28303.71696283011;28336.57495137616;40685.38971915483;42813.143737125705;49502.50497495123;50874.74562627163;54961;40756.29411882279;41704.165916682105;41859.372109417774;41938.37092443677;43745.56254437415;37162.07094822651;37645.62354376421;41220.79389603033;41964.790176048926;42908.92727681708;40569.797151015235;41151.08773012466;41252.58747412608;41348.793256033525;41373.37939930843;31321.647660048067;33361.83319083486;34968.153503114125;36692.63307366892;37082.629173707915;26405.603915940894;26712.198634040233;26844.731552684225;26922.59616105721;27188.00931897529 09:02:05 INFO - PROCESS | 1633 | |2;jquery.html;348.95812502499706;377.7676728811781;399.95000624921903;413.2561389498902;434.68050982527836;20434.489137771565;20529.486762830937;21691;21779.802110883895;21780.455488612773;18102.637947241048;22207.22274720385;22298.55402891941;22905;23005;5747.827565173041;6115.969420152893;6116.938830611703;6121.816345509642;6124.632522048669;5872.970635146839;5969.970150149243;6040.154378387029;6120.234970628671;6124.693765311717;6244.188255526775;6252.49980001601;6256.874862502747;6259.217597800275;6265.530085243602;6236.56344055914;6380.3300653431415;6813.080234168398;6895.620740859251;6898.724051037952;5397.2443857859935;6154.169187159721;6157.78447754331;6159.50723942088;6168.321484636686;13562.728745425036;14052.016358854884;14220.004599678026;14235.003549751522;14274.500392486318;2250.2911582851348;2338.3981972348997;2747.931301717473;2756.944861102767;2986.462436761382;9704.980976997384;10202.948985255027;10547.99794019567;10805.5677772889;10805.621803236927;1583.4695377048702;1882.294388453403;1892.8580356473183;1892.9526761830928;1895.1755986145934;119566;133541.3322933379;136199;138266.30866845703;139710;10159.476078588123;11875.168738188244;11943.940280298542;12205.267683938991;12327.6918077047;16360.018398896103;16364.754528682079;16366.672666546603;16399.508014759576;16411.83588164127;8716.389852710376;8979.236764875059;9010.27917766577;9083.68207112748;9142.497162656118;8811.779705507413;8830.42602230853;8848.513331766686;8980.730578082668;9007.144321289466;4804.879878003008;4881.292212629149;4918.385201849769;4979.228219625964;5090.618203634668;1715.8970461772333;1989.9900500497404;2034.7761746207905;2050.4976280810997;2052.7331446912103;1025.4052649463292;1053.1943063556232;1054.8291396549823;1068.2415485005577;1092.9398883061508;21167.25914592982;21450.498465107292;22789.544209115724;22791.430214244778;22829.20097796569;1028.1723212813756;1074.876753792289;1099.5107177306022;1112.933224006562;1122.3826895207603;10761.461926903623;11669.59156429521;11684.546245288415;11715;11726.530938762524;568777;735450.4063741885;754751;765045;772091;144834;145307.273463632;151688;154490.22754886153;157968;456.1424521898809;477.9426468823763;478.63384510849227;479.84405068352925;481.21321639120987;11217.887821121685;11284.943575282072;11573.247738896946;11724.296542207494;12086.153969222421;44989;56808.715956421605;57940.420595795185;60904.695476522335;62405.68797156167;67768.5619866112;73130.63434682792;88137;91824;98417.50791245997;8750.912490875264;8832.293416526534;9006.54967251648;9156.443404621097;9199.310051746012;13622.114562553403;13867.23730194849;14046.438142474186;14155.787663185267;14546.272686365428;11483.712907177387;11747.649020362767;11867.228630139014;11869.881301186877;11907.940460297643;10541.947290263499;11629.825552616887;11903.10726695484;12038.75922481563;12091.697707557381;10620.20348473852;11797.404570994368;11962.46168922418;12058.879411205775;12145;8742;8982.101789820965;8982.281417486716;9139.817203656023;9216.216621586971;11203.887961120285;11736.589219377282;12071.913527782543;12074;12107.394630268274 09:02:05 INFO - PROCESS | 1633 | |3;mootools.html;1367.1455340412242;1474.6165996840825;1492.5373134328356;1503.0831192972282;1503.5188739603332;7619.771406857796;8239;8454.450460720049;8461.619227134779;8537.87193192101;8295.834083318345;8396.118407567194;8398.412111152222;8402.243798058174;8407;2151.7848215178515;2233.7207849018873;2379.773921477461;2420.382802385398;2422.9151979680714;2382.4282172278613;2459.963100553493;2459.987700061506;2465.827392082555;2466.580681284177;2393.7127544694663;2421.709394872618;2429.2347910408166;2432.5621388150125;2435.561598912204;2410.867402292873;2419.237940048879;2446.963295550577;2447.596146635803;2447.681801365829;2418.6334720882646;2444.3155916343453;2445.364205306615;2446.156076153724;2451.9877400613063;8246.876296855551;8333.624986875544;8367.748967530984;8453.535055572003;8521.44610600309;5095.312132862054;5141.177411614161;5272.815451459181;5292.391374991887;5302.681839089629;3442.1394651337164;3543.5471456702885;3665.9083522911874;3674.7978861162624;3685.594584595692;1238.6284114765535;1281.35932033983;1314.6976195475095;1326.3699742622273;1335.4324412124906;10969.396683182422;10989.505472253768;11001.504932278067;11017.669469915836;11026.338419694845;4585.358049873021;4698.342232087511;4731.101090792808;4804.711717296974;4810.855674329776;8628.96452425713;8812.427192232484;8813.33899957493;8824.735257942144;8824.823503529893;5217.2695822584865;5228.55557277628;5229.294045303835;5229.843104706865;5233.162693968947;3885.6502914737243;4369.519352871182;4885.438174609894;4914.140025495595;4915.4347250065985;3696.9260614787554;3704.184949374787;3805.82873770681;3813.218290250492;3820.5033345665443;1170.3446070200714;1184.4729095552395;1186.9940650296867;1191.338806962127;1200.2678366196612;837.2506606587192;943.5801068524578;951.743029382063;966.7824739433712;1015.1523477896039;4988.700677959334;5584.385717571064;5949.137375080589;5955.28536575605;6045.72794224261;985.4284514981437;1022.892596277395;1033.7363972187045;1047.4814966591587;1079.0558261521169;3739.8130093495215;3824.827882745283;3897.0452239201577;3922.8626998054933;4003.5195776507007;9523.476208808583;10191;10195.184385249311;10202.081812636898;10208.387496750218;8869.778255543662;9884.30809843304;10032.548535315927;10178.949105254575;10186.847197292047;7504.774856754306;7507.211742766931;7628.351590114791;7670.079590449071;7790.182030886788;5376.435474275145;5679.119736440858;5742.856428589319;5757.712114394348;5925.911111333247;9195.26437884981;9199.724008279762;9260.953695231481;9319.86020209711;9413.199878010446;9386.202172815114;9552.617895284111;9563.378380405251;9642.662506812228;9647.324687271823;6730.6634668265415;6929.930700692928;7212.3148300911325;7331.266873312839;7352.926470735224;7278;7838.804029899298;7991.600419979094;8001.279884810395;8056.556889370906;7021.719131234898;7127.144742630918;7164.211936687065;7180.856382872418;7287.562746235243;7061.293870612898;7064.399526040344;7068;7084.220735718964;7103.857922841411;6358.395952384516;6404.455621272058;6483.513736469878;6491.772787952399;6492.967535162294;5008.549230569266;5033.622478314068;5055.317532133115;5094.312267843794;5105.387353517453;4966.553010228952;4967.627427942846;5106.029854327666;5169.353830771153;5255.737213139404 09:02:05 INFO - PROCESS | 1633 | |4;prototype.html;363.70539862711206;365.1965675513869;373.712241573988;379.94300854871767;381.66032231314153;4320.805563749631;4515.548445155487;4814.542618451242;5472.288602481677;5497.532709719679;4818.855434336975;5123.462036486171;5180.533751962323;5337.519623233918;5371.140617501191;3860.3823388257883;4125.113100683352;4230.894227644303;4260.25445547028;4292.763897985609;3850.595687452819;4259.063006138645;4262.2754131797665;4267.871963841089;4294.377315289281;3863.459115723801;4039.313316736147;4087.2220584046036;4180.895477613054;4254.659627229814;3329.3174899145615;3439.7420193485464;3461.5326930864517;3472.5485686860548;3651.3062518121474;3529.100079479742;3538.380783362901;3557.5908770491205;3559.7896715116726;3559.982200089009;4869.264138178047;4892.77680579855;5230.607704422184;5289.259503669489;5357.1696387060065;3575.6781889629797;3791.241751649681;3938.5076865391825;4673.3690951721765;4721.268203428474;4705.435347758256;4973.403191616993;5669.121286200645;5704.7751376963015;5758.452946970031;3944.6449819516383;3949.98025009876;3950.2889479893606;3958.5843486433796;3969.5435024972207;4454.57681520255;5543.279373681396;5751.079827227623;5905.645661260338;5962.672053037081;3226.451503244454;3352.3295340931422;3523.9119022024656;3936.4292177634657;3975.860844870416;4063.6952228582973;4085.6507508182913;4089.8568550100604;4091.877243682635;4176.373543968429;4380.890477738082;4622.815087396467;4661.720296782204;4717.575418212309;4723.291506274087;4930.33440485537;5605.159226116034;5703.7148142592705;5716.084796753686;5747.166660834156;1080.8540846985713;1279.7842050052489;1286.4661165616164;1299.7985312276612;1312.8424589049375;793.5913004802532;837.392890154633;960;965.9760653706952;997.551102004101;4918.754062296871;4952.885600739877;5090.058339207185;5093.726568357911;5157.885267040496;4784.30627559002;5603.467670571289;5610.438956104438;5635.745012515525;5652.802151924663;4935.507568677866;5116.616253780907;5380.354357477127;5444.891102177934;5466.262054622575;2581.250967719373;2798.4403119376207;2909.9815064727177;2924.956125658117;2932.7213914678073;4526.306847425776;5365.409804921455;5433.239346491494;5660.066089095253;5747.48272655463;4513.232750432434;5256.316678831804;5282.550983166397;5714.085746280658;5754.74103665336;4757.9286310705365;5529.751161197836;5769.653820770767;5817.331006934172;5830.356027482908;5461.863453413696;5470.317508285815;5561.527270181918;5597.132444471114;5647.519960803378;5522.061249587499;5542.889142217053;5544.3346798384455;5551.639143455663;5617.5505959522325;4803.735794531334;5410.891782164414;5442.37412697529;5775.8556036099435;5810.380747305818;3683.3922402803237;3941.862034828882;3987.202559488172;3994.6604538614542;4016.678665706795;5104.69371837691;5901.350851406256;5916.822495325147;5937.079752638348;6012.308584512837;4972.502749725143;5405.78376864921;5768.451997060272;5833.075085221782;5833.649981001154;4976.402831660224;5435.84720861907;5459.287684374504;5709.172170035405;5752.395998420106;4534.319852022091;5276.868078298074;5456.754446050017;5598.648567601535;5643.109558298016;4690.6247500199215;5156.4070131935305;5463.180522921593;5486.31421072366;5530.336359636869;5540.307461567304;5540.501354878081;5550.47270509301;5557;5575.208857976615 09:02:05 INFO - PROCESS | 1633 | |5;yui.html;726.1141407482876;751.2862780358661;767.3515879082173;791.606583461787;862.5816479007682;15112.773308400368;15661;15675.216239188037;15680.372785088612;15685.686286274282;14124;14393;14446.783298250535;14472.42110315586;14483.420663173487;906.2161230535588;916.2257892081215;926.1803304075908;927.3045216087934;928.2573940847329;915.199200699388;915.6200176926568;915.9496227707474;916.4638686368482;916.724982505249;757.9583122928236;780.2743448592806;947.3984020147221;982.3221976835996;986.7286496213562;975.4878688688424;975.8877729061143;976.8583555384465;977.3207620703614;978.280963491833;725.0719079578148;725.365305357812;726.2555880222761;726.8255618651485;727.9854402911913;15396.923015384851;15571.299291531795;15613;15630.609234769108;15808.762868556982;14592.343344549521;14637.926810365987;14724.19016954067;14756.926215368854;14758.409663613442;11719.296842189497;11856.110791690571;11873.10951678619;11906.821397679041;12127.696807579792;3628.5827129880136;3741.1769410729594;3794.6205379461835;3934;3982;103844.48077759563;105057.94942050558;106435;113649.43175284153;113927;10889.782204355868;10970.451477426097;11220.943895280472;11538.59614913474;11691.941540292244;22596.66105008426;23007;23270.534589308118;23552.057917683444;23619;7763.534187948741;8035.638396272182;8106.837863242702;8117.4317797754775;8189;4322.740635561876;4381.408509851193;4397.120575884772;4424.203643344164;4562.973331000565;3714.60996595359;3771.905702357463;3816.885493435201;3821.8662346818282;3825.8087095645105;673.4541842562702;674.1337381464892;684.9246582875879;688.0917189310063;708.1183926012147;542.8472187763562;602.7619090459244;640.8272860664972;680.8059702984625;743.2938708227098;10346.275760696679;10405.375677459377;10519.275263948077;10719.67237676678;11220;584.3192680527138;676.1615596660205;681.8908974564046;711.263841923617;723.8081908294201;5007.24891266313;5091.289511046888;5103.260027296022;5182.507661772125;5188.273641690166;77750.6112469434;77820;88324;100069.49965250272;105221;95121;95177.572336415;95769;97381;98171;80205;80431.39137217223;82979;83970;84012.57993710115;9667.613295468103;10032.448215348226;10068.194544436281;10074.8488772667;10081.395116293046;42403.363949540166;46055.69721513844;53951;55227.72386138044;55264.44735552593;71059;73198.63400682963;74215.8867616997;74876.62561687156;76497;11576.41826016162;11937.28376297425;11947.402629868298;12052.578159764365;12398.752024959631;13161.802572961606;13184.73630527365;13245.801312980506;13304.46782128704;13557.389917453542;12294.569690060805;12475.563355282522;12553.309567973483;12949.482020719066;12987.220766754024;12084.214526055779;12151.392430378623;12521.499140034297;12932.353382331034;13144.27706476153;9830.311878168459;11763.353015584225;12173.2696038238;12195.756084878076;12271.263724176579;10106.242031847494;10173.135283500986;10545.683629491128;10937.890621093688;11252.437378131224;8144.226298501633;10271.94864025705;10373.32573382758;10402.739931501774;10569.524371403459 09:02:05 INFO - PROCESS | 1633 | __end_tp_report 09:02:05 INFO - PROCESS | 1633 | __start_cc_report 09:02:05 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,1355 09:02:05 INFO - PROCESS | 1633 | __end_cc_report 09:02:05 INFO - PROCESS | 1633 | __startTimestamp1490025725497__endTimestamp 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | ------- Summary: start ------- 09:02:05 INFO - PROCESS | 1633 | Number of tests: 6 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5959.09 Median:6226.19 stddev:661.86 (10.6%) stddev-sans-first:634.66 09:02:05 INFO - PROCESS | 1633 | Values: 3479.1 3511.9 3534.5 3563.9 3574.4 5971.3 6034.8 6036.8 6068.5 6071.7 6013.5 6074.2 6083.2 6085.6 6089.0 5360.1 5364.0 5410.2 5429.2 5486.4 4235.5 5210.3 5360.4 5485.1 5543.1 4460.5 5438.5 5455.6 5467.7 5488.5 5447.8 5455.8 5457.3 5471.1 5476.3 5336.2 5397.8 5432.6 5451.5 5483.5 6180.3 6188.6 6191.2 6192.8 6202.7 6196.6 6363.9 6369.4 6371.9 6392.1 5314.7 6320.0 6367.2 6402.1 6440.1 6212.1 6215.8 6219.3 6227.6 6229.3 6610.2 6624.7 6630.7 6635.2 6641.7 6201.2 6230.3 6286.8 6303.2 6305.0 6460.5 6472.8 6473.2 6477.5 6482.7 6243.6 6344.3 6363.9 6384.5 6395.9 6227.3 6267.8 6269.4 6396.8 6409.2 5166.8 5183.9 5189.9 5191.1 5231.3 4627.7 4630.3 4642.4 4662.4 4668.1 5932.8 6126.6 6127.4 6149.6 6152.4 6305.3 6358.8 6373.6 6409.4 6422.6 5167.5 5672.0 6108.8 6127.4 6152.0 5661.8 5671.2 5676.1 5686.0 5693.8 6399.3 6512.5 6560.1 6608.2 6650.7 5914.2 6412.6 6433.1 6441.2 6448.8 6594.1 6643.2 6643.7 6644.4 6665.1 6238.8 6281.7 6282.8 6307.4 6351.4 6286.8 6334.4 6441.5 6454.0 6463.3 6281.4 6282.6 6287.9 6293.7 6295.0 6195.9 6235.4 6240.4 6257.8 6297.5 6226.2 6241.3 6269.2 6269.2 6284.0 6301.1 6303.0 6308.2 6311.1 6313.5 6172.1 6180.9 6207.4 6218.0 6262.0 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:69519.80 Median:40627.59 stddev:143333.33 (352.8%) stddev-sans-first:143641.80 09:02:05 INFO - PROCESS | 1633 | Values: 522.2 530.7 532.1 534.1 589.6 33123.5 42175.2 43928.6 43995.3 45664.0 38488.0 45700.9 45951.3 46516.1 46625.0 8289.6 9773.0 9774.5 10004.4 10007.8 9272.6 12130.5 12365.1 12399.1 12527.9 10149.8 12269.3 12273.3 12289.4 12290.8 12182.4 12249.8 12264.4 12265.5 12272.3 12135.9 12212.5 12236.8 12241.3 12242.9 43559.0 43852.1 43917.6 43969.3 44065.0 3571.4 4113.6 4170.4 4185.8 4206.3 31310.8 32486.5 33201.0 33801.0 33813.7 3290.2 3331.3 3488.1 3558.6 3564.5 476520.0 477333.0 477427.0 477636.2 478233.0 68985.7 69340.0 69389.3 69456.6 72710.3 72224.6 72305.0 72416.9 72424.6 72425.6 17912.4 18239.4 18241.1 18263.3 18267.7 12633.0 12890.7 13696.7 13806.4 13861.0 15966.5 17011.3 18912.6 19298.0 19317.2 7681.9 7685.7 7721.5 7745.1 7756.1 889.1 890.4 905.4 923.7 945.2 31531.5 31905.0 32016.2 32311.7 32320.0 995.7 1090.8 1131.7 1233.0 1245.3 16298.0 16571.0 16634.8 16645.7 17019.7 605400.0 609562.0 610009.0 610131.0 610691.0 66291.3 66475.3 66564.0 66704.0 66859.7 1308.4 1436.9 1486.9 1503.2 1514.3 29276.9 29841.0 30917.0 31643.9 31746.4 55546.4 55836.4 55841.0 55965.4 56112.4 519124.0 520687.0 522076.4 522866.0 523133.0 27213.9 28261.6 28266.7 28303.7 28336.6 40685.4 42813.1 49502.5 50874.7 54961.0 40756.3 41704.2 41859.4 41938.4 43745.6 37162.1 37645.6 41220.8 41964.8 42908.9 40569.8 41151.1 41252.6 41348.8 41373.4 31321.6 33361.8 34968.2 36692.6 37082.6 26405.6 26712.2 26844.7 26922.6 27188.0 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:39640.44 Median:21780.13 stddev:120668.87 (554.0%) stddev-sans-first:120971.31 09:02:05 INFO - PROCESS | 1633 | Values: 349.0 377.8 400.0 413.3 434.7 20434.5 20529.5 21691.0 21779.8 21780.5 18102.6 22207.2 22298.6 22905.0 23005.0 5747.8 6116.0 6116.9 6121.8 6124.6 5873.0 5970.0 6040.2 6120.2 6124.7 6244.2 6252.5 6256.9 6259.2 6265.5 6236.6 6380.3 6813.1 6895.6 6898.7 5397.2 6154.2 6157.8 6159.5 6168.3 13562.7 14052.0 14220.0 14235.0 14274.5 2250.3 2338.4 2747.9 2756.9 2986.5 9705.0 10202.9 10548.0 10805.6 10805.6 1583.5 1882.3 1892.9 1893.0 1895.2 119566.0 133541.3 136199.0 138266.3 139710.0 10159.5 11875.2 11943.9 12205.3 12327.7 16360.0 16364.8 16366.7 16399.5 16411.8 8716.4 8979.2 9010.3 9083.7 9142.5 8811.8 8830.4 8848.5 8980.7 9007.1 4804.9 4881.3 4918.4 4979.2 5090.6 1715.9 1990.0 2034.8 2050.5 2052.7 1025.4 1053.2 1054.8 1068.2 1092.9 21167.3 21450.5 22789.5 22791.4 22829.2 1028.2 1074.9 1099.5 1112.9 1122.4 10761.5 11669.6 11684.5 11715.0 11726.5 568777.0 735450.4 754751.0 765045.0 772091.0 144834.0 145307.3 151688.0 154490.2 157968.0 456.1 477.9 478.6 479.8 481.2 11217.9 11284.9 11573.2 11724.3 12086.2 44989.0 56808.7 57940.4 60904.7 62405.7 67768.6 73130.6 88137.0 91824.0 98417.5 8750.9 8832.3 9006.5 9156.4 9199.3 13622.1 13867.2 14046.4 14155.8 14546.3 11483.7 11747.6 11867.2 11869.9 11907.9 10541.9 11629.8 11903.1 12038.8 12091.7 10620.2 11797.4 11962.5 12058.9 12145.0 8742.0 8982.1 8982.3 9139.8 9216.2 11203.9 11736.6 12071.9 12074.0 12107.4 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5481.98 Median:5105.71 stddev:2930.32 (57.4%) stddev-sans-first:2922.21 09:02:05 INFO - PROCESS | 1633 | Values: 1367.1 1474.6 1492.5 1503.1 1503.5 7619.8 8239.0 8454.5 8461.6 8537.9 8295.8 8396.1 8398.4 8402.2 8407.0 2151.8 2233.7 2379.8 2420.4 2422.9 2382.4 2460.0 2460.0 2465.8 2466.6 2393.7 2421.7 2429.2 2432.6 2435.6 2410.9 2419.2 2447.0 2447.6 2447.7 2418.6 2444.3 2445.4 2446.2 2452.0 8246.9 8333.6 8367.7 8453.5 8521.4 5095.3 5141.2 5272.8 5292.4 5302.7 3442.1 3543.5 3665.9 3674.8 3685.6 1238.6 1281.4 1314.7 1326.4 1335.4 10969.4 10989.5 11001.5 11017.7 11026.3 4585.4 4698.3 4731.1 4804.7 4810.9 8629.0 8812.4 8813.3 8824.7 8824.8 5217.3 5228.6 5229.3 5229.8 5233.2 3885.7 4369.5 4885.4 4914.1 4915.4 3696.9 3704.2 3805.8 3813.2 3820.5 1170.3 1184.5 1187.0 1191.3 1200.3 837.3 943.6 951.7 966.8 1015.2 4988.7 5584.4 5949.1 5955.3 6045.7 985.4 1022.9 1033.7 1047.5 1079.1 3739.8 3824.8 3897.0 3922.9 4003.5 9523.5 10191.0 10195.2 10202.1 10208.4 8869.8 9884.3 10032.5 10178.9 10186.8 7504.8 7507.2 7628.4 7670.1 7790.2 5376.4 5679.1 5742.9 5757.7 5925.9 9195.3 9199.7 9261.0 9319.9 9413.2 9386.2 9552.6 9563.4 9642.7 9647.3 6730.7 6929.9 7212.3 7331.3 7352.9 7278.0 7838.8 7991.6 8001.3 8056.6 7021.7 7127.1 7164.2 7180.9 7287.6 7061.3 7064.4 7068.0 7084.2 7103.9 6358.4 6404.5 6483.5 6491.8 6493.0 5008.5 5033.6 5055.3 5094.3 5105.4 4966.6 4967.6 5106.0 5169.4 5255.7 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4506.57 Median:4974.90 stddev:1372.20 (27.6%) stddev-sans-first:1340.36 09:02:05 INFO - PROCESS | 1633 | Values: 363.7 365.2 373.7 379.9 381.7 4320.8 4515.5 4814.5 5472.3 5497.5 4818.9 5123.5 5180.5 5337.5 5371.1 3860.4 4125.1 4230.9 4260.3 4292.8 3850.6 4259.1 4262.3 4267.9 4294.4 3863.5 4039.3 4087.2 4180.9 4254.7 3329.3 3439.7 3461.5 3472.5 3651.3 3529.1 3538.4 3557.6 3559.8 3560.0 4869.3 4892.8 5230.6 5289.3 5357.2 3575.7 3791.2 3938.5 4673.4 4721.3 4705.4 4973.4 5669.1 5704.8 5758.5 3944.6 3950.0 3950.3 3958.6 3969.5 4454.6 5543.3 5751.1 5905.6 5962.7 3226.5 3352.3 3523.9 3936.4 3975.9 4063.7 4085.7 4089.9 4091.9 4176.4 4380.9 4622.8 4661.7 4717.6 4723.3 4930.3 5605.2 5703.7 5716.1 5747.2 1080.9 1279.8 1286.5 1299.8 1312.8 793.6 837.4 960.0 966.0 997.6 4918.8 4952.9 5090.1 5093.7 5157.9 4784.3 5603.5 5610.4 5635.7 5652.8 4935.5 5116.6 5380.4 5444.9 5466.3 2581.3 2798.4 2910.0 2925.0 2932.7 4526.3 5365.4 5433.2 5660.1 5747.5 4513.2 5256.3 5282.6 5714.1 5754.7 4757.9 5529.8 5769.7 5817.3 5830.4 5461.9 5470.3 5561.5 5597.1 5647.5 5522.1 5542.9 5544.3 5551.6 5617.6 4803.7 5410.9 5442.4 5775.9 5810.4 3683.4 3941.9 3987.2 3994.7 4016.7 5104.7 5901.4 5916.8 5937.1 6012.3 4972.5 5405.8 5768.5 5833.1 5833.6 4976.4 5435.8 5459.3 5709.2 5752.4 4534.3 5276.9 5456.8 5598.6 5643.1 4690.6 5156.4 5463.2 5486.3 5530.3 5540.3 5540.5 5550.5 5557.0 5575.2 09:02:05 INFO - PROCESS | 1633 | 09:02:05 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:20665.07 Median:3823.84 stddev:29811.03 (779.6%) stddev-sans-first:29857.06 09:02:05 INFO - PROCESS | 1633 | Values: 726.1 751.3 767.4 791.6 862.6 15112.8 15661.0 15675.2 15680.4 15685.7 14124.0 14393.0 14446.8 14472.4 14483.4 906.2 916.2 926.2 927.3 928.3 915.2 915.6 915.9 916.5 916.7 758.0 780.3 947.4 982.3 986.7 975.5 975.9 976.9 977.3 978.3 725.1 725.4 726.3 726.8 728.0 15396.9 15571.3 15613.0 15630.6 15808.8 14592.3 14637.9 14724.2 14756.9 14758.4 11719.3 11856.1 11873.1 11906.8 12127.7 3628.6 3741.2 3794.6 3934.0 3982.0 103844.5 105057.9 106435.0 113649.4 113927.0 10889.8 10970.5 11220.9 11538.6 11691.9 22596.7 23007.0 23270.5 23552.1 23619.0 7763.5 8035.6 8106.8 8117.4 8189.0 4322.7 4381.4 4397.1 4424.2 4563.0 3714.6 3771.9 3816.9 3821.9 3825.8 673.5 674.1 684.9 688.1 708.1 542.8 602.8 640.8 680.8 743.3 10346.3 10405.4 10519.3 10719.7 11220.0 584.3 676.2 681.9 711.3 723.8 5007.2 5091.3 5103.3 5182.5 5188.3 77750.6 77820.0 88324.0 100069.5 105221.0 95121.0 95177.6 95769.0 97381.0 98171.0 80205.0 80431.4 82979.0 83970.0 84012.6 9667.6 10032.4 10068.2 10074.8 10081.4 42403.4 46055.7 53951.0 55227.7 55264.4 71059.0 73198.6 74215.9 74876.6 76497.0 11576.4 11937.3 11947.4 12052.6 12398.8 13161.8 13184.7 13245.8 13304.5 13557.4 12294.6 12475.6 12553.3 12949.5 12987.2 12084.2 12151.4 12521.5 12932.4 13144.3 9830.3 11763.4 12173.3 12195.8 12271.3 10106.2 10173.1 10545.7 10937.9 11252.4 8144.2 10271.9 10373.3 10402.7 10569.5 09:02:05 INFO - PROCESS | 1633 | -------- Summary: end -------- 09:02:05 INFO - PROCESS | 1633 | 09:02:06 INFO - TEST-INFO | 1633: exit 0 09:02:06 INFO - TEST-OK | dromaeo_css | took 1116617ms 09:02:06 INFO - TEST-START | kraken 09:02:06 INFO - operating with platform_type : mac_ 09:02:06 INFO - Initialising browser for kraken test... 09:02:06 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpMRXHyY/profile http://localhost:49242/getInfo.html) 09:02:08 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 09:02:08 INFO - PROCESS | 1643 | colorDepth:24 09:02:08 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 09:02:08 INFO - PROCESS | 1643 | __metrics 09:02:08 INFO - PROCESS | 1643 | 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" 09:02:08 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:09 INFO - TEST-INFO | 1643: exit 0 09:02:09 INFO - Browser initialized. 09:02:09 INFO - Running cycle 1/1 for kraken test... 09:02:09 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpMRXHyY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:21 INFO - PROCESS | 1645 | RSS: Main: 167723008 09:02:21 INFO - PROCESS | 1645 | 09:02:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:24 INFO - PROCESS | 1645 | RSS: Main: 215724032 09:02:24 INFO - PROCESS | 1645 | 09:02:27 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 09:02:27 INFO - PROCESS | 1645 | RSS: Main: 228859904 09:02:27 INFO - PROCESS | 1645 | 09:02:31 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 09:02:31 INFO - PROCESS | 1645 | RSS: Main: 324915200 09:02:31 INFO - PROCESS | 1645 | 09:02:33 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 09:02:34 INFO - PROCESS | 1645 | RSS: Main: 227332096 09:02:34 INFO - PROCESS | 1645 | 09:02:36 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:36 INFO - PROCESS | 1645 | RSS: Main: 229081088 09:02:36 INFO - PROCESS | 1645 | 09:02:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:40 INFO - PROCESS | 1645 | RSS: Main: 267456512 09:02:40 INFO - PROCESS | 1645 | 09:02:43 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:44 INFO - PROCESS | 1645 | RSS: Main: 270454784 09:02:44 INFO - PROCESS | 1645 | 09:02:46 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 09:02:47 INFO - PROCESS | 1645 | RSS: Main: 268922880 09:02:47 INFO - PROCESS | 1645 | 09:02:49 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:49 INFO - PROCESS | 1645 | RSS: Main: 246652928 09:02:49 INFO - PROCESS | 1645 | 09:02:51 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:52 INFO - PROCESS | 1645 | RSS: Main: 247324672 09:02:52 INFO - PROCESS | 1645 | 09:02:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:55 INFO - PROCESS | 1645 | RSS: Main: 255033344 09:02:55 INFO - PROCESS | 1645 | 09:02:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:58 INFO - PROCESS | 1645 | RSS: Main: 271011840 09:02:58 INFO - PROCESS | 1645 | 09:03:01 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:02 INFO - PROCESS | 1645 | RSS: Main: 264146944 09:03:02 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 09:03:03 INFO - PROCESS | 1645 | RSS: Main: 308224000 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | __start_tp_report 09:03:03 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 09:03:03 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 09:03:03 INFO - PROCESS | 1645 | |i|pagename|runs| 09:03:03 INFO - PROCESS | 1645 | |0;ai-astar;112;114;114;115;114;114;114;114;113;115 09:03:03 INFO - PROCESS | 1645 | |1;audio-beat-detection;135;107;108;141;106;108;108;105;132;136 09:03:03 INFO - PROCESS | 1645 | |2;audio-dft;181;183;184;180;187;181;181;182;182;182 09:03:03 INFO - PROCESS | 1645 | |3;audio-fft;80;58;57;88;62;69;78;79;94;58 09:03:03 INFO - PROCESS | 1645 | |4;audio-oscillator;81;69;86;68;69;87;113;97;86;82 09:03:03 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;90;87;92;87;90;87;91;88;91;87 09:03:03 INFO - PROCESS | 1645 | |6;imaging-darkroom;99;94;95;95;94;94;111;144;93;94 09:03:03 INFO - PROCESS | 1645 | |7;imaging-desaturate;90;91;121;80;131;131;119;86;87;84 09:03:03 INFO - PROCESS | 1645 | |8;json-parse-financial;56;51;51;53;55;56;55;56;55;54 09:03:03 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;71;69;64;75;71;66;68;69;71;69 09:03:03 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;82;100;99;77;81;78;75;79;84;88 09:03:03 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;133;132;131;130;127;130;134;134;200;177 09:03:03 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;163;162;165;162;163;163;164;163;165;164 09:03:03 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;64;64;64;64;64;63;64;63;62;64 09:03:03 INFO - PROCESS | 1645 | __end_tp_report 09:03:03 INFO - PROCESS | 1645 | __start_cc_report 09:03:03 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1957 09:03:03 INFO - PROCESS | 1645 | __end_cc_report 09:03:03 INFO - PROCESS | 1645 | __startTimestamp1490025783939__endTimestamp 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | ------- Summary: start ------- 09:03:03 INFO - PROCESS | 1645 | Number of tests: 14 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.60 09:03:03 INFO - PROCESS | 1645 | Values: 112.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 113.0 115.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:120.00 stddev:15.16 (12.6%) stddev-sans-first:14.87 09:03:03 INFO - PROCESS | 1645 | Values: 135.0 107.0 108.0 141.0 106.0 108.0 108.0 105.0 132.0 136.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.00 stddev:2.00 (1.1%) stddev-sans-first:2.07 09:03:03 INFO - PROCESS | 1645 | Values: 181.0 183.0 184.0 180.0 187.0 181.0 181.0 182.0 182.0 182.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:72.30 Median:78.50 stddev:13.39 (17.1%) stddev-sans-first:13.91 09:03:03 INFO - PROCESS | 1645 | Values: 80.0 58.0 57.0 88.0 62.0 69.0 78.0 79.0 94.0 58.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:84.00 stddev:13.93 (16.6%) stddev-sans-first:14.73 09:03:03 INFO - PROCESS | 1645 | Values: 81.0 69.0 86.0 68.0 69.0 87.0 113.0 97.0 86.0 82.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:90.00 stddev:2.00 (2.2%) stddev-sans-first:2.09 09:03:03 INFO - PROCESS | 1645 | Values: 90.0 87.0 92.0 87.0 90.0 87.0 91.0 88.0 91.0 87.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.00 stddev:15.93 (16.9%) stddev-sans-first:16.88 09:03:03 INFO - PROCESS | 1645 | Values: 99.0 94.0 95.0 95.0 94.0 94.0 111.0 144.0 93.0 94.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:85.00 stddev:20.78 (24.4%) stddev-sans-first:21.58 09:03:03 INFO - PROCESS | 1645 | Values: 90.0 91.0 121.0 80.0 131.0 131.0 119.0 86.0 87.0 84.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.93 (3.5%) stddev-sans-first:1.94 09:03:03 INFO - PROCESS | 1645 | Values: 56.0 51.0 51.0 53.0 55.0 56.0 55.0 56.0 55.0 54.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.00 stddev:3.02 (4.3%) stddev-sans-first:3.14 09:03:03 INFO - PROCESS | 1645 | Values: 71.0 69.0 64.0 75.0 71.0 66.0 68.0 69.0 71.0 69.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.50 stddev:8.82 (10.8%) stddev-sans-first:9.32 09:03:03 INFO - PROCESS | 1645 | Values: 82.0 100.0 99.0 77.0 81.0 78.0 75.0 79.0 84.0 88.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:133.50 stddev:24.78 (18.6%) stddev-sans-first:26.03 09:03:03 INFO - PROCESS | 1645 | Values: 133.0 132.0 131.0 130.0 127.0 130.0 134.0 134.0 200.0 177.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:163.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 09:03:03 INFO - PROCESS | 1645 | Values: 163.0 162.0 165.0 162.0 163.0 163.0 164.0 163.0 165.0 164.0 09:03:03 INFO - PROCESS | 1645 | 09:03:03 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 09:03:03 INFO - PROCESS | 1645 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 64.0 63.0 62.0 64.0 09:03:03 INFO - PROCESS | 1645 | -------- Summary: end -------- 09:03:03 INFO - PROCESS | 1645 | 09:03:04 INFO - TEST-INFO | 1645: exit 0 09:03:04 INFO - TEST-OK | kraken | took 58714ms 09:03:04 INFO - SUITE-END | took 1175s 09:03:05 INFO - Completed test suite (00:19:35) 09:03:05 INFO - javascript benchmark 09:03:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3479.1476088358354, 3511.8770843020484, 3534.522839416678, 3563.8574457021714, 3574.356615809155, 5971.283445986483, 6034.788782392618, 6036.788712395067, 6068.484178844804, 6071.7267722952465, 6013.518918486521, 6074.240719910012, 6083.239595050619, 6085.604435711675, 6089.0, 5360.088784906566, 5363.973180134094, 5410.215518749779, 5429.239906413105, 5486.396496385394, 4235.53409124996, 5210.270562121306, 5360.356757189143, 5485.122380419134, 5543.1408131739445, 4460.464744230697, 5438.456154384569, 5455.563554915617, 5467.6719396836315, 5488.53347465464, 5447.809326673548, 5455.754491047913, 5457.345118585776, 5471.124620060811, 5476.315460567429, 5336.226247194174, 5397.8380648580605, 5432.6468779529205, 5451.454854514556, 5483.506484416422, 6180.2892667343385, 6188.566800323979, 6191.195144631214, 6192.783252586138, 6202.689865506707, 6196.597221180609, 6363.872722545523, 6369.36306369364, 6371.904421433682, 6392.105105285264, 5314.73426328682, 6320.020396838451, 6367.172267605228, 6402.13571167891, 6440.066190402412, 6212.068189771525, 6215.844603884939, 6219.284782250099, 6227.595206311576, 6229.314775374705, 6610.2398224204835, 6624.668766561749, 6630.668466576652, 6635.2037755469655, 6641.734330626818, 6201.162843016225, 6230.252369715572, 6286.842828929313, 6303.180586523723, 6304.968475157595, 6460.450861676716, 6472.805815825533, 6473.158489396443, 6477.481801455872, 6482.675866206765, 6243.594166379262, 6344.302126766052, 6363.936360636427, 6384.48924086072, 6395.936040639627, 6227.252729672377, 6267.780627678009, 6269.435750782452, 6396.776112836028, 6409.230892292861, 5166.819161329336, 5183.937292854956, 5189.870253243624, 5191.091558977164, 5231.267622532849, 4627.676062675648, 4630.305454181899, 4642.3500709900645, 4662.4405071390975, 4668.066386722669, 5932.822015339547, 6126.632402055891, 6127.387261273837, 6149.569530132848, 6152.415520525543, 6305.306416294204, 6358.77744278948, 6373.5857169283845, 6409.359064093646, 6422.582532135396, 5167.457416971164, 5671.97904377216, 6108.827782940766, 6127.372786728385, 6151.96924015377, 5661.773529058792, 5671.2060311556415, 5676.120201368794, 5686.0333743263745, 5693.800716974969, 6399.328070552618, 6512.511561632991, 6560.147180866456, 6608.240052394036, 6650.70071846768, 5914.201582786269, 6412.647304398116, 6433.099366088845, 6441.1626488556185, 6448.806535803933, 6594.076829243813, 6643.169603799525, 6643.667816609247, 6644.435223006099, 6665.066890635412, 6238.844028899314, 6281.654509002049, 6282.780102696383, 6307.369263073656, 6351.428371446592, 6286.811395658137, 6334.429901308904, 6441.484681225397, 6453.967730161319, 6463.3213512580505, 6281.371862813682, 6282.623042617458, 6287.905681414874, 6293.748250070129, 6295.0, 6195.938040619536, 6235.407636274546, 6240.438360547572, 6257.843553911189, 6297.52768542352, 6226.1905952225925, 6241.31345551998, 6269.185005949197, 6269.216347956505, 6284.025975973731, 6301.0863424804065, 6303.0, 6308.211473565804, 6311.053341998737, 6313.526485513513, 6172.074188871526, 6180.876382472416, 6207.441330280297, 6218.036204388327, 6261.96869015652], "value": 5917.962524402991, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.2218893848166, 530.6921985248558, 532.0556013076788, 534.1480338859518, 589.6491587505433, 33123.50314745281, 42175.156496870084, 43928.56071439285, 43995.34006989898, 45664.0, 38488.03779905504, 45700.94345754441, 45951.31073033907, 46516.06967860641, 46625.0, 8289.626966786478, 9773.045390921845, 9774.462404567728, 10004.399736015863, 10007.799844003115, 9272.629094836198, 12130.45412956419, 12365.07261955357, 12399.070069744761, 12527.874721252807, 10149.847752283722, 12269.263844169334, 12273.263604183732, 12289.446974886107, 12290.815637765441, 12182.390880455941, 12249.755004899942, 12264.38678066102, 12265.509379624804, 12272.325022123825, 12135.93932030343, 12212.450439730233, 12236.81644775329, 12241.32672703001, 12242.938785306105, 43559.0, 43852.12295754067, 43917.560824391665, 43969.34045989313, 44065.0, 3571.4107172316535, 4113.609207125318, 4170.374443833419, 4185.832566697329, 4206.26390381682, 31310.84344578285, 32486.512702309483, 33201.0, 33801.0, 33813.661863381545, 3290.226796702773, 3331.3004269103517, 3488.1105318143964, 3558.6085530591613, 3564.465330200465, 476520.0, 477333.0, 477427.0, 477636.22363776265, 478233.0, 68985.65507172432, 69340.0, 69389.30610693828, 69456.61086778236, 72710.27289727035, 72224.63887680633, 72305.0, 72416.91374629385, 72424.63787681027, 72425.63787181031, 17912.373066942593, 18239.36162234342, 18241.087945602667, 18263.269469221348, 18267.72598411025, 12633.0, 12890.677733056562, 13696.65758356029, 13806.378712957941, 13861.029727918949, 15966.458458115923, 17011.31954721822, 18912.621747564972, 19298.035098245033, 19317.227310907405, 7681.884771728429, 7685.7309994151055, 7721.498102623312, 7745.095589154067, 7756.1468238494845, 889.1197714262962, 890.4212262029603, 905.44767691708, 923.736735030513, 945.2438049560325, 31531.527027094613, 31905.0, 32016.199595009846, 32311.676883231336, 32320.030399088064, 995.6764051683232, 1090.836374543809, 1131.7000994736402, 1232.9938350308191, 1245.2777389114474, 16298.0, 16571.0, 16634.75047874283, 16645.667086658443, 17019.659606807796, 605400.0, 609562.0, 610009.0, 610131.0, 610691.0, 66291.33708662851, 66475.33524664788, 66564.0, 66703.99832007571, 66859.66570167118, 1308.385059022296, 1436.920969346675, 1486.947956821506, 1503.1582313904248, 1514.2882845062802, 29276.853615731787, 29841.0, 30917.0, 31643.89246376458, 31746.365072697954, 55546.44453555575, 55836.44163558475, 55841.0, 55965.44034559765, 56112.43887561235, 519124.0, 520687.0, 522076.3896180495, 522866.0, 523133.0, 27213.86393068022, 28261.57607635846, 28266.717332826407, 28303.71696283011, 28336.57495137616, 40685.38971915483, 42813.143737125705, 49502.50497495123, 50874.74562627163, 54961.0, 40756.29411882279, 41704.165916682105, 41859.372109417774, 41938.37092443677, 43745.56254437415, 37162.07094822651, 37645.62354376421, 41220.79389603033, 41964.790176048926, 42908.92727681708, 40569.797151015235, 41151.08773012466, 41252.58747412608, 41348.793256033525, 41373.37939930843, 31321.647660048067, 33361.83319083486, 34968.153503114125, 36692.63307366892, 37082.629173707915, 26405.603915940894, 26712.198634040233, 26844.731552684225, 26922.59616105721, 27188.00931897529], "value": 21442.294424456828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.95812502499706, 377.7676728811781, 399.95000624921903, 413.2561389498902, 434.68050982527836, 20434.489137771565, 20529.486762830937, 21691.0, 21779.802110883895, 21780.455488612773, 18102.637947241048, 22207.22274720385, 22298.55402891941, 22905.0, 23005.0, 5747.827565173041, 6115.969420152893, 6116.938830611703, 6121.816345509642, 6124.632522048669, 5872.970635146839, 5969.970150149243, 6040.154378387029, 6120.234970628671, 6124.693765311717, 6244.188255526775, 6252.49980001601, 6256.874862502747, 6259.217597800275, 6265.530085243602, 6236.56344055914, 6380.3300653431415, 6813.080234168398, 6895.620740859251, 6898.724051037952, 5397.2443857859935, 6154.169187159721, 6157.78447754331, 6159.50723942088, 6168.321484636686, 13562.728745425036, 14052.016358854884, 14220.004599678026, 14235.003549751522, 14274.500392486318, 2250.2911582851348, 2338.3981972348997, 2747.931301717473, 2756.944861102767, 2986.462436761382, 9704.980976997384, 10202.948985255027, 10547.99794019567, 10805.5677772889, 10805.621803236927, 1583.4695377048702, 1882.294388453403, 1892.8580356473183, 1892.9526761830928, 1895.1755986145934, 119566.0, 133541.3322933379, 136199.0, 138266.30866845703, 139710.0, 10159.476078588123, 11875.168738188244, 11943.940280298542, 12205.267683938991, 12327.6918077047, 16360.018398896103, 16364.754528682079, 16366.672666546603, 16399.508014759576, 16411.83588164127, 8716.389852710376, 8979.236764875059, 9010.27917766577, 9083.68207112748, 9142.497162656118, 8811.779705507413, 8830.42602230853, 8848.513331766686, 8980.730578082668, 9007.144321289466, 4804.879878003008, 4881.292212629149, 4918.385201849769, 4979.228219625964, 5090.618203634668, 1715.8970461772333, 1989.9900500497404, 2034.7761746207905, 2050.4976280810997, 2052.7331446912103, 1025.4052649463292, 1053.1943063556232, 1054.8291396549823, 1068.2415485005577, 1092.9398883061508, 21167.25914592982, 21450.498465107292, 22789.544209115724, 22791.430214244778, 22829.20097796569, 1028.1723212813756, 1074.876753792289, 1099.5107177306022, 1112.933224006562, 1122.3826895207603, 10761.461926903623, 11669.59156429521, 11684.546245288415, 11715.0, 11726.530938762524, 568777.0, 735450.4063741885, 754751.0, 765045.0, 772091.0, 144834.0, 145307.273463632, 151688.0, 154490.22754886153, 157968.0, 456.1424521898809, 477.9426468823763, 478.63384510849227, 479.84405068352925, 481.21321639120987, 11217.887821121685, 11284.943575282072, 11573.247738896946, 11724.296542207494, 12086.153969222421, 44989.0, 56808.715956421605, 57940.420595795185, 60904.695476522335, 62405.68797156167, 67768.5619866112, 73130.63434682792, 88137.0, 91824.0, 98417.50791245997, 8750.912490875264, 8832.293416526534, 9006.54967251648, 9156.443404621097, 9199.310051746012, 13622.114562553403, 13867.23730194849, 14046.438142474186, 14155.787663185267, 14546.272686365428, 11483.712907177387, 11747.649020362767, 11867.228630139014, 11869.881301186877, 11907.940460297643, 10541.947290263499, 11629.825552616887, 11903.10726695484, 12038.75922481563, 12091.697707557381, 10620.20348473852, 11797.404570994368, 11962.46168922418, 12058.879411205775, 12145.0, 8742.0, 8982.101789820965, 8982.281417486716, 9139.817203656023, 9216.216621586971, 11203.887961120285, 11736.589219377282, 12071.913527782543, 12074.0, 12107.394630268274], "value": 9761.213599669738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.1455340412242, 1474.6165996840825, 1492.5373134328356, 1503.0831192972282, 1503.5188739603332, 7619.771406857796, 8239.0, 8454.450460720049, 8461.619227134779, 8537.87193192101, 8295.834083318345, 8396.118407567194, 8398.412111152222, 8402.243798058174, 8407.0, 2151.7848215178515, 2233.7207849018873, 2379.773921477461, 2420.382802385398, 2422.9151979680714, 2382.4282172278613, 2459.963100553493, 2459.987700061506, 2465.827392082555, 2466.580681284177, 2393.7127544694663, 2421.709394872618, 2429.2347910408166, 2432.5621388150125, 2435.561598912204, 2410.867402292873, 2419.237940048879, 2446.963295550577, 2447.596146635803, 2447.681801365829, 2418.6334720882646, 2444.3155916343453, 2445.364205306615, 2446.156076153724, 2451.9877400613063, 8246.876296855551, 8333.624986875544, 8367.748967530984, 8453.535055572003, 8521.44610600309, 5095.312132862054, 5141.177411614161, 5272.815451459181, 5292.391374991887, 5302.681839089629, 3442.1394651337164, 3543.5471456702885, 3665.9083522911874, 3674.7978861162624, 3685.594584595692, 1238.6284114765535, 1281.35932033983, 1314.6976195475095, 1326.3699742622273, 1335.4324412124906, 10969.396683182422, 10989.505472253768, 11001.504932278067, 11017.669469915836, 11026.338419694845, 4585.358049873021, 4698.342232087511, 4731.101090792808, 4804.711717296974, 4810.855674329776, 8628.96452425713, 8812.427192232484, 8813.33899957493, 8824.735257942144, 8824.823503529893, 5217.2695822584865, 5228.55557277628, 5229.294045303835, 5229.843104706865, 5233.162693968947, 3885.6502914737243, 4369.519352871182, 4885.438174609894, 4914.140025495595, 4915.4347250065985, 3696.9260614787554, 3704.184949374787, 3805.82873770681, 3813.218290250492, 3820.5033345665443, 1170.3446070200714, 1184.4729095552395, 1186.9940650296867, 1191.338806962127, 1200.2678366196612, 837.2506606587192, 943.5801068524578, 951.743029382063, 966.7824739433712, 1015.1523477896039, 4988.700677959334, 5584.385717571064, 5949.137375080589, 5955.28536575605, 6045.72794224261, 985.4284514981437, 1022.892596277395, 1033.7363972187045, 1047.4814966591587, 1079.0558261521169, 3739.8130093495215, 3824.827882745283, 3897.0452239201577, 3922.8626998054933, 4003.5195776507007, 9523.476208808583, 10191.0, 10195.184385249311, 10202.081812636898, 10208.387496750218, 8869.778255543662, 9884.30809843304, 10032.548535315927, 10178.949105254575, 10186.847197292047, 7504.774856754306, 7507.211742766931, 7628.351590114791, 7670.079590449071, 7790.182030886788, 5376.435474275145, 5679.119736440858, 5742.856428589319, 5757.712114394348, 5925.911111333247, 9195.26437884981, 9199.724008279762, 9260.953695231481, 9319.86020209711, 9413.199878010446, 9386.202172815114, 9552.617895284111, 9563.378380405251, 9642.662506812228, 9647.324687271823, 6730.6634668265415, 6929.930700692928, 7212.3148300911325, 7331.266873312839, 7352.926470735224, 7278.0, 7838.804029899298, 7991.600419979094, 8001.279884810395, 8056.556889370906, 7021.719131234898, 7127.144742630918, 7164.211936687065, 7180.856382872418, 7287.562746235243, 7061.293870612898, 7064.399526040344, 7068.0, 7084.220735718964, 7103.857922841411, 6358.395952384516, 6404.455621272058, 6483.513736469878, 6491.772787952399, 6492.967535162294, 5008.549230569266, 5033.622478314068, 5055.317532133115, 5094.312267843794, 5105.387353517453, 4966.553010228952, 4967.627427942846, 5106.029854327666, 5169.353830771153, 5255.737213139404], "value": 4497.832355406719, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.70539862711206, 365.1965675513869, 373.712241573988, 379.94300854871767, 381.66032231314153, 4320.805563749631, 4515.548445155487, 4814.542618451242, 5472.288602481677, 5497.532709719679, 4818.855434336975, 5123.462036486171, 5180.533751962323, 5337.519623233918, 5371.140617501191, 3860.3823388257883, 4125.113100683352, 4230.894227644303, 4260.25445547028, 4292.763897985609, 3850.595687452819, 4259.063006138645, 4262.2754131797665, 4267.871963841089, 4294.377315289281, 3863.459115723801, 4039.313316736147, 4087.2220584046036, 4180.895477613054, 4254.659627229814, 3329.3174899145615, 3439.7420193485464, 3461.5326930864517, 3472.5485686860548, 3651.3062518121474, 3529.100079479742, 3538.380783362901, 3557.5908770491205, 3559.7896715116726, 3559.982200089009, 4869.264138178047, 4892.77680579855, 5230.607704422184, 5289.259503669489, 5357.1696387060065, 3575.6781889629797, 3791.241751649681, 3938.5076865391825, 4673.3690951721765, 4721.268203428474, 4705.435347758256, 4973.403191616993, 5669.121286200645, 5704.7751376963015, 5758.452946970031, 3944.6449819516383, 3949.98025009876, 3950.2889479893606, 3958.5843486433796, 3969.5435024972207, 4454.57681520255, 5543.279373681396, 5751.079827227623, 5905.645661260338, 5962.672053037081, 3226.451503244454, 3352.3295340931422, 3523.9119022024656, 3936.4292177634657, 3975.860844870416, 4063.6952228582973, 4085.6507508182913, 4089.8568550100604, 4091.877243682635, 4176.373543968429, 4380.890477738082, 4622.815087396467, 4661.720296782204, 4717.575418212309, 4723.291506274087, 4930.33440485537, 5605.159226116034, 5703.7148142592705, 5716.084796753686, 5747.166660834156, 1080.8540846985713, 1279.7842050052489, 1286.4661165616164, 1299.7985312276612, 1312.8424589049375, 793.5913004802532, 837.392890154633, 960.0, 965.9760653706952, 997.551102004101, 4918.754062296871, 4952.885600739877, 5090.058339207185, 5093.726568357911, 5157.885267040496, 4784.30627559002, 5603.467670571289, 5610.438956104438, 5635.745012515525, 5652.802151924663, 4935.507568677866, 5116.616253780907, 5380.354357477127, 5444.891102177934, 5466.262054622575, 2581.250967719373, 2798.4403119376207, 2909.9815064727177, 2924.956125658117, 2932.7213914678073, 4526.306847425776, 5365.409804921455, 5433.239346491494, 5660.066089095253, 5747.48272655463, 4513.232750432434, 5256.316678831804, 5282.550983166397, 5714.085746280658, 5754.74103665336, 4757.9286310705365, 5529.751161197836, 5769.653820770767, 5817.331006934172, 5830.356027482908, 5461.863453413696, 5470.317508285815, 5561.527270181918, 5597.132444471114, 5647.519960803378, 5522.061249587499, 5542.889142217053, 5544.3346798384455, 5551.639143455663, 5617.5505959522325, 4803.735794531334, 5410.891782164414, 5442.37412697529, 5775.8556036099435, 5810.380747305818, 3683.3922402803237, 3941.862034828882, 3987.202559488172, 3994.6604538614542, 4016.678665706795, 5104.69371837691, 5901.350851406256, 5916.822495325147, 5937.079752638348, 6012.308584512837, 4972.502749725143, 5405.78376864921, 5768.451997060272, 5833.075085221782, 5833.649981001154, 4976.402831660224, 5435.84720861907, 5459.287684374504, 5709.172170035405, 5752.395998420106, 4534.319852022091, 5276.868078298074, 5456.754446050017, 5598.648567601535, 5643.109558298016, 4690.6247500199215, 5156.4070131935305, 5463.180522921593, 5486.31421072366, 5530.336359636869, 5540.307461567304, 5540.501354878081, 5550.47270509301, 5557.0, 5575.208857976615], "value": 4087.9166673011077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.1141407482876, 751.2862780358661, 767.3515879082173, 791.606583461787, 862.5816479007682, 15112.773308400368, 15661.0, 15675.216239188037, 15680.372785088612, 15685.686286274282, 14124.0, 14393.0, 14446.783298250535, 14472.42110315586, 14483.420663173487, 906.2161230535588, 916.2257892081215, 926.1803304075908, 927.3045216087934, 928.2573940847329, 915.199200699388, 915.6200176926568, 915.9496227707474, 916.4638686368482, 916.724982505249, 757.9583122928236, 780.2743448592806, 947.3984020147221, 982.3221976835996, 986.7286496213562, 975.4878688688424, 975.8877729061143, 976.8583555384465, 977.3207620703614, 978.280963491833, 725.0719079578148, 725.365305357812, 726.2555880222761, 726.8255618651485, 727.9854402911913, 15396.923015384851, 15571.299291531795, 15613.0, 15630.609234769108, 15808.762868556982, 14592.343344549521, 14637.926810365987, 14724.19016954067, 14756.926215368854, 14758.409663613442, 11719.296842189497, 11856.110791690571, 11873.10951678619, 11906.821397679041, 12127.696807579792, 3628.5827129880136, 3741.1769410729594, 3794.6205379461835, 3934.0, 3982.0, 103844.48077759563, 105057.94942050558, 106435.0, 113649.43175284153, 113927.0, 10889.782204355868, 10970.451477426097, 11220.943895280472, 11538.59614913474, 11691.941540292244, 22596.66105008426, 23007.0, 23270.534589308118, 23552.057917683444, 23619.0, 7763.534187948741, 8035.638396272182, 8106.837863242702, 8117.4317797754775, 8189.0, 4322.740635561876, 4381.408509851193, 4397.120575884772, 4424.203643344164, 4562.973331000565, 3714.60996595359, 3771.905702357463, 3816.885493435201, 3821.8662346818282, 3825.8087095645105, 673.4541842562702, 674.1337381464892, 684.9246582875879, 688.0917189310063, 708.1183926012147, 542.8472187763562, 602.7619090459244, 640.8272860664972, 680.8059702984625, 743.2938708227098, 10346.275760696679, 10405.375677459377, 10519.275263948077, 10719.67237676678, 11220.0, 584.3192680527138, 676.1615596660205, 681.8908974564046, 711.263841923617, 723.8081908294201, 5007.24891266313, 5091.289511046888, 5103.260027296022, 5182.507661772125, 5188.273641690166, 77750.6112469434, 77820.0, 88324.0, 100069.49965250272, 105221.0, 95121.0, 95177.572336415, 95769.0, 97381.0, 98171.0, 80205.0, 80431.39137217223, 82979.0, 83970.0, 84012.57993710115, 9667.613295468103, 10032.448215348226, 10068.194544436281, 10074.8488772667, 10081.395116293046, 42403.363949540166, 46055.69721513844, 53951.0, 55227.72386138044, 55264.44735552593, 71059.0, 73198.63400682963, 74215.8867616997, 74876.62561687156, 76497.0, 11576.41826016162, 11937.28376297425, 11947.402629868298, 12052.578159764365, 12398.752024959631, 13161.802572961606, 13184.73630527365, 13245.801312980506, 13304.46782128704, 13557.389917453542, 12294.569690060805, 12475.563355282522, 12553.309567973483, 12949.482020719066, 12987.220766754024, 12084.214526055779, 12151.392430378623, 12521.499140034297, 12932.353382331034, 13144.27706476153, 9830.311878168459, 11763.353015584225, 12173.2696038238, 12195.756084878076, 12271.263724176579, 10106.242031847494, 10173.135283500986, 10545.683629491128, 10937.890621093688, 11252.437378131224, 8144.226298501633, 10271.94864025705, 10373.32573382758, 10402.739931501774, 10569.524371403459], "value": 7595.391009151583, "unit": "score"}], "name": "dromaeo_css", "value": 7464.635763657621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 107.0, 108.0, 141.0, 106.0, 108.0, 108.0, 105.0, 132.0, 136.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 184.0, 180.0, 187.0, 181.0, 181.0, 182.0, 182.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 57.0, 88.0, 62.0, 69.0, 78.0, 79.0, 94.0, 58.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 86.0, 68.0, 69.0, 87.0, 113.0, 97.0, 86.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 92.0, 87.0, 90.0, 87.0, 91.0, 88.0, 91.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 95.0, 94.0, 94.0, 111.0, 144.0, 93.0, 94.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 121.0, 80.0, 131.0, 131.0, 119.0, 86.0, 87.0, 84.0], "value": 102.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 51.0, 53.0, 55.0, 56.0, 55.0, 56.0, 55.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 64.0, 75.0, 71.0, 66.0, 68.0, 69.0, 71.0, 69.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 100.0, 99.0, 77.0, 81.0, 78.0, 75.0, 79.0, 84.0, 88.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 131.0, 130.0, 127.0, 130.0, 134.0, 134.0, 200.0, 177.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 162.0, 163.0, 163.0, 164.0, 163.0, 165.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 62.0, 64.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1440.8, "alertThreshold": 2.0}]} 09:03:05 INFO - Return code: 0 09:03:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:05 INFO - # TBPL SUCCESS # 09:03:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:03:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:03:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:03:05 INFO - 2017-03-20 09:03:05.280 screenresolution[1649:9741] starting screenresolution argv=screenresolution get 09:03:05 INFO - 2017-03-20 09:03:05.283 screenresolution[1649:9741] Display 0: 1600x1200x32@60 09:03:05 INFO - 2017-03-20 09:03:05.289 screenresolution[1650:9744] starting screenresolution argv=screenresolution list 09:03:05 INFO - Available Modes on Display 0 09:03:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:03:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:03:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:03:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:03:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:03:05 INFO - Intel Iris: 09:03:05 INFO - Chipset Model: Intel Iris 09:03:05 INFO - Type: GPU 09:03:05 INFO - Bus: Built-In 09:03:05 INFO - VRAM (Dynamic, Max): 1536 MB 09:03:05 INFO - Vendor: Intel (0x8086) 09:03:05 INFO - Device ID: 0x0a2e 09:03:05 INFO - Revision ID: 0x0009 09:03:05 INFO - Displays: 09:03:05 INFO - Display: 09:03:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:03:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:03:05 INFO - Display Serial Number: 1600x1200 60 09:03:05 INFO - Main Display: Yes 09:03:05 INFO - Mirror: Off 09:03:05 INFO - Online: Yes 09:03:05 INFO - Rotation: Supported 09:03:05 INFO - Return code: 0 09:03:05 INFO - Running post-action listener: _resource_record_post_action 09:03:05 INFO - [mozharness: 2017-03-20 16:03:05.526253Z] Finished run-tests step (success) 09:03:05 INFO - Running post-run listener: _resource_record_post_run 09:03:05 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 38183936; Write bytes: 421878272; Read time: 241; Write time: 1401 09:03:05 INFO - TinderboxPrint: CPU usage
53.6% 09:03:05 INFO - TinderboxPrint: I/O read bytes / time
38,183,936 / 241 09:03:05 INFO - TinderboxPrint: I/O write bytes / time
421,878,272 / 1,401 09:03:05 INFO - TinderboxPrint: CPU idle
2,210.5 (46.4%) 09:03:05 INFO - TinderboxPrint: CPU system
952.0 (20.0%) 09:03:05 INFO - TinderboxPrint: CPU user
1,603.1 (33.6%) 09:03:05 INFO - TinderboxPrint: Swap in / out
160,411,648 / 0 09:03:05 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123007488; Write bytes: 123848704; Read time: 11053; Write time: 287 09:03:05 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34378752; Write bytes: 296653312; Read time: 217; Write time: 1108 09:03:05 INFO - Running post-run listener: _upload_blobber_files 09:03:05 INFO - Blob upload gear active. 09:03:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:05 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 09:03:05 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'] 09:03:05 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 09:03:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:07 INFO - (blobuploader) - INFO - Done attempting. 09:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:08 INFO - (blobuploader) - INFO - Done attempting. 09:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:03:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:09 INFO - (blobuploader) - INFO - Done attempting. 09:03:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:12 INFO - (blobuploader) - INFO - Done attempting. 09:03:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:12 INFO - Return code: 0 09:03:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2b0a9cc9f86ccfdd885bba7067915110c3c6b3b51cbdc6eacce8b49b98ec70a2ae39c895f96547512ff67db4c488ce24c41a355800d2d6c9b08a071f340f85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7db91d31dd944bc6446c48fbbc84f3706cdecdecca574eee77e659d18afbba3f751db306c8db0014c4d4686393e1e8ec6aaffa8a55252053898f1c4bf2b76f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d1cfc672d0fded5d2859c38631ab46359c8cde28be6b0193ab049659e3f43cb98cd698038ee32473ea2bc91181acaf6f4e7a97d0dc5a6b871cf31b737d4bb4f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f78e1adc967abeb964630e5b09d7cd4afc037354aa77bf0f04220f9c1417c6bbdb4b68dbe532d01e260f0c63ea7d821f01267329a1959a76f62ab42a72e41e8"} 09:03:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:12 INFO - Contents: 09:03:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2b0a9cc9f86ccfdd885bba7067915110c3c6b3b51cbdc6eacce8b49b98ec70a2ae39c895f96547512ff67db4c488ce24c41a355800d2d6c9b08a071f340f85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7db91d31dd944bc6446c48fbbc84f3706cdecdecca574eee77e659d18afbba3f751db306c8db0014c4d4686393e1e8ec6aaffa8a55252053898f1c4bf2b76f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d1cfc672d0fded5d2859c38631ab46359c8cde28be6b0193ab049659e3f43cb98cd698038ee32473ea2bc91181acaf6f4e7a97d0dc5a6b871cf31b737d4bb4f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f78e1adc967abeb964630e5b09d7cd4afc037354aa77bf0f04220f9c1417c6bbdb4b68dbe532d01e260f0c63ea7d821f01267329a1959a76f62ab42a72e41e8"} 09:03:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:12 INFO - Copying logs to upload dir... 09:03:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.441526 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-20 09:03:12.450975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 09:03:12.454712) ========= 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.WxpS22w7x4/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.DaHUa7UKIs/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/f2b0a9cc9f86ccfdd885bba7067915110c3c6b3b51cbdc6eacce8b49b98ec70a2ae39c895f96547512ff67db4c488ce24c41a355800d2d6c9b08a071f340f85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7db91d31dd944bc6446c48fbbc84f3706cdecdecca574eee77e659d18afbba3f751db306c8db0014c4d4686393e1e8ec6aaffa8a55252053898f1c4bf2b76f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d1cfc672d0fded5d2859c38631ab46359c8cde28be6b0193ab049659e3f43cb98cd698038ee32473ea2bc91181acaf6f4e7a97d0dc5a6b871cf31b737d4bb4f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f78e1adc967abeb964630e5b09d7cd4afc037354aa77bf0f04220f9c1417c6bbdb4b68dbe532d01e260f0c63ea7d821f01267329a1959a76f62ab42a72e41e8"} build_url:https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010891 build_url: 'https://queue.taskcluster.net/v1/task/SI8IZzv8SUOmpx7wcznZjA/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/f2b0a9cc9f86ccfdd885bba7067915110c3c6b3b51cbdc6eacce8b49b98ec70a2ae39c895f96547512ff67db4c488ce24c41a355800d2d6c9b08a071f340f85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7db91d31dd944bc6446c48fbbc84f3706cdecdecca574eee77e659d18afbba3f751db306c8db0014c4d4686393e1e8ec6aaffa8a55252053898f1c4bf2b76f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d1cfc672d0fded5d2859c38631ab46359c8cde28be6b0193ab049659e3f43cb98cd698038ee32473ea2bc91181acaf6f4e7a97d0dc5a6b871cf31b737d4bb4f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f78e1adc967abeb964630e5b09d7cd4afc037354aa77bf0f04220f9c1417c6bbdb4b68dbe532d01e260f0c63ea7d821f01267329a1959a76f62ab42a72e41e8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 09:03:12.488182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:03:12.488586) ========= 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.WxpS22w7x4/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.DaHUa7UKIs/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.004987 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 09:03:12.537281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 09:03:12.537632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 09:03:12.537997) ========= ========= Total master_lag: 0.22 =========