builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0215 starttime: 1488136952.91 results: success (0) buildid: 20170226102410 builduid: 62440b47ee7f4047bf076da0fb92d16e revision: aa2b14b08dbb728ab6b9868e43a66842626f1833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:32.909924) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:32.910321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:32.910866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:33.031737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:33.032235) ========= 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.KmZCqNbr9z/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.asYLlMeRdV/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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-02-26 11:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.09M=0.001s 2017-02-26 11:22:33 (8.09 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169794 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:33.228284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:33.228839) ========= 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.KmZCqNbr9z/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.asYLlMeRdV/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.021242 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:33.279137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-26 11:22:33.279451) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aa2b14b08dbb728ab6b9868e43a66842626f1833 --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 aa2b14b08dbb728ab6b9868e43a66842626f1833 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KmZCqNbr9z/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.asYLlMeRdV/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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-02-26 11:22:33,341 truncating revision to first 12 chars 2017-02-26 11:22:33,341 Setting DEBUG logging. 2017-02-26 11:22:33,342 attempt 1/10 2017-02-26 11:22:33,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aa2b14b08dbb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-26 11:22:34,293 unpacking tar archive at: mozilla-central-aa2b14b08dbb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.209418 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-26 11:22:34.515011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:34.515409) ========= script_repo_revision: aa2b14b08dbb728ab6b9868e43a66842626f1833 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:34.515864) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:34.516198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 11:22:34.537274) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-26 11:22:34.537785) ========= /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.KmZCqNbr9z/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.asYLlMeRdV/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:22:34 INFO - MultiFileLogger online at 20170226 11:22:34 in /builds/slave/test 11:22:34 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 11:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:34 INFO - {'append_to_log': False, 11:22:34 INFO - 'base_work_dir': '/builds/slave/test', 11:22:34 INFO - 'blob_upload_branch': 'Firefox', 11:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:34 INFO - 'branch': 'Firefox', 11:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:34 INFO - 'config_files': ('talos/mac_config.py',), 11:22:34 INFO - 'default_actions': ('clobber', 11:22:34 INFO - 'read-buildbot-config', 11:22:34 INFO - 'download-and-extract', 11:22:34 INFO - 'populate-webroot', 11:22:34 INFO - 'create-virtualenv', 11:22:34 INFO - 'install', 11:22:34 INFO - 'run-tests'), 11:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:34 INFO - 'download_minidump_stackwalk': True, 11:22:34 INFO - 'download_symbols': 'ondemand', 11:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:34 INFO - 'gecko_profile': False, 11:22:34 INFO - 'gecko_profile_interval': 0, 11:22:34 INFO - 'installer_path': 'installer.exe', 11:22:34 INFO - 'log_level': 'info', 11:22:34 INFO - 'log_name': 'talos', 11:22:34 INFO - 'log_to_console': True, 11:22:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:22:34 INFO - 'opt_config_files': (), 11:22:34 INFO - 'pip_index': False, 11:22:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:22:34 INFO - 'cmd': ('bash', 11:22:34 INFO - '-c', 11:22:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:22:34 INFO - 'enabled': True, 11:22:34 INFO - 'halt_on_failure': False, 11:22:34 INFO - 'name': 'check_screen_resolution'},), 11:22:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:22:34 INFO - 'cmd': ('bash', 11:22:34 INFO - '-c', 11:22:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:22:34 INFO - 'enabled': True, 11:22:34 INFO - 'halt_on_failure': False, 11:22:34 INFO - 'name': 'check_screen_resolution'},), 11:22:34 INFO - 'run_cmd_checks_enabled': True, 11:22:34 INFO - 'suite': 'dromaeojs', 11:22:34 INFO - 'system_bits': '32', 11:22:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:34 INFO - 'title': 't-yosemite-r7-0215', 11:22:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:34 INFO - 'use_talos_json': True, 11:22:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:34 INFO - 'work_dir': 'build'} 11:22:34 INFO - [mozharness: 2017-02-26 19:22:34.719313Z] Running clobber step. 11:22:34 INFO - Running pre-action listener: _resource_record_pre_action 11:22:34 INFO - Running main action method: clobber 11:22:34 INFO - rmtree: /builds/slave/test/build 11:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:36 INFO - Running post-action listener: _resource_record_post_action 11:22:36 INFO - [mozharness: 2017-02-26 19:22:36.699485Z] Finished clobber step (success) 11:22:36 INFO - [mozharness: 2017-02-26 19:22:36.699614Z] Running read-buildbot-config step. 11:22:36 INFO - Running pre-action listener: _resource_record_pre_action 11:22:36 INFO - Running main action method: read_buildbot_config 11:22:36 INFO - Using buildbot properties: 11:22:36 INFO - { 11:22:36 INFO - "project": "", 11:22:36 INFO - "product": "firefox", 11:22:36 INFO - "script_repo_revision": "production", 11:22:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 11:22:36 INFO - "repository": "", 11:22:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 11:22:36 INFO - "buildid": "20170226102410", 11:22:36 INFO - "pgo_build": "False", 11:22:36 INFO - "basedir": "/builds/slave/test", 11:22:36 INFO - "buildnumber": 26, 11:22:36 INFO - "slavename": "t-yosemite-r7-0215", 11:22:36 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:22:36 INFO - "platform": "yosemite_r7", 11:22:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:22:36 INFO - "branch": "mozilla-central", 11:22:36 INFO - "repo_path": "mozilla-central", 11:22:36 INFO - "revision": "aa2b14b08dbb728ab6b9868e43a66842626f1833", 11:22:36 INFO - "stage_platform": "macosx64", 11:22:36 INFO - "builduid": "62440b47ee7f4047bf076da0fb92d16e", 11:22:36 INFO - "slavebuilddir": "test" 11:22:36 INFO - } 11:22:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 11:22:36 INFO - Running post-action listener: _resource_record_post_action 11:22:36 INFO - [mozharness: 2017-02-26 19:22:36.702925Z] Finished read-buildbot-config step (success) 11:22:36 INFO - [mozharness: 2017-02-26 19:22:36.703019Z] Running download-and-extract step. 11:22:36 INFO - Running pre-action listener: _resource_record_pre_action 11:22:36 INFO - Running main action method: download_and_extract 11:22:36 INFO - mkdir: /builds/slave/test/build/tests 11:22:36 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')]} 11:22:36 INFO - trying https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 11:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 11:22:38 INFO - Downloaded 1199 bytes. 11:22:38 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:22:38 INFO - Using the following test package requirements: 11:22:38 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:22:38 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 11:22:38 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 11:22:38 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'jsshell-mac.zip'], 11:22:38 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 11:22:38 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:22:38 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 11:22:38 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 11:22:38 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 11:22:38 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:22:38 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 11:22:38 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:22:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:22:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:22:38 INFO - Fetch https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:22:39 INFO - Expected file size: 51745871 11:22:39 INFO - Obtained file size: 51745871 11:22:55 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:22:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:22:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:22:55 INFO - Fetch https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:22:57 INFO - Expected file size: 51745871 11:22:57 INFO - Obtained file size: 51745871 11:23:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 11:23:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:23:12 INFO - Fetch https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 11:23:14 INFO - Expected file size: 14404421 11:23:14 INFO - Obtained file size: 14404421 11:23:14 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')]} 11:23:14 INFO - trying https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:23:14 INFO - Downloading https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 11:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 11:23:16 INFO - Downloaded 74908668 bytes. 11:23:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:23:16 INFO - mkdir: /builds/slave/test/properties 11:23:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:23:16 INFO - Writing to file /builds/slave/test/properties/build_url 11:23:16 INFO - Contents: 11:23:16 INFO - build_url:https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:23:17 INFO - Running post-action listener: _resource_record_post_action 11:23:17 INFO - Running post-action listener: set_extra_try_arguments 11:23:17 INFO - [mozharness: 2017-02-26 19:23:17.369211Z] Finished download-and-extract step (success) 11:23:17 INFO - [mozharness: 2017-02-26 19:23:17.369356Z] Running populate-webroot step. 11:23:17 INFO - Running pre-action listener: _resource_record_pre_action 11:23:17 INFO - Running main action method: populate_webroot 11:23:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:23:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:23:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:23:17 INFO - '--tppagecycles', 11:23:17 INFO - '7'], 11:23:17 INFO - 'tests': ['tsvgm']}}, 11:23:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:23:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:23:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:23:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:23:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:23:17 INFO - 'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:23:17 INFO - 'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['damp', 'tps']}, 11:23:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:23:17 INFO - 'tests': ['damp', 'tps']}, 11:23:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['dromaeo_dom']}, 11:23:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:23:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['basic_compositor_video']}, 11:23:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:23:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['a11yr', 11:23:17 INFO - 'ts_paint', 11:23:17 INFO - 'tpaint', 11:23:17 INFO - 'sessionrestore', 11:23:17 INFO - 'sessionrestore_no_auto_restore', 11:23:17 INFO - 'tabpaint']}, 11:23:17 INFO - 'other-e10s': {'tests': ['a11yr', 11:23:17 INFO - 'ts_paint', 11:23:17 INFO - 'tpaint', 11:23:17 INFO - 'sessionrestore', 11:23:17 INFO - 'sessionrestore_no_auto_restore', 11:23:17 INFO - 'tabpaint']}, 11:23:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:23:17 INFO - 'ts_paint', 11:23:17 INFO - 'tpaint', 11:23:17 INFO - 'sessionrestore', 11:23:17 INFO - 'sessionrestore_no_auto_restore', 11:23:17 INFO - 'tabpaint']}, 11:23:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:23:17 INFO - 'ts_paint', 11:23:17 INFO - 'tpaint', 11:23:17 INFO - 'sessionrestore', 11:23:17 INFO - 'sessionrestore_no_auto_restore', 11:23:17 INFO - 'tabpaint']}, 11:23:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['a11yr', 11:23:17 INFO - 'ts_paint', 11:23:17 INFO - 'tpaint', 11:23:17 INFO - 'sessionrestore', 11:23:17 INFO - 'sessionrestore_no_auto_restore', 11:23:17 INFO - 'tabpaint']}, 11:23:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['a11yr', 11:23:17 INFO - 'ts_paint', 11:23:17 INFO - 'tpaint', 11:23:17 INFO - 'sessionrestore', 11:23:17 INFO - 'sessionrestore_no_auto_restore', 11:23:17 INFO - 'tabpaint']}, 11:23:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['tsvgx', 11:23:17 INFO - 'tsvgr_opacity', 11:23:17 INFO - 'tart', 11:23:17 INFO - 'tscrollx', 11:23:17 INFO - 'cart', 11:23:17 INFO - 'tsvg_static']}, 11:23:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:23:17 INFO - 'tsvgr_opacity', 11:23:17 INFO - 'tart', 11:23:17 INFO - 'tscrollx', 11:23:17 INFO - 'cart', 11:23:17 INFO - 'tsvg_static']}, 11:23:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:23:17 INFO - 'talos_options': ['--disable-e10s'], 11:23:17 INFO - 'tests': ['tp5o']}, 11:23:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:23:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:23:17 INFO - 'talos_options': ['--disable-e10s', 11:23:17 INFO - '--xperf_path', 11:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:17 INFO - 'tests': ['tp5n']}, 11:23:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:23:17 INFO - 'talos_options': ['--xperf_path', 11:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:17 INFO - 'tests': ['tp5n']}}, 11:23:17 INFO - 'talos.zip': {'path': '', 11:23:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:23:17 INFO - Running post-action listener: _resource_record_post_action 11:23:17 INFO - [mozharness: 2017-02-26 19:23:17.387961Z] Finished populate-webroot step (success) 11:23:17 INFO - [mozharness: 2017-02-26 19:23:17.388094Z] Running create-virtualenv step. 11:23:17 INFO - Running pre-action listener: _resource_record_pre_action 11:23:17 INFO - Running main action method: create_virtualenv 11:23:17 INFO - Creating virtualenv /builds/slave/test/build/venv 11:23:17 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 11:23:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:23:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:23:17 INFO - Using real prefix '/tools/python27' 11:23:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:23:18 INFO - Installing distribute.............................................................................................................................................................................................done. 11:23:21 INFO - Installing pip.................done. 11:23:21 INFO - Return code: 0 11:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:23:21 INFO - Reading from file tmpfile_stdout 11:23:21 INFO - Output received: 11:23:21 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) 11:23:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:21 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:21 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 11:23:21 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 11:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:21 INFO - 'HOME': '/Users/cltbld', 11:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:21 INFO - 'LOGNAME': 'cltbld', 11:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:21 INFO - 'MOZ_NO_REMOTE': '1', 11:23:21 INFO - 'NO_EM_RESTART': '1', 11:23:21 INFO - 'PAGER': '/bin/cat', 11:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:21 INFO - 'PWD': '/builds/slave/test', 11:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:21 INFO - 'SHELL': '/bin/bash', 11:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:21 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:21 INFO - 'USER': 'cltbld', 11:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:21 INFO - 'XPC_FLAGS': '0x0', 11:23:21 INFO - 'XPC_SERVICE_NAME': '0', 11:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:21 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 11:23:21 INFO - Cleaning up... 11:23:21 INFO - Return code: 0 11:23:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:21 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:21 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 11:23:21 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 11:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:21 INFO - 'HOME': '/Users/cltbld', 11:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:21 INFO - 'LOGNAME': 'cltbld', 11:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:21 INFO - 'MOZ_NO_REMOTE': '1', 11:23:21 INFO - 'NO_EM_RESTART': '1', 11:23:21 INFO - 'PAGER': '/bin/cat', 11:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:21 INFO - 'PWD': '/builds/slave/test', 11:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:21 INFO - 'SHELL': '/bin/bash', 11:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:21 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:21 INFO - 'USER': 'cltbld', 11:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:21 INFO - 'XPC_FLAGS': '0x0', 11:23:21 INFO - 'XPC_SERVICE_NAME': '0', 11:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:21 INFO - Downloading/unpacking psutil>=3.1.1 11:23:21 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 11:23:21 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 11:23:21 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 11:23:21 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 11:23:21 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 11:23:21 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 11:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:23:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:25 INFO - Installing collected packages: psutil 11:23:25 INFO - Running setup.py install for psutil 11:23:26 INFO - building 'psutil._psutil_osx' extension 11:23:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:23:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:23:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:23:26 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 11:23:26 INFO - building 'psutil._psutil_posix' extension 11:23:26 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 11:23:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:23:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:23:26 INFO - ^ 11:23:26 INFO - 1 warning generated. 11:23:26 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 11:23:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:26 INFO - Successfully installed psutil 11:23:26 INFO - Cleaning up... 11:23:26 INFO - Return code: 0 11:23:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:23:26 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')]} 11:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:26 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')]} 11:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:26 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:26 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 11:23:26 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 11:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:26 INFO - 'HOME': '/Users/cltbld', 11:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:26 INFO - 'LOGNAME': 'cltbld', 11:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:26 INFO - 'MOZ_NO_REMOTE': '1', 11:23:26 INFO - 'NO_EM_RESTART': '1', 11:23:26 INFO - 'PAGER': '/bin/cat', 11:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:26 INFO - 'PWD': '/builds/slave/test', 11:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:26 INFO - 'SHELL': '/bin/bash', 11:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:26 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:26 INFO - 'USER': 'cltbld', 11:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:26 INFO - 'XPC_FLAGS': '0x0', 11:23:26 INFO - 'XPC_SERVICE_NAME': '0', 11:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:23:27 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 11:23:27 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 11:23:27 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 11:23:27 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 11:23:27 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 11:23:27 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 11:23:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:23:29 INFO - Installing collected packages: mozsystemmonitor 11:23:29 INFO - Running setup.py install for mozsystemmonitor 11:23:29 INFO - Successfully installed mozsystemmonitor 11:23:29 INFO - Cleaning up... 11:23:30 INFO - Return code: 0 11:23:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:30 INFO - 'HOME': '/Users/cltbld', 11:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:30 INFO - 'LOGNAME': 'cltbld', 11:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:30 INFO - 'MOZ_NO_REMOTE': '1', 11:23:30 INFO - 'NO_EM_RESTART': '1', 11:23:30 INFO - 'PAGER': '/bin/cat', 11:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:30 INFO - 'PWD': '/builds/slave/test', 11:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:30 INFO - 'SHELL': '/bin/bash', 11:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:30 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:30 INFO - 'USER': 'cltbld', 11:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:30 INFO - 'XPC_FLAGS': '0x0', 11:23:30 INFO - 'XPC_SERVICE_NAME': '0', 11:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:30 INFO - Downloading/unpacking jsonschema==2.5.1 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:23:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:23:33 INFO - warning: no files found matching '*.txt' 11:23:33 INFO - no previously-included directories found matching 'build' 11:23:33 INFO - no previously-included directories found matching 'dist' 11:23:33 INFO - no previously-included directories found matching '.git*' 11:23:33 INFO - Installing collected packages: jsonschema, functools32 11:23:33 INFO - Running setup.py install for functools32 11:23:33 INFO - warning: no files found matching '*.txt' 11:23:33 INFO - no previously-included directories found matching 'build' 11:23:33 INFO - no previously-included directories found matching 'dist' 11:23:33 INFO - no previously-included directories found matching '.git*' 11:23:33 INFO - Successfully installed jsonschema functools32 11:23:33 INFO - Cleaning up... 11:23:33 INFO - Return code: 0 11:23:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:23: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')]} 11:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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')]} 11:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:33 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:33 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 11:23:33 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 11:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:33 INFO - 'HOME': '/Users/cltbld', 11:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:33 INFO - 'LOGNAME': 'cltbld', 11:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:33 INFO - 'MOZ_NO_REMOTE': '1', 11:23:33 INFO - 'NO_EM_RESTART': '1', 11:23:33 INFO - 'PAGER': '/bin/cat', 11:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:33 INFO - 'PWD': '/builds/slave/test', 11:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:33 INFO - 'SHELL': '/bin/bash', 11:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:33 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:33 INFO - 'USER': 'cltbld', 11:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:33 INFO - 'XPC_FLAGS': '0x0', 11:23:33 INFO - 'XPC_SERVICE_NAME': '0', 11:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:23:33 INFO - Cleaning up... 11:23:33 INFO - Return code: 0 11:23:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:23: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')]} 11:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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')]} 11:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:33 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:33 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 11:23:33 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 11:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:33 INFO - 'HOME': '/Users/cltbld', 11:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:33 INFO - 'LOGNAME': 'cltbld', 11:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:33 INFO - 'MOZ_NO_REMOTE': '1', 11:23:33 INFO - 'NO_EM_RESTART': '1', 11:23:33 INFO - 'PAGER': '/bin/cat', 11:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:33 INFO - 'PWD': '/builds/slave/test', 11:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:33 INFO - 'SHELL': '/bin/bash', 11:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:33 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:33 INFO - 'USER': 'cltbld', 11:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:33 INFO - 'XPC_FLAGS': '0x0', 11:23:33 INFO - 'XPC_SERVICE_NAME': '0', 11:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:23:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:23:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:38 INFO - Downloading docopt-0.6.1.tar.gz 11:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:23:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:23:38 INFO - Running setup.py install for blobuploader 11:23:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:23:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:23:38 INFO - Running setup.py install for requests 11:23:38 INFO - Running setup.py install for docopt 11:23:39 INFO - Successfully installed blobuploader requests docopt 11:23:39 INFO - Cleaning up... 11:23:39 INFO - Return code: 0 11:23:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:39 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:39 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 11:23:39 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 11:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:39 INFO - 'HOME': '/Users/cltbld', 11:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:39 INFO - 'LOGNAME': 'cltbld', 11:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:39 INFO - 'MOZ_NO_REMOTE': '1', 11:23:39 INFO - 'NO_EM_RESTART': '1', 11:23:39 INFO - 'PAGER': '/bin/cat', 11:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:39 INFO - 'PWD': '/builds/slave/test', 11:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:39 INFO - 'SHELL': '/bin/bash', 11:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:39 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:39 INFO - 'USER': 'cltbld', 11:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:39 INFO - 'XPC_FLAGS': '0x0', 11:23:39 INFO - 'XPC_SERVICE_NAME': '0', 11:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-6gdBsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-JogG3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-OBdRAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-yhaowB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-YILGeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-uw4MVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-4dNv9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-JgUf4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-6mNzYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-puNwX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-9zGtu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-usWVuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-1I4yVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-gGdVVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-d1ZL13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:41 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-eSfDdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:41 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-LHUIYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:23:41 INFO - Running setup.py install for manifestparser 11:23:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:23:41 INFO - Running setup.py install for mozcrash 11:23:41 INFO - Running setup.py install for mozdebug 11:23:41 INFO - Running setup.py install for mozdevice 11:23:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:23:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:23:41 INFO - Running setup.py install for mozfile 11:23:41 INFO - Running setup.py install for mozhttpd 11:23:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Running setup.py install for mozinfo 11:23:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Running setup.py install for mozInstall 11:23:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Running setup.py install for mozleak 11:23:42 INFO - Running setup.py install for mozlog 11:23:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Running setup.py install for moznetwork 11:23:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:23:42 INFO - Running setup.py install for mozprocess 11:23:43 INFO - Running setup.py install for mozprofile 11:23:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:23:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:23:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:23:43 INFO - Running setup.py install for mozrunner 11:23:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:23:43 INFO - Running setup.py install for mozscreenshot 11:23:43 INFO - Running setup.py install for moztest 11:23:43 INFO - Running setup.py install for mozversion 11:23:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:23:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:23:43 INFO - Cleaning up... 11:23:43 INFO - Return code: 0 11:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:43 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')]} 11:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:43 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')]} 11:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:43 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:43 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 11:23:43 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 11:23:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:43 INFO - 'HOME': '/Users/cltbld', 11:23:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:43 INFO - 'LOGNAME': 'cltbld', 11:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:43 INFO - 'MOZ_NO_REMOTE': '1', 11:23:43 INFO - 'NO_EM_RESTART': '1', 11:23:43 INFO - 'PAGER': '/bin/cat', 11:23:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:43 INFO - 'PWD': '/builds/slave/test', 11:23:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:43 INFO - 'SHELL': '/bin/bash', 11:23:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:43 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:43 INFO - 'USER': 'cltbld', 11:23:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:43 INFO - 'XPC_FLAGS': '0x0', 11:23:43 INFO - 'XPC_SERVICE_NAME': '0', 11:23:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-UOSHGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-y6jrWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-WmF720-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-WSYLV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-DzRmEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-U93J0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-3q6H2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-tP63Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:44 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)) 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:44 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-DgA4aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-sTOLkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-kV15cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-l9Me3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-RNezHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-2jBKn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-WiiqXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-KYbJYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:45 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)) 11:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-8CXhXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:45 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)) 11:23:45 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)) 11:23:45 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)) 11:23:45 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)) 11:23:45 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)) 11:23:45 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)) 11:23:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:48 INFO - Downloading blessings-1.6.tar.gz 11:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:48 INFO - Installing collected packages: blessings 11:23:48 INFO - Running setup.py install for blessings 11:23:48 INFO - Successfully installed blessings 11:23:48 INFO - Cleaning up... 11:23:48 INFO - Return code: 0 11:23:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:49 INFO - Reading from file tmpfile_stdout 11:23:49 INFO - Current package versions: 11:23:49 INFO - blessings == 1.6 11:23:49 INFO - blobuploader == 1.2.4 11:23:49 INFO - docopt == 0.6.1 11:23:49 INFO - functools32 == 3.2.3-2 11:23:49 INFO - jsonschema == 2.5.1 11:23:49 INFO - manifestparser == 1.1 11:23:49 INFO - mozInstall == 1.12 11:23:49 INFO - mozcrash == 1.0 11:23:49 INFO - mozdebug == 0.1 11:23:49 INFO - mozdevice == 0.49 11:23:49 INFO - mozfile == 1.2 11:23:49 INFO - mozhttpd == 0.7 11:23:49 INFO - mozinfo == 0.9 11:23:49 INFO - mozleak == 0.1 11:23:49 INFO - mozlog == 3.4 11:23:49 INFO - moznetwork == 0.27 11:23:49 INFO - mozprocess == 0.25 11:23:49 INFO - mozprofile == 0.28 11:23:49 INFO - mozrunner == 6.13 11:23:49 INFO - mozscreenshot == 0.1 11:23:49 INFO - mozsystemmonitor == 0.3 11:23:49 INFO - moztest == 0.8 11:23:49 INFO - mozversion == 1.4 11:23:49 INFO - psutil == 3.1.1 11:23:49 INFO - requests == 1.2.3 11:23:49 INFO - wsgiref == 0.1.2 11:23:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:49 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')]} 11:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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')]} 11:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:49 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 11:23:49 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 11:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:49 INFO - 'HOME': '/Users/cltbld', 11:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:49 INFO - 'LOGNAME': 'cltbld', 11:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:49 INFO - 'MOZ_NO_REMOTE': '1', 11:23:49 INFO - 'NO_EM_RESTART': '1', 11:23:49 INFO - 'PAGER': '/bin/cat', 11:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:49 INFO - 'PWD': '/builds/slave/test', 11:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:49 INFO - 'SHELL': '/bin/bash', 11:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:49 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:49 INFO - 'USER': 'cltbld', 11:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:49 INFO - 'XPC_FLAGS': '0x0', 11:23:49 INFO - 'XPC_SERVICE_NAME': '0', 11:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 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)) 11:23:49 INFO - Cleaning up... 11:23:49 INFO - Return code: 0 11:23:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23:49 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')]} 11:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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')]} 11:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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 0x107ec5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ec8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd199577b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, '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.KmZCqNbr9z/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.asYLlMeRdV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 11:23:49 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 11:23:49 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 11:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:49 INFO - 'HOME': '/Users/cltbld', 11:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:49 INFO - 'LOGNAME': 'cltbld', 11:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:49 INFO - 'MOZ_NO_REMOTE': '1', 11:23:49 INFO - 'NO_EM_RESTART': '1', 11:23:49 INFO - 'PAGER': '/bin/cat', 11:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:49 INFO - 'PWD': '/builds/slave/test', 11:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:49 INFO - 'SHELL': '/bin/bash', 11:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:23:49 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:49 INFO - 'USER': 'cltbld', 11:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:49 INFO - 'XPC_FLAGS': '0x0', 11:23:49 INFO - 'XPC_SERVICE_NAME': '0', 11:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:23:49 INFO - Cleaning up... 11:23:49 INFO - Return code: 0 11:23:49 INFO - Running post-action listener: _resource_record_post_action 11:23:49 INFO - Running post-action listener: _start_resource_monitoring 11:23:49 INFO - Starting resource monitoring. 11:23:49 INFO - [mozharness: 2017-02-26 19:23:49.753739Z] Finished create-virtualenv step (success) 11:23:49 INFO - [mozharness: 2017-02-26 19:23:49.754694Z] Running install step. 11:23:49 INFO - Running pre-action listener: _resource_record_pre_action 11:23:49 INFO - Running main action method: install 11:23:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:50 INFO - Reading from file tmpfile_stdout 11:23:50 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:50 INFO - Reading from file tmpfile_stdout 11:23:50 INFO - Output received: 11:23:50 INFO - Usage: mozinstall [options] installer 11:23:50 INFO - Options: 11:23:50 INFO - -h, --help show this help message and exit 11:23:50 INFO - -d DEST, --destination=DEST 11:23:50 INFO - Directory to install application into. [default: 11:23:50 INFO - "/builds/slave/test"] 11:23:50 INFO - --app=APP Application being installed. [default: firefox] 11:23:50 INFO - mkdir: /builds/slave/test/build/application 11:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:24:10 INFO - Reading from file tmpfile_stdout 11:24:10 INFO - Output received: 11:24:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:24:10 INFO - Running post-action listener: _resource_record_post_action 11:24:10 INFO - [mozharness: 2017-02-26 19:24:10.646507Z] Finished install step (success) 11:24:10 INFO - [mozharness: 2017-02-26 19:24:10.646657Z] Running run-tests step. 11:24:10 INFO - Running pre-action listener: _resource_record_pre_action 11:24:10 INFO - Running main action method: run_tests 11:24:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:24:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:24:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:24:10 INFO - 2017-02-26 11:24:10.661 screenresolution[1902:18742] starting screenresolution argv=screenresolution get 11:24:10 INFO - 2017-02-26 11:24:10.663 screenresolution[1902:18742] Display 0: 1600x1200x32@60 11:24:10 INFO - 2017-02-26 11:24:10.669 screenresolution[1903:18744] starting screenresolution argv=screenresolution list 11:24:10 INFO - Available Modes on Display 0 11:24:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:24:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:24:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:24:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:24:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:24:10 INFO - Intel Iris: 11:24:10 INFO - Chipset Model: Intel Iris 11:24:10 INFO - Type: GPU 11:24:10 INFO - Bus: Built-In 11:24:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:24:10 INFO - Vendor: Intel (0x8086) 11:24:10 INFO - Device ID: 0x0a2e 11:24:10 INFO - Revision ID: 0x0009 11:24:10 INFO - Displays: 11:24:10 INFO - Display: 11:24:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:24:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:24:10 INFO - Display Serial Number: 1600x1200 60 11:24:10 INFO - Main Display: Yes 11:24:10 INFO - Mirror: Off 11:24:10 INFO - Online: Yes 11:24:10 INFO - Rotation: Supported 11:24:10 INFO - Return code: 0 11:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:10 INFO - Python 2.7.3 11:24:10 INFO - Return code: 0 11:24:10 INFO - grabbing minidump binary from tooltool 11:24:10 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')]} 11:24:10 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 0x107ca3d30>, '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 0x107bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:10 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 11:24:10 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 11:24:10 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 11:24:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:11 INFO - Return code: 0 11:24:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:24:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:11 INFO - ENV: RUST_BACKTRACE is now 1 11:24:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:24:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:11 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/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--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 11:24:11 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/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0215 --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 11:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KmZCqNbr9z/Render', 11:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:11 INFO - 'HOME': '/Users/cltbld', 11:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:11 INFO - 'LOGNAME': 'cltbld', 11:24:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:11 INFO - 'MOZ_NO_REMOTE': '1', 11:24:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:11 INFO - 'NO_EM_RESTART': '1', 11:24:11 INFO - 'PAGER': '/bin/cat', 11:24:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:11 INFO - 'PWD': '/builds/slave/test', 11:24:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:11 INFO - 'RUST_BACKTRACE': '1', 11:24:11 INFO - 'SHELL': '/bin/bash', 11:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asYLlMeRdV/Listeners', 11:24:11 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 11:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:11 INFO - 'USER': 'cltbld', 11:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:11 INFO - 'XPC_FLAGS': '0x0', 11:24:11 INFO - 'XPC_SERVICE_NAME': '0', 11:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:11 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/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--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 11:24:11 INFO - mozversion application_buildid: 20170226102410 11:24:11 INFO - mozversion application_changeset: aa2b14b08dbb728ab6b9868e43a66842626f1833 11:24:11 INFO - mozversion application_display_name: Nightly 11:24:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:11 INFO - mozversion application_name: Firefox 11:24:11 INFO - mozversion application_remotingname: firefox 11:24:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:24:11 INFO - mozversion application_vendor: Mozilla 11:24:11 INFO - mozversion application_version: 54.0a1 11:24:11 INFO - mozversion platform_buildid: 20170226102410 11:24:11 INFO - mozversion platform_changeset: aa2b14b08dbb728ab6b9868e43a66842626f1833 11:24:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:24:11 INFO - mozversion platform_version: 54.0a1 11:24:11 INFO - using testdate: 1488137051 11:24:11 INFO - actual date: 1488137051 11:24:11 INFO - starting webserver on 'localhost:49367' 11:24:11 INFO - SUITE-START | Running 2 tests 11:24:11 INFO - TEST-START | dromaeo_css 11:24:11 INFO - operating with platform_type : mac_ 11:24:11 INFO - Initialising browser for dromaeo_css test... 11:24:11 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpF5byKY/profile http://localhost:49367/getInfo.html) 11:24:13 INFO - PROCESS | 1913 | __metrics Screen width/height:1600/1200 11:24:13 INFO - PROCESS | 1913 | colorDepth:24 11:24:13 INFO - PROCESS | 1913 | Browser inner width/height: 1024/689 11:24:13 INFO - PROCESS | 1913 | __metrics 11:24:13 INFO - PROCESS | 1913 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:24:13 INFO - PROCESS | 1913 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:24:14 INFO - TEST-INFO | 1913: exit 0 11:24:14 INFO - Browser initialized. 11:24:14 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:14 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpF5byKY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:26 INFO - PROCESS | 1915 | RSS: Main: 231145472 11:24:26 INFO - PROCESS | 1915 | 11:27:30 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49367/tests/dromaeo/cssquery-ext.html) 11:27:33 INFO - PROCESS | 1915 | RSS: Main: 481210368 11:27:33 INFO - PROCESS | 1915 | 11:29:16 INFO - PROCESS | 1915 | ************************* 11:29:16 INFO - PROCESS | 1915 | A coding exception was thrown and uncaught in a Task. 11:29:16 INFO - PROCESS | 1915 | 11:29:16 ERROR - PROCESS | 1915 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:29:16 INFO - PROCESS | 1915 | Full stack: 11:29:16 INFO - PROCESS | 1915 | ************************* 11:30:36 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-ext.html (next: http://localhost:49367/tests/dromaeo/cssquery-jquery.html) 11:30:37 INFO - PROCESS | 1915 | RSS: Main: 369127424 11:30:37 INFO - PROCESS | 1915 | 11:33:39 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49367/tests/dromaeo/cssquery-mootools.html) 11:33:40 INFO - PROCESS | 1915 | RSS: Main: 354983936 11:33:40 INFO - PROCESS | 1915 | 11:36:42 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49367/tests/dromaeo/cssquery-prototype.html) 11:36:43 INFO - PROCESS | 1915 | RSS: Main: 339668992 11:36:43 INFO - PROCESS | 1915 | 11:39:46 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49367/tests/dromaeo/cssquery-yui.html) 11:39:47 INFO - PROCESS | 1915 | RSS: Main: 341528576 11:39:47 INFO - PROCESS | 1915 | 11:42:50 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-yui.html (next: http://localhost:49367/tests/dromaeo/cssquery-dojo.html) 11:42:51 INFO - PROCESS | 1915 | RSS: Main: 496914432 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | __start_tp_report 11:42:51 INFO - PROCESS | 1915 | _x_x_mozilla_page_load 11:42:51 INFO - PROCESS | 1915 | _x_x_mozilla_page_load_details 11:42:51 INFO - PROCESS | 1915 | |i|pagename|runs| 11:42:51 INFO - PROCESS | 1915 | |0;dojo.html;3233.5796346474954;3238.0771480128165;3245.2860370718436;3286.1291757684235;3289.8684052637896;5414.8917021659645;5482.862928426782;5634.661920284786;5670.4896559309655;5697.515711164551;5496.80761173359;5522.530584900278;5570.61005729598;5576.609637325389;5607.803726869561;4994.150994330972;4994.900101997958;5063.341765570471;5069.112905241586;5141.1003074462005;5218.817341393052;5220.295260139889;5247.921281180786;5254.763535640886;5263.236830659552;4961.18140506816;5011.997600479882;5024.874378140539;5070.72111033893;5138.999999999981;5044.419891712427;5045.268436076785;5056.544910957995;5057.988402319551;5060.0132974070075;4963;5000.474950130257;5025.572826309768;5034.169362055257;5036.823711170092;5462.371827239878;5474.534664553517;5482.835514934558;5490.56075513958;5492.862678433031;5981.7906373277165;5985.371535988746;5988.700564971778;5991.490723288525;5991.820245392645;6068.484178844804;6087.726052327655;6120.632762034292;6129.172561704202;6141.692915354259;5632.127020311817;5633.492985631272;5659.037963546207;5663.66018038919;5677.630953987978;6257.687115644199;6277.686115694197;6280.183576135073;6291.1192433059405;6297.590656607306;5812.447817457335;5851.151583020438;5860.120981852756;6074.514038876968;6075.422834830684;6084.361142080106;6089.269287685506;6097.481714054266;6100.908486372708;6104.328523862371;6016.608920420159;6023.698815059317;6037.577369584087;6041.516678665696;6043.395660433922;6002.129691194839;6067.24159480065;6075.149479072933;6077.3314935357075;6085.756569737249;4763.499832517605;4845.830395936126;4876.122297986326;4888.193448081098;4927.285543596158;4302.397664326997;4306.418633484503;4373.2565463871215;4400.625946794495;4468.955310446919;5575.024370735106;5624.015797235467;5639.492445679908;5640.32316122068;5646.830595082154;6008.8197354078575;6101.542384321194;6233.470155036873;6252.280987686474;6265.780697675559;5520.558355331564;5521.558275338044;5562.276904002454;5568.3318001839225;5586.022446072003;5291.365036195604;5297.54970827484;5301.867453313621;5345.919811202835;5384.515393614593;6210.782622608187;6289.119523266838;6294.622322660655;6307.369263073748;6323.620582765049;6214.9067763984485;6217.409346112112;6222.782202622887;6225;6230.43926046658;6096.16386044079;6115.027386288435;6148.569600128127;6251.281102673069;6301.527385446201;5952.494038006818;5962.70186490665;5966.522678185822;5969.880602388015;5980.521558275241;5937.34689184198;6061.454469097803;6093.9085913712215;6113.633182009094;6114.938850611615;4889.731064791471;5749.655020698771;5825.242718446744;5832.62087964281;5850.970745146247;4521.773911304487;5131.820386286462;5750.597458177887;5827.329857066492;5944.1975333331175;5682.460166284196;5825.70871456434;5830.096335068071;5839.270091238595;5869.853253668522;5921.2006379138265;5945.256842894638;5950.702464876826;5958.463738263577;5966.492848107786;5556.583256255878;5594.440555944373;5599.832005039855;5629.352624448241;5776.075827867521 11:42:51 INFO - PROCESS | 1915 | |1;ext.html;752.984940301194;773.9613019349031;840.0926998841252;852.8933883264592;853.5732133933034;26526.602100968477;27474.17577472674;27497.450050998967;36947.63052369475;37246.510139594386;38314.80842595783;38448;38470.615293847055;38488.80755596225;38520.61479385205;9078.182963533282;9185.862212066824;9217.400868943498;9221.723348299562;9245.352825302198;7276.963615181917;7455.701771929116;7461.962690186541;9112;9248.53757312135;7390.852182956338;7454.217307182749;10766.676999690022;10994.945025274863;11015.394153321564;10830.837537436944;10903.34579925199;10911.181661375429;10912.399818010006;10913.781724365548;10632.946835265851;10709.518071686793;10710.625128120479;10718.517666704938;10722.356658600509;25637.74362256372;26095;26110.86944565265;26570.202893913214;35622.46566301508;3092.427900838352;3759.172981943968;3772.8302226399605;3773.8301776420126;3918.471006414126;21367.931603419922;21699.674504882438;21723.891380542995;21895.67156492654;21973.450663733376;3006.338605506785;3007.6541197762317;3026.8183908965534;3042.604461420023;3082.8458577071056;328396;331065;332552;333543;333544;47530.435217358834;47600.761996189794;47633.76183119062;47634.76182619134;47659;40639.18721625551;41278.79360603238;41405.585944140774;48754;49617;12825.486980520674;12914.160579562298;13118.95048396126;13151.342432878319;13155.473781048842;9449.291303152291;11285.210035297614;11289.20975531705;11296.661100167008;11301.039411650101;11205;11239.325640461599;11275.66173014811;11333.489992950337;11374.976252137181;5149.510796474329;5165.251038599382;5198.870028249248;5206.635535512478;5231.293775340357;847.5507980770202;945.163530275711;1010.3483253301579;1013.8175128476797;1030.7320096774743;11593.826092608617;14423;14751.92624036873;14798.408063677547;15056.698866022618;1083.6748975307376;1084.159776173472;1088.455772113943;1100.878903320634;1106.756513567014;6037.426444487766;7533.472656913963;7566.31903128721;7713.1515533291295;7727.22727727234;413058;413203;413899;414237.85762141994;414389;50714.98570028579;50718;50824;51019;51085.48914510808;1293.2369901758009;1330.8402991641065;1331.673739933742;1332.6535100873843;1334.739725753488;14395.928020359832;14419.423223071379;14788.704225915637;14945.626359341104;14949.25253737287;42366.72899813011;42378;42417.575824241365;42506.78746606247;42513.574864250964;400633;401803;401906;402601;402614;30155.547666785456;30393.544096838123;31046.84476577693;31226.843865780527;31339.05982820519;39643.405348920365;39849.00377490586;40012.39981400223;40118;40355;32849;33411.83294083514;34382.82808585941;34654.653453465144;34709.305813884086;33051.67793288338;33066.173345665586;34232.82883585566;34396.48405273873;34453.96638100861;32579;32928.83535582307;33262.16844578905;33534;33592.32815343728;24695.876520618;27480.900763970018;29046;29786.702132978393;30298.84850575733;18665;21033;21708.24021159315;22469.66295505536;22513.986870590536 11:42:51 INFO - PROCESS | 1915 | |2;jquery.html;346.6204506065858;357.59770258459235;381.3117323231566;395.58463613206146;419.7691269801608;13517.391717372717;13562.457501699933;19968.20127194912;20156.294529691462;21028.948552572387;17753.7336939946;20570.69143962842;20981.790182098175;21201.257955971505;21409.464763380885;5881.470667639912;6230.501559875199;6233.906491402633;6237.500999920018;6241.843953901143;5734.770609175628;5998.640081595118;6039.245094363205;6069.08963655453;6161.753529858823;6103.23709536308;6110.725017374207;6111.51107911366;6115.174451449042;6116.113163591277;5863.384344643794;6030.517558595324;6106.297775755756;6107.7556897724035;6115.6330620162935;5750.396208398141;5849.707514624251;5957.910631340534;5964.284285885721;5966.164736936832;13192.6701832454;13235.602931912059;13442.185304983897;13443.19340839543;13456.461741530327;2498.6376975338476;2509.949801003988;2543.4404431025146;2548.9745102548923;2599.7270286619823;9650.565724542343;9905.455199963999;9922.958089400581;9994.650187243484;10165.59337626494;1708.4789139312504;1765.0429799426934;1779.3416435918664;1812.3837895115723;1837.5083624470406;105548;108014;109363.45318273437;109814.90185098126;109951.45024274828;9551.570179341947;11319.547218111184;11595.188336816342;11684.12369072306;11937.462814173383;13091.869081309256;13765.655858603615;13792.448302068005;14093.295335233197;14146.292685365896;5811.738471768781;5932.851678708067;5940.970295148497;6180.598261113013;7679.731209407644;7158.964205179045;8070.112287648354;8080.515169089874;8150.429469937166;8266.917330826614;4731.4558825735485;4771.9522804772205;4772.737499437495;4794.7362895040405;4923.77842997066;1813.8911665300125;1913.6842421000379;1947.2863879785698;2005.959880802376;2009.3770931011434;879.824035192964;887.0440678304324;937.7327461673391;1008.7982403519326;1024.5594394410325;19953.501162471053;20098.89950550238;21097.9451027448;21237.46906327354;21263.78736212649;1012.7215015870695;1024.3495380433478;1067.9786404271872;1070.0097818058405;1073.7906108308962;10257.705912076724;10982.450877456095;11057.286120651312;11066.059384952368;11071.280366776135;566596;603288;652618;658469;659403;109068;120087;143553.46697995384;146132;151827;793.4604468961162;982.2289502740315;1020.505055048301;1020.7652239984845;1021.5249908792447;15371.61570960735;16922.830771692126;17525.47423577295;18190.9994950279;18329.908350458696;52629.68425789386;54229;54271.72864135654;56135.59661008507;57056.714716426155;78640;78785.8182127257;80529;80847.19152808632;81336;6637.037629543785;8164.1019487857475;8243.876341854757;8306.169383061646;8329.416940814328;12182.695432614255;12466.812997804858;12611.558595449114;12832.55086071983;12886.420111094836;10014.449205293779;10169.288149829441;10188.898111018794;10308.587656493657;11279.436028198721;9034.728958131267;10285.228607854591;10628.681139565826;11149.99650031501;11215.847266785053;11282.266652667551;11571.958523732905;11625.88374116248;11649.76700465969;11686.889745474165;5925.377835327401;7532.17146113938;7623.161452240138;7657.617119144132;8347.95826020866;9419.974705438364;10771.299865508718;11176.497057632263;11196.776064478829;11241.887581124083 11:42:51 INFO - PROCESS | 1915 | |3;mootools.html;1421.3390773290419;1462.722082804267;1478.963025924352;1485.502356710502;1492.6119209005658;8081.8383632327395;8476.872846907301;8485.10906354833;8493.490390576555;8510.872336914952;8090.555019473926;8394.538300393491;8415.326773858093;8482.024567174776;8490.91509084909;1913.7129430585385;2159.8380121490873;2226.866388016724;2230.408941630461;2234;1861.6090620969544;2203.537257175995;2237.5301186750803;2244.5847518209102;2244.9336565131593;2188.4528867783056;2197.9340619781433;2215.7341119065736;2220.2673117871063;2224.477247846763;1827.8994655293955;1840.8803427777152;2203.768604296542;2206.415299945516;2210.32585061557;2122.7664956854733;2222.0445208560313;2222.2222222222254;2226.087304205268;2227.487677834091;8367.037790654093;8423.073461919184;8425.789355266168;8453.365997550147;8455.027671817757;4970.925436118425;5114.105031619451;5119.283300337956;5127;5131.3329267195395;3202.903912882617;3357.4460214064893;3381.594208694972;3434.742394320436;3438.5186073949667;959.3716115944068;983.6311383231289;1197.2038594334756;1203.3921923834976;1250.856151542566;10559.102476289525;10703.304285221435;10792.352458852494;10794.5682172713;10800.973907478778;4108.609682080198;4271;4354.042110735633;4359.934600980988;4363.956360436418;8641.092685268082;8652.826943461221;8654.913450865537;8659.134086591417;8664.090270521505;5008.29883816266;5008.749562521859;5012.298278241049;5016.072026675077;5022.296878437021;3883.805809709503;4478.776061196927;4501.7524036177665;4683.976580117078;4695.389599352131;3494.650534946485;3521.154922818505;3531.3643544161782;3564.502908778319;3581.659742324475;1095.780843831237;1099.6810924831868;1104.0560320925654;1104.9558017679203;1115.0912006714664;855.9657613695382;876.6230520875957;883.3110174064112;917.9724608261763;930.186087173723;5275.894482110413;5279.102552566073;5458.808941687022;5595.776168953196;5615.971920140373;469.5117078238662;500.2396357536597;553.7701853730657;583.4544700704854;584.2200662116122;3100.8294543799857;3630.1650620357464;3635.2547727715755;3653.5067765851268;3790.8483660653815;9511.476868772284;9904.950475247577;9919.454430006275;9923.354981926152;9930.106290433896;9592.616295348247;9684.757881052888;9778.804423911482;9898.10917017472;9919.206463482904;6198.6280823150755;6787.898181527281;7068.92931070693;7069.116360454943;7786.961065194524;5300.946990530199;5417.864553386197;5709;5790.768369265183;5803.8549036274435;8208.630611622371;8923.776905577413;8938.955305223431;8961.596728147118;9213.815723685622;8999.550022498717;9225.12361325673;9240;9299.395539289924;9312.20846228051;6495.935040649533;6566.606003639797;6576.704048317742;6581.210254769267;6591.406773390418;7642.273983971514;7701.845963080819;7721.92278077212;7761.185075566984;7809.843803124019;6470.48236141117;6820.829479263058;6980.965095174492;7011.228764835966;7065.6467176639935;6428.903566446414;6905.378515933389;6970.268121847336;7001.964990175016;7024.1571011478945;6198.1012753149635;6314.1160237565855;6315.179026726496;6316.557840951089;6325;4666.883327916829;4871.415430148405;4893.574497851447;4911.386076740408;5064.5948324134715;4347.021920067959;4868.269759535956;4990.4011518618;5040.243963405518;5101.770420331169 11:42:51 INFO - PROCESS | 1915 | |4;prototype.html;304.8003557669724;314.4795363673121;342.6607658418165;349.23169028138085;365.10913371373846;5049.873753156168;5196.038732834423;5382.2195781611745;5444.2378067070595;5489.835304940848;4566.725996440216;4866.58634016109;5121.308623335858;5323.1749078892735;5372.973135134329;3409.7613167078316;3511.4030614795547;4012.6990475714438;4044.795586405416;4056.65518430933;3558.7864728116265;3588.3899737044767;3857.8812144478065;4063.1106535461004;4074.5314288856716;3062.7702922280805;3706.4440333949988;3832.5698499842624;3856.592343794509;4047.271491131595;3275.4922986937063;3377.645347238529;3432.5709286339206;3806.8477260909667;3996.800159992018;2875.6980517045827;3058.709422604849;3462.480627905809;3466.6706662866986;3473.9826300868585;4388.868333949987;4867.610591152735;5126.71803050832;5149.794008239666;5171.81898633546;3992.9618299242115;4192.517860446027;4538.591526762574;4588.518205588399;4619.584237418615;4971.967100068955;5113.749950021978;5601.635893666939;5615.578831587606;5698.7435565399655;2889.436559870826;3064.2798942248555;3790.4503846942316;3808.9809550952345;3814.5803961564206;4445.622122119624;4872.8538143855385;5479.479449452296;5857.502112320458;5907.911381329283;3794.9241015180096;3802.619738026175;3814.5803961564206;3835.980820095882;3845.576986531479;2993.012305939035;3508.6842184203542;3914.5320504810697;3926.155876486569;3943.743656662308;4548.249538826123;4564.972881101792;4576.427946506687;4585.449746030497;4610.74640894754;4411.779411029435;4872;5570.022641962126;5643.943560564424;5644.604877658607;1142.6914733022038;1228.4410593180082;1258.452573130691;1260.0801414966943;1260.4328052376468;807.3339494916718;850.5917159763349;863.2360361080489;866;872.0189786490198;4901.779419926112;4918;4924.005777660053;5048.495150484922;5059.418166910778;5015.673981191211;5062.594992400599;5135.87160320995;5523.100372304572;5610.923958135516;4454.732716037048;4463.799129039201;4510.729356238636;4846.927296090562;5101.846944591668;2390.8565486070893;2460.7785299323145;2742.766864816513;2876.5685147228082;2895.290653789793;4928.704277743347;5342;5783.624064435882;5841.7371218295275;5887.999040163182;4993.675411098267;5075.644704870698;5396.001739678172;5459.47134802256;5489.161131021073;5122.385313762298;5354.625176237704;5445.237666726662;5778.306603207558;5880.8235752927485;4693;5116.718580478109;5362.533234712077;5636.408177141341;5688.971555142198;4824.517548245288;5278.868028299324;5420.858651260117;5512.7519261634125;5566.995881482744;4755.881102972453;4809.831655892027;5222.582193424593;5229.581633469389;5825.960913680178;3294.58817647794;3686.5391826021746;3733.8693145740854;3735.6077611850365;3748.175401411685;5064.82273120439;5313.4952179544425;5487.146683724521;5688.886222275614;5859.384764599656;5610.9158362623775;5623.2127502148915;5642.266505354278;5671.631343962629;5694.202811606461;5208.906129712803;5634.450296313296;5651.897879913377;5667.716614169358;5698.743556539883;4567.2692369222095;5235.581153507786;5239.47605239473;5543.417941116125;5545.112781954868;4661.974365639554;5598.776048958159;5610.326760788732;5664.320281566073;5669.7165141741925;3958.247932892741;5263.263143159884;5394.379646340721;5429.67421954684;5540.722963851872 11:42:51 INFO - PROCESS | 1915 | |5;yui.html;694.2294053600499;694.3716983673285;741.2550386861207;807.64867282732;848.3976376772491;12182.390880455974;12812;13923.512677056306;14294.857051429482;15176.468823591176;13676.384562694679;13759.587212383645;13763.793543096861;13778.104423212484;13785.448582056732;886.6542048601051;897.9236764874961;898.6719847255754;904.5793705926743;907.8184363127401;892.7143314139478;894.1282249806452;894.463322006794;895.3374502867863;907.9727608171765;917.6375331743957;941.90110038446;949.4255975135047;956.5456408206081;957.3155194036262;941.8493041113389;944.5088553951906;945.9243260539175;946.2666433514013;946.7964387656618;667.2993356975205;706.9858602827966;707.3916431868589;707.7664370757637;709.8048036789872;14795.038322509003;14952.62618434537;15018.174000429972;15021.474248401362;15219.771703424458;13615.96781680335;13694.863051369459;13973.650658733512;14019.088759230719;14102.94227932909;11319.264247823865;11388.658340249805;11546.826797598043;11901.702457438547;11947.820782688266;3572.5712914450432;3632.3824949758605;3632.8365223565;3651.72612054097;3661.1945372018113;93864.53067734686;100700.49649751704;101231;103342;104598;10482.68551943443;10491.94754026225;10691.518881650345;10715.624953126759;10831.458427078773;21944;22256.99843507046;22306.553868922532;22332.665010024863;22336.664950025763;7424.554526728413;7437.665305061177;7444.516106453063;7489.138749043821;7670.117936437381;3963.0884896473394;4012.1373904610064;4048.3117869962175;4061.3501839706096;4126.7523948563185;3488.755787094879;3559.4660800879556;3576.5886923004186;3585.049961760136;3603.5855876574005;615.7567760734485;615.984600384985;622.7726879688971;623.7224435126416;636.0776873533302;639.2871947778194;659.1957811469999;669.8057563306586;672.67711498481;689.152342618582;7692.807679807937;8400.563836487472;9340.486273255035;9505.714828555154;9651.9034809651;541.6695815552509;548.2461615278992;590.9970450147722;643.83904023994;690.5235387582552;4210.031692710693;4403.9779801100785;4600.401947746772;4781.976090119527;4783.521647835259;72675.63662181655;73836;85675.57162214149;91456.54271728599;93335;73425;78212.6089369561;79222.52947459793;79545.06823976334;80343.59828200821;49614;68373;70284.29715702777;72819.54360912752;73127;8346.499210047417;8470;8475.533845638549;8568.186022327869;8782.209601135928;33669;44754.55245447504;45044.162883396195;45872.31191532063;46912.7654361726;47303.52696473129;58667.70666146642;59228.70385648044;61216.69391653013;62276;11229.550817967516;11296.774064518828;11376.431178441211;11764.999152449258;11947.044236461235;12186.086043546593;12195.939020305197;12214.75570488603;12287.324197169242;12386.3187524687;11439;11440.313581185155;11501.19491635611;11661.883381166419;11840.940795295968;9372.48451335156;10044.598216071276;11279.492422841156;11641.301521908374;11904.345261010727;11343.149263805413;11451.25566838153;11603.129765267808;11962.70093247641;12124.818127727915;9216.815174767238;9587.137157655565;9707.077827606367;9735;9791.314607977658;8665.17680820321;9199.86200206984;9274.211692005985;9289.581968811555;9480.715578532656 11:42:51 INFO - PROCESS | 1915 | __end_tp_report 11:42:51 INFO - PROCESS | 1915 | __start_cc_report 11:42:51 INFO - PROCESS | 1915 | _x_x_mozilla_cycle_collect,2972 11:42:51 INFO - PROCESS | 1915 | __end_cc_report 11:42:51 INFO - PROCESS | 1915 | __startTimestamp1488138171252__endTimestamp 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | ------- Summary: start ------- 11:42:51 INFO - PROCESS | 1915 | Number of tests: 6 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | [#0] dojo.html Cycles:165 Average:5591.15 Median:5697.52 stddev:635.05 (11.1%) stddev-sans-first:609.47 11:42:51 INFO - PROCESS | 1915 | Values: 3233.6 3238.1 3245.3 3286.1 3289.9 5414.9 5482.9 5634.7 5670.5 5697.5 5496.8 5522.5 5570.6 5576.6 5607.8 4994.2 4994.9 5063.3 5069.1 5141.1 5218.8 5220.3 5247.9 5254.8 5263.2 4961.2 5012.0 5024.9 5070.7 5139.0 5044.4 5045.3 5056.5 5058.0 5060.0 4963.0 5000.5 5025.6 5034.2 5036.8 5462.4 5474.5 5482.8 5490.6 5492.9 5981.8 5985.4 5988.7 5991.5 5991.8 6068.5 6087.7 6120.6 6129.2 6141.7 5632.1 5633.5 5659.0 5663.7 5677.6 6257.7 6277.7 6280.2 6291.1 6297.6 5812.4 5851.2 5860.1 6074.5 6075.4 6084.4 6089.3 6097.5 6100.9 6104.3 6016.6 6023.7 6037.6 6041.5 6043.4 6002.1 6067.2 6075.1 6077.3 6085.8 4763.5 4845.8 4876.1 4888.2 4927.3 4302.4 4306.4 4373.3 4400.6 4469.0 5575.0 5624.0 5639.5 5640.3 5646.8 6008.8 6101.5 6233.5 6252.3 6265.8 5520.6 5521.6 5562.3 5568.3 5586.0 5291.4 5297.5 5301.9 5345.9 5384.5 6210.8 6289.1 6294.6 6307.4 6323.6 6214.9 6217.4 6222.8 6225.0 6230.4 6096.2 6115.0 6148.6 6251.3 6301.5 5952.5 5962.7 5966.5 5969.9 5980.5 5937.3 6061.5 6093.9 6113.6 6114.9 4889.7 5749.7 5825.2 5832.6 5851.0 4521.8 5131.8 5750.6 5827.3 5944.2 5682.5 5825.7 5830.1 5839.3 5869.9 5921.2 5945.3 5950.7 5958.5 5966.5 5556.6 5594.4 5599.8 5629.4 5776.1 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | [#1] ext.html Cycles:180 Average:50259.81 Median:182907.08 stddev:102061.37 (55.8%) stddev-sans-first:102279.99 11:42:51 INFO - PROCESS | 1915 | Values: 753.0 774.0 840.1 852.9 853.6 26526.6 27474.2 27497.5 36947.6 37246.5 38314.8 38448.0 38470.6 38488.8 38520.6 9078.2 9185.9 9217.4 9221.7 9245.4 7277.0 7455.7 7462.0 9112.0 9248.5 7390.9 7454.2 10766.7 10994.9 11015.4 10830.8 10903.3 10911.2 10912.4 10913.8 10632.9 10709.5 10710.6 10718.5 10722.4 25637.7 26095.0 26110.9 26570.2 35622.5 3092.4 3759.2 3772.8 3773.8 3918.5 21367.9 21699.7 21723.9 21895.7 21973.5 3006.3 3007.7 3026.8 3042.6 3082.8 328396.0 331065.0 332552.0 333543.0 333544.0 47530.4 47600.8 47633.8 47634.8 47659.0 40639.2 41278.8 41405.6 48754.0 49617.0 12825.5 12914.2 13119.0 13151.3 13155.5 9449.3 11285.2 11289.2 11296.7 11301.0 11205.0 11239.3 11275.7 11333.5 11375.0 5149.5 5165.3 5198.9 5206.6 5231.3 847.6 945.2 1010.3 1013.8 1030.7 11593.8 14423.0 14751.9 14798.4 15056.7 1083.7 1084.2 1088.5 1100.9 1106.8 6037.4 7533.5 7566.3 7713.2 7727.2 413058.0 413203.0 413899.0 414237.9 414389.0 50715.0 50718.0 50824.0 51019.0 51085.5 1293.2 1330.8 1331.7 1332.7 1334.7 14395.9 14419.4 14788.7 14945.6 14949.3 42366.7 42378.0 42417.6 42506.8 42513.6 400633.0 401803.0 401906.0 402601.0 402614.0 30155.5 30393.5 31046.8 31226.8 31339.1 39643.4 39849.0 40012.4 40118.0 40355.0 32849.0 33411.8 34382.8 34654.7 34709.3 33051.7 33066.2 34232.8 34396.5 34454.0 32579.0 32928.8 33262.2 33534.0 33592.3 24695.9 27480.9 29046.0 29786.7 30298.8 18665.0 21033.0 21708.2 22469.7 22514.0 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | [#2] jquery.html Cycles:180 Average:35301.05 Median:21250.63 stddev:104869.89 (493.5%) stddev-sans-first:105131.23 11:42:51 INFO - PROCESS | 1915 | Values: 346.6 357.6 381.3 395.6 419.8 13517.4 13562.5 19968.2 20156.3 21028.9 17753.7 20570.7 20981.8 21201.3 21409.5 5881.5 6230.5 6233.9 6237.5 6241.8 5734.8 5998.6 6039.2 6069.1 6161.8 6103.2 6110.7 6111.5 6115.2 6116.1 5863.4 6030.5 6106.3 6107.8 6115.6 5750.4 5849.7 5957.9 5964.3 5966.2 13192.7 13235.6 13442.2 13443.2 13456.5 2498.6 2509.9 2543.4 2549.0 2599.7 9650.6 9905.5 9923.0 9994.7 10165.6 1708.5 1765.0 1779.3 1812.4 1837.5 105548.0 108014.0 109363.5 109814.9 109951.5 9551.6 11319.5 11595.2 11684.1 11937.5 13091.9 13765.7 13792.4 14093.3 14146.3 5811.7 5932.9 5941.0 6180.6 7679.7 7159.0 8070.1 8080.5 8150.4 8266.9 4731.5 4772.0 4772.7 4794.7 4923.8 1813.9 1913.7 1947.3 2006.0 2009.4 879.8 887.0 937.7 1008.8 1024.6 19953.5 20098.9 21097.9 21237.5 21263.8 1012.7 1024.3 1068.0 1070.0 1073.8 10257.7 10982.5 11057.3 11066.1 11071.3 566596.0 603288.0 652618.0 658469.0 659403.0 109068.0 120087.0 143553.5 146132.0 151827.0 793.5 982.2 1020.5 1020.8 1021.5 15371.6 16922.8 17525.5 18191.0 18329.9 52629.7 54229.0 54271.7 56135.6 57056.7 78640.0 78785.8 80529.0 80847.2 81336.0 6637.0 8164.1 8243.9 8306.2 8329.4 12182.7 12466.8 12611.6 12832.6 12886.4 10014.4 10169.3 10188.9 10308.6 11279.4 9034.7 10285.2 10628.7 11150.0 11215.8 11282.3 11572.0 11625.9 11649.8 11686.9 5925.4 7532.2 7623.2 7657.6 8348.0 9420.0 10771.3 11176.5 11196.8 11241.9 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | [#3] mootools.html Cycles:180 Average:5266.34 Median:5277.50 stddev:2937.23 (55.7%) stddev-sans-first:2931.25 11:42:51 INFO - PROCESS | 1915 | Values: 1421.3 1462.7 1479.0 1485.5 1492.6 8081.8 8476.9 8485.1 8493.5 8510.9 8090.6 8394.5 8415.3 8482.0 8490.9 1913.7 2159.8 2226.9 2230.4 2234.0 1861.6 2203.5 2237.5 2244.6 2244.9 2188.5 2197.9 2215.7 2220.3 2224.5 1827.9 1840.9 2203.8 2206.4 2210.3 2122.8 2222.0 2222.2 2226.1 2227.5 8367.0 8423.1 8425.8 8453.4 8455.0 4970.9 5114.1 5119.3 5127.0 5131.3 3202.9 3357.4 3381.6 3434.7 3438.5 959.4 983.6 1197.2 1203.4 1250.9 10559.1 10703.3 10792.4 10794.6 10801.0 4108.6 4271.0 4354.0 4359.9 4364.0 8641.1 8652.8 8654.9 8659.1 8664.1 5008.3 5008.7 5012.3 5016.1 5022.3 3883.8 4478.8 4501.8 4684.0 4695.4 3494.7 3521.2 3531.4 3564.5 3581.7 1095.8 1099.7 1104.1 1105.0 1115.1 856.0 876.6 883.3 918.0 930.2 5275.9 5279.1 5458.8 5595.8 5616.0 469.5 500.2 553.8 583.5 584.2 3100.8 3630.2 3635.3 3653.5 3790.8 9511.5 9905.0 9919.5 9923.4 9930.1 9592.6 9684.8 9778.8 9898.1 9919.2 6198.6 6787.9 7068.9 7069.1 7787.0 5300.9 5417.9 5709.0 5790.8 5803.9 8208.6 8923.8 8939.0 8961.6 9213.8 8999.6 9225.1 9240.0 9299.4 9312.2 6495.9 6566.6 6576.7 6581.2 6591.4 7642.3 7701.8 7721.9 7761.2 7809.8 6470.5 6820.8 6981.0 7011.2 7065.6 6428.9 6905.4 6970.3 7002.0 7024.2 6198.1 6314.1 6315.2 6316.6 6325.0 4666.9 4871.4 4893.6 4911.4 5064.6 4347.0 4868.3 4990.4 5040.2 5101.8 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | [#4] prototype.html Cycles:180 Average:4378.30 Median:4921.00 stddev:1378.27 (28.0%) stddev-sans-first:1347.80 11:42:51 INFO - PROCESS | 1915 | Values: 304.8 314.5 342.7 349.2 365.1 5049.9 5196.0 5382.2 5444.2 5489.8 4566.7 4866.6 5121.3 5323.2 5373.0 3409.8 3511.4 4012.7 4044.8 4056.7 3558.8 3588.4 3857.9 4063.1 4074.5 3062.8 3706.4 3832.6 3856.6 4047.3 3275.5 3377.6 3432.6 3806.8 3996.8 2875.7 3058.7 3462.5 3466.7 3474.0 4388.9 4867.6 5126.7 5149.8 5171.8 3993.0 4192.5 4538.6 4588.5 4619.6 4972.0 5113.7 5601.6 5615.6 5698.7 2889.4 3064.3 3790.5 3809.0 3814.6 4445.6 4872.9 5479.5 5857.5 5907.9 3794.9 3802.6 3814.6 3836.0 3845.6 2993.0 3508.7 3914.5 3926.2 3943.7 4548.2 4565.0 4576.4 4585.4 4610.7 4411.8 4872.0 5570.0 5643.9 5644.6 1142.7 1228.4 1258.5 1260.1 1260.4 807.3 850.6 863.2 866.0 872.0 4901.8 4918.0 4924.0 5048.5 5059.4 5015.7 5062.6 5135.9 5523.1 5610.9 4454.7 4463.8 4510.7 4846.9 5101.8 2390.9 2460.8 2742.8 2876.6 2895.3 4928.7 5342.0 5783.6 5841.7 5888.0 4993.7 5075.6 5396.0 5459.5 5489.2 5122.4 5354.6 5445.2 5778.3 5880.8 4693.0 5116.7 5362.5 5636.4 5689.0 4824.5 5278.9 5420.9 5512.8 5567.0 4755.9 4809.8 5222.6 5229.6 5826.0 3294.6 3686.5 3733.9 3735.6 3748.2 5064.8 5313.5 5487.1 5688.9 5859.4 5610.9 5623.2 5642.3 5671.6 5694.2 5208.9 5634.5 5651.9 5667.7 5698.7 4567.3 5235.6 5239.5 5543.4 5545.1 4662.0 5598.8 5610.3 5664.3 5669.7 3958.2 5263.3 5394.4 5429.7 5540.7 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - PROCESS | 1915 | [#5] yui.html Cycles:180 Average:18205.33 Median:544.96 stddev:25806.91 (4735.6%) stddev-sans-first:25845.81 11:42:51 INFO - PROCESS | 1915 | Values: 694.2 694.4 741.3 807.6 848.4 12182.4 12812.0 13923.5 14294.9 15176.5 13676.4 13759.6 13763.8 13778.1 13785.4 886.7 897.9 898.7 904.6 907.8 892.7 894.1 894.5 895.3 908.0 917.6 941.9 949.4 956.5 957.3 941.8 944.5 945.9 946.3 946.8 667.3 707.0 707.4 707.8 709.8 14795.0 14952.6 15018.2 15021.5 15219.8 13616.0 13694.9 13973.7 14019.1 14102.9 11319.3 11388.7 11546.8 11901.7 11947.8 3572.6 3632.4 3632.8 3651.7 3661.2 93864.5 100700.5 101231.0 103342.0 104598.0 10482.7 10491.9 10691.5 10715.6 10831.5 21944.0 22257.0 22306.6 22332.7 22336.7 7424.6 7437.7 7444.5 7489.1 7670.1 3963.1 4012.1 4048.3 4061.4 4126.8 3488.8 3559.5 3576.6 3585.0 3603.6 615.8 616.0 622.8 623.7 636.1 639.3 659.2 669.8 672.7 689.2 7692.8 8400.6 9340.5 9505.7 9651.9 541.7 548.2 591.0 643.8 690.5 4210.0 4404.0 4600.4 4782.0 4783.5 72675.6 73836.0 85675.6 91456.5 93335.0 73425.0 78212.6 79222.5 79545.1 80343.6 49614.0 68373.0 70284.3 72819.5 73127.0 8346.5 8470.0 8475.5 8568.2 8782.2 33669.0 44754.6 45044.2 45872.3 46912.8 47303.5 58667.7 59228.7 61216.7 62276.0 11229.6 11296.8 11376.4 11765.0 11947.0 12186.1 12195.9 12214.8 12287.3 12386.3 11439.0 11440.3 11501.2 11661.9 11840.9 9372.5 10044.6 11279.5 11641.3 11904.3 11343.1 11451.3 11603.1 11962.7 12124.8 9216.8 9587.1 9707.1 9735.0 9791.3 8665.2 9199.9 9274.2 9289.6 9480.7 11:42:51 INFO - PROCESS | 1915 | -------- Summary: end -------- 11:42:51 INFO - PROCESS | 1915 | 11:42:51 INFO - TEST-INFO | 1915: exit 0 11:42:51 INFO - TEST-OK | dromaeo_css | took 1120703ms 11:42:51 INFO - TEST-START | kraken 11:42:51 INFO - operating with platform_type : mac_ 11:42:51 INFO - Initialising browser for kraken test... 11:42:51 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpHmgEeT/profile http://localhost:49367/getInfo.html) 11:42:54 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 11:42:54 INFO - PROCESS | 1918 | colorDepth:24 11:42:54 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 11:42:54 INFO - PROCESS | 1918 | __metrics 11:42:54 INFO - PROCESS | 1918 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:42:54 INFO - PROCESS | 1918 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:42:55 INFO - TEST-INFO | 1918: exit 0 11:42:55 INFO - Browser initialized. 11:42:55 INFO - Running cycle 1/1 for kraken test... 11:42:55 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpHmgEeT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:07 INFO - PROCESS | 1919 | RSS: Main: 232087552 11:43:07 INFO - PROCESS | 1919 | 11:43:10 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:10 INFO - PROCESS | 1919 | RSS: Main: 284291072 11:43:10 INFO - PROCESS | 1919 | 11:43:13 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-dft) 11:43:14 INFO - PROCESS | 1919 | RSS: Main: 285958144 11:43:14 INFO - PROCESS | 1919 | 11:43:17 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-fft) 11:43:18 INFO - PROCESS | 1919 | RSS: Main: 377110528 11:43:18 INFO - PROCESS | 1919 | 11:43:20 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-oscillator) 11:43:21 INFO - PROCESS | 1919 | RSS: Main: 282198016 11:43:21 INFO - PROCESS | 1919 | 11:43:23 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:43:23 INFO - PROCESS | 1919 | RSS: Main: 283738112 11:43:23 INFO - PROCESS | 1919 | 11:43:26 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-darkroom) 11:43:27 INFO - PROCESS | 1919 | RSS: Main: 326230016 11:43:27 INFO - PROCESS | 1919 | 11:43:30 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-desaturate) 11:43:31 INFO - PROCESS | 1919 | RSS: Main: 327852032 11:43:31 INFO - PROCESS | 1919 | 11:43:34 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49367/tests/kraken/driver.html?testName=json-parse-financial) 11:43:35 INFO - PROCESS | 1919 | RSS: Main: 326447104 11:43:35 INFO - PROCESS | 1919 | 11:43:36 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49367/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:43:37 INFO - PROCESS | 1919 | RSS: Main: 300056576 11:43:37 INFO - PROCESS | 1919 | 11:43:39 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:43:40 INFO - PROCESS | 1919 | RSS: Main: 304689152 11:43:40 INFO - PROCESS | 1919 | 11:43:42 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:43:43 INFO - PROCESS | 1919 | RSS: Main: 308744192 11:43:43 INFO - PROCESS | 1919 | 11:43:46 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:43:46 INFO - PROCESS | 1919 | RSS: Main: 312627200 11:43:46 INFO - PROCESS | 1919 | 11:43:49 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:43:50 INFO - PROCESS | 1919 | RSS: Main: 313720832 11:43:50 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49367/tests/kraken/driver.html?testName=ai-astar) 11:43:52 INFO - PROCESS | 1919 | RSS: Main: 358899712 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | __start_tp_report 11:43:52 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 11:43:52 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 11:43:52 INFO - PROCESS | 1919 | |i|pagename|runs| 11:43:52 INFO - PROCESS | 1919 | |0;ai-astar;115;115;114;114;114;116;114;114;114;114 11:43:52 INFO - PROCESS | 1919 | |1;audio-beat-detection;162;110;111;176;114;113;111;111;133;110 11:43:52 INFO - PROCESS | 1919 | |2;audio-dft;186;186;242;242;181;198;232;265;202;185 11:43:52 INFO - PROCESS | 1919 | |3;audio-fft;80;60;59;89;61;62;62;60;80;60 11:43:52 INFO - PROCESS | 1919 | |4;audio-oscillator;94;73;88;69;69;71;88;69;68;85 11:43:52 INFO - PROCESS | 1919 | |5;imaging-gaussian-blur;88;88;89;88;89;89;89;89;89;89 11:43:52 INFO - PROCESS | 1919 | |6;imaging-darkroom;95;96;94;96;101;95;95;96;94;95 11:43:52 INFO - PROCESS | 1919 | |7;imaging-desaturate;85;88;85;109;139;105;87;87;128;136 11:43:52 INFO - PROCESS | 1919 | |8;json-parse-financial;61;61;60;61;61;61;62;62;62;62 11:43:52 INFO - PROCESS | 1919 | |9;json-stringify-tinderbox;60;58;70;75;71;65;63;63;63;63 11:43:52 INFO - PROCESS | 1919 | |10;stanford-crypto-aes;87;89;88;87;89;90;89;87;90;102 11:43:52 INFO - PROCESS | 1919 | |11;stanford-crypto-ccm;141;140;150;138;139;139;137;144;163;133 11:43:52 INFO - PROCESS | 1919 | |12;stanford-crypto-pbkdf2;169;170;170;174;173;172;172;173;171;170 11:43:52 INFO - PROCESS | 1919 | |13;stanford-crypto-sha256-iterative;68;71;84;84;84;73;65;65;66;65 11:43:52 INFO - PROCESS | 1919 | __end_tp_report 11:43:52 INFO - PROCESS | 1919 | __start_cc_report 11:43:52 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,2127 11:43:52 INFO - PROCESS | 1919 | __end_cc_report 11:43:52 INFO - PROCESS | 1919 | __startTimestamp1488138232422__endTimestamp 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | ------- Summary: start ------- 11:43:52 INFO - PROCESS | 1919 | Number of tests: 14 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 11:43:52 INFO - PROCESS | 1919 | Values: 115.0 115.0 114.0 114.0 114.0 116.0 114.0 114.0 114.0 114.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:113.50 stddev:24.35 (21.5%) stddev-sans-first:21.86 11:43:52 INFO - PROCESS | 1919 | Values: 162.0 110.0 111.0 176.0 114.0 113.0 111.0 111.0 133.0 110.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#2] audio-dft Cycles:10 Average:211.90 Median:217.00 stddev:30.45 (14.0%) stddev-sans-first:30.83 11:43:52 INFO - PROCESS | 1919 | Values: 186.0 186.0 242.0 242.0 181.0 198.0 232.0 265.0 202.0 185.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#3] audio-fft Cycles:10 Average:67.30 Median:62.00 stddev:11.15 (18.0%) stddev-sans-first:10.83 11:43:52 INFO - PROCESS | 1919 | Values: 80.0 60.0 59.0 89.0 61.0 62.0 62.0 60.0 80.0 60.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:79.00 stddev:10.10 (12.8%) stddev-sans-first:8.75 11:43:52 INFO - PROCESS | 1919 | Values: 94.0 73.0 88.0 69.0 69.0 71.0 88.0 69.0 68.0 85.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:43:52 INFO - PROCESS | 1919 | Values: 88.0 88.0 89.0 88.0 89.0 89.0 89.0 89.0 89.0 89.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:95.00 stddev:2.00 (2.1%) stddev-sans-first:2.11 11:43:52 INFO - PROCESS | 1919 | Values: 95.0 96.0 94.0 96.0 101.0 95.0 95.0 96.0 94.0 95.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:85.00 stddev:22.11 (26.0%) stddev-sans-first:22.25 11:43:52 INFO - PROCESS | 1919 | Values: 85.0 88.0 85.0 109.0 139.0 105.0 87.0 87.0 128.0 136.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 11:43:52 INFO - PROCESS | 1919 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 62.0 62.0 62.0 62.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:64.00 stddev:5.28 (8.2%) stddev-sans-first:5.27 11:43:52 INFO - PROCESS | 1919 | Values: 60.0 58.0 70.0 75.0 71.0 65.0 63.0 63.0 63.0 63.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:89.00 stddev:4.44 (5.0%) stddev-sans-first:4.59 11:43:52 INFO - PROCESS | 1919 | Values: 87.0 89.0 88.0 87.0 89.0 90.0 89.0 87.0 90.0 102.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:140.50 stddev:8.51 (6.1%) stddev-sans-first:9.02 11:43:52 INFO - PROCESS | 1919 | Values: 141.0 140.0 150.0 138.0 139.0 139.0 137.0 144.0 163.0 133.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:1.65 (1.0%) stddev-sans-first:1.50 11:43:52 INFO - PROCESS | 1919 | Values: 169.0 170.0 170.0 174.0 173.0 172.0 172.0 173.0 171.0 170.0 11:43:52 INFO - PROCESS | 1919 | 11:43:52 INFO - PROCESS | 1919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:8.37 (11.6%) stddev-sans-first:8.72 11:43:52 INFO - PROCESS | 1919 | Values: 68.0 71.0 84.0 84.0 84.0 73.0 65.0 65.0 66.0 65.0 11:43:52 INFO - PROCESS | 1919 | -------- Summary: end -------- 11:43:52 INFO - PROCESS | 1919 | 11:43:53 INFO - TEST-INFO | 1919: exit 0 11:43:53 INFO - TEST-OK | kraken | took 61449ms 11:43:53 INFO - SUITE-END | took 1182s 11:43:53 INFO - Completed test suite (00:19:42) 11:43:53 INFO - javascript benchmark 11:43:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6803.82191908809, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.5796346474954, 3238.0771480128165, 3245.2860370718436, 3286.1291757684235, 3289.8684052637896, 5414.8917021659645, 5482.862928426782, 5634.661920284786, 5670.4896559309655, 5697.515711164551, 5496.80761173359, 5522.530584900278, 5570.61005729598, 5576.609637325389, 5607.803726869561, 4994.150994330972, 4994.900101997958, 5063.341765570471, 5069.112905241586, 5141.1003074462005, 5218.817341393052, 5220.295260139889, 5247.921281180786, 5254.763535640886, 5263.236830659552, 4961.18140506816, 5011.997600479882, 5024.874378140539, 5070.72111033893, 5138.999999999981, 5044.419891712427, 5045.268436076785, 5056.544910957995, 5057.988402319551, 5060.0132974070075, 4963.0, 5000.474950130257, 5025.572826309768, 5034.169362055257, 5036.823711170092, 5462.371827239878, 5474.534664553517, 5482.835514934558, 5490.56075513958, 5492.862678433031, 5981.7906373277165, 5985.371535988746, 5988.700564971778, 5991.490723288525, 5991.820245392645, 6068.484178844804, 6087.726052327655, 6120.632762034292, 6129.172561704202, 6141.692915354259, 5632.127020311817, 5633.492985631272, 5659.037963546207, 5663.66018038919, 5677.630953987978, 6257.687115644199, 6277.686115694197, 6280.183576135073, 6291.1192433059405, 6297.590656607306, 5812.447817457335, 5851.151583020438, 5860.120981852756, 6074.514038876968, 6075.422834830684, 6084.361142080106, 6089.269287685506, 6097.481714054266, 6100.908486372708, 6104.328523862371, 6016.608920420159, 6023.698815059317, 6037.577369584087, 6041.516678665696, 6043.395660433922, 6002.129691194839, 6067.24159480065, 6075.149479072933, 6077.3314935357075, 6085.756569737249, 4763.499832517605, 4845.830395936126, 4876.122297986326, 4888.193448081098, 4927.285543596158, 4302.397664326997, 4306.418633484503, 4373.2565463871215, 4400.625946794495, 4468.955310446919, 5575.024370735106, 5624.015797235467, 5639.492445679908, 5640.32316122068, 5646.830595082154, 6008.8197354078575, 6101.542384321194, 6233.470155036873, 6252.280987686474, 6265.780697675559, 5520.558355331564, 5521.558275338044, 5562.276904002454, 5568.3318001839225, 5586.022446072003, 5291.365036195604, 5297.54970827484, 5301.867453313621, 5345.919811202835, 5384.515393614593, 6210.782622608187, 6289.119523266838, 6294.622322660655, 6307.369263073748, 6323.620582765049, 6214.9067763984485, 6217.409346112112, 6222.782202622887, 6225.0, 6230.43926046658, 6096.16386044079, 6115.027386288435, 6148.569600128127, 6251.281102673069, 6301.527385446201, 5952.494038006818, 5962.70186490665, 5966.522678185822, 5969.880602388015, 5980.521558275241, 5937.34689184198, 6061.454469097803, 6093.9085913712215, 6113.633182009094, 6114.938850611615, 4889.731064791471, 5749.655020698771, 5825.242718446744, 5832.62087964281, 5850.970745146247, 4521.773911304487, 5131.820386286462, 5750.597458177887, 5827.329857066492, 5944.1975333331175, 5682.460166284196, 5825.70871456434, 5830.096335068071, 5839.270091238595, 5869.853253668522, 5921.2006379138265, 5945.256842894638, 5950.702464876826, 5958.463738263577, 5966.492848107786, 5556.583256255878, 5594.440555944373, 5599.832005039855, 5629.352624448241, 5776.075827867521], "value": 5550.316264659186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.984940301194, 773.9613019349031, 840.0926998841252, 852.8933883264592, 853.5732133933034, 26526.602100968477, 27474.17577472674, 27497.450050998967, 36947.63052369475, 37246.510139594386, 38314.80842595783, 38448.0, 38470.615293847055, 38488.80755596225, 38520.61479385205, 9078.182963533282, 9185.862212066824, 9217.400868943498, 9221.723348299562, 9245.352825302198, 7276.963615181917, 7455.701771929116, 7461.962690186541, 9112.0, 9248.53757312135, 7390.852182956338, 7454.217307182749, 10766.676999690022, 10994.945025274863, 11015.394153321564, 10830.837537436944, 10903.34579925199, 10911.181661375429, 10912.399818010006, 10913.781724365548, 10632.946835265851, 10709.518071686793, 10710.625128120479, 10718.517666704938, 10722.356658600509, 25637.74362256372, 26095.0, 26110.86944565265, 26570.202893913214, 35622.46566301508, 3092.427900838352, 3759.172981943968, 3772.8302226399605, 3773.8301776420126, 3918.471006414126, 21367.931603419922, 21699.674504882438, 21723.891380542995, 21895.67156492654, 21973.450663733376, 3006.338605506785, 3007.6541197762317, 3026.8183908965534, 3042.604461420023, 3082.8458577071056, 328396.0, 331065.0, 332552.0, 333543.0, 333544.0, 47530.435217358834, 47600.761996189794, 47633.76183119062, 47634.76182619134, 47659.0, 40639.18721625551, 41278.79360603238, 41405.585944140774, 48754.0, 49617.0, 12825.486980520674, 12914.160579562298, 13118.95048396126, 13151.342432878319, 13155.473781048842, 9449.291303152291, 11285.210035297614, 11289.20975531705, 11296.661100167008, 11301.039411650101, 11205.0, 11239.325640461599, 11275.66173014811, 11333.489992950337, 11374.976252137181, 5149.510796474329, 5165.251038599382, 5198.870028249248, 5206.635535512478, 5231.293775340357, 847.5507980770202, 945.163530275711, 1010.3483253301579, 1013.8175128476797, 1030.7320096774743, 11593.826092608617, 14423.0, 14751.92624036873, 14798.408063677547, 15056.698866022618, 1083.6748975307376, 1084.159776173472, 1088.455772113943, 1100.878903320634, 1106.756513567014, 6037.426444487766, 7533.472656913963, 7566.31903128721, 7713.1515533291295, 7727.22727727234, 413058.0, 413203.0, 413899.0, 414237.85762141994, 414389.0, 50714.98570028579, 50718.0, 50824.0, 51019.0, 51085.48914510808, 1293.2369901758009, 1330.8402991641065, 1331.673739933742, 1332.6535100873843, 1334.739725753488, 14395.928020359832, 14419.423223071379, 14788.704225915637, 14945.626359341104, 14949.25253737287, 42366.72899813011, 42378.0, 42417.575824241365, 42506.78746606247, 42513.574864250964, 400633.0, 401803.0, 401906.0, 402601.0, 402614.0, 30155.547666785456, 30393.544096838123, 31046.84476577693, 31226.843865780527, 31339.05982820519, 39643.405348920365, 39849.00377490586, 40012.39981400223, 40118.0, 40355.0, 32849.0, 33411.83294083514, 34382.82808585941, 34654.653453465144, 34709.305813884086, 33051.67793288338, 33066.173345665586, 34232.82883585566, 34396.48405273873, 34453.96638100861, 32579.0, 32928.83535582307, 33262.16844578905, 33534.0, 33592.32815343728, 24695.876520618, 27480.900763970018, 29046.0, 29786.702132978393, 30298.84850575733, 18665.0, 21033.0, 21708.24021159315, 22469.66295505536, 22513.986870590536], "value": 16512.41287943036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.6204506065858, 357.59770258459235, 381.3117323231566, 395.58463613206146, 419.7691269801608, 13517.391717372717, 13562.457501699933, 19968.20127194912, 20156.294529691462, 21028.948552572387, 17753.7336939946, 20570.69143962842, 20981.790182098175, 21201.257955971505, 21409.464763380885, 5881.470667639912, 6230.501559875199, 6233.906491402633, 6237.500999920018, 6241.843953901143, 5734.770609175628, 5998.640081595118, 6039.245094363205, 6069.08963655453, 6161.753529858823, 6103.23709536308, 6110.725017374207, 6111.51107911366, 6115.174451449042, 6116.113163591277, 5863.384344643794, 6030.517558595324, 6106.297775755756, 6107.7556897724035, 6115.6330620162935, 5750.396208398141, 5849.707514624251, 5957.910631340534, 5964.284285885721, 5966.164736936832, 13192.6701832454, 13235.602931912059, 13442.185304983897, 13443.19340839543, 13456.461741530327, 2498.6376975338476, 2509.949801003988, 2543.4404431025146, 2548.9745102548923, 2599.7270286619823, 9650.565724542343, 9905.455199963999, 9922.958089400581, 9994.650187243484, 10165.59337626494, 1708.4789139312504, 1765.0429799426934, 1779.3416435918664, 1812.3837895115723, 1837.5083624470406, 105548.0, 108014.0, 109363.45318273437, 109814.90185098126, 109951.45024274828, 9551.570179341947, 11319.547218111184, 11595.188336816342, 11684.12369072306, 11937.462814173383, 13091.869081309256, 13765.655858603615, 13792.448302068005, 14093.295335233197, 14146.292685365896, 5811.738471768781, 5932.851678708067, 5940.970295148497, 6180.598261113013, 7679.731209407644, 7158.964205179045, 8070.112287648354, 8080.515169089874, 8150.429469937166, 8266.917330826614, 4731.4558825735485, 4771.9522804772205, 4772.737499437495, 4794.7362895040405, 4923.77842997066, 1813.8911665300125, 1913.6842421000379, 1947.2863879785698, 2005.959880802376, 2009.3770931011434, 879.824035192964, 887.0440678304324, 937.7327461673391, 1008.7982403519326, 1024.5594394410325, 19953.501162471053, 20098.89950550238, 21097.9451027448, 21237.46906327354, 21263.78736212649, 1012.7215015870695, 1024.3495380433478, 1067.9786404271872, 1070.0097818058405, 1073.7906108308962, 10257.705912076724, 10982.450877456095, 11057.286120651312, 11066.059384952368, 11071.280366776135, 566596.0, 603288.0, 652618.0, 658469.0, 659403.0, 109068.0, 120087.0, 143553.46697995384, 146132.0, 151827.0, 793.4604468961162, 982.2289502740315, 1020.505055048301, 1020.7652239984845, 1021.5249908792447, 15371.61570960735, 16922.830771692126, 17525.47423577295, 18190.9994950279, 18329.908350458696, 52629.68425789386, 54229.0, 54271.72864135654, 56135.59661008507, 57056.714716426155, 78640.0, 78785.8182127257, 80529.0, 80847.19152808632, 81336.0, 6637.037629543785, 8164.1019487857475, 8243.876341854757, 8306.169383061646, 8329.416940814328, 12182.695432614255, 12466.812997804858, 12611.558595449114, 12832.55086071983, 12886.420111094836, 10014.449205293779, 10169.288149829441, 10188.898111018794, 10308.587656493657, 11279.436028198721, 9034.728958131267, 10285.228607854591, 10628.681139565826, 11149.99650031501, 11215.847266785053, 11282.266652667551, 11571.958523732905, 11625.88374116248, 11649.76700465969, 11686.889745474165, 5925.377835327401, 7532.17146113938, 7623.161452240138, 7657.617119144132, 8347.95826020866, 9419.974705438364, 10771.299865508718, 11176.497057632263, 11196.776064478829, 11241.887581124083], "value": 9296.60757170018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.3390773290419, 1462.722082804267, 1478.963025924352, 1485.502356710502, 1492.6119209005658, 8081.8383632327395, 8476.872846907301, 8485.10906354833, 8493.490390576555, 8510.872336914952, 8090.555019473926, 8394.538300393491, 8415.326773858093, 8482.024567174776, 8490.91509084909, 1913.7129430585385, 2159.8380121490873, 2226.866388016724, 2230.408941630461, 2234.0, 1861.6090620969544, 2203.537257175995, 2237.5301186750803, 2244.5847518209102, 2244.9336565131593, 2188.4528867783056, 2197.9340619781433, 2215.7341119065736, 2220.2673117871063, 2224.477247846763, 1827.8994655293955, 1840.8803427777152, 2203.768604296542, 2206.415299945516, 2210.32585061557, 2122.7664956854733, 2222.0445208560313, 2222.2222222222254, 2226.087304205268, 2227.487677834091, 8367.037790654093, 8423.073461919184, 8425.789355266168, 8453.365997550147, 8455.027671817757, 4970.925436118425, 5114.105031619451, 5119.283300337956, 5127.0, 5131.3329267195395, 3202.903912882617, 3357.4460214064893, 3381.594208694972, 3434.742394320436, 3438.5186073949667, 959.3716115944068, 983.6311383231289, 1197.2038594334756, 1203.3921923834976, 1250.856151542566, 10559.102476289525, 10703.304285221435, 10792.352458852494, 10794.5682172713, 10800.973907478778, 4108.609682080198, 4271.0, 4354.042110735633, 4359.934600980988, 4363.956360436418, 8641.092685268082, 8652.826943461221, 8654.913450865537, 8659.134086591417, 8664.090270521505, 5008.29883816266, 5008.749562521859, 5012.298278241049, 5016.072026675077, 5022.296878437021, 3883.805809709503, 4478.776061196927, 4501.7524036177665, 4683.976580117078, 4695.389599352131, 3494.650534946485, 3521.154922818505, 3531.3643544161782, 3564.502908778319, 3581.659742324475, 1095.780843831237, 1099.6810924831868, 1104.0560320925654, 1104.9558017679203, 1115.0912006714664, 855.9657613695382, 876.6230520875957, 883.3110174064112, 917.9724608261763, 930.186087173723, 5275.894482110413, 5279.102552566073, 5458.808941687022, 5595.776168953196, 5615.971920140373, 469.5117078238662, 500.2396357536597, 553.7701853730657, 583.4544700704854, 584.2200662116122, 3100.8294543799857, 3630.1650620357464, 3635.2547727715755, 3653.5067765851268, 3790.8483660653815, 9511.476868772284, 9904.950475247577, 9919.454430006275, 9923.354981926152, 9930.106290433896, 9592.616295348247, 9684.757881052888, 9778.804423911482, 9898.10917017472, 9919.206463482904, 6198.6280823150755, 6787.898181527281, 7068.92931070693, 7069.116360454943, 7786.961065194524, 5300.946990530199, 5417.864553386197, 5709.0, 5790.768369265183, 5803.8549036274435, 8208.630611622371, 8923.776905577413, 8938.955305223431, 8961.596728147118, 9213.815723685622, 8999.550022498717, 9225.12361325673, 9240.0, 9299.395539289924, 9312.20846228051, 6495.935040649533, 6566.606003639797, 6576.704048317742, 6581.210254769267, 6591.406773390418, 7642.273983971514, 7701.845963080819, 7721.92278077212, 7761.185075566984, 7809.843803124019, 6470.48236141117, 6820.829479263058, 6980.965095174492, 7011.228764835966, 7065.6467176639935, 6428.903566446414, 6905.378515933389, 6970.268121847336, 7001.964990175016, 7024.1571011478945, 6198.1012753149635, 6314.1160237565855, 6315.179026726496, 6316.557840951089, 6325.0, 4666.883327916829, 4871.415430148405, 4893.574497851447, 4911.386076740408, 5064.5948324134715, 4347.021920067959, 4868.269759535956, 4990.4011518618, 5040.243963405518, 5101.770420331169], "value": 4201.598986644294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.8003557669724, 314.4795363673121, 342.6607658418165, 349.23169028138085, 365.10913371373846, 5049.873753156168, 5196.038732834423, 5382.2195781611745, 5444.2378067070595, 5489.835304940848, 4566.725996440216, 4866.58634016109, 5121.308623335858, 5323.1749078892735, 5372.973135134329, 3409.7613167078316, 3511.4030614795547, 4012.6990475714438, 4044.795586405416, 4056.65518430933, 3558.7864728116265, 3588.3899737044767, 3857.8812144478065, 4063.1106535461004, 4074.5314288856716, 3062.7702922280805, 3706.4440333949988, 3832.5698499842624, 3856.592343794509, 4047.271491131595, 3275.4922986937063, 3377.645347238529, 3432.5709286339206, 3806.8477260909667, 3996.800159992018, 2875.6980517045827, 3058.709422604849, 3462.480627905809, 3466.6706662866986, 3473.9826300868585, 4388.868333949987, 4867.610591152735, 5126.71803050832, 5149.794008239666, 5171.81898633546, 3992.9618299242115, 4192.517860446027, 4538.591526762574, 4588.518205588399, 4619.584237418615, 4971.967100068955, 5113.749950021978, 5601.635893666939, 5615.578831587606, 5698.7435565399655, 2889.436559870826, 3064.2798942248555, 3790.4503846942316, 3808.9809550952345, 3814.5803961564206, 4445.622122119624, 4872.8538143855385, 5479.479449452296, 5857.502112320458, 5907.911381329283, 3794.9241015180096, 3802.619738026175, 3814.5803961564206, 3835.980820095882, 3845.576986531479, 2993.012305939035, 3508.6842184203542, 3914.5320504810697, 3926.155876486569, 3943.743656662308, 4548.249538826123, 4564.972881101792, 4576.427946506687, 4585.449746030497, 4610.74640894754, 4411.779411029435, 4872.0, 5570.022641962126, 5643.943560564424, 5644.604877658607, 1142.6914733022038, 1228.4410593180082, 1258.452573130691, 1260.0801414966943, 1260.4328052376468, 807.3339494916718, 850.5917159763349, 863.2360361080489, 866.0, 872.0189786490198, 4901.779419926112, 4918.0, 4924.005777660053, 5048.495150484922, 5059.418166910778, 5015.673981191211, 5062.594992400599, 5135.87160320995, 5523.100372304572, 5610.923958135516, 4454.732716037048, 4463.799129039201, 4510.729356238636, 4846.927296090562, 5101.846944591668, 2390.8565486070893, 2460.7785299323145, 2742.766864816513, 2876.5685147228082, 2895.290653789793, 4928.704277743347, 5342.0, 5783.624064435882, 5841.7371218295275, 5887.999040163182, 4993.675411098267, 5075.644704870698, 5396.001739678172, 5459.47134802256, 5489.161131021073, 5122.385313762298, 5354.625176237704, 5445.237666726662, 5778.306603207558, 5880.8235752927485, 4693.0, 5116.718580478109, 5362.533234712077, 5636.408177141341, 5688.971555142198, 4824.517548245288, 5278.868028299324, 5420.858651260117, 5512.7519261634125, 5566.995881482744, 4755.881102972453, 4809.831655892027, 5222.582193424593, 5229.581633469389, 5825.960913680178, 3294.58817647794, 3686.5391826021746, 3733.8693145740854, 3735.6077611850365, 3748.175401411685, 5064.82273120439, 5313.4952179544425, 5487.146683724521, 5688.886222275614, 5859.384764599656, 5610.9158362623775, 5623.2127502148915, 5642.266505354278, 5671.631343962629, 5694.202811606461, 5208.906129712803, 5634.450296313296, 5651.897879913377, 5667.716614169358, 5698.743556539883, 4567.2692369222095, 5235.581153507786, 5239.47605239473, 5543.417941116125, 5545.112781954868, 4661.974365639554, 5598.776048958159, 5610.326760788732, 5664.320281566073, 5669.7165141741925, 3958.247932892741, 5263.263143159884, 5394.379646340721, 5429.67421954684, 5540.722963851872], "value": 3951.3400505944956, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.2294053600499, 694.3716983673285, 741.2550386861207, 807.64867282732, 848.3976376772491, 12182.390880455974, 12812.0, 13923.512677056306, 14294.857051429482, 15176.468823591176, 13676.384562694679, 13759.587212383645, 13763.793543096861, 13778.104423212484, 13785.448582056732, 886.6542048601051, 897.9236764874961, 898.6719847255754, 904.5793705926743, 907.8184363127401, 892.7143314139478, 894.1282249806452, 894.463322006794, 895.3374502867863, 907.9727608171765, 917.6375331743957, 941.90110038446, 949.4255975135047, 956.5456408206081, 957.3155194036262, 941.8493041113389, 944.5088553951906, 945.9243260539175, 946.2666433514013, 946.7964387656618, 667.2993356975205, 706.9858602827966, 707.3916431868589, 707.7664370757637, 709.8048036789872, 14795.038322509003, 14952.62618434537, 15018.174000429972, 15021.474248401362, 15219.771703424458, 13615.96781680335, 13694.863051369459, 13973.650658733512, 14019.088759230719, 14102.94227932909, 11319.264247823865, 11388.658340249805, 11546.826797598043, 11901.702457438547, 11947.820782688266, 3572.5712914450432, 3632.3824949758605, 3632.8365223565, 3651.72612054097, 3661.1945372018113, 93864.53067734686, 100700.49649751704, 101231.0, 103342.0, 104598.0, 10482.68551943443, 10491.94754026225, 10691.518881650345, 10715.624953126759, 10831.458427078773, 21944.0, 22256.99843507046, 22306.553868922532, 22332.665010024863, 22336.664950025763, 7424.554526728413, 7437.665305061177, 7444.516106453063, 7489.138749043821, 7670.117936437381, 3963.0884896473394, 4012.1373904610064, 4048.3117869962175, 4061.3501839706096, 4126.7523948563185, 3488.755787094879, 3559.4660800879556, 3576.5886923004186, 3585.049961760136, 3603.5855876574005, 615.7567760734485, 615.984600384985, 622.7726879688971, 623.7224435126416, 636.0776873533302, 639.2871947778194, 659.1957811469999, 669.8057563306586, 672.67711498481, 689.152342618582, 7692.807679807937, 8400.563836487472, 9340.486273255035, 9505.714828555154, 9651.9034809651, 541.6695815552509, 548.2461615278992, 590.9970450147722, 643.83904023994, 690.5235387582552, 4210.031692710693, 4403.9779801100785, 4600.401947746772, 4781.976090119527, 4783.521647835259, 72675.63662181655, 73836.0, 85675.57162214149, 91456.54271728599, 93335.0, 73425.0, 78212.6089369561, 79222.52947459793, 79545.06823976334, 80343.59828200821, 49614.0, 68373.0, 70284.29715702777, 72819.54360912752, 73127.0, 8346.499210047417, 8470.0, 8475.533845638549, 8568.186022327869, 8782.209601135928, 33669.0, 44754.55245447504, 45044.162883396195, 45872.31191532063, 46912.7654361726, 47303.52696473129, 58667.70666146642, 59228.70385648044, 61216.69391653013, 62276.0, 11229.550817967516, 11296.774064518828, 11376.431178441211, 11764.999152449258, 11947.044236461235, 12186.086043546593, 12195.939020305197, 12214.75570488603, 12287.324197169242, 12386.3187524687, 11439.0, 11440.313581185155, 11501.19491635611, 11661.883381166419, 11840.940795295968, 9372.48451335156, 10044.598216071276, 11279.492422841156, 11641.301521908374, 11904.345261010727, 11343.149263805413, 11451.25566838153, 11603.129765267808, 11962.70093247641, 12124.818127727915, 9216.815174767238, 9587.137157655565, 9707.077827606367, 9735.0, 9791.314607977658, 8665.17680820321, 9199.86200206984, 9274.211692005985, 9289.581968811555, 9480.715578532656], "value": 7012.330565570589, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1487.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 116.0, 114.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 110.0, 111.0, 176.0, 114.0, 113.0, 111.0, 111.0, 133.0, 110.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 242.0, 242.0, 181.0, 198.0, 232.0, 265.0, 202.0, 185.0], "value": 211.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 89.0, 61.0, 62.0, 62.0, 60.0, 80.0, 60.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 73.0, 88.0, 69.0, 69.0, 71.0, 88.0, 69.0, 68.0, 85.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 88.0, 89.0, 89.0, 89.0, 89.0, 89.0, 89.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 96.0, 101.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 85.0, 109.0, 139.0, 105.0, 87.0, 87.0, 128.0, 136.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 70.0, 75.0, 71.0, 65.0, 63.0, 63.0, 63.0, 63.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 88.0, 87.0, 89.0, 90.0, 89.0, 87.0, 90.0, 102.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 150.0, 138.0, 139.0, 139.0, 137.0, 144.0, 163.0, 133.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 170.0, 174.0, 173.0, 172.0, 172.0, 173.0, 171.0, 170.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 84.0, 84.0, 84.0, 73.0, 65.0, 65.0, 66.0, 65.0], "value": 72.5, "unit": "score"}]}]} 11:43:53 INFO - Return code: 0 11:43:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:43:53 ERROR - # TBPL SUCCESS # 11:43:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:43:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:43:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:43:53 INFO - 2017-02-26 11:43:53.742 screenresolution[1923:21134] starting screenresolution argv=screenresolution get 11:43:53 INFO - 2017-02-26 11:43:53.744 screenresolution[1923:21134] Display 0: 1600x1200x32@60 11:43:53 INFO - 2017-02-26 11:43:53.750 screenresolution[1924:21138] starting screenresolution argv=screenresolution list 11:43:53 INFO - Available Modes on Display 0 11:43:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:43:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:43:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:43:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:43:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:43:53 INFO - Intel Iris: 11:43:53 INFO - Chipset Model: Intel Iris 11:43:53 INFO - Type: GPU 11:43:53 INFO - Bus: Built-In 11:43:53 INFO - VRAM (Dynamic, Max): 1536 MB 11:43:53 INFO - Vendor: Intel (0x8086) 11:43:53 INFO - Device ID: 0x0a2e 11:43:53 INFO - Revision ID: 0x0009 11:43:53 INFO - Displays: 11:43:53 INFO - Display: 11:43:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:43:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:43:53 INFO - Display Serial Number: 1600x1200 60 11:43:53 INFO - Main Display: Yes 11:43:53 INFO - Mirror: Off 11:43:53 INFO - Online: Yes 11:43:53 INFO - Rotation: Supported 11:43:53 INFO - Return code: 0 11:43:54 INFO - Running post-action listener: _resource_record_post_action 11:43:54 INFO - [mozharness: 2017-02-26 19:43:54.000324Z] Finished run-tests step (success) 11:43:54 INFO - Running post-run listener: _resource_record_post_run 11:43:54 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 946176; Write bytes: 514670592; Read time: 8; Write time: 1609 11:43:54 INFO - TinderboxPrint: CPU usage
53.6% 11:43:54 INFO - TinderboxPrint: I/O read bytes / time
946,176 / 8 11:43:54 INFO - TinderboxPrint: I/O write bytes / time
514,670,592 / 1,609 11:43:54 INFO - TinderboxPrint: CPU idle
2,233.9 (46.4%) 11:43:54 INFO - TinderboxPrint: CPU system
960.0 (19.9%) 11:43:54 INFO - TinderboxPrint: CPU user
1,619.9 (33.7%) 11:43:54 INFO - TinderboxPrint: Swap in / out
211,439,616 / 0 11:43:54 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201787904; Write bytes: 203302912; Read time: 15749; Write time: 443 11:43:54 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 946176; Write bytes: 299358208; Read time: 8; Write time: 1125 11:43:54 INFO - Running post-run listener: _upload_blobber_files 11:43:54 INFO - Blob upload gear active. 11:43:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:43: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 11:43: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'] 11:43: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 11:43:54 INFO - (blobuploader) - INFO - Open directory for files ... 11:43:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:43:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:43:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:55 INFO - (blobuploader) - INFO - Done attempting. 11:43:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:43:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:43:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:56 INFO - (blobuploader) - INFO - Done attempting. 11:43:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:43:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:43:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:57 INFO - (blobuploader) - INFO - Done attempting. 11:43:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:43:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:59 INFO - (blobuploader) - INFO - Done attempting. 11:43:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:43:59 INFO - Return code: 0 11:43:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:43:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:43:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8765c5af0ef9a11a12a6a0e148fed78870079350f07e80acefc172d97f5d1b81d71aad606d363de01519c42f54e4d95e252ecfe17486fa3c880151d13cc1374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aebe87b232e73add57b4d9bded0669d0317f45e2f3acfb7073fe58d9faa5223e54a6a982d1721f18c99bfd8778446500937f79444c5b64ce150bced401af1222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e88b227c581732003a89e01aa2d9b48657cae5436945d5c038511304c94864db8a4a6d1fceb71ee636a69a1de7651a74f1781328ab1a520654be9dae1b514d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb9e00d95433a03753c778ceab16f20157bfb7e737ce245adb9dfb936de4ed0c5b78f762b52f8bbcc4257acb3c1d9100ad7753694088a6f506346b7bcc54270"} 11:43:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:43:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:43:59 INFO - Contents: 11:43:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8765c5af0ef9a11a12a6a0e148fed78870079350f07e80acefc172d97f5d1b81d71aad606d363de01519c42f54e4d95e252ecfe17486fa3c880151d13cc1374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aebe87b232e73add57b4d9bded0669d0317f45e2f3acfb7073fe58d9faa5223e54a6a982d1721f18c99bfd8778446500937f79444c5b64ce150bced401af1222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e88b227c581732003a89e01aa2d9b48657cae5436945d5c038511304c94864db8a4a6d1fceb71ee636a69a1de7651a74f1781328ab1a520654be9dae1b514d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb9e00d95433a03753c778ceab16f20157bfb7e737ce245adb9dfb936de4ed0c5b78f762b52f8bbcc4257acb3c1d9100ad7753694088a6f506346b7bcc54270"} 11:43:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:43:59 INFO - Copying logs to upload dir... 11:43:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:43:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.367617 ========= master_lag: -0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-26 11:43:59.754591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 11:43:59.758505) ========= 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.KmZCqNbr9z/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.asYLlMeRdV/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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/d8765c5af0ef9a11a12a6a0e148fed78870079350f07e80acefc172d97f5d1b81d71aad606d363de01519c42f54e4d95e252ecfe17486fa3c880151d13cc1374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aebe87b232e73add57b4d9bded0669d0317f45e2f3acfb7073fe58d9faa5223e54a6a982d1721f18c99bfd8778446500937f79444c5b64ce150bced401af1222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e88b227c581732003a89e01aa2d9b48657cae5436945d5c038511304c94864db8a4a6d1fceb71ee636a69a1de7651a74f1781328ab1a520654be9dae1b514d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb9e00d95433a03753c778ceab16f20157bfb7e737ce245adb9dfb936de4ed0c5b78f762b52f8bbcc4257acb3c1d9100ad7753694088a6f506346b7bcc54270"} build_url:https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/afAACs2_QaW1yF9A8T5iBA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8765c5af0ef9a11a12a6a0e148fed78870079350f07e80acefc172d97f5d1b81d71aad606d363de01519c42f54e4d95e252ecfe17486fa3c880151d13cc1374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aebe87b232e73add57b4d9bded0669d0317f45e2f3acfb7073fe58d9faa5223e54a6a982d1721f18c99bfd8778446500937f79444c5b64ce150bced401af1222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e88b227c581732003a89e01aa2d9b48657cae5436945d5c038511304c94864db8a4a6d1fceb71ee636a69a1de7651a74f1781328ab1a520654be9dae1b514d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb9e00d95433a03753c778ceab16f20157bfb7e737ce245adb9dfb936de4ed0c5b78f762b52f8bbcc4257acb3c1d9100ad7753694088a6f506346b7bcc54270"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 11:43:59.793103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:43:59.793436) ========= 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.KmZCqNbr9z/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.asYLlMeRdV/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.004840 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 11:43:59.841836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 11:43:59.842155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 11:43:59.842520) ========= ========= Total master_lag: -0.00 =========