builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1491062128.77 results: success (0) buildid: 20170401080123 builduid: 6b4d6011a6714c4793879dcd2985de29 revision: f94c044dfb9b5c0bb0df326ed7a7ed804953f456 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:28.773614) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:28.774193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:28.774542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:28.801373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:28.801815) ========= 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.YccCqJP7LV/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.4KKiyZRbrR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-04-01 08:55:28-- 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% 14.8M=0.001s 2017-04-01 08:55:28 (14.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133572 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:28.959990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:28.960304) ========= 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.YccCqJP7LV/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.4KKiyZRbrR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.026074 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:29.009561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 08:55:29.009956) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f94c044dfb9b5c0bb0df326ed7a7ed804953f456 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f94c044dfb9b5c0bb0df326ed7a7ed804953f456 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YccCqJP7LV/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.4KKiyZRbrR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-04-01 08:55:29,113 truncating revision to first 12 chars 2017-04-01 08:55:29,113 Setting DEBUG logging. 2017-04-01 08:55:29,113 attempt 1/10 2017-04-01 08:55:29,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f94c044dfb9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 08:55:30,426 unpacking tar archive at: mozilla-central-f94c044dfb9b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590307 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 08:55:30.623529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:30.623872) ========= script_repo_revision: f94c044dfb9b5c0bb0df326ed7a7ed804953f456 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:30.624265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:30.624547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 08:55:30.644443) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-01 08:55:30.644826) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YccCqJP7LV/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.4KKiyZRbrR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:55:30 INFO - MultiFileLogger online at 20170401 08:55:30 in /builds/slave/test 08:55:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:55:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:30 INFO - {'append_to_log': False, 08:55:30 INFO - 'base_work_dir': '/builds/slave/test', 08:55:30 INFO - 'blob_upload_branch': 'Firefox', 08:55:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:30 INFO - 'branch': 'Firefox', 08:55:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:30 INFO - 'config_files': ('talos/mac_config.py',), 08:55:30 INFO - 'default_actions': ('clobber', 08:55:30 INFO - 'read-buildbot-config', 08:55:30 INFO - 'download-and-extract', 08:55:30 INFO - 'populate-webroot', 08:55:30 INFO - 'create-virtualenv', 08:55:30 INFO - 'install', 08:55:30 INFO - 'run-tests'), 08:55:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:30 INFO - 'download_minidump_stackwalk': True, 08:55:30 INFO - 'download_symbols': 'ondemand', 08:55:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:30 INFO - 'gecko_profile': False, 08:55:30 INFO - 'gecko_profile_interval': 0, 08:55:30 INFO - 'installer_path': 'installer.exe', 08:55:30 INFO - 'log_level': 'info', 08:55:30 INFO - 'log_name': 'talos', 08:55:30 INFO - 'log_to_console': True, 08:55:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:30 INFO - 'opt_config_files': (), 08:55:30 INFO - 'pip_index': False, 08:55:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:30 INFO - 'cmd': ('bash', 08:55:30 INFO - '-c', 08:55:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:30 INFO - 'enabled': True, 08:55:30 INFO - 'halt_on_failure': False, 08:55:30 INFO - 'name': 'check_screen_resolution'},), 08:55:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:30 INFO - 'cmd': ('bash', 08:55:30 INFO - '-c', 08:55:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:30 INFO - 'enabled': True, 08:55:30 INFO - 'halt_on_failure': False, 08:55:30 INFO - 'name': 'check_screen_resolution'},), 08:55:30 INFO - 'run_cmd_checks_enabled': True, 08:55:30 INFO - 'suite': 'dromaeojs', 08:55:30 INFO - 'system_bits': '32', 08:55:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:30 INFO - 'title': 't-yosemite-r7-0191', 08:55:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:30 INFO - 'use_talos_json': True, 08:55:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:30 INFO - 'work_dir': 'build'} 08:55:30 INFO - [mozharness: 2017-04-01 15:55:30.861165Z] Running clobber step. 08:55:30 INFO - Running pre-action listener: _resource_record_pre_action 08:55:30 INFO - Running main action method: clobber 08:55:30 INFO - rmtree: /builds/slave/test/build 08:55:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:33 INFO - Running post-action listener: _resource_record_post_action 08:55:33 INFO - [mozharness: 2017-04-01 15:55:33.521397Z] Finished clobber step (success) 08:55:33 INFO - [mozharness: 2017-04-01 15:55:33.521566Z] Running read-buildbot-config step. 08:55:33 INFO - Running pre-action listener: _resource_record_pre_action 08:55:33 INFO - Running main action method: read_buildbot_config 08:55:33 INFO - Using buildbot properties: 08:55:33 INFO - { 08:55:33 INFO - "project": "", 08:55:33 INFO - "product": "firefox", 08:55:33 INFO - "script_repo_revision": "production", 08:55:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:55:33 INFO - "repository": "", 08:55:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:55:33 INFO - "buildid": "20170401080123", 08:55:33 INFO - "pgo_build": "False", 08:55:33 INFO - "basedir": "/builds/slave/test", 08:55:33 INFO - "buildnumber": 20, 08:55:33 INFO - "slavename": "t-yosemite-r7-0191", 08:55:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:55:33 INFO - "platform": "yosemite_r7", 08:55:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:55:33 INFO - "branch": "mozilla-central", 08:55:33 INFO - "repo_path": "mozilla-central", 08:55:33 INFO - "revision": "f94c044dfb9b5c0bb0df326ed7a7ed804953f456", 08:55:33 INFO - "stage_platform": "macosx64", 08:55:33 INFO - "builduid": "6b4d6011a6714c4793879dcd2985de29", 08:55:33 INFO - "slavebuilddir": "test" 08:55:33 INFO - } 08:55:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:55:33 INFO - Running post-action listener: _resource_record_post_action 08:55:33 INFO - [mozharness: 2017-04-01 15:55:33.525059Z] Finished read-buildbot-config step (success) 08:55:33 INFO - [mozharness: 2017-04-01 15:55:33.525206Z] Running download-and-extract step. 08:55:33 INFO - Running pre-action listener: _resource_record_pre_action 08:55:33 INFO - Running main action method: download_and_extract 08:55:33 INFO - mkdir: /builds/slave/test/build/tests 08:55:33 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:55:33 INFO - trying https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:55:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 08:55:36 INFO - Downloaded 1325 bytes. 08:55:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:55:36 INFO - Using the following test package requirements: 08:55:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 08:55:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:55:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:55:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:55:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'jsshell-mac.zip'], 08:55:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:55:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:55:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:55:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:55:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:55:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:55:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:55:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:55:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:55:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:55:37 INFO - Expected file size: 52515536 08:55:37 INFO - Obtained file size: 52515536 08:55:53 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:55:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:55:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:55:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:55:55 INFO - Expected file size: 52515536 08:55:55 INFO - Obtained file size: 52515536 08:56:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:56:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:56:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:56:11 INFO - Expected file size: 14404152 08:56:11 INFO - Obtained file size: 14404152 08:56: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:56:12 INFO - trying https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:56:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 08:56:14 INFO - Downloaded 75592079 bytes. 08:56:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:56:14 INFO - mkdir: /builds/slave/test/properties 08:56:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:14 INFO - Contents: 08:56:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:56:15 INFO - Running post-action listener: _resource_record_post_action 08:56:15 INFO - Running post-action listener: set_extra_try_arguments 08:56:15 INFO - [mozharness: 2017-04-01 15:56:15.039429Z] Finished download-and-extract step (success) 08:56:15 INFO - [mozharness: 2017-04-01 15:56:15.039579Z] Running populate-webroot step. 08:56:15 INFO - Running pre-action listener: _resource_record_pre_action 08:56:15 INFO - Running main action method: populate_webroot 08:56:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:15 INFO - '--tppagecycles', 08:56:15 INFO - '7'], 08:56:15 INFO - 'tests': ['tsvgm']}}, 08:56:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:56:15 INFO - 'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:56:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:56:15 INFO - 'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['damp', 'tps']}, 08:56:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:56:15 INFO - 'tests': ['damp', 'tps']}, 08:56:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['dromaeo_dom']}, 08:56:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['basic_compositor_video']}, 08:56:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['a11yr', 08:56:15 INFO - 'ts_paint', 08:56:15 INFO - 'tpaint', 08:56:15 INFO - 'sessionrestore', 08:56:15 INFO - 'sessionrestore_no_auto_restore', 08:56:15 INFO - 'tabpaint']}, 08:56:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:15 INFO - 'ts_paint', 08:56:15 INFO - 'tpaint', 08:56:15 INFO - 'sessionrestore', 08:56:15 INFO - 'sessionrestore_no_auto_restore', 08:56:15 INFO - 'tabpaint']}, 08:56:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:15 INFO - 'ts_paint', 08:56:15 INFO - 'tpaint', 08:56:15 INFO - 'sessionrestore', 08:56:15 INFO - 'sessionrestore_no_auto_restore', 08:56:15 INFO - 'tabpaint']}, 08:56:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:15 INFO - 'ts_paint', 08:56:15 INFO - 'tpaint', 08:56:15 INFO - 'sessionrestore', 08:56:15 INFO - 'sessionrestore_no_auto_restore', 08:56:15 INFO - 'tabpaint']}, 08:56:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['a11yr', 08:56:15 INFO - 'ts_paint', 08:56:15 INFO - 'tpaint', 08:56:15 INFO - 'sessionrestore', 08:56:15 INFO - 'sessionrestore_no_auto_restore', 08:56:15 INFO - 'tabpaint']}, 08:56:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['a11yr', 08:56:15 INFO - 'ts_paint', 08:56:15 INFO - 'tpaint', 08:56:15 INFO - 'sessionrestore', 08:56:15 INFO - 'sessionrestore_no_auto_restore', 08:56:15 INFO - 'tabpaint']}, 08:56:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['tsvgx', 08:56:15 INFO - 'tsvgr_opacity', 08:56:15 INFO - 'tart', 08:56:15 INFO - 'tscrollx', 08:56:15 INFO - 'cart', 08:56:15 INFO - 'tsvg_static']}, 08:56:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:15 INFO - 'tsvgr_opacity', 08:56:15 INFO - 'tart', 08:56:15 INFO - 'tscrollx', 08:56:15 INFO - 'cart', 08:56:15 INFO - 'tsvg_static']}, 08:56:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:56:15 INFO - 'talos_options': ['--disable-e10s'], 08:56:15 INFO - 'tests': ['tp5o']}, 08:56:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:56:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:56:15 INFO - 'talos_options': ['--disable-e10s', 08:56:15 INFO - '--xperf_path', 08:56:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:15 INFO - 'tests': ['tp5n']}, 08:56:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:56:15 INFO - 'talos_options': ['--xperf_path', 08:56:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:15 INFO - 'tests': ['tp5n']}}, 08:56:15 INFO - 'talos.zip': {'path': '', 08:56:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:15 INFO - Running post-action listener: _resource_record_post_action 08:56:15 INFO - [mozharness: 2017-04-01 15:56:15.057863Z] Finished populate-webroot step (success) 08:56:15 INFO - [mozharness: 2017-04-01 15:56:15.058000Z] Running create-virtualenv step. 08:56:15 INFO - Running pre-action listener: _resource_record_pre_action 08:56:15 INFO - Running main action method: create_virtualenv 08:56:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:15 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:56:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:15 INFO - Using real prefix '/tools/python27' 08:56:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:15 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:18 INFO - Installing pip.................done. 08:56:18 INFO - Return code: 0 08:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:56:19 INFO - Reading from file tmpfile_stdout 08:56:19 INFO - Output received: 08:56:19 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:56:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:19 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:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:19 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:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:19 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:19 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:56:19 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:56:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:19 INFO - 'HOME': '/Users/cltbld', 08:56:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:19 INFO - 'LOGNAME': 'cltbld', 08:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:19 INFO - 'MOZ_NO_REMOTE': '1', 08:56:19 INFO - 'NO_EM_RESTART': '1', 08:56:19 INFO - 'PAGER': '/bin/cat', 08:56:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:19 INFO - 'PWD': '/builds/slave/test', 08:56:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:19 INFO - 'SHELL': '/bin/bash', 08:56:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:19 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:19 INFO - 'USER': 'cltbld', 08:56:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:19 INFO - 'XPC_FLAGS': '0x0', 08:56:19 INFO - 'XPC_SERVICE_NAME': '0', 08:56:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:19 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:56:19 INFO - Cleaning up... 08:56:19 INFO - Return code: 0 08:56:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56:19 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:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:19 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:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:19 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:19 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:56:19 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:56:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:19 INFO - 'HOME': '/Users/cltbld', 08:56:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:19 INFO - 'LOGNAME': 'cltbld', 08:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:19 INFO - 'MOZ_NO_REMOTE': '1', 08:56:19 INFO - 'NO_EM_RESTART': '1', 08:56:19 INFO - 'PAGER': '/bin/cat', 08:56:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:19 INFO - 'PWD': '/builds/slave/test', 08:56:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:19 INFO - 'SHELL': '/bin/bash', 08:56:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:19 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:19 INFO - 'USER': 'cltbld', 08:56:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:19 INFO - 'XPC_FLAGS': '0x0', 08:56:19 INFO - 'XPC_SERVICE_NAME': '0', 08:56:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:19 INFO - Downloading/unpacking psutil>=3.1.1 08:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:23 INFO - Installing collected packages: psutil 08:56:23 INFO - Running setup.py install for psutil 08:56:23 INFO - building 'psutil._psutil_osx' extension 08:56:23 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:56:23 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:56:23 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:56:23 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:56:23 INFO - building 'psutil._psutil_posix' extension 08:56:23 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:56:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:56:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:56:24 INFO - ^ 08:56:24 INFO - 1 warning generated. 08:56:24 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:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:24 INFO - Successfully installed psutil 08:56:24 INFO - Cleaning up... 08:56:24 INFO - Return code: 0 08:56:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:24 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:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:24 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:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:24 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:24 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:56:24 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:56:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:24 INFO - 'HOME': '/Users/cltbld', 08:56:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:24 INFO - 'LOGNAME': 'cltbld', 08:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:24 INFO - 'MOZ_NO_REMOTE': '1', 08:56:24 INFO - 'NO_EM_RESTART': '1', 08:56:24 INFO - 'PAGER': '/bin/cat', 08:56:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:24 INFO - 'PWD': '/builds/slave/test', 08:56:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:24 INFO - 'SHELL': '/bin/bash', 08:56:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:24 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:24 INFO - 'USER': 'cltbld', 08:56:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:24 INFO - 'XPC_FLAGS': '0x0', 08:56:24 INFO - 'XPC_SERVICE_NAME': '0', 08:56:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:27 INFO - Installing collected packages: mozsystemmonitor 08:56:27 INFO - Running setup.py install for mozsystemmonitor 08:56:27 INFO - Successfully installed mozsystemmonitor 08:56:27 INFO - Cleaning up... 08:56:27 INFO - Return code: 0 08:56:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:27 INFO - 'HOME': '/Users/cltbld', 08:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:27 INFO - 'LOGNAME': 'cltbld', 08:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:27 INFO - 'MOZ_NO_REMOTE': '1', 08:56:27 INFO - 'NO_EM_RESTART': '1', 08:56:27 INFO - 'PAGER': '/bin/cat', 08:56:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:27 INFO - 'PWD': '/builds/slave/test', 08:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:27 INFO - 'SHELL': '/bin/bash', 08:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:27 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:27 INFO - 'USER': 'cltbld', 08:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:27 INFO - 'XPC_FLAGS': '0x0', 08:56:27 INFO - 'XPC_SERVICE_NAME': '0', 08:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:28 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:30 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:56:30 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:56:30 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:56:30 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:56:30 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:56:30 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:56:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:31 INFO - warning: no files found matching '*.txt' 08:56:31 INFO - no previously-included directories found matching 'build' 08:56:31 INFO - no previously-included directories found matching 'dist' 08:56:31 INFO - no previously-included directories found matching '.git*' 08:56:31 INFO - Installing collected packages: jsonschema, functools32 08:56:31 INFO - Running setup.py install for functools32 08:56:31 INFO - warning: no files found matching '*.txt' 08:56:31 INFO - no previously-included directories found matching 'build' 08:56:31 INFO - no previously-included directories found matching 'dist' 08:56:31 INFO - no previously-included directories found matching '.git*' 08:56:31 INFO - Successfully installed jsonschema functools32 08:56:31 INFO - Cleaning up... 08:56:31 INFO - Return code: 0 08:56:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:31 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:31 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:56:31 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:56:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:31 INFO - 'HOME': '/Users/cltbld', 08:56:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:31 INFO - 'LOGNAME': 'cltbld', 08:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:31 INFO - 'MOZ_NO_REMOTE': '1', 08:56:31 INFO - 'NO_EM_RESTART': '1', 08:56:31 INFO - 'PAGER': '/bin/cat', 08:56:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:31 INFO - 'PWD': '/builds/slave/test', 08:56:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:31 INFO - 'SHELL': '/bin/bash', 08:56:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:31 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:31 INFO - 'USER': 'cltbld', 08:56:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:31 INFO - 'XPC_FLAGS': '0x0', 08:56:31 INFO - 'XPC_SERVICE_NAME': '0', 08:56:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:31 INFO - Cleaning up... 08:56:31 INFO - Return code: 0 08:56:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:31 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:31 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:56:31 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:56:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:31 INFO - 'HOME': '/Users/cltbld', 08:56:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:31 INFO - 'LOGNAME': 'cltbld', 08:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:31 INFO - 'MOZ_NO_REMOTE': '1', 08:56:31 INFO - 'NO_EM_RESTART': '1', 08:56:31 INFO - 'PAGER': '/bin/cat', 08:56:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:31 INFO - 'PWD': '/builds/slave/test', 08:56:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:31 INFO - 'SHELL': '/bin/bash', 08:56:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:31 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:31 INFO - 'USER': 'cltbld', 08:56:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:31 INFO - 'XPC_FLAGS': '0x0', 08:56:31 INFO - 'XPC_SERVICE_NAME': '0', 08:56:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:32 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:56:32 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:56:32 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:56:32 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:56:32 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:56:32 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:56:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:36 INFO - Downloading docopt-0.6.1.tar.gz 08:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:36 INFO - Running setup.py install for blobuploader 08:56:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:36 INFO - Running setup.py install for requests 08:56:36 INFO - Running setup.py install for docopt 08:56:36 INFO - Successfully installed blobuploader requests docopt 08:56:36 INFO - Cleaning up... 08:56:37 INFO - Return code: 0 08:56:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:37 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:37 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:56:37 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:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:37 INFO - 'HOME': '/Users/cltbld', 08:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:37 INFO - 'LOGNAME': 'cltbld', 08:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:37 INFO - 'MOZ_NO_REMOTE': '1', 08:56:37 INFO - 'NO_EM_RESTART': '1', 08:56:37 INFO - 'PAGER': '/bin/cat', 08:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:37 INFO - 'PWD': '/builds/slave/test', 08:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:37 INFO - 'SHELL': '/bin/bash', 08:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:37 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:37 INFO - 'USER': 'cltbld', 08:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:37 INFO - 'XPC_FLAGS': '0x0', 08:56:37 INFO - 'XPC_SERVICE_NAME': '0', 08:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:37 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iZ515C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:37 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-9Xccij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:37 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-RMokbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:37 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8JpEcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:37 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-MkYfDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:37 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-oLltGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:37 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EgwpLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-v3PSpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-eY1Md9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-6me70w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-AbdvTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hfEDdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-wAIXRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-PM4c1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-zSPj1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qo8nGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:38 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-6FDnBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:39 INFO - Running setup.py install for manifestparser 08:56:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:39 INFO - Running setup.py install for mozcrash 08:56:39 INFO - Running setup.py install for mozdebug 08:56:39 INFO - Running setup.py install for mozdevice 08:56:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:39 INFO - Running setup.py install for mozfile 08:56:39 INFO - Running setup.py install for mozhttpd 08:56:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:39 INFO - Running setup.py install for mozinfo 08:56:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozInstall 08:56:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozleak 08:56:40 INFO - Running setup.py install for mozlog 08:56:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for moznetwork 08:56:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozprocess 08:56:40 INFO - Running setup.py install for mozprofile 08:56:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozrunner 08:56:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:41 INFO - Running setup.py install for mozscreenshot 08:56:41 INFO - Running setup.py install for moztest 08:56:41 INFO - Running setup.py install for mozversion 08:56:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:41 INFO - Cleaning up... 08:56:41 INFO - Return code: 0 08:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:41 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:56:41 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:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:41 INFO - 'HOME': '/Users/cltbld', 08:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:41 INFO - 'LOGNAME': 'cltbld', 08:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:41 INFO - 'MOZ_NO_REMOTE': '1', 08:56:41 INFO - 'NO_EM_RESTART': '1', 08:56:41 INFO - 'PAGER': '/bin/cat', 08:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:41 INFO - 'PWD': '/builds/slave/test', 08:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:41 INFO - 'SHELL': '/bin/bash', 08:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:41 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:41 INFO - 'USER': 'cltbld', 08:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:41 INFO - 'XPC_FLAGS': '0x0', 08:56:41 INFO - 'XPC_SERVICE_NAME': '0', 08:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-c3a1Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:41 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:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YTv7s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-fK_Sox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iTgWIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-l4m0zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_6pqCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-eJ4XJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-83kDBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yYrVzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Kk423p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:42 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:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ay_75U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ITET2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-mgVWK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bENw_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-TPOKr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ZkXzj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:43 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:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-lhWgaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:43 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:56:43 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:56:43 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:56:43 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:56:43 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:56:43 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:56:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:46 INFO - Downloading blessings-1.6.tar.gz 08:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:46 INFO - Installing collected packages: blessings 08:56:46 INFO - Running setup.py install for blessings 08:56:46 INFO - Successfully installed blessings 08:56:46 INFO - Cleaning up... 08:56:46 INFO - Return code: 0 08:56:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:46 INFO - Reading from file tmpfile_stdout 08:56:46 INFO - Current package versions: 08:56:46 INFO - blessings == 1.6 08:56:46 INFO - blobuploader == 1.2.4 08:56:46 INFO - docopt == 0.6.1 08:56:46 INFO - functools32 == 3.2.3-2 08:56:46 INFO - jsonschema == 2.5.1 08:56:46 INFO - manifestparser == 1.1 08:56:46 INFO - mozInstall == 1.12 08:56:46 INFO - mozcrash == 1.0 08:56:46 INFO - mozdebug == 0.1 08:56:46 INFO - mozdevice == 0.49 08:56:46 INFO - mozfile == 1.2 08:56:46 INFO - mozhttpd == 0.7 08:56:46 INFO - mozinfo == 0.9 08:56:46 INFO - mozleak == 0.1 08:56:46 INFO - mozlog == 3.4 08:56:46 INFO - moznetwork == 0.27 08:56:46 INFO - mozprocess == 0.25 08:56:46 INFO - mozprofile == 0.28 08:56:46 INFO - mozrunner == 6.13 08:56:46 INFO - mozscreenshot == 0.1 08:56:46 INFO - mozsystemmonitor == 0.3 08:56:46 INFO - moztest == 0.8 08:56:46 INFO - mozversion == 1.4 08:56:46 INFO - psutil == 3.1.1 08:56:46 INFO - requests == 1.2.3 08:56:46 INFO - wsgiref == 0.1.2 08:56:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:46 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:46 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:56:46 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:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:47 INFO - 'HOME': '/Users/cltbld', 08:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:47 INFO - 'LOGNAME': 'cltbld', 08:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:47 INFO - 'MOZ_NO_REMOTE': '1', 08:56:47 INFO - 'NO_EM_RESTART': '1', 08:56:47 INFO - 'PAGER': '/bin/cat', 08:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:47 INFO - 'PWD': '/builds/slave/test', 08:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:47 INFO - 'SHELL': '/bin/bash', 08:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:47 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:47 INFO - 'USER': 'cltbld', 08:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:47 INFO - 'XPC_FLAGS': '0x0', 08:56:47 INFO - 'XPC_SERVICE_NAME': '0', 08:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:47 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:56:47 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:56:47 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:56:47 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:56:47 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:56:47 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:56:47 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:56:47 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:56:47 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:56:47 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:56:47 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:56:47 INFO - Cleaning up... 08:56:47 INFO - Return code: 0 08:56:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:47 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:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 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:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 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 0x106863b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106866768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d61dbe920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, '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.YccCqJP7LV/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.4KKiyZRbrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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:56:47 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:56:47 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:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:47 INFO - 'HOME': '/Users/cltbld', 08:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:47 INFO - 'LOGNAME': 'cltbld', 08:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:47 INFO - 'MOZ_NO_REMOTE': '1', 08:56:47 INFO - 'NO_EM_RESTART': '1', 08:56:47 INFO - 'PAGER': '/bin/cat', 08:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:47 INFO - 'PWD': '/builds/slave/test', 08:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:47 INFO - 'SHELL': '/bin/bash', 08:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:56:47 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:47 INFO - 'USER': 'cltbld', 08:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:47 INFO - 'XPC_FLAGS': '0x0', 08:56:47 INFO - 'XPC_SERVICE_NAME': '0', 08:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:47 INFO - Cleaning up... 08:56:47 INFO - Return code: 0 08:56:47 INFO - Running post-action listener: _resource_record_post_action 08:56:47 INFO - Running post-action listener: _start_resource_monitoring 08:56:47 INFO - Starting resource monitoring. 08:56:47 INFO - [mozharness: 2017-04-01 15:56:47.554263Z] Finished create-virtualenv step (success) 08:56:47 INFO - [mozharness: 2017-04-01 15:56:47.555235Z] Running install step. 08:56:47 INFO - Running pre-action listener: _resource_record_pre_action 08:56:47 INFO - Running main action method: install 08:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:47 INFO - Reading from file tmpfile_stdout 08:56:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:47 INFO - Reading from file tmpfile_stdout 08:56:47 INFO - Output received: 08:56:47 INFO - Usage: mozinstall [options] installer 08:56:47 INFO - Options: 08:56:47 INFO - -h, --help show this help message and exit 08:56:47 INFO - -d DEST, --destination=DEST 08:56:47 INFO - Directory to install application into. [default: 08:56:47 INFO - "/builds/slave/test"] 08:56:47 INFO - --app=APP Application being installed. [default: firefox] 08:56:47 INFO - mkdir: /builds/slave/test/build/application 08:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:57:08 INFO - Reading from file tmpfile_stdout 08:57:08 INFO - Output received: 08:57:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:57:08 INFO - Running post-action listener: _resource_record_post_action 08:57:08 INFO - [mozharness: 2017-04-01 15:57:08.277803Z] Finished install step (success) 08:57:08 INFO - [mozharness: 2017-04-01 15:57:08.277932Z] Running run-tests step. 08:57:08 INFO - Running pre-action listener: _resource_record_pre_action 08:57:08 INFO - Running main action method: run_tests 08:57:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:08 INFO - 2017-04-01 08:57:08.292 screenresolution[1632:7450] starting screenresolution argv=screenresolution get 08:57:08 INFO - 2017-04-01 08:57:08.294 screenresolution[1632:7450] Display 0: 1600x1200x32@60 08:57:08 INFO - 2017-04-01 08:57:08.300 screenresolution[1633:7453] starting screenresolution argv=screenresolution list 08:57:08 INFO - Available Modes on Display 0 08:57:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:08 INFO - Intel Iris: 08:57:08 INFO - Chipset Model: Intel Iris 08:57:08 INFO - Type: GPU 08:57:08 INFO - Bus: Built-In 08:57:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:08 INFO - Vendor: Intel (0x8086) 08:57:08 INFO - Device ID: 0x0a2e 08:57:08 INFO - Revision ID: 0x0009 08:57:08 INFO - Displays: 08:57:08 INFO - Display: 08:57:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:08 INFO - Display Serial Number: 1600x1200 60 08:57:08 INFO - Main Display: Yes 08:57:08 INFO - Mirror: Off 08:57:08 INFO - Online: Yes 08:57:08 INFO - Rotation: Supported 08:57:08 INFO - Return code: 0 08:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:08 INFO - Python 2.7.3 08:57:08 INFO - Return code: 0 08:57:08 INFO - grabbing minidump binary from tooltool 08:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:08 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 0x106641d30>, '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 0x106568db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106636be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:08 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:57:08 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:57:08 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:57:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:08 INFO - Return code: 0 08:57:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:57:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:08 INFO - ENV: RUST_BACKTRACE is now 1 08:57:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:57:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YccCqJP7LV/Render', 08:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:08 INFO - 'HOME': '/Users/cltbld', 08:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:08 INFO - 'LOGNAME': 'cltbld', 08:57:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:08 INFO - 'MOZ_NO_REMOTE': '1', 08:57:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:08 INFO - 'NO_EM_RESTART': '1', 08:57:08 INFO - 'PAGER': '/bin/cat', 08:57:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:08 INFO - 'PWD': '/builds/slave/test', 08:57:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:08 INFO - 'RUST_BACKTRACE': '1', 08:57:08 INFO - 'SHELL': '/bin/bash', 08:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4KKiyZRbrR/Listeners', 08:57:08 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:08 INFO - 'USER': 'cltbld', 08:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:08 INFO - 'XPC_FLAGS': '0x0', 08:57:08 INFO - 'XPC_SERVICE_NAME': '0', 08:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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:57:08 INFO - mozversion application_buildid: 20170401080123 08:57:08 INFO - mozversion application_changeset: f94c044dfb9b5c0bb0df326ed7a7ed804953f456 08:57:08 INFO - mozversion application_display_name: Nightly 08:57:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:08 INFO - mozversion application_name: Firefox 08:57:08 INFO - mozversion application_remotingname: firefox 08:57:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:57:08 INFO - mozversion application_vendor: Mozilla 08:57:08 INFO - mozversion application_version: 55.0a1 08:57:08 INFO - mozversion platform_buildid: 20170401080123 08:57:08 INFO - mozversion platform_changeset: f94c044dfb9b5c0bb0df326ed7a7ed804953f456 08:57:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:57:08 INFO - mozversion platform_version: 55.0a1 08:57:08 INFO - using testdate: 1491062228 08:57:08 INFO - actual date: 1491062228 08:57:08 INFO - starting webserver on 'localhost:49251' 08:57:08 INFO - SUITE-START | Running 2 tests 08:57:08 INFO - TEST-START | dromaeo_css 08:57:08 INFO - operating with platform_type : mac_ 08:57:08 INFO - Initialising browser for dromaeo_css test... 08:57:08 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpZDNCbL/profile http://localhost:49251/getInfo.html) 08:57:11 INFO - PID 1643 | __metrics Screen width/height:1600/1200 08:57:11 INFO - PID 1643 | colorDepth:24 08:57:11 INFO - PID 1643 | Browser inner width/height: 1024/689 08:57:11 INFO - PID 1643 | __metrics 08:57:11 INFO - PID 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:57:11 INFO - PID 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:12 INFO - TEST-INFO | 1643: exit 0 08:57:12 INFO - Browser initialized. 08:57:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:12 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpZDNCbL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:24 INFO - PID 1645 | RSS: Main: 232718336 08:57:24 INFO - PID 1645 | 09:00:29 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 09:00:32 INFO - PID 1645 | RSS: Main: 462712832 09:00:32 INFO - PID 1645 | 09:02:14 INFO - PID 1645 | ************************* 09:02:14 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 09:02:14 INFO - PID 1645 | 09:02:14 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:02:14 INFO - PID 1645 | Full stack: 09:02:14 INFO - PID 1645 | ************************* 09:02:14 INFO - PID 1645 | ************************* 09:02:14 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 09:02:14 INFO - PID 1645 | 09:02:14 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:02:14 INFO - PID 1645 | Full stack: 09:02:14 INFO - PID 1645 | ************************* 09:02:14 INFO - PID 1645 | ************************* 09:02:14 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 09:02:14 INFO - PID 1645 | 09:02:14 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:02:14 INFO - PID 1645 | Full stack: 09:02:14 INFO - PID 1645 | ************************* 09:02:14 INFO - PID 1645 | ************************* 09:02:14 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 09:02:14 INFO - PID 1645 | 09:02:14 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:02:14 INFO - PID 1645 | Full stack: 09:02:14 INFO - PID 1645 | ************************* 09:03:35 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 09:03:35 INFO - PID 1645 | RSS: Main: 373022720 09:03:35 INFO - PID 1645 | 09:06:38 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 09:06:38 INFO - PID 1645 | RSS: Main: 341532672 09:06:38 INFO - PID 1645 | 09:09:41 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 09:09:41 INFO - PID 1645 | RSS: Main: 341229568 09:09:41 INFO - PID 1645 | 09:12:45 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 09:12:46 INFO - PID 1645 | RSS: Main: 346505216 09:12:46 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 09:15:49 INFO - PID 1645 | RSS: Main: 498499584 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | __start_tp_report 09:15:49 INFO - PID 1645 | _x_x_mozilla_page_load 09:15:49 INFO - PID 1645 | _x_x_mozilla_page_load_details 09:15:49 INFO - PID 1645 | |i|pagename|runs| 09:15:49 INFO - PID 1645 | |0;dojo.html;2972.643282806063;3112.813231206127;3482.077249528874;3518.1204698825295;3555.6444355564445;6055.969720151393;6118.131909153803;6243.500519958404;6253.343398943114;6270.090836828657;6107.522607572288;6178.691065446721;6234.7506099756065;6239.157713708648;6245.406686364788;5166.612504062192;5271.051210782058;5338.599605029638;5347.224652425396;5442.673439593617;5355.357357117151;5361.892762144755;5396.460353964611;5433.4566543345545;5434.510894019538;5203.609729270301;5289.761960711778;5292.206169074631;5308.9469105308835;5318.095923692981;5261;5269.868253293698;5274.156135018417;5283.313169288006;5292.52367286946;5199.740012999335;5253.9737301313635;5270.077736396153;5271.077561426735;5273.235380869791;6026.276846778414;6032.638041717511;6033;6051.213342265477;6066.241719785027;6345.302016778197;6352.269489008777;6356.586821856565;6371.39471750183;6374.968125159345;6351.364863513658;6399.424051835357;6567.211934567835;6609.471242300604;6677.565958212701;6335.873282534323;6338.334474880164;6341.302456729756;6352.745890164388;6355.904661430082;6819.386255237053;6825.215100263533;6827.52207345491;6828.317168283232;6843.726250950006;5504.4770746778995;5761.625494342854;6352.555321127476;6360.300366959631;6371.076193951943;6376.713047912763;6384.106225128486;6389.776357827547;6393;6401.903971440339;6345.936540634627;6356.904646430307;6376.681165941777;6450.193725784277;6547.985062315349;5342.6260161788305;6322.4942004639515;6472.773452929125;6482.57863238888;6503.02454631809;5288.603354748332;5301.151815709468;5309.548688361455;5317.867053323698;5324.866878328073;4618.815247390134;4646.465656449484;4686.74222917736;4728.267118596623;4743.28850672395;5999.880002399927;6006.129111278928;6018.638881667114;6027.547933904974;6062.969295219735;6328.430441260309;6524;6590.406863382223;6624.138861948012;6646.501512386591;6278.654673992883;6288.276848162428;6316.968415157987;6320.968395158086;6330.272018717815;5838.007538718428;5884.7940322088525;5888.5289176865745;5888.735006924699;5893.5874488785375;5712.571557133148;6493.318201588765;6569.704363303758;6570.441512471493;6728.697208625722;6625.734970601122;6658.3674550917585;6682.866342673216;6686.465082793267;6712.563683360566;6815.114035175396;6844.178698556205;6844.623545704835;6847.794566163023;6851.862962740617;6317.652529110943;6358.93641063602;6363.904541431974;6473.902891456538;6564.901526477202;5237.738113094406;6348.42864142211;6546.18172728409;6556.2788093308745;6651.567648102858;6359.8092057238355;6381.29805721361;6385.776497822554;6405.615663060231;6421.903671444838;6271.090691849565;6355.30091689923;6418.743250269937;6421.518386120966;6433.613983161025;6254.312025677263;6268.27914789805;6276.309605943434;6306.432421082125;6312.147860038836;6251.374862513712;6317.873642527032;6474.0612611172055;6477.352264773485;6485.967570162119;6226.346233645583;6264.5301602379095;6268.686565671607;6271.247450305992;6304.71628776697 09:15:49 INFO - PID 1645 | |1;ext.html;698.4831224893579;817.9509229446231;1136.153565593633;1149.6953307373542;1154.0709728668419;36737.448938265916;37463.06342341443;37548;37610;37613.62386376136;39005.41491877624;39356.622518211865;39434;39454;39559;6105.847353816168;6259.06114082889;8495.78760530987;8669.739907802776;8678.132186781302;8471.407001509897;8610.784730381727;8678.305735541142;8684.782880427976;8685;8667.826643467128;8737.21365077143;8738;8768.430052046628;8770.254528365096;8671.176238257356;8734.563271836383;8740.694075707383;8748.34387420946;8760.116574936419;7268.4185265179185;8495.36284778644;8574.271186949118;8576.05663377028;8581.613827377783;38122.90033594611;38283.425748613794;38287.617123828684;38352.04119896997;38421.03947401337;2895.869685864141;2958.1864987128497;2972.940541189164;2991.6809139530424;3011.6837732038257;26953.46093078147;26976.325591860164;27385.90456381762;27416.451670966468;28060.43879122406;2752.119321817019;2772.487089888357;2791.3579876628287;2795.804293699442;2798.6501687289087;276343;277065;277214.8417773735;277787;278919;39359.80320098381;39898.80050599787;39997;47435.76282118567;47441.5255847444;51037;51369.55141504461;51699;51863.74068129711;51934.22098668523;12414.379281035912;14234.288285585679;14360.928195358956;14376.712465750627;14379.928100359431;10020.949895250476;11229.55081796719;11408.201425900108;11421.600243991421;11426.428678566039;13614.455421783017;13620;13622.659433514043;13716.314184290944;13753.106048107042;5943.970280148572;5973.671448070311;5989.9101513477335;5993.321869876441;6009.549283803733;879.7668617816283;910.6129894794685;1000.8048430555972;1010.5856598794606;1023.0280637455716;23706.407339816644;23823.761762382503;23849.880750596483;23872.28383148508;23910.043598256223;1077.2836064017497;1080.524569189554;1120.1934607082887;1122.0630773304383;1123.2137503747247;10278.948605256926;11523.884761152281;11576.24754390962;12127;12190.39048047594;421059;424060;424316;424493;424905;56845;57100.42899570951;57168.142477862864;57224.42775572191;57225;1314.3822403470353;1470.9485168019069;1475.3056163525798;1514.9697006060037;1520.9771853422208;23116.19093331725;23144.652830207222;23148;23227.535449290583;23332.066717331116;38424.6157538421;38506.422403663404;38524.80737596406;38541.4218786724;38548;348105;353738;430790;431765;434161.43789215304;32219.516707249877;32510.51234231441;32663.34673306473;32766.34467310688;32849.671503285615;41042.79478602707;41218.79390603028;41505.58494415017;42558;42710.14579708326;28665.28336791597;29483.55774663339;29606.111816645534;29670.961516346822;30181.245468863453;25116.62325065089;28687.42625147527;28706.13881583556;29602.111936641933;29903.401931960805;34452;34828.30343393169;35370.29259414849;35961.640383595826;36005.45991810073;26146.565037612865;29984.85007574948;30109.18650329366;30147.849260753555;30191.943281985026;22458.775412246323;23438.64842027337;23653.645195322428;23777.643335349636;23971.640425393285 09:15:49 INFO - PID 1645 | |2;jquery.html;370.44988192534083;424.59451224081005;431.58136607490763;440.42964361152303;451.52815308003136;19918.203271869108;21641.134354625814;22482.43793905153;22653.20713775018;22700;21639.891800541016;22412;22688.256437687804;22750.431239218986;23080;6115.541334399927;6331.050342448623;6333.968330158343;6334.936650633504;6346.524010699216;5876.6180198286975;6235.906461403082;6282.68586570672;6299.905501417483;6317.210348706411;5956.672383018932;6255.15555400022;6266.436020758131;6273.968630156865;6274.309825919146;6186.907196392058;6268.529860260499;6300.4329610334835;6305.527085468562;6315.336889626569;5529.447055294479;5534.806281780118;5540.141278101901;5603.971980140073;5615.101583746622;27280;27662.861685691645;27954.3011424714;28319.150425487267;28400.857995710096;2063.4428704249917;2070.730804995341;2083.062621820172;2087.4155236533793;2156.568686262738;15779.763303550455;16488;16847.209377889998;17126.657466850593;17508.649827003515;1843.373253093941;1892.5174080609495;1893.725409815583;1894.725264836591;1919.8560107991957;153861.2306938458;163997.3600263994;164463;164592.9999999988;165371;11919.284842909454;11993.64019079429;12014.579489717818;12079.57721479744;12239.449224784728;16507.174641267888;16509.83490165107;16517.752233716503;16526.504204873872;16577.50267491977;7769;8613.870791938127;8853.203211710977;8854.38019338653;8954.417962832395;8364.414490985573;8378.204070613281;8382.87425688615;8528.573571321533;8531.402801803813;7599.278068583476;7729.1884352142215;7810.570418626917;7896.32881205104;7923.7226697065325;2122.4799924018407;2141.5609799990966;2144.860584062062;2149.065156656828;2328.2316835444262;917.5779141594808;937.5593471068587;939.1031564855547;948.3645957208687;958.3579002068631;19040.80959190418;19899.502512437306;21382.251621193183;21422.250221242182;21434;878.3939082033377;913.5112714697605;954.346272803132;996.257787947969;1005.1305620638095;10621.309614875008;10813.405262710468;10911.345319280868;10942.890571094347;10958;673576;683947.1605283984;693641;705977;718117;144848;165604.17197914174;165785;166163.16918415332;169695;1114.1365441782684;1126.2285334545863;1148.3741360958297;1154.4631746237872;1155.6995181252935;17773.20020599102;18363.17365718519;18440.723389149443;18445.72331415003;18868.905655471634;60711.48221294503;61182.08226876689;61875.6906215466;61908.69045654923;62486.37513624987;86604.1339586596;86717.56641216754;89851.20297594143;90076;91529.54235228781;8481.194286542768;8712;8750.256228220673;8810.339224558056;9025.05236950137;13548.79676804829;13806.240656763974;14096.154230746188;14269.286535673382;14297.428102875769;10605.363678179334;10640.733981650212;11138.053265472525;11719.924765387947;11932.98569621592;8328.458650187718;10738.463076846283;10839.970202830718;11188.496517656562;11208.383538905113;10446.582136714447;11818.586349477728;12071.456784444897;12158;12203;8475.957620211859;8572.699955501528;8630.56847157627;8920.330975176757;8972.775680608038;11402.030827379765;11737;11904;11953.641390758292;12082.033437324817 09:15:49 INFO - PID 1645 | |3;mootools.html;1187.0800129899333;1369.4659082957646;1426.2797287369876;1458.249001764091;1463.5975106845617;9095.90904090959;9524.571394287264;10713.785724285519;11018.50416731247;11042.447877606128;10713.196510261723;10845.566177352897;10853.34879907206;10855.348679079261;10867.673969780919;2414.855108693484;2462.335169504233;2467.494163696447;2469;2469.4196863737097;2072.7409073865765;2158.384860314811;2395.2454976682375;2482.9255122346267;2488.415222422729;2424.59994100974;2455.5211733711935;2456.3736247256925;2460.8277420580475;2463.5935070713313;2423.503181847726;2434.342727463593;2450.644656524794;2452.276578409356;2454.631805229212;1884.510027392874;2399.2322456813827;2416.613341865293;2421.176799888029;2453.7178224504232;10802.297850639683;10928.125749939985;10954.452277386099;10956.068734157607;10964.287321324167;6043.546733994968;6287.52843536732;6299.464545513637;6314.305426403092;6315.115883776275;3364.175776934667;3694.9630503695157;3941.1526521797664;4019.3569028955226;4027.0939038716347;1098.9230753847235;1153.8038533449335;1161.5179700424399;1194.3908606610692;1206.3485717712424;15043.774343384748;15265.160416177107;15265.465708700141;15276.236188190545;15278.083315001135;4813.9037219256115;5414.8917021659345;5634.577406694432;5643.5203007743985;5654.434556544313;12336.198147120409;12590.496380144876;12613.243205407705;12622.30577318238;12624.495020199089;5386.757595908115;6343.873122537523;6358.427741503287;6364.586301890362;6375.840603984845;5596.608237423423;5787;5794.217780599565;5835.241418615553;5845.035569131046;3984.880453586397;4093.7543747375253;4096.40602112698;4382.276924307517;4439.511653718088;1340.4102195034154;1364.5633397312963;1391.6660001599746;1401.9719605607831;1417.9007469477037;765.1124695353475;767.1293082351459;787.2875048081495;794.7019867549669;802.1457148137215;5762.88474230513;6300.621962682162;6566.901496477557;6583.835404114935;6652.334766523406;796.956167410798;871.54679566625;873.1268731268731;890.7262614461382;907.1699395053453;3785.6782173515007;4043.0700938784244;4155.97922010388;4173.248815213291;4313.180495705868;13402;13750.243736594382;13841.584752457442;13872.028957972845;13892.16647001183;13193.142445740996;13753.174809511462;13786.862131378557;13938.721225575431;13956.302184890716;9937.65218217359;10231.744206394751;10233.795324093477;10239.334443261165;10248.795024099476;5845.413755496551;6510.641914694737;6669.266380698023;6870.3473170048765;6902.827429314308;12095.032397408362;12458.127931045103;12493.25040497573;12511.874881251071;12530.686732831753;12455.93772031134;12571.245725256515;12841.550545730855;12851.871481285067;12871.485140594272;8673.34949878749;9050.185483306534;9079.727608171765;9213.309001824757;9243.352965292364;8891.377603567687;9206.12541808554;9208.940971788063;10070.345427547187;10247.487625618838;8348.833023339621;8537.359698022798;8582.613782379933;8650.78373040679;8728.69449569262;8319.084900661044;8417.326613870999;8493.87259191125;8538.743837684879;8633.30933525329;7783.844323113619;7792.103908050647;7806.4925779824125;7905.486143400661;7924.6433910473015;5835.212246346859;5918.911216331845;5949.167116603766;6079.392060794062;6219.595726277777;5513.842093160481;5593.552515798645;5950.910736338872;6130.693465326805;6407.0709747085475 09:15:49 INFO - PID 1645 | |4;prototype.html;364.93613617616916;393.0664671405412;397.98116820938384;399.30520893645064;400.0877998164185;4841.8305359312435;5704.60067795254;5858.355580886099;5885.7939972100985;5891.793787217438;5236.188390799422;5761.251037365137;5781.335146458158;5831.3293971193325;5839.503642190408;4459.576340247671;4476.798544065517;4482.305242687373;4497.550244975492;4507.233770259048;4489.842855500058;4495.842645507408;4505.752183629899;4521.163584736818;4543.250363689987;2850.50116229659;4259.787010649455;4291.613754762071;4324.243257429953;4447.710898791584;3746.6066063063395;4235.301175306071;4242.851500197494;4251.383549385353;4265.253580623378;3089.7373723233554;3694.390425579776;3703.8148092595534;3711.5175027246287;3725.832337544817;5488.9725551371985;5661.782716715926;5699.722659470821;5720.942790572082;5730.541556675497;3998.9200215995515;5025.522575355335;5074.619403544712;5083.517065878736;5112.616553758483;6105.870413973429;6166.691665416756;6167.687117331001;6186.907196392058;6209.5032397408095;3434.793912365241;4058.857939972116;4171.455412198557;4199.496060472732;4225.091605304874;5501.972490137524;5668.696199874011;6180.474659653934;6517.837054073639;6578.868422631521;3723.3670276053135;4106.7946602669745;4124.65948566711;4159;4268.765217913045;4337.631301339358;4344.218040752695;4349.869503914888;4361.956380436219;4362.967737422461;4183.832646694098;4981.103401387785;5008.223725322581;5060.773259765691;5107.233914912793;6189.164462797555;6197.566170368121;6209.2548894133;6237.937620623827;6260.812175634738;1461.5615315405548;1468.7796830475513;1483.428879881232;1483.8367779544242;1486.3311509820408;920.7288274627703;980.1374790184734;982.4400091947664;987.980240395188;993.1210878372692;5412.3505179377935;5507.256520369779;5864.560157988082;5919.4968427684125;5929.762809487572;6395.488360931115;6435.163428754232;6468.708908099053;6478.578892371981;6479.481641468671;5569.387367389584;5882.470577648032;5897.7935772247765;5951;5968.194293770285;2945.9705402946124;3306.231166326052;3345.8661653534073;3358.966410335914;3378.847951842173;5761.942380576224;6224.221972253468;6487.902681459782;6576.309487503743;6613.140291762136;5404.513593776579;5602.310890772452;6464.838379040561;6519.380658837497;6626.9337306627285;6187.876242475215;6496.252930912911;6572.539922205496;6589.308122647149;6592.274849766618;5547.694876781816;6358.046293056079;6359.8092057238355;6405.8718825624155;6410.423061924263;5273.31446911899;6044.637321760709;6265.843353916189;6278.4035516625845;6282.434580887742;5531.640443371168;5756.395578464369;5835.416458354131;6219;6559.409653131241;3725.1990821973404;4243.265925985113;4604.815807367801;4653.60444362233;4689.80409995449;5031.679091799395;5394.757235924314;5604.579656525695;6468.902966455413;6472.223333200046;5437.592180586551;6183.96908015457;6216.409441103088;6217.844553886189;6229.283632382334;5453.64551304164;5986.910196347146;6229.781957631461;6235.688215589294;6318.652474113968;4841.782119804547;5219.530242278213;5814.527921590352;5862.794802181903;6108.938910610837;6242.438180563771;6242.687865606611;6249.718762655601;6255.093011513396;6290.402411770874;4894.755262236945;5459.45595143599;5696.202531645656;5785.537157027512;6189.907151392643 09:15:49 INFO - PID 1645 | |5;yui.html;640.7212862404854;736.8231624410143;741.6772857597957;752.2966026764975;770.7841804294796;15714.607134821636;16387.672246555063;16438.424655137074;16530.33878644854;16540.172991350446;15229.543113706579;15669.373225070984;15670.84329156708;15694.136822474788;15697.607559811011;960.8078384323128;983.8475036369374;988.3921388346188;990.692885205585;992.8560358747977;998.2862253488754;1009.7273736091252;1010.5200029985734;1012.2559918459926;1015.4364327798069;1036.6371769880557;1071.2661826648732;1073.2219141122703;1076;1088.3633074651339;1077.5959015369237;1092.0771947704177;1092.1153865368997;1094.108301734084;1095.1239008793013;796.5539297993084;796.5817945578559;797.2306724011357;797.3222760653456;799.9880001799978;16301.91849040759;16783.916080419644;16841.915790420968;16988.830111698848;17340.47978560645;13786.793198102036;13951.372188251553;14894.70210595793;14936;14981;11583.131265155147;12038.69903252417;12248.326342051183;12259.325737084457;12391.814122788166;3028.258076771205;3169.873205071817;3185.490321548564;3187.553742476055;3192.4413227685295;107267;112095;112287;116713;116838.41580792126;10841.186910981707;11522.539098436137;11615.303081815118;11619.941900290614;11979.161458697981;24349.513009739705;25122.623160652605;25140.622890656654;25309.367265818135;25349.873250633627;7801.648925798353;7811.765647030598;8024.956755621732;8131.186881311822;8221.465604735673;4090.8159132839096;4118.114605359862;4209.936850947238;4272.615464608138;4345.391645169679;3735.589085200626;4119.299719047769;4122.690798190148;4220.324748040299;4227.915441691211;716.935351003759;819.512390127873;825.6129702100409;847.0724556610502;868.8132051608934;480.4042986696471;545.1958361416879;550.1280470454295;556.449115375775;588.9352171261157;8533.53065581399;8545.529995850287;9881.654142104991;9938.751531211778;10233.43716095607;514.143950322716;527.9889012540941;560.2772423573626;562.2858969109209;563.3408911573468;4116.4648595682365;4385.473743150778;4518.525554816697;4519.819207231674;4605.171069207575;75886.62056689791;95776;97439.51280243554;100310.4984475073;102946.48526757318;89650;91162;91520;92015.5399223013;92355;80508.99999999882;80602.5969870147;81340;81786.18213817905;81873.59063204765;8248.83502329938;8793.29653627721;9164.587593558439;9253.629854806002;9320.95339523298;32032.83983580067;39610.2077958445;40614.59385406108;41003.38494922519;41574.168516628895;50768.11557977265;51693;52025.7398713004;52493.68765780886;53165;9978.550965206729;11368.317900925971;11490.533733654318;11592.594259201225;11708.356040417859;11057.809416337914;11818.704532386759;11915.642530724092;11937.940310298392;12103.273803571814;9760.46317452547;11059.115270778479;11537;11711.238769479956;11980.221285616408;11278.49246783913;11545.82681259765;11636.010939069934;11960.10299227544;12265.080118990933;11326.01915239207;11426.542938282375;11469.139814513777;11653.859404724686;11684.18210725241;8720.869186962074;8758.91241087581;8797.648094076165;8834.160754728548;8848.823023539622;8140.348772098337;8987.735403139643;9827.115559599384;10288.228382871164;11359.807220241755 09:15:49 INFO - PID 1645 | __end_tp_report 09:15:49 INFO - PID 1645 | __start_cc_report 09:15:49 INFO - PID 1645 | _x_x_mozilla_cycle_collect,2578 09:15:49 INFO - PID 1645 | __end_cc_report 09:15:49 INFO - PID 1645 | __startTimestamp1491063349706__endTimestamp 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | ------- Summary: start ------- 09:15:49 INFO - PID 1645 | Number of tests: 6 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:6015.63 Median:6306.43 stddev:717.89 (11.4%) stddev-sans-first:679.24 09:15:49 INFO - PID 1645 | Values: 2972.6 3112.8 3482.1 3518.1 3555.6 6056.0 6118.1 6243.5 6253.3 6270.1 6107.5 6178.7 6234.8 6239.2 6245.4 5166.6 5271.1 5338.6 5347.2 5442.7 5355.4 5361.9 5396.5 5433.5 5434.5 5203.6 5289.8 5292.2 5308.9 5318.1 5261.0 5269.9 5274.2 5283.3 5292.5 5199.7 5254.0 5270.1 5271.1 5273.2 6026.3 6032.6 6033.0 6051.2 6066.2 6345.3 6352.3 6356.6 6371.4 6375.0 6351.4 6399.4 6567.2 6609.5 6677.6 6335.9 6338.3 6341.3 6352.7 6355.9 6819.4 6825.2 6827.5 6828.3 6843.7 5504.5 5761.6 6352.6 6360.3 6371.1 6376.7 6384.1 6389.8 6393.0 6401.9 6345.9 6356.9 6376.7 6450.2 6548.0 5342.6 6322.5 6472.8 6482.6 6503.0 5288.6 5301.2 5309.5 5317.9 5324.9 4618.8 4646.5 4686.7 4728.3 4743.3 5999.9 6006.1 6018.6 6027.5 6063.0 6328.4 6524.0 6590.4 6624.1 6646.5 6278.7 6288.3 6317.0 6321.0 6330.3 5838.0 5884.8 5888.5 5888.7 5893.6 5712.6 6493.3 6569.7 6570.4 6728.7 6625.7 6658.4 6682.9 6686.5 6712.6 6815.1 6844.2 6844.6 6847.8 6851.9 6317.7 6358.9 6363.9 6473.9 6564.9 5237.7 6348.4 6546.2 6556.3 6651.6 6359.8 6381.3 6385.8 6405.6 6421.9 6271.1 6355.3 6418.7 6421.5 6433.6 6254.3 6268.3 6276.3 6306.4 6312.1 6251.4 6317.9 6474.1 6477.4 6486.0 6226.3 6264.5 6268.7 6271.2 6304.7 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:50260.68 Median:33650.84 stddev:98977.59 (294.1%) stddev-sans-first:99185.29 09:15:49 INFO - PID 1645 | Values: 698.5 818.0 1136.2 1149.7 1154.1 36737.4 37463.1 37548.0 37610.0 37613.6 39005.4 39356.6 39434.0 39454.0 39559.0 6105.8 6259.1 8495.8 8669.7 8678.1 8471.4 8610.8 8678.3 8684.8 8685.0 8667.8 8737.2 8738.0 8768.4 8770.3 8671.2 8734.6 8740.7 8748.3 8760.1 7268.4 8495.4 8574.3 8576.1 8581.6 38122.9 38283.4 38287.6 38352.0 38421.0 2895.9 2958.2 2972.9 2991.7 3011.7 26953.5 26976.3 27385.9 27416.5 28060.4 2752.1 2772.5 2791.4 2795.8 2798.7 276343.0 277065.0 277214.8 277787.0 278919.0 39359.8 39898.8 39997.0 47435.8 47441.5 51037.0 51369.6 51699.0 51863.7 51934.2 12414.4 14234.3 14360.9 14376.7 14379.9 10020.9 11229.6 11408.2 11421.6 11426.4 13614.5 13620.0 13622.7 13716.3 13753.1 5944.0 5973.7 5989.9 5993.3 6009.5 879.8 910.6 1000.8 1010.6 1023.0 23706.4 23823.8 23849.9 23872.3 23910.0 1077.3 1080.5 1120.2 1122.1 1123.2 10278.9 11523.9 11576.2 12127.0 12190.4 421059.0 424060.0 424316.0 424493.0 424905.0 56845.0 57100.4 57168.1 57224.4 57225.0 1314.4 1470.9 1475.3 1515.0 1521.0 23116.2 23144.7 23148.0 23227.5 23332.1 38424.6 38506.4 38524.8 38541.4 38548.0 348105.0 353738.0 430790.0 431765.0 434161.4 32219.5 32510.5 32663.3 32766.3 32849.7 41042.8 41218.8 41505.6 42558.0 42710.1 28665.3 29483.6 29606.1 29671.0 30181.2 25116.6 28687.4 28706.1 29602.1 29903.4 34452.0 34828.3 35370.3 35961.6 36005.5 26146.6 29984.9 30109.2 30147.8 30191.9 22458.8 23438.6 23653.6 23777.6 23971.6 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:41103.07 Median:22694.13 stddev:117198.56 (516.4%) stddev-sans-first:117487.42 09:15:49 INFO - PID 1645 | Values: 370.4 424.6 431.6 440.4 451.5 19918.2 21641.1 22482.4 22653.2 22700.0 21639.9 22412.0 22688.3 22750.4 23080.0 6115.5 6331.1 6334.0 6334.9 6346.5 5876.6 6235.9 6282.7 6299.9 6317.2 5956.7 6255.2 6266.4 6274.0 6274.3 6186.9 6268.5 6300.4 6305.5 6315.3 5529.4 5534.8 5540.1 5604.0 5615.1 27280.0 27662.9 27954.3 28319.2 28400.9 2063.4 2070.7 2083.1 2087.4 2156.6 15779.8 16488.0 16847.2 17126.7 17508.6 1843.4 1892.5 1893.7 1894.7 1919.9 153861.2 163997.4 164463.0 164593.0 165371.0 11919.3 11993.6 12014.6 12079.6 12239.4 16507.2 16509.8 16517.8 16526.5 16577.5 7769.0 8613.9 8853.2 8854.4 8954.4 8364.4 8378.2 8382.9 8528.6 8531.4 7599.3 7729.2 7810.6 7896.3 7923.7 2122.5 2141.6 2144.9 2149.1 2328.2 917.6 937.6 939.1 948.4 958.4 19040.8 19899.5 21382.3 21422.3 21434.0 878.4 913.5 954.3 996.3 1005.1 10621.3 10813.4 10911.3 10942.9 10958.0 673576.0 683947.2 693641.0 705977.0 718117.0 144848.0 165604.2 165785.0 166163.2 169695.0 1114.1 1126.2 1148.4 1154.5 1155.7 17773.2 18363.2 18440.7 18445.7 18868.9 60711.5 61182.1 61875.7 61908.7 62486.4 86604.1 86717.6 89851.2 90076.0 91529.5 8481.2 8712.0 8750.3 8810.3 9025.1 13548.8 13806.2 14096.2 14269.3 14297.4 10605.4 10640.7 11138.1 11719.9 11933.0 8328.5 10738.5 10840.0 11188.5 11208.4 10446.6 11818.6 12071.5 12158.0 12203.0 8476.0 8572.7 8630.6 8920.3 8972.8 11402.0 11737.0 11904.0 11953.6 12082.0 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:6783.71 Median:3740.32 stddev:4203.25 (112.4%) stddev-sans-first:4194.00 09:15:49 INFO - PID 1645 | Values: 1187.1 1369.5 1426.3 1458.2 1463.6 9095.9 9524.6 10713.8 11018.5 11042.4 10713.2 10845.6 10853.3 10855.3 10867.7 2414.9 2462.3 2467.5 2469.0 2469.4 2072.7 2158.4 2395.2 2482.9 2488.4 2424.6 2455.5 2456.4 2460.8 2463.6 2423.5 2434.3 2450.6 2452.3 2454.6 1884.5 2399.2 2416.6 2421.2 2453.7 10802.3 10928.1 10954.5 10956.1 10964.3 6043.5 6287.5 6299.5 6314.3 6315.1 3364.2 3695.0 3941.2 4019.4 4027.1 1098.9 1153.8 1161.5 1194.4 1206.3 15043.8 15265.2 15265.5 15276.2 15278.1 4813.9 5414.9 5634.6 5643.5 5654.4 12336.2 12590.5 12613.2 12622.3 12624.5 5386.8 6343.9 6358.4 6364.6 6375.8 5596.6 5787.0 5794.2 5835.2 5845.0 3984.9 4093.8 4096.4 4382.3 4439.5 1340.4 1364.6 1391.7 1402.0 1417.9 765.1 767.1 787.3 794.7 802.1 5762.9 6300.6 6566.9 6583.8 6652.3 797.0 871.5 873.1 890.7 907.2 3785.7 4043.1 4156.0 4173.2 4313.2 13402.0 13750.2 13841.6 13872.0 13892.2 13193.1 13753.2 13786.9 13938.7 13956.3 9937.7 10231.7 10233.8 10239.3 10248.8 5845.4 6510.6 6669.3 6870.3 6902.8 12095.0 12458.1 12493.3 12511.9 12530.7 12455.9 12571.2 12841.6 12851.9 12871.5 8673.3 9050.2 9079.7 9213.3 9243.4 8891.4 9206.1 9208.9 10070.3 10247.5 8348.8 8537.4 8582.6 8650.8 8728.7 8319.1 8417.3 8493.9 8538.7 8633.3 7783.8 7792.1 7806.5 7905.5 7924.6 5835.2 5918.9 5949.2 6079.4 6219.6 5513.8 5593.6 5950.9 6130.7 6407.1 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:4983.88 Median:5633.18 stddev:1545.50 (27.4%) stddev-sans-first:1510.45 09:15:49 INFO - PID 1645 | Values: 364.9 393.1 398.0 399.3 400.1 4841.8 5704.6 5858.4 5885.8 5891.8 5236.2 5761.3 5781.3 5831.3 5839.5 4459.6 4476.8 4482.3 4497.6 4507.2 4489.8 4495.8 4505.8 4521.2 4543.3 2850.5 4259.8 4291.6 4324.2 4447.7 3746.6 4235.3 4242.9 4251.4 4265.3 3089.7 3694.4 3703.8 3711.5 3725.8 5489.0 5661.8 5699.7 5720.9 5730.5 3998.9 5025.5 5074.6 5083.5 5112.6 6105.9 6166.7 6167.7 6186.9 6209.5 3434.8 4058.9 4171.5 4199.5 4225.1 5502.0 5668.7 6180.5 6517.8 6578.9 3723.4 4106.8 4124.7 4159.0 4268.8 4337.6 4344.2 4349.9 4362.0 4363.0 4183.8 4981.1 5008.2 5060.8 5107.2 6189.2 6197.6 6209.3 6237.9 6260.8 1461.6 1468.8 1483.4 1483.8 1486.3 920.7 980.1 982.4 988.0 993.1 5412.4 5507.3 5864.6 5919.5 5929.8 6395.5 6435.2 6468.7 6478.6 6479.5 5569.4 5882.5 5897.8 5951.0 5968.2 2946.0 3306.2 3345.9 3359.0 3378.8 5761.9 6224.2 6487.9 6576.3 6613.1 5404.5 5602.3 6464.8 6519.4 6626.9 6187.9 6496.3 6572.5 6589.3 6592.3 5547.7 6358.0 6359.8 6405.9 6410.4 5273.3 6044.6 6265.8 6278.4 6282.4 5531.6 5756.4 5835.4 6219.0 6559.4 3725.2 4243.3 4604.8 4653.6 4689.8 5031.7 5394.8 5604.6 6468.9 6472.2 5437.6 6184.0 6216.4 6217.8 6229.3 5453.6 5986.9 6229.8 6235.7 6318.7 4841.8 5219.5 5814.5 5862.8 6108.9 6242.4 6242.7 6249.7 6255.1 6290.4 4894.8 5459.5 5696.2 5785.5 6189.9 09:15:49 INFO - PID 1645 | 09:15:49 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:19689.60 Median:22352.70 stddev:28987.74 (129.7%) stddev-sans-first:29033.77 09:15:49 INFO - PID 1645 | Values: 640.7 736.8 741.7 752.3 770.8 15714.6 16387.7 16438.4 16530.3 16540.2 15229.5 15669.4 15670.8 15694.1 15697.6 960.8 983.8 988.4 990.7 992.9 998.3 1009.7 1010.5 1012.3 1015.4 1036.6 1071.3 1073.2 1076.0 1088.4 1077.6 1092.1 1092.1 1094.1 1095.1 796.6 796.6 797.2 797.3 800.0 16301.9 16783.9 16841.9 16988.8 17340.5 13786.8 13951.4 14894.7 14936.0 14981.0 11583.1 12038.7 12248.3 12259.3 12391.8 3028.3 3169.9 3185.5 3187.6 3192.4 107267.0 112095.0 112287.0 116713.0 116838.4 10841.2 11522.5 11615.3 11619.9 11979.2 24349.5 25122.6 25140.6 25309.4 25349.9 7801.6 7811.8 8025.0 8131.2 8221.5 4090.8 4118.1 4209.9 4272.6 4345.4 3735.6 4119.3 4122.7 4220.3 4227.9 716.9 819.5 825.6 847.1 868.8 480.4 545.2 550.1 556.4 588.9 8533.5 8545.5 9881.7 9938.8 10233.4 514.1 528.0 560.3 562.3 563.3 4116.5 4385.5 4518.5 4519.8 4605.2 75886.6 95776.0 97439.5 100310.5 102946.5 89650.0 91162.0 91520.0 92015.5 92355.0 80509.0 80602.6 81340.0 81786.2 81873.6 8248.8 8793.3 9164.6 9253.6 9321.0 32032.8 39610.2 40614.6 41003.4 41574.2 50768.1 51693.0 52025.7 52493.7 53165.0 9978.6 11368.3 11490.5 11592.6 11708.4 11057.8 11818.7 11915.6 11937.9 12103.3 9760.5 11059.1 11537.0 11711.2 11980.2 11278.5 11545.8 11636.0 11960.1 12265.1 11326.0 11426.5 11469.1 11653.9 11684.2 8720.9 8758.9 8797.6 8834.2 8848.8 8140.3 8987.7 9827.1 10288.2 11359.8 09:15:49 INFO - PID 1645 | -------- Summary: end -------- 09:15:49 INFO - PID 1645 | 09:15:50 INFO - TEST-INFO | 1645: exit 0 09:15:50 INFO - TEST-OK | dromaeo_css | took 1121482ms 09:15:50 INFO - TEST-START | kraken 09:15:50 INFO - operating with platform_type : mac_ 09:15:50 INFO - Initialising browser for kraken test... 09:15:50 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpoCXBAO/profile http://localhost:49251/getInfo.html) 09:15:52 INFO - PID 1655 | __metrics Screen width/height:1600/1200 09:15:52 INFO - PID 1655 | colorDepth:24 09:15:52 INFO - PID 1655 | Browser inner width/height: 1024/689 09:15:52 INFO - PID 1655 | __metrics 09:15:52 INFO - PID 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:15:52 INFO - PID 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:53 INFO - TEST-INFO | 1655: exit 0 09:15:53 INFO - Browser initialized. 09:15:53 INFO - Running cycle 1/1 for kraken test... 09:15:53 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpoCXBAO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:06 INFO - PID 1656 | RSS: Main: 232558592 09:16:06 INFO - PID 1656 | 09:16:08 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:09 INFO - PID 1656 | RSS: Main: 286748672 09:16:09 INFO - PID 1656 | 09:16:12 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 09:16:13 INFO - PID 1656 | RSS: Main: 287125504 09:16:13 INFO - PID 1656 | 09:16:16 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 09:16:17 INFO - PID 1656 | RSS: Main: 380481536 09:16:17 INFO - PID 1656 | 09:16:19 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 09:16:20 INFO - PID 1656 | RSS: Main: 283078656 09:16:20 INFO - PID 1656 | 09:16:22 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:23 INFO - PID 1656 | RSS: Main: 287477760 09:16:23 INFO - PID 1656 | 09:16:26 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:27 INFO - PID 1656 | RSS: Main: 328130560 09:16:27 INFO - PID 1656 | 09:16:30 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:30 INFO - PID 1656 | RSS: Main: 342036480 09:16:30 INFO - PID 1656 | 09:16:34 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 09:16:34 INFO - PID 1656 | RSS: Main: 349855744 09:16:34 INFO - PID 1656 | 09:16:36 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:37 INFO - PID 1656 | RSS: Main: 305451008 09:16:37 INFO - PID 1656 | 09:16:39 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:39 INFO - PID 1656 | RSS: Main: 307798016 09:16:39 INFO - PID 1656 | 09:16:42 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:42 INFO - PID 1656 | RSS: Main: 309411840 09:16:42 INFO - PID 1656 | 09:16:45 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:46 INFO - PID 1656 | RSS: Main: 327122944 09:16:46 INFO - PID 1656 | 09:16:49 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:50 INFO - PID 1656 | RSS: Main: 321007616 09:16:50 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 09:16:52 INFO - PID 1656 | RSS: Main: 384131072 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | __start_tp_report 09:16:52 INFO - PID 1656 | _x_x_mozilla_page_load 09:16:52 INFO - PID 1656 | _x_x_mozilla_page_load_details 09:16:52 INFO - PID 1656 | |i|pagename|runs| 09:16:52 INFO - PID 1656 | |0;ai-astar;110;122;123;124;124;124;123;123;123;123 09:16:52 INFO - PID 1656 | |1;audio-beat-detection;156;122;117;164;120;119;118;118;153;101 09:16:52 INFO - PID 1656 | |2;audio-dft;211;216;210;214;213;210;217;215;210;211 09:16:52 INFO - PID 1656 | |3;audio-fft;91;63;64;95;64;65;51;57;96;93 09:16:52 INFO - PID 1656 | |4;audio-oscillator;99;79;100;94;106;112;130;82;75;92 09:16:52 INFO - PID 1656 | |5;imaging-gaussian-blur;99;81;125;107;93;91;96;130;137;90 09:16:52 INFO - PID 1656 | |6;imaging-darkroom;101;100;101;102;99;100;100;101;100;101 09:16:52 INFO - PID 1656 | |7;imaging-desaturate;102;101;102;127;156;101;102;100;101;99 09:16:52 INFO - PID 1656 | |8;json-parse-financial;51;61;70;76;82;75;51;51;49;50 09:16:52 INFO - PID 1656 | |9;json-stringify-tinderbox;57;58;67;68;69;85;92;91;87;66 09:16:52 INFO - PID 1656 | |10;stanford-crypto-aes;91;89;89;94;89;91;91;102;115;117 09:16:52 INFO - PID 1656 | |11;stanford-crypto-ccm;155;154;160;141;166;171;173;145;227;182 09:16:52 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;199;200;202;202;198;203;204;242;195;199 09:16:52 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;73;72;74;73;73;72;72;72;74;73 09:16:52 INFO - PID 1656 | __end_tp_report 09:16:52 INFO - PID 1656 | __start_cc_report 09:16:52 INFO - PID 1656 | _x_x_mozilla_cycle_collect,2130 09:16:52 INFO - PID 1656 | __end_cc_report 09:16:52 INFO - PID 1656 | __startTimestamp1491063412742__endTimestamp 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | ------- Summary: start ------- 09:16:52 INFO - PID 1656 | Number of tests: 14 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:121.90 Median:123.00 stddev:4.23 (3.4%) stddev-sans-first:0.67 09:16:52 INFO - PID 1656 | Values: 110.0 122.0 123.0 124.0 124.0 124.0 123.0 123.0 123.0 123.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:121.00 stddev:20.90 (17.3%) stddev-sans-first:19.71 09:16:52 INFO - PID 1656 | Values: 156.0 122.0 117.0 164.0 120.0 119.0 118.0 118.0 153.0 101.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:212.70 Median:213.50 stddev:2.67 (1.2%) stddev-sans-first:2.76 09:16:52 INFO - PID 1656 | Values: 211.0 216.0 210.0 214.0 213.0 210.0 217.0 215.0 210.0 211.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:73.90 Median:78.00 stddev:17.62 (22.6%) stddev-sans-first:17.57 09:16:52 INFO - PID 1656 | Values: 91.0 63.0 64.0 95.0 64.0 65.0 51.0 57.0 96.0 93.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:80.50 stddev:16.58 (20.6%) stddev-sans-first:17.57 09:16:52 INFO - PID 1656 | Values: 99.0 79.0 100.0 94.0 106.0 112.0 130.0 82.0 75.0 92.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:104.90 Median:90.50 stddev:19.18 (21.2%) stddev-sans-first:20.22 09:16:52 INFO - PID 1656 | Values: 99.0 81.0 125.0 107.0 93.0 91.0 96.0 130.0 137.0 90.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:101.00 stddev:0.85 (0.8%) stddev-sans-first:0.88 09:16:52 INFO - PID 1656 | Values: 101.0 100.0 101.0 102.0 99.0 100.0 100.0 101.0 100.0 101.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:109.10 Median:102.00 stddev:18.42 (18.1%) stddev-sans-first:19.35 09:16:52 INFO - PID 1656 | Values: 102.0 101.0 102.0 127.0 156.0 101.0 102.0 100.0 101.0 99.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:65.50 stddev:12.93 (19.7%) stddev-sans-first:13.13 09:16:52 INFO - PID 1656 | Values: 51.0 61.0 70.0 76.0 82.0 75.0 51.0 51.0 49.0 50.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:77.00 stddev:13.42 (17.4%) stddev-sans-first:12.75 09:16:52 INFO - PID 1656 | Values: 57.0 58.0 67.0 68.0 69.0 85.0 92.0 91.0 87.0 66.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:90.00 stddev:10.84 (12.0%) stddev-sans-first:11.29 09:16:52 INFO - PID 1656 | Values: 91.0 89.0 89.0 94.0 89.0 91.0 91.0 102.0 115.0 117.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:167.40 Median:168.50 stddev:24.49 (14.5%) stddev-sans-first:25.56 09:16:52 INFO - PID 1656 | Values: 155.0 154.0 160.0 141.0 166.0 171.0 173.0 145.0 227.0 182.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.40 Median:202.00 stddev:13.48 (6.7%) stddev-sans-first:14.15 09:16:52 INFO - PID 1656 | Values: 199.0 200.0 202.0 202.0 198.0 203.0 204.0 242.0 195.0 199.0 09:16:52 INFO - PID 1656 | 09:16:52 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 09:16:52 INFO - PID 1656 | Values: 73.0 72.0 74.0 73.0 73.0 72.0 72.0 72.0 74.0 73.0 09:16:52 INFO - PID 1656 | -------- Summary: end -------- 09:16:52 INFO - PID 1656 | 09:16:53 INFO - TEST-INFO | 1656: exit 0 09:16:53 INFO - TEST-OK | kraken | took 63342ms 09:16:53 INFO - SUITE-END | took 1184s 09:16:53 INFO - Completed test suite (00:19:45) 09:16:53 INFO - javascript benchmark 09:16:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7559.858561781822, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2972.643282806063, 3112.813231206127, 3482.077249528874, 3518.1204698825295, 3555.6444355564445, 6055.969720151393, 6118.131909153803, 6243.500519958404, 6253.343398943114, 6270.090836828657, 6107.522607572288, 6178.691065446721, 6234.7506099756065, 6239.157713708648, 6245.406686364788, 5166.612504062192, 5271.051210782058, 5338.599605029638, 5347.224652425396, 5442.673439593617, 5355.357357117151, 5361.892762144755, 5396.460353964611, 5433.4566543345545, 5434.510894019538, 5203.609729270301, 5289.761960711778, 5292.206169074631, 5308.9469105308835, 5318.095923692981, 5261.0, 5269.868253293698, 5274.156135018417, 5283.313169288006, 5292.52367286946, 5199.740012999335, 5253.9737301313635, 5270.077736396153, 5271.077561426735, 5273.235380869791, 6026.276846778414, 6032.638041717511, 6033.0, 6051.213342265477, 6066.241719785027, 6345.302016778197, 6352.269489008777, 6356.586821856565, 6371.39471750183, 6374.968125159345, 6351.364863513658, 6399.424051835357, 6567.211934567835, 6609.471242300604, 6677.565958212701, 6335.873282534323, 6338.334474880164, 6341.302456729756, 6352.745890164388, 6355.904661430082, 6819.386255237053, 6825.215100263533, 6827.52207345491, 6828.317168283232, 6843.726250950006, 5504.4770746778995, 5761.625494342854, 6352.555321127476, 6360.300366959631, 6371.076193951943, 6376.713047912763, 6384.106225128486, 6389.776357827547, 6393.0, 6401.903971440339, 6345.936540634627, 6356.904646430307, 6376.681165941777, 6450.193725784277, 6547.985062315349, 5342.6260161788305, 6322.4942004639515, 6472.773452929125, 6482.57863238888, 6503.02454631809, 5288.603354748332, 5301.151815709468, 5309.548688361455, 5317.867053323698, 5324.866878328073, 4618.815247390134, 4646.465656449484, 4686.74222917736, 4728.267118596623, 4743.28850672395, 5999.880002399927, 6006.129111278928, 6018.638881667114, 6027.547933904974, 6062.969295219735, 6328.430441260309, 6524.0, 6590.406863382223, 6624.138861948012, 6646.501512386591, 6278.654673992883, 6288.276848162428, 6316.968415157987, 6320.968395158086, 6330.272018717815, 5838.007538718428, 5884.7940322088525, 5888.5289176865745, 5888.735006924699, 5893.5874488785375, 5712.571557133148, 6493.318201588765, 6569.704363303758, 6570.441512471493, 6728.697208625722, 6625.734970601122, 6658.3674550917585, 6682.866342673216, 6686.465082793267, 6712.563683360566, 6815.114035175396, 6844.178698556205, 6844.623545704835, 6847.794566163023, 6851.862962740617, 6317.652529110943, 6358.93641063602, 6363.904541431974, 6473.902891456538, 6564.901526477202, 5237.738113094406, 6348.42864142211, 6546.18172728409, 6556.2788093308745, 6651.567648102858, 6359.8092057238355, 6381.29805721361, 6385.776497822554, 6405.615663060231, 6421.903671444838, 6271.090691849565, 6355.30091689923, 6418.743250269937, 6421.518386120966, 6433.613983161025, 6254.312025677263, 6268.27914789805, 6276.309605943434, 6306.432421082125, 6312.147860038836, 6251.374862513712, 6317.873642527032, 6474.0612611172055, 6477.352264773485, 6485.967570162119, 6226.346233645583, 6264.5301602379095, 6268.686565671607, 6271.247450305992, 6304.71628776697], "value": 5966.320537974034, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4831224893579, 817.9509229446231, 1136.153565593633, 1149.6953307373542, 1154.0709728668419, 36737.448938265916, 37463.06342341443, 37548.0, 37610.0, 37613.62386376136, 39005.41491877624, 39356.622518211865, 39434.0, 39454.0, 39559.0, 6105.847353816168, 6259.06114082889, 8495.78760530987, 8669.739907802776, 8678.132186781302, 8471.407001509897, 8610.784730381727, 8678.305735541142, 8684.782880427976, 8685.0, 8667.826643467128, 8737.21365077143, 8738.0, 8768.430052046628, 8770.254528365096, 8671.176238257356, 8734.563271836383, 8740.694075707383, 8748.34387420946, 8760.116574936419, 7268.4185265179185, 8495.36284778644, 8574.271186949118, 8576.05663377028, 8581.613827377783, 38122.90033594611, 38283.425748613794, 38287.617123828684, 38352.04119896997, 38421.03947401337, 2895.869685864141, 2958.1864987128497, 2972.940541189164, 2991.6809139530424, 3011.6837732038257, 26953.46093078147, 26976.325591860164, 27385.90456381762, 27416.451670966468, 28060.43879122406, 2752.119321817019, 2772.487089888357, 2791.3579876628287, 2795.804293699442, 2798.6501687289087, 276343.0, 277065.0, 277214.8417773735, 277787.0, 278919.0, 39359.80320098381, 39898.80050599787, 39997.0, 47435.76282118567, 47441.5255847444, 51037.0, 51369.55141504461, 51699.0, 51863.74068129711, 51934.22098668523, 12414.379281035912, 14234.288285585679, 14360.928195358956, 14376.712465750627, 14379.928100359431, 10020.949895250476, 11229.55081796719, 11408.201425900108, 11421.600243991421, 11426.428678566039, 13614.455421783017, 13620.0, 13622.659433514043, 13716.314184290944, 13753.106048107042, 5943.970280148572, 5973.671448070311, 5989.9101513477335, 5993.321869876441, 6009.549283803733, 879.7668617816283, 910.6129894794685, 1000.8048430555972, 1010.5856598794606, 1023.0280637455716, 23706.407339816644, 23823.761762382503, 23849.880750596483, 23872.28383148508, 23910.043598256223, 1077.2836064017497, 1080.524569189554, 1120.1934607082887, 1122.0630773304383, 1123.2137503747247, 10278.948605256926, 11523.884761152281, 11576.24754390962, 12127.0, 12190.39048047594, 421059.0, 424060.0, 424316.0, 424493.0, 424905.0, 56845.0, 57100.42899570951, 57168.142477862864, 57224.42775572191, 57225.0, 1314.3822403470353, 1470.9485168019069, 1475.3056163525798, 1514.9697006060037, 1520.9771853422208, 23116.19093331725, 23144.652830207222, 23148.0, 23227.535449290583, 23332.066717331116, 38424.6157538421, 38506.422403663404, 38524.80737596406, 38541.4218786724, 38548.0, 348105.0, 353738.0, 430790.0, 431765.0, 434161.43789215304, 32219.516707249877, 32510.51234231441, 32663.34673306473, 32766.34467310688, 32849.671503285615, 41042.79478602707, 41218.79390603028, 41505.58494415017, 42558.0, 42710.14579708326, 28665.28336791597, 29483.55774663339, 29606.111816645534, 29670.961516346822, 30181.245468863453, 25116.62325065089, 28687.42625147527, 28706.13881583556, 29602.111936641933, 29903.401931960805, 34452.0, 34828.30343393169, 35370.29259414849, 35961.640383595826, 36005.45991810073, 26146.565037612865, 29984.85007574948, 30109.18650329366, 30147.849260753555, 30191.943281985026, 22458.775412246323, 23438.64842027337, 23653.645195322428, 23777.643335349636, 23971.640425393285], "value": 17360.40108281633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.44988192534083, 424.59451224081005, 431.58136607490763, 440.42964361152303, 451.52815308003136, 19918.203271869108, 21641.134354625814, 22482.43793905153, 22653.20713775018, 22700.0, 21639.891800541016, 22412.0, 22688.256437687804, 22750.431239218986, 23080.0, 6115.541334399927, 6331.050342448623, 6333.968330158343, 6334.936650633504, 6346.524010699216, 5876.6180198286975, 6235.906461403082, 6282.68586570672, 6299.905501417483, 6317.210348706411, 5956.672383018932, 6255.15555400022, 6266.436020758131, 6273.968630156865, 6274.309825919146, 6186.907196392058, 6268.529860260499, 6300.4329610334835, 6305.527085468562, 6315.336889626569, 5529.447055294479, 5534.806281780118, 5540.141278101901, 5603.971980140073, 5615.101583746622, 27280.0, 27662.861685691645, 27954.3011424714, 28319.150425487267, 28400.857995710096, 2063.4428704249917, 2070.730804995341, 2083.062621820172, 2087.4155236533793, 2156.568686262738, 15779.763303550455, 16488.0, 16847.209377889998, 17126.657466850593, 17508.649827003515, 1843.373253093941, 1892.5174080609495, 1893.725409815583, 1894.725264836591, 1919.8560107991957, 153861.2306938458, 163997.3600263994, 164463.0, 164592.9999999988, 165371.0, 11919.284842909454, 11993.64019079429, 12014.579489717818, 12079.57721479744, 12239.449224784728, 16507.174641267888, 16509.83490165107, 16517.752233716503, 16526.504204873872, 16577.50267491977, 7769.0, 8613.870791938127, 8853.203211710977, 8854.38019338653, 8954.417962832395, 8364.414490985573, 8378.204070613281, 8382.87425688615, 8528.573571321533, 8531.402801803813, 7599.278068583476, 7729.1884352142215, 7810.570418626917, 7896.32881205104, 7923.7226697065325, 2122.4799924018407, 2141.5609799990966, 2144.860584062062, 2149.065156656828, 2328.2316835444262, 917.5779141594808, 937.5593471068587, 939.1031564855547, 948.3645957208687, 958.3579002068631, 19040.80959190418, 19899.502512437306, 21382.251621193183, 21422.250221242182, 21434.0, 878.3939082033377, 913.5112714697605, 954.346272803132, 996.257787947969, 1005.1305620638095, 10621.309614875008, 10813.405262710468, 10911.345319280868, 10942.890571094347, 10958.0, 673576.0, 683947.1605283984, 693641.0, 705977.0, 718117.0, 144848.0, 165604.17197914174, 165785.0, 166163.16918415332, 169695.0, 1114.1365441782684, 1126.2285334545863, 1148.3741360958297, 1154.4631746237872, 1155.6995181252935, 17773.20020599102, 18363.17365718519, 18440.723389149443, 18445.72331415003, 18868.905655471634, 60711.48221294503, 61182.08226876689, 61875.6906215466, 61908.69045654923, 62486.37513624987, 86604.1339586596, 86717.56641216754, 89851.20297594143, 90076.0, 91529.54235228781, 8481.194286542768, 8712.0, 8750.256228220673, 8810.339224558056, 9025.05236950137, 13548.79676804829, 13806.240656763974, 14096.154230746188, 14269.286535673382, 14297.428102875769, 10605.363678179334, 10640.733981650212, 11138.053265472525, 11719.924765387947, 11932.98569621592, 8328.458650187718, 10738.463076846283, 10839.970202830718, 11188.496517656562, 11208.383538905113, 10446.582136714447, 11818.586349477728, 12071.456784444897, 12158.0, 12203.0, 8475.957620211859, 8572.699955501528, 8630.56847157627, 8920.330975176757, 8972.775680608038, 11402.030827379765, 11737.0, 11904.0, 11953.641390758292, 12082.033437324817], "value": 10504.937990364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.0800129899333, 1369.4659082957646, 1426.2797287369876, 1458.249001764091, 1463.5975106845617, 9095.90904090959, 9524.571394287264, 10713.785724285519, 11018.50416731247, 11042.447877606128, 10713.196510261723, 10845.566177352897, 10853.34879907206, 10855.348679079261, 10867.673969780919, 2414.855108693484, 2462.335169504233, 2467.494163696447, 2469.0, 2469.4196863737097, 2072.7409073865765, 2158.384860314811, 2395.2454976682375, 2482.9255122346267, 2488.415222422729, 2424.59994100974, 2455.5211733711935, 2456.3736247256925, 2460.8277420580475, 2463.5935070713313, 2423.503181847726, 2434.342727463593, 2450.644656524794, 2452.276578409356, 2454.631805229212, 1884.510027392874, 2399.2322456813827, 2416.613341865293, 2421.176799888029, 2453.7178224504232, 10802.297850639683, 10928.125749939985, 10954.452277386099, 10956.068734157607, 10964.287321324167, 6043.546733994968, 6287.52843536732, 6299.464545513637, 6314.305426403092, 6315.115883776275, 3364.175776934667, 3694.9630503695157, 3941.1526521797664, 4019.3569028955226, 4027.0939038716347, 1098.9230753847235, 1153.8038533449335, 1161.5179700424399, 1194.3908606610692, 1206.3485717712424, 15043.774343384748, 15265.160416177107, 15265.465708700141, 15276.236188190545, 15278.083315001135, 4813.9037219256115, 5414.8917021659345, 5634.577406694432, 5643.5203007743985, 5654.434556544313, 12336.198147120409, 12590.496380144876, 12613.243205407705, 12622.30577318238, 12624.495020199089, 5386.757595908115, 6343.873122537523, 6358.427741503287, 6364.586301890362, 6375.840603984845, 5596.608237423423, 5787.0, 5794.217780599565, 5835.241418615553, 5845.035569131046, 3984.880453586397, 4093.7543747375253, 4096.40602112698, 4382.276924307517, 4439.511653718088, 1340.4102195034154, 1364.5633397312963, 1391.6660001599746, 1401.9719605607831, 1417.9007469477037, 765.1124695353475, 767.1293082351459, 787.2875048081495, 794.7019867549669, 802.1457148137215, 5762.88474230513, 6300.621962682162, 6566.901496477557, 6583.835404114935, 6652.334766523406, 796.956167410798, 871.54679566625, 873.1268731268731, 890.7262614461382, 907.1699395053453, 3785.6782173515007, 4043.0700938784244, 4155.97922010388, 4173.248815213291, 4313.180495705868, 13402.0, 13750.243736594382, 13841.584752457442, 13872.028957972845, 13892.16647001183, 13193.142445740996, 13753.174809511462, 13786.862131378557, 13938.721225575431, 13956.302184890716, 9937.65218217359, 10231.744206394751, 10233.795324093477, 10239.334443261165, 10248.795024099476, 5845.413755496551, 6510.641914694737, 6669.266380698023, 6870.3473170048765, 6902.827429314308, 12095.032397408362, 12458.127931045103, 12493.25040497573, 12511.874881251071, 12530.686732831753, 12455.93772031134, 12571.245725256515, 12841.550545730855, 12851.871481285067, 12871.485140594272, 8673.34949878749, 9050.185483306534, 9079.727608171765, 9213.309001824757, 9243.352965292364, 8891.377603567687, 9206.12541808554, 9208.940971788063, 10070.345427547187, 10247.487625618838, 8348.833023339621, 8537.359698022798, 8582.613782379933, 8650.78373040679, 8728.69449569262, 8319.084900661044, 8417.326613870999, 8493.87259191125, 8538.743837684879, 8633.30933525329, 7783.844323113619, 7792.103908050647, 7806.4925779824125, 7905.486143400661, 7924.6433910473015, 5835.212246346859, 5918.911216331845, 5949.167116603766, 6079.392060794062, 6219.595726277777, 5513.842093160481, 5593.552515798645, 5950.910736338872, 6130.693465326805, 6407.0709747085475], "value": 5170.831474821031, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.93613617616916, 393.0664671405412, 397.98116820938384, 399.30520893645064, 400.0877998164185, 4841.8305359312435, 5704.60067795254, 5858.355580886099, 5885.7939972100985, 5891.793787217438, 5236.188390799422, 5761.251037365137, 5781.335146458158, 5831.3293971193325, 5839.503642190408, 4459.576340247671, 4476.798544065517, 4482.305242687373, 4497.550244975492, 4507.233770259048, 4489.842855500058, 4495.842645507408, 4505.752183629899, 4521.163584736818, 4543.250363689987, 2850.50116229659, 4259.787010649455, 4291.613754762071, 4324.243257429953, 4447.710898791584, 3746.6066063063395, 4235.301175306071, 4242.851500197494, 4251.383549385353, 4265.253580623378, 3089.7373723233554, 3694.390425579776, 3703.8148092595534, 3711.5175027246287, 3725.832337544817, 5488.9725551371985, 5661.782716715926, 5699.722659470821, 5720.942790572082, 5730.541556675497, 3998.9200215995515, 5025.522575355335, 5074.619403544712, 5083.517065878736, 5112.616553758483, 6105.870413973429, 6166.691665416756, 6167.687117331001, 6186.907196392058, 6209.5032397408095, 3434.793912365241, 4058.857939972116, 4171.455412198557, 4199.496060472732, 4225.091605304874, 5501.972490137524, 5668.696199874011, 6180.474659653934, 6517.837054073639, 6578.868422631521, 3723.3670276053135, 4106.7946602669745, 4124.65948566711, 4159.0, 4268.765217913045, 4337.631301339358, 4344.218040752695, 4349.869503914888, 4361.956380436219, 4362.967737422461, 4183.832646694098, 4981.103401387785, 5008.223725322581, 5060.773259765691, 5107.233914912793, 6189.164462797555, 6197.566170368121, 6209.2548894133, 6237.937620623827, 6260.812175634738, 1461.5615315405548, 1468.7796830475513, 1483.428879881232, 1483.8367779544242, 1486.3311509820408, 920.7288274627703, 980.1374790184734, 982.4400091947664, 987.980240395188, 993.1210878372692, 5412.3505179377935, 5507.256520369779, 5864.560157988082, 5919.4968427684125, 5929.762809487572, 6395.488360931115, 6435.163428754232, 6468.708908099053, 6478.578892371981, 6479.481641468671, 5569.387367389584, 5882.470577648032, 5897.7935772247765, 5951.0, 5968.194293770285, 2945.9705402946124, 3306.231166326052, 3345.8661653534073, 3358.966410335914, 3378.847951842173, 5761.942380576224, 6224.221972253468, 6487.902681459782, 6576.309487503743, 6613.140291762136, 5404.513593776579, 5602.310890772452, 6464.838379040561, 6519.380658837497, 6626.9337306627285, 6187.876242475215, 6496.252930912911, 6572.539922205496, 6589.308122647149, 6592.274849766618, 5547.694876781816, 6358.046293056079, 6359.8092057238355, 6405.8718825624155, 6410.423061924263, 5273.31446911899, 6044.637321760709, 6265.843353916189, 6278.4035516625845, 6282.434580887742, 5531.640443371168, 5756.395578464369, 5835.416458354131, 6219.0, 6559.409653131241, 3725.1990821973404, 4243.265925985113, 4604.815807367801, 4653.60444362233, 4689.80409995449, 5031.679091799395, 5394.757235924314, 5604.579656525695, 6468.902966455413, 6472.223333200046, 5437.592180586551, 6183.96908015457, 6216.409441103088, 6217.844553886189, 6229.283632382334, 5453.64551304164, 5986.910196347146, 6229.781957631461, 6235.688215589294, 6318.652474113968, 4841.782119804547, 5219.530242278213, 5814.527921590352, 5862.794802181903, 6108.938910610837, 6242.438180563771, 6242.687865606611, 6249.718762655601, 6255.093011513396, 6290.402411770874, 4894.755262236945, 5459.45595143599, 5696.202531645656, 5785.537157027512, 6189.907151392643], "value": 4509.5315631022395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.7212862404854, 736.8231624410143, 741.6772857597957, 752.2966026764975, 770.7841804294796, 15714.607134821636, 16387.672246555063, 16438.424655137074, 16530.33878644854, 16540.172991350446, 15229.543113706579, 15669.373225070984, 15670.84329156708, 15694.136822474788, 15697.607559811011, 960.8078384323128, 983.8475036369374, 988.3921388346188, 990.692885205585, 992.8560358747977, 998.2862253488754, 1009.7273736091252, 1010.5200029985734, 1012.2559918459926, 1015.4364327798069, 1036.6371769880557, 1071.2661826648732, 1073.2219141122703, 1076.0, 1088.3633074651339, 1077.5959015369237, 1092.0771947704177, 1092.1153865368997, 1094.108301734084, 1095.1239008793013, 796.5539297993084, 796.5817945578559, 797.2306724011357, 797.3222760653456, 799.9880001799978, 16301.91849040759, 16783.916080419644, 16841.915790420968, 16988.830111698848, 17340.47978560645, 13786.793198102036, 13951.372188251553, 14894.70210595793, 14936.0, 14981.0, 11583.131265155147, 12038.69903252417, 12248.326342051183, 12259.325737084457, 12391.814122788166, 3028.258076771205, 3169.873205071817, 3185.490321548564, 3187.553742476055, 3192.4413227685295, 107267.0, 112095.0, 112287.0, 116713.0, 116838.41580792126, 10841.186910981707, 11522.539098436137, 11615.303081815118, 11619.941900290614, 11979.161458697981, 24349.513009739705, 25122.623160652605, 25140.622890656654, 25309.367265818135, 25349.873250633627, 7801.648925798353, 7811.765647030598, 8024.956755621732, 8131.186881311822, 8221.465604735673, 4090.8159132839096, 4118.114605359862, 4209.936850947238, 4272.615464608138, 4345.391645169679, 3735.589085200626, 4119.299719047769, 4122.690798190148, 4220.324748040299, 4227.915441691211, 716.935351003759, 819.512390127873, 825.6129702100409, 847.0724556610502, 868.8132051608934, 480.4042986696471, 545.1958361416879, 550.1280470454295, 556.449115375775, 588.9352171261157, 8533.53065581399, 8545.529995850287, 9881.654142104991, 9938.751531211778, 10233.43716095607, 514.143950322716, 527.9889012540941, 560.2772423573626, 562.2858969109209, 563.3408911573468, 4116.4648595682365, 4385.473743150778, 4518.525554816697, 4519.819207231674, 4605.171069207575, 75886.62056689791, 95776.0, 97439.51280243554, 100310.4984475073, 102946.48526757318, 89650.0, 91162.0, 91520.0, 92015.5399223013, 92355.0, 80508.99999999882, 80602.5969870147, 81340.0, 81786.18213817905, 81873.59063204765, 8248.83502329938, 8793.29653627721, 9164.587593558439, 9253.629854806002, 9320.95339523298, 32032.83983580067, 39610.2077958445, 40614.59385406108, 41003.38494922519, 41574.168516628895, 50768.11557977265, 51693.0, 52025.7398713004, 52493.68765780886, 53165.0, 9978.550965206729, 11368.317900925971, 11490.533733654318, 11592.594259201225, 11708.356040417859, 11057.809416337914, 11818.704532386759, 11915.642530724092, 11937.940310298392, 12103.273803571814, 9760.46317452547, 11059.115270778479, 11537.0, 11711.238769479956, 11980.221285616408, 11278.49246783913, 11545.82681259765, 11636.010939069934, 11960.10299227544, 12265.080118990933, 11326.01915239207, 11426.542938282375, 11469.139814513777, 11653.859404724686, 11684.18210725241, 8720.869186962074, 8758.91241087581, 8797.648094076165, 8834.160754728548, 8848.823023539622, 8140.348772098337, 8987.735403139643, 9827.115559599384, 10288.228382871164, 11359.807220241755], "value": 7356.929501364276, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1625.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 123.0, 124.0, 124.0, 124.0, 123.0, 123.0, 123.0, 123.0], "value": 121.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 117.0, 164.0, 120.0, 119.0, 118.0, 118.0, 153.0, 101.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 216.0, 210.0, 214.0, 213.0, 210.0, 217.0, 215.0, 210.0, 211.0], "value": 212.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 63.0, 64.0, 95.0, 64.0, 65.0, 51.0, 57.0, 96.0, 93.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 79.0, 100.0, 94.0, 106.0, 112.0, 130.0, 82.0, 75.0, 92.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 81.0, 125.0, 107.0, 93.0, 91.0, 96.0, 130.0, 137.0, 90.0], "value": 104.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 101.0, 102.0, 99.0, 100.0, 100.0, 101.0, 100.0, 101.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 102.0, 127.0, 156.0, 101.0, 102.0, 100.0, 101.0, 99.0], "value": 109.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 61.0, 70.0, 76.0, 82.0, 75.0, 51.0, 51.0, 49.0, 50.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 67.0, 68.0, 69.0, 85.0, 92.0, 91.0, 87.0, 66.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 89.0, 94.0, 89.0, 91.0, 91.0, 102.0, 115.0, 117.0], "value": 96.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 160.0, 141.0, 166.0, 171.0, 173.0, 145.0, 227.0, 182.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 200.0, 202.0, 202.0, 198.0, 203.0, 204.0, 242.0, 195.0, 199.0], "value": 204.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 73.0, 73.0, 72.0, 72.0, 72.0, 74.0, 73.0], "value": 72.8, "unit": "score"}]}]} 09:16:53 INFO - Return code: 0 09:16:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:54 ERROR - # TBPL SUCCESS # 09:16:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:54 INFO - 2017-04-01 09:16:54.048 screenresolution[1660:9885] starting screenresolution argv=screenresolution get 09:16:54 INFO - 2017-04-01 09:16:54.051 screenresolution[1660:9885] Display 0: 1600x1200x32@60 09:16:54 INFO - 2017-04-01 09:16:54.057 screenresolution[1661:9888] starting screenresolution argv=screenresolution list 09:16:54 INFO - Available Modes on Display 0 09:16:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:54 INFO - Intel Iris: 09:16:54 INFO - Chipset Model: Intel Iris 09:16:54 INFO - Type: GPU 09:16:54 INFO - Bus: Built-In 09:16:54 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:54 INFO - Vendor: Intel (0x8086) 09:16:54 INFO - Device ID: 0x0a2e 09:16:54 INFO - Revision ID: 0x0009 09:16:54 INFO - Displays: 09:16:54 INFO - Display: 09:16:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:54 INFO - Display Serial Number: 1600x1200 60 09:16:54 INFO - Main Display: Yes 09:16:54 INFO - Mirror: Off 09:16:54 INFO - Online: Yes 09:16:54 INFO - Rotation: Supported 09:16:54 INFO - Return code: 0 09:16:54 INFO - Running post-action listener: _resource_record_post_action 09:16:54 INFO - [mozharness: 2017-04-01 16:16:54.294280Z] Finished run-tests step (success) 09:16:54 INFO - Running post-run listener: _resource_record_post_run 09:16:54 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 36275200; Write bytes: 512881152; Read time: 372; Write time: 1526 09:16:54 INFO - TinderboxPrint: CPU usage
53.5% 09:16:54 INFO - TinderboxPrint: I/O read bytes / time
36,275,200 / 372 09:16:54 INFO - TinderboxPrint: I/O write bytes / time
512,881,152 / 1,526 09:16:54 INFO - TinderboxPrint: CPU idle
2,243.2 (46.5%) 09:16:54 INFO - TinderboxPrint: CPU system
961.5 (19.9%) 09:16:54 INFO - TinderboxPrint: CPU user
1,621.0 (33.6%) 09:16:54 INFO - TinderboxPrint: Swap in / out
247,844,864 / 0 09:16:54 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205226496; Write bytes: 203929088; Read time: 15582; Write time: 413 09:16:54 INFO - run-tests - Wall time: 1186s; CPU: 54.0%; Read bytes: 35320832; Write bytes: 299006976; Read time: 356; Write time: 1085 09:16:54 INFO - Running post-run listener: _upload_blobber_files 09:16:54 INFO - Blob upload gear active. 09:16:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:54 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:16:54 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:16:54 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:16:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:56 INFO - (blobuploader) - INFO - Done attempting. 09:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:56 INFO - (blobuploader) - INFO - Done attempting. 09:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:16:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:57 INFO - (blobuploader) - INFO - Done attempting. 09:16:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:16:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:00 INFO - (blobuploader) - INFO - Done attempting. 09:17:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:00 INFO - Return code: 0 09:17:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2eb469b96f8a5965692643947c9028c18a904407130a5e29b75fdf760164d75a71a5d1c618708212c3336123a267e56500e18259028da3e32f174e85f68de4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b6a6d635bd3f04febc589ec57cf7425001e289485360be1651f6cb807abc3c2bd59e765a37dc709d0d77e25827ee6b662787f7fcfc7baf6c7f2a4c61acafa87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b00284294e82cd2a0aa4f5e0ea01b2048902ae2ad437d6193c2dc51cf800bffa0715d3d7411751f01622680d76506c4e4795e1ae7c6e665738586c1a3bf020cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3ff86bb2e35b3618239533fa010fe7adb159b785dc7009d6c1805a7a2311d844ff261458701d4fae880fd2e54e4e21a9917707245cbd99cbce7d562abd228ff"} 09:17:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:00 INFO - Contents: 09:17:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2eb469b96f8a5965692643947c9028c18a904407130a5e29b75fdf760164d75a71a5d1c618708212c3336123a267e56500e18259028da3e32f174e85f68de4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b6a6d635bd3f04febc589ec57cf7425001e289485360be1651f6cb807abc3c2bd59e765a37dc709d0d77e25827ee6b662787f7fcfc7baf6c7f2a4c61acafa87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b00284294e82cd2a0aa4f5e0ea01b2048902ae2ad437d6193c2dc51cf800bffa0715d3d7411751f01622680d76506c4e4795e1ae7c6e665738586c1a3bf020cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3ff86bb2e35b3618239533fa010fe7adb159b785dc7009d6c1805a7a2311d844ff261458701d4fae880fd2e54e4e21a9917707245cbd99cbce7d562abd228ff"} 09:17:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:00 INFO - Copying logs to upload dir... 09:17:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.423121 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-01 09:17:00.108718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 09:17:00.112850) ========= 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.YccCqJP7LV/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.4KKiyZRbrR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/Firefox/sha512/e2eb469b96f8a5965692643947c9028c18a904407130a5e29b75fdf760164d75a71a5d1c618708212c3336123a267e56500e18259028da3e32f174e85f68de4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b6a6d635bd3f04febc589ec57cf7425001e289485360be1651f6cb807abc3c2bd59e765a37dc709d0d77e25827ee6b662787f7fcfc7baf6c7f2a4c61acafa87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b00284294e82cd2a0aa4f5e0ea01b2048902ae2ad437d6193c2dc51cf800bffa0715d3d7411751f01622680d76506c4e4795e1ae7c6e665738586c1a3bf020cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3ff86bb2e35b3618239533fa010fe7adb159b785dc7009d6c1805a7a2311d844ff261458701d4fae880fd2e54e4e21a9917707245cbd99cbce7d562abd228ff"} build_url:https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/Fp17yHx1SHCUnA17n9yIWw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2eb469b96f8a5965692643947c9028c18a904407130a5e29b75fdf760164d75a71a5d1c618708212c3336123a267e56500e18259028da3e32f174e85f68de4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b6a6d635bd3f04febc589ec57cf7425001e289485360be1651f6cb807abc3c2bd59e765a37dc709d0d77e25827ee6b662787f7fcfc7baf6c7f2a4c61acafa87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b00284294e82cd2a0aa4f5e0ea01b2048902ae2ad437d6193c2dc51cf800bffa0715d3d7411751f01622680d76506c4e4795e1ae7c6e665738586c1a3bf020cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3ff86bb2e35b3618239533fa010fe7adb159b785dc7009d6c1805a7a2311d844ff261458701d4fae880fd2e54e4e21a9917707245cbd99cbce7d562abd228ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 09:17:00.147444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 09:17:00.148013) ========= 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.YccCqJP7LV/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.4KKiyZRbrR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005213 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 09:17:00.199085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 09:17:00.199622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 09:17:00.200191) ========= ========= Total master_lag: 0.18 =========