builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1485106615.14 results: success (0) buildid: 20170122084825 builduid: 6b04244f4f564349b392dae9c6c20601 revision: bd0cd9af94d9334b862d9891013fed56fb9b3b7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.137897) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.138340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.138648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.168813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.169101) ========= 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.FPpecVvAkq/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.5RrfImNtEL/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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-01-22 09:36:55-- 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% 159M=0s 2017-01-22 09:36:55 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.634542 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.829674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.829997) ========= 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.FPpecVvAkq/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.5RrfImNtEL/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.025502 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:55.878228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-22 09:36:55.878612) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bd0cd9af94d9334b862d9891013fed56fb9b3b7c --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 bd0cd9af94d9334b862d9891013fed56fb9b3b7c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FPpecVvAkq/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.5RrfImNtEL/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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-01-22 09:36:55,987 truncating revision to first 12 chars 2017-01-22 09:36:55,987 Setting DEBUG logging. 2017-01-22 09:36:55,987 attempt 1/10 2017-01-22 09:36:55,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bd0cd9af94d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-22 09:36:57,030 unpacking tar archive at: mozilla-central-bd0cd9af94d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.326612 ========= master_lag: 0.62 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-22 09:36:57.825832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:57.826108) ========= script_repo_revision: bd0cd9af94d9334b862d9891013fed56fb9b3b7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:57.826488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:57.826759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 09:36:57.892451) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-22 09:36:57.894261) ========= /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.FPpecVvAkq/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.5RrfImNtEL/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:36:58 INFO - MultiFileLogger online at 20170122 09:36:58 in /builds/slave/test 09:36:58 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 09:36:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:36:58 INFO - {'append_to_log': False, 09:36:58 INFO - 'base_work_dir': '/builds/slave/test', 09:36:58 INFO - 'blob_upload_branch': 'Firefox', 09:36:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:36:58 INFO - 'branch': 'Firefox', 09:36:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:36:58 INFO - 'config_files': ('talos/mac_config.py',), 09:36:58 INFO - 'default_actions': ('clobber', 09:36:58 INFO - 'read-buildbot-config', 09:36:58 INFO - 'download-and-extract', 09:36:58 INFO - 'populate-webroot', 09:36:58 INFO - 'create-virtualenv', 09:36:58 INFO - 'install', 09:36:58 INFO - 'run-tests'), 09:36:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:36:58 INFO - 'download_minidump_stackwalk': True, 09:36:58 INFO - 'download_symbols': 'ondemand', 09:36:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:36:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:36:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:36:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:36:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:36:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:36:58 INFO - 'installer_path': 'installer.exe', 09:36:58 INFO - 'log_level': 'info', 09:36:58 INFO - 'log_name': 'talos', 09:36:58 INFO - 'log_to_console': True, 09:36:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:36:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:36:58 INFO - 'opt_config_files': (), 09:36:58 INFO - 'pip_index': False, 09:36:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:36:58 INFO - 'cmd': ('bash', 09:36:58 INFO - '-c', 09:36:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:36:58 INFO - 'enabled': True, 09:36:58 INFO - 'halt_on_failure': False, 09:36:58 INFO - 'name': 'check_screen_resolution'},), 09:36:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:36:58 INFO - 'cmd': ('bash', 09:36:58 INFO - '-c', 09:36:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:36:58 INFO - 'enabled': True, 09:36:58 INFO - 'halt_on_failure': False, 09:36:58 INFO - 'name': 'check_screen_resolution'},), 09:36:58 INFO - 'run_cmd_checks_enabled': True, 09:36:58 INFO - 'sps_profile': False, 09:36:58 INFO - 'sps_profile_interval': 0, 09:36:58 INFO - 'suite': 'dromaeojs', 09:36:58 INFO - 'system_bits': '32', 09:36:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:36:58 INFO - 'title': 't-yosemite-r7-0263', 09:36:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:36:58 INFO - 'use_talos_json': True, 09:36:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:36:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:36:58 INFO - 'work_dir': 'build'} 09:36:58 INFO - [mozharness: 2017-01-22 17:36:58.114439Z] Running clobber step. 09:36:58 INFO - Running pre-action listener: _resource_record_pre_action 09:36:58 INFO - Running main action method: clobber 09:36:58 INFO - rmtree: /builds/slave/test/build 09:36:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:00 INFO - Running post-action listener: _resource_record_post_action 09:37:00 INFO - [mozharness: 2017-01-22 17:37:00.514173Z] Finished clobber step (success) 09:37:00 INFO - [mozharness: 2017-01-22 17:37:00.514332Z] Running read-buildbot-config step. 09:37:00 INFO - Running pre-action listener: _resource_record_pre_action 09:37:00 INFO - Running main action method: read_buildbot_config 09:37:00 INFO - Using buildbot properties: 09:37:00 INFO - { 09:37:00 INFO - "project": "", 09:37:00 INFO - "product": "firefox", 09:37:00 INFO - "script_repo_revision": "production", 09:37:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:37:00 INFO - "repository": "", 09:37:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:37:00 INFO - "buildid": "20170122084825", 09:37:00 INFO - "pgo_build": "False", 09:37:00 INFO - "basedir": "/builds/slave/test", 09:37:00 INFO - "buildnumber": 30, 09:37:00 INFO - "slavename": "t-yosemite-r7-0263", 09:37:00 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:37:00 INFO - "platform": "yosemite_r7", 09:37:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:37:00 INFO - "branch": "mozilla-central", 09:37:00 INFO - "repo_path": "mozilla-central", 09:37:00 INFO - "revision": "bd0cd9af94d9334b862d9891013fed56fb9b3b7c", 09:37:00 INFO - "stage_platform": "macosx64", 09:37:00 INFO - "builduid": "6b04244f4f564349b392dae9c6c20601", 09:37:00 INFO - "slavebuilddir": "test" 09:37:00 INFO - } 09:37:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:37:00 INFO - Running post-action listener: _resource_record_post_action 09:37:00 INFO - [mozharness: 2017-01-22 17:37:00.517764Z] Finished read-buildbot-config step (success) 09:37:00 INFO - [mozharness: 2017-01-22 17:37:00.517865Z] Running download-and-extract step. 09:37:00 INFO - Running pre-action listener: _resource_record_pre_action 09:37:00 INFO - Running main action method: download_and_extract 09:37:00 INFO - mkdir: /builds/slave/test/build/tests 09:37:00 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')]} 09:37:00 INFO - trying https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:37:00 INFO - Downloading https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:37:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 09:37:01 INFO - Downloaded 1199 bytes. 09:37:01 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:37:01 INFO - Using the following test package requirements: 09:37:01 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:37:01 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:37:01 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:37:01 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'jsshell-mac.zip'], 09:37:01 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:37:01 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:37:01 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:37:01 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:37:01 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:37:01 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:37:01 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:37:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:37:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:37:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:37:01 INFO - Fetch https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:37:02 INFO - Expected file size: 16350813 09:37:02 INFO - Obtained file size: 16350813 09:37:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:37:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:37:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:37:09 INFO - Fetch https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:37:10 INFO - Expected file size: 16350813 09:37:10 INFO - Obtained file size: 16350813 09:37:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:37:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:37:16 INFO - Fetch https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:37:18 INFO - Expected file size: 14403485 09:37:18 INFO - Obtained file size: 14403485 09:37:18 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')]} 09:37:18 INFO - trying https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:37:18 INFO - Downloading https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:37:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 09:37:20 INFO - Downloaded 69964131 bytes. 09:37:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:37:20 INFO - mkdir: /builds/slave/test/properties 09:37:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:20 INFO - Contents: 09:37:20 INFO - build_url:https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:37:21 INFO - Running post-action listener: _resource_record_post_action 09:37:21 INFO - Running post-action listener: set_extra_try_arguments 09:37:21 INFO - [mozharness: 2017-01-22 17:37:21.465013Z] Finished download-and-extract step (success) 09:37:21 INFO - [mozharness: 2017-01-22 17:37:21.465138Z] Running populate-webroot step. 09:37:21 INFO - Running pre-action listener: _resource_record_pre_action 09:37:21 INFO - Running main action method: populate_webroot 09:37:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:21 INFO - '--tppagecycles', 09:37:21 INFO - '7'], 09:37:21 INFO - 'tests': ['tsvgm']}}, 09:37:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:37:21 INFO - 'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:37:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:37:21 INFO - 'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['damp', 'tps']}, 09:37:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:37:21 INFO - 'tests': ['damp', 'tps']}, 09:37:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['dromaeo_dom']}, 09:37:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['basic_compositor_video']}, 09:37:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:37:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['a11yr', 09:37:21 INFO - 'ts_paint', 09:37:21 INFO - 'tpaint', 09:37:21 INFO - 'sessionrestore', 09:37:21 INFO - 'sessionrestore_no_auto_restore', 09:37:21 INFO - 'tabpaint']}, 09:37:21 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:21 INFO - 'ts_paint', 09:37:21 INFO - 'tpaint', 09:37:21 INFO - 'sessionrestore', 09:37:21 INFO - 'sessionrestore_no_auto_restore', 09:37:21 INFO - 'tabpaint']}, 09:37:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:37:21 INFO - 'ts_paint', 09:37:21 INFO - 'tpaint', 09:37:21 INFO - 'sessionrestore', 09:37:21 INFO - 'sessionrestore_no_auto_restore', 09:37:21 INFO - 'tabpaint']}, 09:37:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:37:21 INFO - 'ts_paint', 09:37:21 INFO - 'tpaint', 09:37:21 INFO - 'sessionrestore', 09:37:21 INFO - 'sessionrestore_no_auto_restore', 09:37:21 INFO - 'tabpaint']}, 09:37:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['a11yr', 09:37:21 INFO - 'ts_paint', 09:37:21 INFO - 'tpaint', 09:37:21 INFO - 'sessionrestore', 09:37:21 INFO - 'sessionrestore_no_auto_restore', 09:37:21 INFO - 'tabpaint']}, 09:37:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['a11yr', 09:37:21 INFO - 'ts_paint', 09:37:21 INFO - 'tpaint', 09:37:21 INFO - 'sessionrestore', 09:37:21 INFO - 'sessionrestore_no_auto_restore', 09:37:21 INFO - 'tabpaint']}, 09:37:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['tsvgx', 09:37:21 INFO - 'tsvgr_opacity', 09:37:21 INFO - 'tart', 09:37:21 INFO - 'tscrollx', 09:37:21 INFO - 'cart', 09:37:21 INFO - 'tsvg_static']}, 09:37:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:21 INFO - 'tsvgr_opacity', 09:37:21 INFO - 'tart', 09:37:21 INFO - 'tscrollx', 09:37:21 INFO - 'cart', 09:37:21 INFO - 'tsvg_static']}, 09:37:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:37:21 INFO - 'talos_options': ['--disable-e10s'], 09:37:21 INFO - 'tests': ['tp5o']}, 09:37:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:37:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:37:21 INFO - 'talos_options': ['--disable-e10s', 09:37:21 INFO - '--xperf_path', 09:37:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:21 INFO - 'tests': ['tp5n']}, 09:37:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:37:21 INFO - 'talos_options': ['--xperf_path', 09:37:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:21 INFO - 'tests': ['tp5n']}}, 09:37:21 INFO - 'talos.zip': {'path': '', 09:37:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:21 INFO - Running post-action listener: _resource_record_post_action 09:37:21 INFO - [mozharness: 2017-01-22 17:37:21.483210Z] Finished populate-webroot step (success) 09:37:21 INFO - [mozharness: 2017-01-22 17:37:21.483321Z] Running create-virtualenv step. 09:37:21 INFO - Running pre-action listener: _resource_record_pre_action 09:37:21 INFO - Running main action method: create_virtualenv 09:37:21 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:21 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 09:37:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:21 INFO - Using real prefix '/tools/python27' 09:37:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:25 INFO - Installing pip.................done. 09:37:25 INFO - Return code: 0 09:37:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:37:25 INFO - Reading from file tmpfile_stdout 09:37:25 INFO - Output received: 09:37:25 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) 09:37:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:25 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')]} 09:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:25 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')]} 09:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:25 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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:25 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 09:37:25 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 09:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:25 INFO - 'HOME': '/Users/cltbld', 09:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:25 INFO - 'LOGNAME': 'cltbld', 09:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:25 INFO - 'MOZ_NO_REMOTE': '1', 09:37:25 INFO - 'NO_EM_RESTART': '1', 09:37:25 INFO - 'PAGER': '/bin/cat', 09:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:25 INFO - 'PWD': '/builds/slave/test', 09:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:25 INFO - 'SHELL': '/bin/bash', 09:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:25 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:25 INFO - 'USER': 'cltbld', 09:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:25 INFO - 'XPC_FLAGS': '0x0', 09:37:25 INFO - 'XPC_SERVICE_NAME': '0', 09:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:25 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 09:37:25 INFO - Cleaning up... 09:37:25 INFO - Return code: 0 09:37:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:25 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')]} 09:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:25 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')]} 09:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:25 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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:25 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 09:37:25 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 09:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:25 INFO - 'HOME': '/Users/cltbld', 09:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:25 INFO - 'LOGNAME': 'cltbld', 09:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:25 INFO - 'MOZ_NO_REMOTE': '1', 09:37:25 INFO - 'NO_EM_RESTART': '1', 09:37:25 INFO - 'PAGER': '/bin/cat', 09:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:25 INFO - 'PWD': '/builds/slave/test', 09:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:25 INFO - 'SHELL': '/bin/bash', 09:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:25 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:25 INFO - 'USER': 'cltbld', 09:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:25 INFO - 'XPC_FLAGS': '0x0', 09:37:25 INFO - 'XPC_SERVICE_NAME': '0', 09:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:25 INFO - Downloading/unpacking psutil>=3.1.1 09:37:25 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 09:37:25 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 09:37:25 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 09:37:25 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 09:37:25 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 09:37:25 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 09:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:29 INFO - Installing collected packages: psutil 09:37:29 INFO - Running setup.py install for psutil 09:37:29 INFO - building 'psutil._psutil_osx' extension 09:37:29 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 09:37:30 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 09:37:30 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 09:37:30 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 09:37:30 INFO - building 'psutil._psutil_posix' extension 09:37:30 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 09:37:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:37:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:37:30 INFO - ^ 09:37:30 INFO - 1 warning generated. 09:37:30 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 09:37:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:30 INFO - Successfully installed psutil 09:37:30 INFO - Cleaning up... 09:37:31 INFO - Return code: 0 09:37:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:31 INFO - 'HOME': '/Users/cltbld', 09:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:31 INFO - 'LOGNAME': 'cltbld', 09:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:31 INFO - 'MOZ_NO_REMOTE': '1', 09:37:31 INFO - 'NO_EM_RESTART': '1', 09:37:31 INFO - 'PAGER': '/bin/cat', 09:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:31 INFO - 'PWD': '/builds/slave/test', 09:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:31 INFO - 'SHELL': '/bin/bash', 09:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:31 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:31 INFO - 'USER': 'cltbld', 09:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:31 INFO - 'XPC_FLAGS': '0x0', 09:37:31 INFO - 'XPC_SERVICE_NAME': '0', 09:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:37:33 INFO - Installing collected packages: mozsystemmonitor 09:37:33 INFO - Running setup.py install for mozsystemmonitor 09:37:34 INFO - Successfully installed mozsystemmonitor 09:37:34 INFO - Cleaning up... 09:37:34 INFO - Return code: 0 09:37:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:34 INFO - 'HOME': '/Users/cltbld', 09:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:34 INFO - 'LOGNAME': 'cltbld', 09:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:34 INFO - 'MOZ_NO_REMOTE': '1', 09:37:34 INFO - 'NO_EM_RESTART': '1', 09:37:34 INFO - 'PAGER': '/bin/cat', 09:37:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:34 INFO - 'PWD': '/builds/slave/test', 09:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:34 INFO - 'SHELL': '/bin/bash', 09:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:34 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:34 INFO - 'USER': 'cltbld', 09:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:34 INFO - 'XPC_FLAGS': '0x0', 09:37:34 INFO - 'XPC_SERVICE_NAME': '0', 09:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:37 INFO - warning: no files found matching '*.txt' 09:37:37 INFO - no previously-included directories found matching 'build' 09:37:37 INFO - no previously-included directories found matching 'dist' 09:37:37 INFO - no previously-included directories found matching '.git*' 09:37:37 INFO - Installing collected packages: jsonschema, functools32 09:37:37 INFO - Running setup.py install for functools32 09:37:37 INFO - warning: no files found matching '*.txt' 09:37:37 INFO - no previously-included directories found matching 'build' 09:37:37 INFO - no previously-included directories found matching 'dist' 09:37:37 INFO - no previously-included directories found matching '.git*' 09:37:37 INFO - Successfully installed jsonschema functools32 09:37:37 INFO - Cleaning up... 09:37:37 INFO - Return code: 0 09:37:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:37:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:37 INFO - 'HOME': '/Users/cltbld', 09:37:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:37 INFO - 'LOGNAME': 'cltbld', 09:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:37 INFO - 'MOZ_NO_REMOTE': '1', 09:37:37 INFO - 'NO_EM_RESTART': '1', 09:37:37 INFO - 'PAGER': '/bin/cat', 09:37:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:37 INFO - 'PWD': '/builds/slave/test', 09:37:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:37 INFO - 'SHELL': '/bin/bash', 09:37:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:37 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:37 INFO - 'USER': 'cltbld', 09:37:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:37 INFO - 'XPC_FLAGS': '0x0', 09:37:37 INFO - 'XPC_SERVICE_NAME': '0', 09:37:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:37:38 INFO - Cleaning up... 09:37:38 INFO - Return code: 0 09:37:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:38 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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:38 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 09:37:38 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 09:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:38 INFO - 'HOME': '/Users/cltbld', 09:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:38 INFO - 'LOGNAME': 'cltbld', 09:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:38 INFO - 'MOZ_NO_REMOTE': '1', 09:37:38 INFO - 'NO_EM_RESTART': '1', 09:37:38 INFO - 'PAGER': '/bin/cat', 09:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:38 INFO - 'PWD': '/builds/slave/test', 09:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:38 INFO - 'SHELL': '/bin/bash', 09:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:38 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:38 INFO - 'USER': 'cltbld', 09:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:38 INFO - 'XPC_FLAGS': '0x0', 09:37:38 INFO - 'XPC_SERVICE_NAME': '0', 09:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:37:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:42 INFO - Downloading docopt-0.6.1.tar.gz 09:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:42 INFO - Running setup.py install for blobuploader 09:37:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:37:42 INFO - Running setup.py install for requests 09:37:43 INFO - Running setup.py install for docopt 09:37:43 INFO - Successfully installed blobuploader requests docopt 09:37:43 INFO - Cleaning up... 09:37:43 INFO - Return code: 0 09:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:43 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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:43 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 09:37:43 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 09:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:43 INFO - 'HOME': '/Users/cltbld', 09:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:43 INFO - 'LOGNAME': 'cltbld', 09:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:43 INFO - 'MOZ_NO_REMOTE': '1', 09:37:43 INFO - 'NO_EM_RESTART': '1', 09:37:43 INFO - 'PAGER': '/bin/cat', 09:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:43 INFO - 'PWD': '/builds/slave/test', 09:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:43 INFO - 'SHELL': '/bin/bash', 09:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:43 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:43 INFO - 'USER': 'cltbld', 09:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:43 INFO - 'XPC_FLAGS': '0x0', 09:37:43 INFO - 'XPC_SERVICE_NAME': '0', 09:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:43 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-0nl8cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:43 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-4YX9Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:43 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-A6SxX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:43 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NAr3_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-QtCoXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-LgjCyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NnxkZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-dnkZ_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-2YJywH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-gn8_NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-9pprUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-BgQfzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-nwu8rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:44 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ThwZkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:45 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-xd5afq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:45 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-GQjz8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:45 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-RDk2pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:45 INFO - Running setup.py install for manifestparser 09:37:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Running setup.py install for mozcrash 09:37:45 INFO - Running setup.py install for mozdebug 09:37:45 INFO - Running setup.py install for mozdevice 09:37:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for mozfile 09:37:46 INFO - Running setup.py install for mozhttpd 09:37:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for mozinfo 09:37:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for mozInstall 09:37:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for mozleak 09:37:46 INFO - Running setup.py install for mozlog 09:37:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for moznetwork 09:37:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:37:47 INFO - Running setup.py install for mozprocess 09:37:47 INFO - Running setup.py install for mozprofile 09:37:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:37:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:37:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:37:47 INFO - Running setup.py install for mozrunner 09:37:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:37:47 INFO - Running setup.py install for mozscreenshot 09:37:47 INFO - Running setup.py install for moztest 09:37:47 INFO - Running setup.py install for mozversion 09:37:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:37:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:47 INFO - Cleaning up... 09:37:47 INFO - Return code: 0 09:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:47 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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:47 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 09:37:47 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 09:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:47 INFO - 'HOME': '/Users/cltbld', 09:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:47 INFO - 'LOGNAME': 'cltbld', 09:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:47 INFO - 'MOZ_NO_REMOTE': '1', 09:37:47 INFO - 'NO_EM_RESTART': '1', 09:37:47 INFO - 'PAGER': '/bin/cat', 09:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:47 INFO - 'PWD': '/builds/slave/test', 09:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:47 INFO - 'SHELL': '/bin/bash', 09:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:47 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:47 INFO - 'USER': 'cltbld', 09:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:47 INFO - 'XPC_FLAGS': '0x0', 09:37:47 INFO - 'XPC_SERVICE_NAME': '0', 09:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-PM_RMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-9Wu0yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-BbjT0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-mG5l0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-FIY8t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-RjToGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-v7QvJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:48 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-WJWQrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-CnEBix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tBIa74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-5eu8Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-cw0gIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-7bK7J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-4sMYGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-WfAy5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-cA1ZqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:49 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-zjmOKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:50 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)) 09:37:50 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)) 09:37:50 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)) 09:37:50 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)) 09:37:50 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)) 09:37:50 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)) 09:37:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:52 INFO - Downloading blessings-1.6.tar.gz 09:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:37:52 INFO - Installing collected packages: blessings 09:37:52 INFO - Running setup.py install for blessings 09:37:52 INFO - Successfully installed blessings 09:37:52 INFO - Cleaning up... 09:37:53 INFO - Return code: 0 09:37:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:37:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:53 INFO - Reading from file tmpfile_stdout 09:37:53 INFO - Current package versions: 09:37:53 INFO - blessings == 1.6 09:37:53 INFO - blobuploader == 1.2.4 09:37:53 INFO - docopt == 0.6.1 09:37:53 INFO - functools32 == 3.2.3-2 09:37:53 INFO - jsonschema == 2.5.1 09:37:53 INFO - manifestparser == 1.1 09:37:53 INFO - mozInstall == 1.12 09:37:53 INFO - mozcrash == 1.0 09:37:53 INFO - mozdebug == 0.1 09:37:53 INFO - mozdevice == 0.49 09:37:53 INFO - mozfile == 1.2 09:37:53 INFO - mozhttpd == 0.7 09:37:53 INFO - mozinfo == 0.9 09:37:53 INFO - mozleak == 0.1 09:37:53 INFO - mozlog == 3.4 09:37:53 INFO - moznetwork == 0.27 09:37:53 INFO - mozprocess == 0.24 09:37:53 INFO - mozprofile == 0.28 09:37:53 INFO - mozrunner == 6.13 09:37:53 INFO - mozscreenshot == 0.1 09:37:53 INFO - mozsystemmonitor == 0.3 09:37:53 INFO - moztest == 0.8 09:37:53 INFO - mozversion == 1.4 09:37:53 INFO - psutil == 3.1.1 09:37:53 INFO - requests == 1.2.3 09:37:53 INFO - wsgiref == 0.1.2 09:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 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 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:53 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 09:37:53 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 09:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:53 INFO - 'HOME': '/Users/cltbld', 09:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:53 INFO - 'LOGNAME': 'cltbld', 09:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:53 INFO - 'MOZ_NO_REMOTE': '1', 09:37:53 INFO - 'NO_EM_RESTART': '1', 09:37:53 INFO - 'PAGER': '/bin/cat', 09:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:53 INFO - 'PWD': '/builds/slave/test', 09:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:53 INFO - 'SHELL': '/bin/bash', 09:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:53 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:53 INFO - 'USER': 'cltbld', 09:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:53 INFO - 'XPC_FLAGS': '0x0', 09:37:53 INFO - 'XPC_SERVICE_NAME': '0', 09:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 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)) 09:37:53 INFO - Cleaning up... 09:37:53 INFO - Return code: 0 09:37:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c92b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c95768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbff1d5dee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, '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.FPpecVvAkq/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.5RrfImNtEL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 09:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:53 INFO - 'HOME': '/Users/cltbld', 09:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:53 INFO - 'LOGNAME': 'cltbld', 09:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:53 INFO - 'MOZ_NO_REMOTE': '1', 09:37:53 INFO - 'NO_EM_RESTART': '1', 09:37:53 INFO - 'PAGER': '/bin/cat', 09:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:53 INFO - 'PWD': '/builds/slave/test', 09:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:53 INFO - 'SHELL': '/bin/bash', 09:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:37:53 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:53 INFO - 'USER': 'cltbld', 09:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:53 INFO - 'XPC_FLAGS': '0x0', 09:37:53 INFO - 'XPC_SERVICE_NAME': '0', 09:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:37:53 INFO - Cleaning up... 09:37:53 INFO - Return code: 0 09:37:53 INFO - Running post-action listener: _resource_record_post_action 09:37:53 INFO - Running post-action listener: _start_resource_monitoring 09:37:53 INFO - Starting resource monitoring. 09:37:53 INFO - [mozharness: 2017-01-22 17:37:53.896000Z] Finished create-virtualenv step (success) 09:37:53 INFO - [mozharness: 2017-01-22 17:37:53.897056Z] Running install step. 09:37:53 INFO - Running pre-action listener: _resource_record_pre_action 09:37:53 INFO - Running main action method: install 09:37:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:54 INFO - Reading from file tmpfile_stdout 09:37:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:37:54 INFO - Reading from file tmpfile_stdout 09:37:54 INFO - Output received: 09:37:54 INFO - Usage: mozinstall [options] installer 09:37:54 INFO - Options: 09:37:54 INFO - -h, --help show this help message and exit 09:37:54 INFO - -d DEST, --destination=DEST 09:37:54 INFO - Directory to install application into. [default: 09:37:54 INFO - "/builds/slave/test"] 09:37:54 INFO - --app=APP Application being installed. [default: firefox] 09:37:54 INFO - mkdir: /builds/slave/test/build/application 09:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:38:15 INFO - Reading from file tmpfile_stdout 09:38:15 INFO - Output received: 09:38:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:38:15 INFO - Running post-action listener: _resource_record_post_action 09:38:15 INFO - [mozharness: 2017-01-22 17:38:15.938886Z] Finished install step (success) 09:38:15 INFO - [mozharness: 2017-01-22 17:38:15.938984Z] Running run-tests step. 09:38:15 INFO - Running pre-action listener: _resource_record_pre_action 09:38:15 INFO - Running main action method: run_tests 09:38:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:15 INFO - 2017-01-22 09:38:15.952 screenresolution[1642:10031] starting screenresolution argv=screenresolution get 09:38:15 INFO - 2017-01-22 09:38:15.954 screenresolution[1642:10031] Display 0: 1600x1200x32@60 09:38:15 INFO - 2017-01-22 09:38:15.960 screenresolution[1643:10034] starting screenresolution argv=screenresolution list 09:38:15 INFO - Available Modes on Display 0 09:38:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:16 INFO - Intel Iris: 09:38:16 INFO - Chipset Model: Intel Iris 09:38:16 INFO - Type: GPU 09:38:16 INFO - Bus: Built-In 09:38:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:16 INFO - Vendor: Intel (0x8086) 09:38:16 INFO - Device ID: 0x0a2e 09:38:16 INFO - Revision ID: 0x0009 09:38:16 INFO - Displays: 09:38:16 INFO - Display: 09:38:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:16 INFO - Display Serial Number: 1600x1200 60 09:38:16 INFO - Main Display: Yes 09:38:16 INFO - Mirror: Off 09:38:16 INFO - Online: Yes 09:38:16 INFO - Rotation: Supported 09:38:16 INFO - Return code: 0 09:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:16 INFO - Python 2.7.3 09:38:16 INFO - Return code: 0 09:38:16 INFO - grabbing minidump binary from tooltool 09:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:16 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 0x100a70d30>, '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 0x100997db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a65be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:16 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 09:38:16 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 09:38:16 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 09:38:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:16 INFO - Return code: 0 09:38:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:38:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:38:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:16 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/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 09:38:16 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/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --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 09:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FPpecVvAkq/Render', 09:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:16 INFO - 'HOME': '/Users/cltbld', 09:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:16 INFO - 'LOGNAME': 'cltbld', 09:38:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:16 INFO - 'MOZ_NO_REMOTE': '1', 09:38:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:16 INFO - 'NO_EM_RESTART': '1', 09:38:16 INFO - 'PAGER': '/bin/cat', 09:38:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:16 INFO - 'PWD': '/builds/slave/test', 09:38:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:16 INFO - 'SHELL': '/bin/bash', 09:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5RrfImNtEL/Listeners', 09:38:16 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 09:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:16 INFO - 'USER': 'cltbld', 09:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:16 INFO - 'XPC_FLAGS': '0x0', 09:38:16 INFO - 'XPC_SERVICE_NAME': '0', 09:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:16 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/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 09:38:16 INFO - mozversion application_buildid: 20170122084825 09:38:16 INFO - mozversion application_changeset: bd0cd9af94d9334b862d9891013fed56fb9b3b7c 09:38:16 INFO - mozversion application_display_name: Nightly 09:38:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:16 INFO - mozversion application_name: Firefox 09:38:16 INFO - mozversion application_remotingname: firefox 09:38:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:38:16 INFO - mozversion application_vendor: Mozilla 09:38:16 INFO - mozversion application_version: 53.0a1 09:38:16 INFO - mozversion platform_buildid: 20170122084825 09:38:16 INFO - mozversion platform_changeset: bd0cd9af94d9334b862d9891013fed56fb9b3b7c 09:38:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:38:16 INFO - mozversion platform_version: 53.0a1 09:38:16 INFO - using testdate: 1485106696 09:38:16 INFO - actual date: 1485106696 09:38:16 INFO - starting webserver on 'localhost:49243' 09:38:16 INFO - SUITE-START | Running 2 tests 09:38:16 INFO - TEST-START | dromaeo_css 09:38:16 INFO - operating with platform_type : mac_ 09:38:16 INFO - Initialising browser for dromaeo_css test... 09:38:16 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp6FKske/profile http://localhost:49243/getInfo.html) 09:38:19 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 09:38:19 INFO - PROCESS | 1653 | colorDepth:24 09:38:19 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 09:38:19 INFO - PROCESS | 1653 | __metrics 09:38:19 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 09:38:19 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:19 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:20 INFO - TEST-INFO | 1653: exit 0 09:38:20 INFO - Browser initialized. 09:38:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:20 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp6FKske/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:32 INFO - PROCESS | 1656 | RSS: Main: 234577920 09:38:32 INFO - PROCESS | 1656 | 09:41:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 09:41:38 INFO - PROCESS | 1656 | RSS: Main: 385359872 09:41:38 INFO - PROCESS | 1656 | 09:43:22 INFO - PROCESS | 1656 | ************************* 09:43:22 INFO - PROCESS | 1656 | A coding exception was thrown and uncaught in a Task. 09:43:22 INFO - PROCESS | 1656 | 09:43:22 ERROR - PROCESS | 1656 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:43:22 INFO - PROCESS | 1656 | Full stack: 09:43:22 INFO - PROCESS | 1656 | ************************* 09:44:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 09:44:41 INFO - PROCESS | 1656 | RSS: Main: 367460352 09:44:41 INFO - PROCESS | 1656 | 09:47:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 09:47:44 INFO - PROCESS | 1656 | RSS: Main: 334999552 09:47:44 INFO - PROCESS | 1656 | 09:50:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 09:50:48 INFO - PROCESS | 1656 | RSS: Main: 333287424 09:50:48 INFO - PROCESS | 1656 | 09:53:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 09:53:52 INFO - PROCESS | 1656 | RSS: Main: 326975488 09:53:52 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 09:56:55 INFO - PROCESS | 1656 | RSS: Main: 485769216 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | __start_tp_report 09:56:55 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:56:55 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:56:55 INFO - PROCESS | 1656 | |i|pagename|runs| 09:56:55 INFO - PROCESS | 1656 | |0;dojo.html;3313.2379552702882;3346.8828590999306;3350.145712843225;3371.578552680915;3411.2324726936445;5553.639013464132;5628.549716022719;5638.971805140979;5707.429257074291;5716.914246286309;5604.523615492688;5666.461686139821;5667.489925906668;5679.687617181064;5684.033714268574;5082.491750824925;5151.536361727443;5178.016176926372;5218.269442278084;5230.947690523084;5203.817866374678;5205.349331333583;5223.71269580173;5243.659162154467;5267.446918073604;5118.488151184889;5261.526462618363;5315.7873685052555;5325.7869685212545;5326.334208223972;5194.091034069042;5226.372835259755;5231.529162375405;5254.31693879797;5255.106631872591;5044.646874718735;5057.039162559102;5073.949260507385;5097.006083813658;5196;5597.692126933017;5598.580106491989;5637.098064309691;5692.17463467799;5709.486146246858;6287.339829317947;6288.654124023177;6288.9056664150075;6293.559450838443;6298.118263443122;6152.78465253714;6255.749770009194;6288.245410550718;6334.683265836689;6356.141920840673;5763.164341170549;5798.94201057984;5820.272465941757;5826.6212696175035;5885.176075349455;6277.8744425111245;6323.20959880015;6324.873502529924;6345;6347.746090156435;5857.297124345106;6037.879242415127;6173.876522469615;6194;6197.566170368031;6043.607165534314;6128.816135515942;6208;6253.218347706536;6280.497560195174;6253.968730156411;6257.217847769029;6264.310925798159;6267.592606480564;6272.090546870678;6072.332043475214;6112.327643959161;6142.3759981611065;6149.41580549856;6254.593451425734;5008.198688209869;5028.472010438924;5034.521720436553;5072.568831649277;5073.188289873677;4406.603405693503;4471.530489298641;4477.261251893401;4501.864944051684;4523.231050721385;4721;5760.971195143998;5797.913031304533;5841.211436456109;5849.561282903799;6247.500199983991;6281.937180628135;6289.528285378524;6292.465140463112;6311.400416960473;5023.844515761395;5815.563832712479;5818.679972601463;5829.708514574254;5832.387599302097;5341.599380046512;5372.1941708744;5405.621606487587;5409.107497262986;5421.1055175895535;6328.272248691459;6351.93648063532;6352.714127864165;6360.49116070704;6363.300036996019;6223.471004964447;6244.125822384779;6251.562390632612;6266.216722909637;6285.528585356025;6286.214223222098;6295.622262664255;6336.429721325103;6346.524010699124;6367.140436041261;4914;6113.415495409546;6229.626222426669;6241.937580624136;6244.5316601256;6109.725062372115;6290.842728931813;6307.842303942438;6321.178246828067;6338.207724034496;5938.73275702603;6000.249968753906;6074.42292982166;6113.908291375544;6124.234470691164;6017.458428741435;6046.27444706638;6051.243594550681;6112.138751317827;6122.733612273432;5950.047992321208;5951.91072133927;5961.940380596312;5963.671998040149;5972.522198224218;5921;5966.552508561788;5975.850603734768;5989.580729348903;6034.63792172471;5845.941540584539;5861.501772349398;5912.881742365214;5960.5231581474245;5964.493018093337 09:56:55 INFO - PROCESS | 1656 | |1;ext.html;453.3403897329385;455.1625009981633;465.96039336656384;486.8466433073579;528.913083613175;28736.425271494558;40825.18349633009;42590;42690.359644605356;42971.35542966858;43869.561304387025;44112.55887441125;44238;44355.33466997997;44400.111997760025;9325.207357374631;9523.80952380952;9530.332876698634;9534.237261019101;9560.760980975461;8410.78973025673;8684.13158684133;11179.049780768644;11471.19701620887;11503.309801411942;11397.544098236061;11437.828432573519;11442.313461192314;11477.540898364055;11483.253588516762;11255.212135150543;11313.547458101666;11314.3211407315;11322.264052836621;11352.375619340974;8432.873506897402;8673.956630216808;11044.116470682326;11297.548098076068;11375.772484550263;41907.7904610475;42294.78852605717;42347.57652423467;42388.94027649303;42389.36415953763;3452.4648679454726;4023.3160362738404;4032.0537342203015;4106.691998100125;4135.58644135587;30931.536026959613;31499;31696.683033169604;31779.52330715041;32017.679823201703;3222.291095958909;3251.7398608111293;3302.53764472974;3357.6642335766473;3363.814990175539;446272;452811;455434;456863;457536.7123164396;65219;65445;65632.34367656359;65635;65652;57557;66447.66776166185;68785.96821047689;68989;69043;13188.934055329662;16519.421820236475;16524.595409390095;16528.338866445207;16566.254518546695;11342.092632589372;12638.55765048219;12734.61796146117;12742.80885786714;12780;15527.378904843905;16368.427105051265;18440.35458758937;18844.81155188458;18873.716894246598;6482.546221764525;6523.478121750249;6539.934600654028;6557.540972131905;6562.704678289489;732.7362149626131;869.1916517638657;877.1842186766369;880.7225723896952;899.0694631056825;29724;30351.392972140875;30397.696023039487;31032.069037928897;31094.378112437626;1057.878343990451;1059.6079450603327;1081.5727787523883;1082.5182793656747;1195.2828303018293;10491.148343279421;12405;15643;15803.604909877115;16069.35722571084;236124;236926.63073369046;237067;237663.81168094394;237665;62523;62886;62907.6854615724;63101.68449157817;63189.68405157945;1392.276016471429;1426.9571912842632;1435.9928200358931;1438.8129543159532;1439.3163247457373;25808.35479112962;28731.425371492034;29568.852155739085;30383.088507344815;30487.39025219439;54519;54805.067543921235;54840.72579637076;54958;55153.72423137858;486499;488343;488871.77820553345;489866;490639;34700;41497.79251103725;42024.57975420329;42277.78861105675;42328.78835605802;46805.531944680115;47275.58173254808;47559.28661070156;47690.52309476861;48091.75954120207;38774.80612596919;38866.805665971486;38923.80538097292;40628.59371406367;40822.79588602038;37922.2415551693;38864.25110869961;39361.60638393694;39680.4313977154;39940.800295998335;38066.619333807415;38666.226675466896;38696.613033869304;38859.805700971316;38869.6113038866;32071.83964080258;32236.83881580577;34131.48802767911;34427.311453770286;34451.65548344485;20532.460065494848;23022.84885755739;23652.172173973828;24036.51926961416;24704.876475618225 09:56:55 INFO - PROCESS | 1656 | |2;jquery.html;356.9125564236762;366.3095065800965;378.4777007729333;389.54034239597263;405.541737836245;15474.994125381842;15597.84402155978;18421.35525256616;20764.792352076474;21323;20200.959808038413;20900.686489702668;21009.68485472719;21640.350789476342;21670.89164554179;5318.6011049171275;5318.867028324294;5358.383785864637;5440.156775699773;6002.219711437507;3933.567307596162;5927.4072592740595;6045.093236014611;6047.969760151193;6049.395060493959;4155.2728272552185;5764.625299355549;5890.851283999622;6041.9697901510435;6064.423879731418;5452.318460192476;5846.415358464162;6003.129546215774;6075.635461872302;6128.938710612903;5916.615419997686;5924.792632257893;5930.851728706773;5938.940610593882;5943.762249510014;13609.251491167981;19507.609847802963;23644.881775591184;25371.873140634365;26017.609735853977;2594.7934210592166;2619.4630100829286;2631.223788982236;2655.5618322976684;2658.388570628747;8693.565321733888;9616.374935629161;10117.797644047077;10118.544665489997;10556.313839600478;1797.1104303369784;1799.8230985579567;1802.026905471044;1810.7736532933384;1816.3279586552928;122824;124235;126043;128504.7149528502;128969.35515322458;9878.110970012733;10363.326383785181;10401.68794936153;10505.846301508172;11829.763404731857;12729.490820367268;12823.038272129628;12829.743405131845;12847.357632118357;12852.357382130856;7232.276772322725;7579.696812127453;8025.197480252044;8156.062052863878;8168.469049511881;8391.580420978926;8400.537970411564;8580.871286930702;8606.44058136219;8608.397412181212;3979.801009949491;4074.898127546835;4079.6940229482907;4081.714280000431;4139.648129908992;1977.1399441243104;2000.0199205171552;2005.4084045206698;2010.416979076081;2015.3147929703678;959.3045042344384;960.245440328313;974.8878878928872;977.5063592885547;1000.7848312612823;18645.296432017283;18662.50699944001;20664.17343306281;21184;21401.250956216456;984.2568860510412;995.5072239241622;1003.8694969654044;1013.6401577439902;1038.6209033702796;8745.239546994853;11005.339679619248;11328.32030078198;11328.603498877499;11334.716632084264;689668;695579;697137;708141;711257.2764814191;108968;145419;147433.26283368515;149554.25222873816;152783;1000.4147573669485;1019.7297716105238;1062.8830828608848;1071.796358691846;1073.4739977411168;18821.15304811314;19595;19666.704999424735;20096.095675694338;20161.798382015993;56980.43019569917;57222;57700.55748606318;61181.38818611757;61553.69223153855;87430.56284718536;88943.55528222317;91340;92203.36286529891;92467.53766231125;7095.971084192866;8231.506109633441;8385.077641459313;8463.619137138721;8569.871451928351;10865.239433239914;12421;12696.619101426972;13361.465541378237;13655;11159.051480624237;11638.06895448379;11649.359285239054;11784.882151178379;11878.287302761863;10642.574297028032;11138.88611138912;11334.979851813376;11437.142214333791;11897.94051029774;11180.440977950908;11617.6514704559;11897.345645989553;11957;12097.455614497545;8356.373272004746;8619.741407757778;8633.942047237788;8644.654213831376;8757.168069033432;8057.597120144086;9958;10882.45587720595;11524.82712759326;11845.703857403634 09:56:55 INFO - PROCESS | 1656 | |3;mootools.html;1463.0636392708666;1467.112396999815;1472.7054589082186;1486.7844162596416;1492.7686208637665;7509.648263312602;7979.840403191933;8037.839243215132;8403.327733781298;8444.155584441569;7504.212057733941;7689.307962283393;8011.399145064114;8213.46612470189;8221.91778082219;2251.5046689728274;2294.9311520654323;2297.8506397084134;2308.7806658367513;2315.131825565413;2300.091463871778;2318.26974503031;2319.5013072189477;2326.8487548309304;2329.4176455886027;2270.0465804362125;2280.669302951071;2295.7819007194375;2302.24026071396;2310.792028717415;2248.3704562722382;2266.3427605994243;2269.909203631853;2272.6477396003647;2277.2485079923586;2201.1635578480236;2278.5784629843365;2281.3498153026308;2287.3709729824263;2288.439332363565;8283.875741863876;8348.33213342931;8351.123132071105;8354.958225208897;8361.874571881426;4987.800487980477;5156.561692256163;5157.690538567698;5165.22521621756;5172.27588137661;3037.711417415342;3208.6470488246273;3266.3467306538787;3394.8811791587177;3460.3079384123275;1193.6598069550223;1203.554684766642;1224.5163160551622;1244.1539752967979;1268.8160216768608;8586.227239548409;10171.694849154463;10280.228982826318;10284.228682848816;10308.175345972379;4295.52749197588;4423.623991960655;4528.547145285511;4529.932051019237;4625.398698169284;9321.347505674674;9344.766380840534;9360.204382627417;9361.391509551993;9371.625134994523;4468.374427580141;5029.0947629427055;5175.611829112831;5185.455527169668;5186.092433824066;4246.320588705792;4259.595338442843;4636.79134438951;4665.930011049837;4775.761211939389;3724.3110024645525;3769.1707824278615;3860.208657225262;3866.168773713665;3913.7651740895635;1237.4369661803858;1249.7562975219926;1249.8562665293607;1266;1267.6070418170398;906.1618003346878;924.7179610218814;927.2211342472356;930.7068273493828;964.5418426247617;5492.1212605982855;5572.637778544382;5650.124230744241;5745.511631511368;5924.851878703067;952.4428209497521;1003.1523362758458;1004.2066767253933;1008.606643409071;1021.382063851374;3180.9204769880475;3606.495090687253;3814.275287695329;3844.6732027777953;3902.746321489094;9607.279454040836;9924.255680823968;9929.602815887283;9941.204703623693;9955.601775928882;9870.21038316933;9872.111509964137;9890.010998900052;9898.960609135936;9911.10800028001;7282.672279747424;7627.847443051219;7631.961840190764;7657.272559106876;7741.18717534662;4811.975940120277;5364.168553874156;5440.564754819526;5525.254090697865;5567.997760403005;8692.434991725517;8807.867881981903;9153.359264851397;9173.724788256362;9247.0752924707;9095.135962083592;9244.936832264375;9328.02055784133;9436.858447123435;9447;6439.098526206241;6630.336966303331;6632.436242919406;6775.288594697683;6948.166220053626;7506.399488041053;7732.574708391093;7759.030121234846;7774.378049756119;7809.906613074288;6901.344372284625;6957.095577575085;6965.860682786417;6992.580445173306;7047.47143964215;5739.8565035874435;6812;6900.2409734928115;6902.137232845895;6923.169219693669;6217.378262173746;6323.652199129092;6388.233411990591;6417.294097649348;6433.420992110732;4931.852044438672;4972.453030166606;4996.775145118551;5015.974920125376;5095.108356037753;4645.256758918556;4916.950830491649;5016.698998060128;5067.5185857343495;5084.135696931605 09:56:55 INFO - PROCESS | 1656 | |4;prototype.html;288.9191026512577;309.3611691856315;346.71742529838195;349.54908168462686;359.60443512136646;4586.931196032058;5231.718229033887;5236.764345604447;5246.003259380725;5272.420033796279;4046.4739583854057;4594.931076033862;4774.1645212087915;4981.302617633534;5003.3245511855885;3317.336532693465;3428.314337132571;4026.8590599329027;4066.8373265069363;4110.383442483637;4042.8787136385954;4085.836566537335;4091.9795401022952;4104.835806567734;4132.772697501636;3116.579261799651;3522.2488050226557;3969.7221194516396;4033.3143365627766;4071.246819338432;3082.33729748103;3918.9804050979565;3923.8234279457492;3938.9803050984847;3980.343243364856;2951.8930401099587;3058.690688530168;3374.173327534745;3407.9605720255313;3425.383430982422;5077.695338279715;5089.211172268304;5091.523458197118;5115.948840511622;5123.795048198068;3821.99345343694;4255.361695745632;4490.483594386655;4506;4537.185125949613;4706.788194531255;4806.894414284734;5292.338457692788;5451.427600102012;5462.661647896251;3163.9242657496334;3753.5120434343635;3754.812259387047;3762.7930463824478;3764.7741135531955;5444.564434845203;5659.462351076641;5703.5152012079025;5761.8559536011935;5763.567732420085;3379.425497665403;3795.373763329075;3796.3166630006863;3800.923981520354;3812.504374431306;3254.8372581370836;3273.3126043531124;3840.38703744428;3863.265979463893;3878.825452854628;4307.300526226767;4403.735775853459;4498.595126438636;4502.5047244803045;4504.801590870518;4766.833160839354;5253.529011876681;5338.813141540028;5506.311711036121;5527.917081243784;1096.7587130831205;1123.780697942725;1125.1336470917347;1229.8708635593314;1250.7185883176394;718.8059224009488;805.5569436809732;825.8472182646229;849.7535714642685;856.6573370651789;4880.633952453509;4897.681650692693;4908.607311415079;4938;4972.72650004246;4733.573978341966;5217.660852044605;5302.973485132627;5360.4805741301525;5399.973000134974;3989.7406668567032;4689.812407503661;4821.493743156988;4870.878228044327;4880.633952453581;2490.68866391701;2688.6504754381804;2718.5514390125804;2777.180731684158;2830.4480626277677;5012.774425150877;5016;5541.944580554224;5571.693556854412;5590.825926555388;5029.7736601853;5412.83761487156;5440.238366628675;5440.836774896759;5471.2887324647545;4574.908501829945;4842.176829938919;5306.96514179739;5527.143292789624;5611.765411609439;4506.639468842419;5173.275741396133;5174.430812610685;5262.89474210506;5337.879045400509;5596.356419011866;5622.662640241435;5649.661020338793;5662.688552129673;5666;5047.848564543069;5451.318585176853;5784.94215057844;5953.9404605955115;5974.014287642664;3379.6451372606507;3418.777779444328;3634.1459756957624;3822.464854920258;3857.363535016691;5385.3268341457315;5617.354004289559;5622.662640241599;5645.858853528694;5669.121286200645;5484.341878974548;5508.7521061553125;5513.8345849624575;5519.862003449785;5547.1679248113105;4814.614830813456;5247.291615631993;5391.406945236099;5475.5072043516275;5514.972425137848;5119.283300337881;5381.865453363541;5412.296401467784;5426.403095659395;5456.48163424474;3887.5119923248576;4819.927701084556;5056.924146137884;5305.148380396957;5338.679679219259;4674.462436819809;4743.667943244078;4877.268409738567;5405.108157154025;5429.40276569585 09:56:55 INFO - PROCESS | 1656 | |5;yui.html;707.0666719929695;713.9143302803665;772.5712229712507;819;828.8176601147748;15036.473723419682;15970.201489925501;15977.600559986005;15979.680406391864;15999.920000399981;14539.418423263083;14604;14607.561773146823;14693.632659183526;14731.042482238674;852.7697521669161;861.9267362274182;870.2254993056185;873.7553485024204;876.1019954546578;863.8056437301619;865.8354912566592;866.23338345564;866.6749968761715;866.8483015472267;718.9928100718978;743.4721347843038;746.4513582516846;915.7939463620698;918.4764684130049;745.0612228591986;745.4520927118537;869.1873098652717;901.3645380007144;901.9413738107068;670.1589505170979;670.9630970296631;670.993290067098;672.8149758816315;673.0913267089439;15030.023048501813;15369.692606147926;15404.92297538505;15410.845891541165;15437.228138593026;13345.933270333684;14011.633127475463;14176.574702758933;14232.644183895485;14258.28708564578;12751.10742248043;12954.546590869368;12977;13076.280804555745;13287.933560332232;4465.084657645175;4488;4489.461264648263;4566.223741963874;4700.083483720676;106147;108096.4595177027;108827.45586272098;110544;111021;9974.501274936225;11057.612983545538;11147.498362573704;11159.609413670645;11373.829392559119;22249.777502225093;22419.327420177422;22603.660945085838;22667.88666056659;22703.545929081327;7728.806779830549;7748.4188685848785;7774.1837107104075;7868.291853733192;7941.801454963672;4236.343366778155;4263.552327005682;4295.37717031035;4311.965128369232;4405.713628614129;3473.8436770345397;3518.2435776307707;3539;3559.928801423957;3566.8751593694615;646.5635695905245;651.0949779806074;654.6693919570681;666.1706175811049;667.1027468055457;634.5621521150483;643.719981807915;648.4326214562258;657.5495785387026;668.5153263883645;9366.250699943988;9838.75403114928;9921.603135874628;10123.59505619767;10350.223733220038;516.7493765523718;630.3255516597288;647.7409036385484;664.538145988543;681.57401623985;4100.712950093465;4556.134334476439;4794.6939646827;4948.925766113512;4969.346558341254;101057.98942010633;103306.96693033124;103442.93114137676;105629;107922;91407.08592914119;94356.52821735847;95269.5236523813;96020.55969160468;96371.51814240884;69682.65158674275;75849;81070.18929810627;81625.59187204145;82005;8049.055962578177;10251.948740256252;10478.685639430829;10567.841482377617;10622.73443163896;50283.497165029345;50409.99180016453;51653;51699.70750731262;52247.47752522426;63513;66774;69625.95561066487;70189.64905175442;72528.63735681288;12992;13473.595792126252;13500.454385189385;13559.661008474472;13565.728685426038;13347.866521334663;14909.925450373112;14973.475928342456;15044.323005464561;15927.203639818195;13862.02965792385;14022.649433764238;14095.577132686036;14169.929150354183;14185.503507377192;14002.789958150432;14127.43490260378;14133.363998620292;14528.26606173845;14586.781198282246;13547.458101675822;13926.721465570428;14188.574342769733;14650.267486625839;15211.619709507351;10275.763699037228;11298.209125361145;11668.649940501798;11749.706257343634;11800.704982375166;11345.890206830833;11348.773024539298;11522.481488333213;11730.472128754398;11751.88248117542 09:56:55 INFO - PROCESS | 1656 | __end_tp_report 09:56:55 INFO - PROCESS | 1656 | __start_cc_report 09:56:55 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1579 09:56:55 INFO - PROCESS | 1656 | __end_cc_report 09:56:55 INFO - PROCESS | 1656 | __startTimestamp1485107815594__endTimestamp 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:56:55 INFO - PROCESS | 1656 | Number of tests: 6 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5735.78 Median:5950.05 stddev:646.13 (10.9%) stddev-sans-first:619.53 09:56:55 INFO - PROCESS | 1656 | Values: 3313.2 3346.9 3350.1 3371.6 3411.2 5553.6 5628.5 5639.0 5707.4 5716.9 5604.5 5666.5 5667.5 5679.7 5684.0 5082.5 5151.5 5178.0 5218.3 5230.9 5203.8 5205.3 5223.7 5243.7 5267.4 5118.5 5261.5 5315.8 5325.8 5326.3 5194.1 5226.4 5231.5 5254.3 5255.1 5044.6 5057.0 5073.9 5097.0 5196.0 5597.7 5598.6 5637.1 5692.2 5709.5 6287.3 6288.7 6288.9 6293.6 6298.1 6152.8 6255.7 6288.2 6334.7 6356.1 5763.2 5798.9 5820.3 5826.6 5885.2 6277.9 6323.2 6324.9 6345.0 6347.7 5857.3 6037.9 6173.9 6194.0 6197.6 6043.6 6128.8 6208.0 6253.2 6280.5 6254.0 6257.2 6264.3 6267.6 6272.1 6072.3 6112.3 6142.4 6149.4 6254.6 5008.2 5028.5 5034.5 5072.6 5073.2 4406.6 4471.5 4477.3 4501.9 4523.2 4721.0 5761.0 5797.9 5841.2 5849.6 6247.5 6281.9 6289.5 6292.5 6311.4 5023.8 5815.6 5818.7 5829.7 5832.4 5341.6 5372.2 5405.6 5409.1 5421.1 6328.3 6351.9 6352.7 6360.5 6363.3 6223.5 6244.1 6251.6 6266.2 6285.5 6286.2 6295.6 6336.4 6346.5 6367.1 4914.0 6113.4 6229.6 6241.9 6244.5 6109.7 6290.8 6307.8 6321.2 6338.2 5938.7 6000.2 6074.4 6113.9 6124.2 6017.5 6046.3 6051.2 6112.1 6122.7 5950.0 5951.9 5961.9 5963.7 5972.5 5921.0 5966.6 5975.9 5989.6 6034.6 5845.9 5861.5 5912.9 5960.5 5964.5 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:56630.59 Median:38865.53 stddev:108462.49 (279.1%) stddev-sans-first:108684.74 09:56:55 INFO - PROCESS | 1656 | Values: 453.3 455.2 466.0 486.8 528.9 28736.4 40825.2 42590.0 42690.4 42971.4 43869.6 44112.6 44238.0 44355.3 44400.1 9325.2 9523.8 9530.3 9534.2 9560.8 8410.8 8684.1 11179.0 11471.2 11503.3 11397.5 11437.8 11442.3 11477.5 11483.3 11255.2 11313.5 11314.3 11322.3 11352.4 8432.9 8674.0 11044.1 11297.5 11375.8 41907.8 42294.8 42347.6 42388.9 42389.4 3452.5 4023.3 4032.1 4106.7 4135.6 30931.5 31499.0 31696.7 31779.5 32017.7 3222.3 3251.7 3302.5 3357.7 3363.8 446272.0 452811.0 455434.0 456863.0 457536.7 65219.0 65445.0 65632.3 65635.0 65652.0 57557.0 66447.7 68786.0 68989.0 69043.0 13188.9 16519.4 16524.6 16528.3 16566.3 11342.1 12638.6 12734.6 12742.8 12780.0 15527.4 16368.4 18440.4 18844.8 18873.7 6482.5 6523.5 6539.9 6557.5 6562.7 732.7 869.2 877.2 880.7 899.1 29724.0 30351.4 30397.7 31032.1 31094.4 1057.9 1059.6 1081.6 1082.5 1195.3 10491.1 12405.0 15643.0 15803.6 16069.4 236124.0 236926.6 237067.0 237663.8 237665.0 62523.0 62886.0 62907.7 63101.7 63189.7 1392.3 1427.0 1436.0 1438.8 1439.3 25808.4 28731.4 29568.9 30383.1 30487.4 54519.0 54805.1 54840.7 54958.0 55153.7 486499.0 488343.0 488871.8 489866.0 490639.0 34700.0 41497.8 42024.6 42277.8 42328.8 46805.5 47275.6 47559.3 47690.5 48091.8 38774.8 38866.8 38923.8 40628.6 40822.8 37922.2 38864.3 39361.6 39680.4 39940.8 38066.6 38666.2 38696.6 38859.8 38869.6 32071.8 32236.8 34131.5 34427.3 34451.7 20532.5 23022.8 23652.2 24036.5 24704.9 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:38742.71 Median:24508.38 stddev:116741.42 (476.3%) stddev-sans-first:117033.33 09:56:55 INFO - PROCESS | 1656 | Values: 356.9 366.3 378.5 389.5 405.5 15475.0 15597.8 18421.4 20764.8 21323.0 20201.0 20900.7 21009.7 21640.4 21670.9 5318.6 5318.9 5358.4 5440.2 6002.2 3933.6 5927.4 6045.1 6048.0 6049.4 4155.3 5764.6 5890.9 6042.0 6064.4 5452.3 5846.4 6003.1 6075.6 6128.9 5916.6 5924.8 5930.9 5938.9 5943.8 13609.3 19507.6 23644.9 25371.9 26017.6 2594.8 2619.5 2631.2 2655.6 2658.4 8693.6 9616.4 10117.8 10118.5 10556.3 1797.1 1799.8 1802.0 1810.8 1816.3 122824.0 124235.0 126043.0 128504.7 128969.4 9878.1 10363.3 10401.7 10505.8 11829.8 12729.5 12823.0 12829.7 12847.4 12852.4 7232.3 7579.7 8025.2 8156.1 8168.5 8391.6 8400.5 8580.9 8606.4 8608.4 3979.8 4074.9 4079.7 4081.7 4139.6 1977.1 2000.0 2005.4 2010.4 2015.3 959.3 960.2 974.9 977.5 1000.8 18645.3 18662.5 20664.2 21184.0 21401.3 984.3 995.5 1003.9 1013.6 1038.6 8745.2 11005.3 11328.3 11328.6 11334.7 689668.0 695579.0 697137.0 708141.0 711257.3 108968.0 145419.0 147433.3 149554.3 152783.0 1000.4 1019.7 1062.9 1071.8 1073.5 18821.2 19595.0 19666.7 20096.1 20161.8 56980.4 57222.0 57700.6 61181.4 61553.7 87430.6 88943.6 91340.0 92203.4 92467.5 7096.0 8231.5 8385.1 8463.6 8569.9 10865.2 12421.0 12696.6 13361.5 13655.0 11159.1 11638.1 11649.4 11784.9 11878.3 10642.6 11138.9 11335.0 11437.1 11897.9 11180.4 11617.7 11897.3 11957.0 12097.5 8356.4 8619.7 8633.9 8644.7 8757.2 8057.6 9958.0 10882.5 11524.8 11845.7 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5329.93 Median:5173.94 stddev:2869.82 (55.5%) stddev-sans-first:2863.15 09:56:55 INFO - PROCESS | 1656 | Values: 1463.1 1467.1 1472.7 1486.8 1492.8 7509.6 7979.8 8037.8 8403.3 8444.2 7504.2 7689.3 8011.4 8213.5 8221.9 2251.5 2294.9 2297.9 2308.8 2315.1 2300.1 2318.3 2319.5 2326.8 2329.4 2270.0 2280.7 2295.8 2302.2 2310.8 2248.4 2266.3 2269.9 2272.6 2277.2 2201.2 2278.6 2281.3 2287.4 2288.4 8283.9 8348.3 8351.1 8355.0 8361.9 4987.8 5156.6 5157.7 5165.2 5172.3 3037.7 3208.6 3266.3 3394.9 3460.3 1193.7 1203.6 1224.5 1244.2 1268.8 8586.2 10171.7 10280.2 10284.2 10308.2 4295.5 4423.6 4528.5 4529.9 4625.4 9321.3 9344.8 9360.2 9361.4 9371.6 4468.4 5029.1 5175.6 5185.5 5186.1 4246.3 4259.6 4636.8 4665.9 4775.8 3724.3 3769.2 3860.2 3866.2 3913.8 1237.4 1249.8 1249.9 1266.0 1267.6 906.2 924.7 927.2 930.7 964.5 5492.1 5572.6 5650.1 5745.5 5924.9 952.4 1003.2 1004.2 1008.6 1021.4 3180.9 3606.5 3814.3 3844.7 3902.7 9607.3 9924.3 9929.6 9941.2 9955.6 9870.2 9872.1 9890.0 9899.0 9911.1 7282.7 7627.8 7632.0 7657.3 7741.2 4812.0 5364.2 5440.6 5525.3 5568.0 8692.4 8807.9 9153.4 9173.7 9247.1 9095.1 9244.9 9328.0 9436.9 9447.0 6439.1 6630.3 6632.4 6775.3 6948.2 7506.4 7732.6 7759.0 7774.4 7809.9 6901.3 6957.1 6965.9 6992.6 7047.5 5739.9 6812.0 6900.2 6902.1 6923.2 6217.4 6323.7 6388.2 6417.3 6433.4 4931.9 4972.5 4996.8 5016.0 5095.1 4645.3 4917.0 5016.7 5067.5 5084.1 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4352.19 Median:4878.95 stddev:1355.55 (27.8%) stddev-sans-first:1324.60 09:56:55 INFO - PROCESS | 1656 | Values: 288.9 309.4 346.7 349.5 359.6 4586.9 5231.7 5236.8 5246.0 5272.4 4046.5 4594.9 4774.2 4981.3 5003.3 3317.3 3428.3 4026.9 4066.8 4110.4 4042.9 4085.8 4092.0 4104.8 4132.8 3116.6 3522.2 3969.7 4033.3 4071.2 3082.3 3919.0 3923.8 3939.0 3980.3 2951.9 3058.7 3374.2 3408.0 3425.4 5077.7 5089.2 5091.5 5115.9 5123.8 3822.0 4255.4 4490.5 4506.0 4537.2 4706.8 4806.9 5292.3 5451.4 5462.7 3163.9 3753.5 3754.8 3762.8 3764.8 5444.6 5659.5 5703.5 5761.9 5763.6 3379.4 3795.4 3796.3 3800.9 3812.5 3254.8 3273.3 3840.4 3863.3 3878.8 4307.3 4403.7 4498.6 4502.5 4504.8 4766.8 5253.5 5338.8 5506.3 5527.9 1096.8 1123.8 1125.1 1229.9 1250.7 718.8 805.6 825.8 849.8 856.7 4880.6 4897.7 4908.6 4938.0 4972.7 4733.6 5217.7 5303.0 5360.5 5400.0 3989.7 4689.8 4821.5 4870.9 4880.6 2490.7 2688.7 2718.6 2777.2 2830.4 5012.8 5016.0 5541.9 5571.7 5590.8 5029.8 5412.8 5440.2 5440.8 5471.3 4574.9 4842.2 5307.0 5527.1 5611.8 4506.6 5173.3 5174.4 5262.9 5337.9 5596.4 5622.7 5649.7 5662.7 5666.0 5047.8 5451.3 5784.9 5953.9 5974.0 3379.6 3418.8 3634.1 3822.5 3857.4 5385.3 5617.4 5622.7 5645.9 5669.1 5484.3 5508.8 5513.8 5519.9 5547.2 4814.6 5247.3 5391.4 5475.5 5515.0 5119.3 5381.9 5412.3 5426.4 5456.5 3887.5 4819.9 5056.9 5305.1 5338.7 4674.5 4743.7 4877.3 5405.1 5429.4 09:56:55 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:21035.86 Median:4168.53 stddev:30145.36 (723.2%) stddev-sans-first:30191.28 09:56:55 INFO - PROCESS | 1656 | Values: 707.1 713.9 772.6 819.0 828.8 15036.5 15970.2 15977.6 15979.7 15999.9 14539.4 14604.0 14607.6 14693.6 14731.0 852.8 861.9 870.2 873.8 876.1 863.8 865.8 866.2 866.7 866.8 719.0 743.5 746.5 915.8 918.5 745.1 745.5 869.2 901.4 901.9 670.2 671.0 671.0 672.8 673.1 15030.0 15369.7 15404.9 15410.8 15437.2 13345.9 14011.6 14176.6 14232.6 14258.3 12751.1 12954.5 12977.0 13076.3 13287.9 4465.1 4488.0 4489.5 4566.2 4700.1 106147.0 108096.5 108827.5 110544.0 111021.0 9974.5 11057.6 11147.5 11159.6 11373.8 22249.8 22419.3 22603.7 22667.9 22703.5 7728.8 7748.4 7774.2 7868.3 7941.8 4236.3 4263.6 4295.4 4312.0 4405.7 3473.8 3518.2 3539.0 3559.9 3566.9 646.6 651.1 654.7 666.2 667.1 634.6 643.7 648.4 657.5 668.5 9366.3 9838.8 9921.6 10123.6 10350.2 516.7 630.3 647.7 664.5 681.6 4100.7 4556.1 4794.7 4948.9 4969.3 101058.0 103307.0 103442.9 105629.0 107922.0 91407.1 94356.5 95269.5 96020.6 96371.5 69682.7 75849.0 81070.2 81625.6 82005.0 8049.1 10251.9 10478.7 10567.8 10622.7 50283.5 50410.0 51653.0 51699.7 52247.5 63513.0 66774.0 69626.0 70189.6 72528.6 12992.0 13473.6 13500.5 13559.7 13565.7 13347.9 14909.9 14973.5 15044.3 15927.2 13862.0 14022.6 14095.6 14169.9 14185.5 14002.8 14127.4 14133.4 14528.3 14586.8 13547.5 13926.7 14188.6 14650.3 15211.6 10275.8 11298.2 11668.6 11749.7 11800.7 11345.9 11348.8 11522.5 11730.5 11751.9 09:56:55 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:56:55 INFO - PROCESS | 1656 | 09:56:56 INFO - TEST-INFO | 1656: exit 0 09:56:56 INFO - TEST-OK | dromaeo_css | took 1119688ms 09:56:56 INFO - TEST-START | kraken 09:56:56 INFO - operating with platform_type : mac_ 09:56:56 INFO - Initialising browser for kraken test... 09:56:56 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpwZPu1B/profile http://localhost:49243/getInfo.html) 09:56:58 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 09:56:58 INFO - PROCESS | 1662 | colorDepth:24 09:56:58 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 09:56:58 INFO - PROCESS | 1662 | __metrics 09:56:58 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 09:56:58 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:56:58 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:59 INFO - TEST-INFO | 1662: exit 0 09:56:59 INFO - Browser initialized. 09:56:59 INFO - Running cycle 1/1 for kraken test... 09:56:59 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpwZPu1B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:11 INFO - PROCESS | 1663 | RSS: Main: 227266560 09:57:11 INFO - PROCESS | 1663 | 09:57:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 09:57:15 INFO - PROCESS | 1663 | RSS: Main: 288333824 09:57:15 INFO - PROCESS | 1663 | 09:57:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 09:57:18 INFO - PROCESS | 1663 | RSS: Main: 289898496 09:57:18 INFO - PROCESS | 1663 | 09:57:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 09:57:22 INFO - PROCESS | 1663 | RSS: Main: 381190144 09:57:22 INFO - PROCESS | 1663 | 09:57:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 09:57:25 INFO - PROCESS | 1663 | RSS: Main: 286040064 09:57:25 INFO - PROCESS | 1663 | 09:57:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:28 INFO - PROCESS | 1663 | RSS: Main: 289632256 09:57:28 INFO - PROCESS | 1663 | 09:57:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:31 INFO - PROCESS | 1663 | RSS: Main: 331403264 09:57:31 INFO - PROCESS | 1663 | 09:57:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:35 INFO - PROCESS | 1663 | RSS: Main: 330252288 09:57:35 INFO - PROCESS | 1663 | 09:57:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 09:57:38 INFO - PROCESS | 1663 | RSS: Main: 330313728 09:57:38 INFO - PROCESS | 1663 | 09:57:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:40 INFO - PROCESS | 1663 | RSS: Main: 302850048 09:57:40 INFO - PROCESS | 1663 | 09:57:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:43 INFO - PROCESS | 1663 | RSS: Main: 308047872 09:57:43 INFO - PROCESS | 1663 | 09:57:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:46 INFO - PROCESS | 1663 | RSS: Main: 309231616 09:57:46 INFO - PROCESS | 1663 | 09:57:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:49 INFO - PROCESS | 1663 | RSS: Main: 328658944 09:57:49 INFO - PROCESS | 1663 | 09:57:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:53 INFO - PROCESS | 1663 | RSS: Main: 322908160 09:57:53 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 09:57:55 INFO - PROCESS | 1663 | RSS: Main: 366796800 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | __start_tp_report 09:57:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 09:57:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 09:57:55 INFO - PROCESS | 1663 | |i|pagename|runs| 09:57:55 INFO - PROCESS | 1663 | |0;ai-astar;105;108;112;113;113;113;113;114;114;114 09:57:55 INFO - PROCESS | 1663 | |1;audio-beat-detection;144;112;112;148;120;143;142;112;131;111 09:57:55 INFO - PROCESS | 1663 | |2;audio-dft;200;266;215;185;183;182;182;184;180;186 09:57:55 INFO - PROCESS | 1663 | |3;audio-fft;79;57;58;88;61;60;59;60;74;59 09:57:55 INFO - PROCESS | 1663 | |4;audio-oscillator;86;71;87;70;69;69;82;69;71;84 09:57:55 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;86;104;114;87;85;90;87;88;84 09:57:55 INFO - PROCESS | 1663 | |6;imaging-darkroom;96;96;97;97;96;94;97;97;96;97 09:57:55 INFO - PROCESS | 1663 | |7;imaging-desaturate;86;84;87;87;85;84;86;86;85;84 09:57:55 INFO - PROCESS | 1663 | |8;json-parse-financial;56;55;55;55;55;56;55;56;55;56 09:57:55 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;66;74;75;72;73;70;71;71;71;72 09:57:55 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;86;88;86;87;91;87;85;83;75;77 09:57:55 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;142;141;141;140;141;128;156;149;203;154 09:57:55 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;177;176;174;176;178;173;175;175;176;178 09:57:55 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;69;68;66;67;67;66;67;67;66 09:57:55 INFO - PROCESS | 1663 | __end_tp_report 09:57:55 INFO - PROCESS | 1663 | __start_cc_report 09:57:55 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1952 09:57:55 INFO - PROCESS | 1663 | __end_cc_report 09:57:55 INFO - PROCESS | 1663 | __startTimestamp1485107875501__endTimestamp 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | ------- Summary: start ------- 09:57:55 INFO - PROCESS | 1663 | Number of tests: 14 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.00 (2.7%) stddev-sans-first:1.87 09:57:55 INFO - PROCESS | 1663 | Values: 105.0 108.0 112.0 113.0 113.0 113.0 113.0 114.0 114.0 114.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:136.50 stddev:15.65 (11.5%) stddev-sans-first:15.42 09:57:55 INFO - PROCESS | 1663 | Values: 144.0 112.0 112.0 148.0 120.0 143.0 142.0 112.0 131.0 111.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:196.30 Median:185.50 stddev:26.79 (14.4%) stddev-sans-first:28.38 09:57:55 INFO - PROCESS | 1663 | Values: 200.0 266.0 215.0 185.0 183.0 182.0 182.0 184.0 180.0 186.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:65.50 Median:60.50 stddev:10.82 (17.9%) stddev-sans-first:10.32 09:57:55 INFO - PROCESS | 1663 | Values: 79.0 57.0 58.0 88.0 61.0 60.0 59.0 60.0 74.0 59.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:76.50 stddev:7.84 (10.3%) stddev-sans-first:7.40 09:57:55 INFO - PROCESS | 1663 | Values: 86.0 71.0 87.0 70.0 69.0 69.0 82.0 69.0 71.0 84.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:87.00 stddev:9.81 (11.3%) stddev-sans-first:10.28 09:57:55 INFO - PROCESS | 1663 | Values: 87.0 86.0 104.0 114.0 87.0 85.0 90.0 87.0 88.0 84.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:97.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 09:57:55 INFO - PROCESS | 1663 | Values: 96.0 96.0 97.0 97.0 96.0 94.0 97.0 97.0 96.0 97.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.22 09:57:55 INFO - PROCESS | 1663 | Values: 86.0 84.0 87.0 87.0 85.0 84.0 86.0 86.0 85.0 84.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:57:55 INFO - PROCESS | 1663 | Values: 56.0 55.0 55.0 55.0 55.0 56.0 55.0 56.0 55.0 56.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.00 stddev:2.46 (3.4%) stddev-sans-first:1.62 09:57:55 INFO - PROCESS | 1663 | Values: 66.0 74.0 75.0 72.0 73.0 70.0 71.0 71.0 71.0 72.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:86.50 stddev:4.95 (5.7%) stddev-sans-first:5.22 09:57:55 INFO - PROCESS | 1663 | Values: 86.0 88.0 86.0 87.0 91.0 87.0 85.0 83.0 75.0 77.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:145.50 stddev:20.41 (14.0%) stddev-sans-first:21.47 09:57:55 INFO - PROCESS | 1663 | Values: 142.0 141.0 141.0 140.0 141.0 128.0 156.0 149.0 203.0 154.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.00 stddev:1.62 (0.9%) stddev-sans-first:1.66 09:57:55 INFO - PROCESS | 1663 | Values: 177.0 176.0 174.0 176.0 178.0 173.0 175.0 175.0 176.0 178.0 09:57:55 INFO - PROCESS | 1663 | 09:57:55 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 09:57:55 INFO - PROCESS | 1663 | Values: 67.0 69.0 68.0 66.0 67.0 67.0 66.0 67.0 67.0 66.0 09:57:55 INFO - PROCESS | 1663 | -------- Summary: end -------- 09:57:55 INFO - PROCESS | 1663 | 09:57:56 INFO - TEST-INFO | 1663: exit 0 09:57:56 INFO - TEST-OK | kraken | took 60188ms 09:57:56 INFO - SUITE-END | took 1179s 09:57:56 INFO - Completed test suite (00:19:40) 09:57:56 INFO - javascript benchmark 09:57:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.2379552702882, 3346.8828590999306, 3350.145712843225, 3371.578552680915, 3411.2324726936445, 5553.639013464132, 5628.549716022719, 5638.971805140979, 5707.429257074291, 5716.914246286309, 5604.523615492688, 5666.461686139821, 5667.489925906668, 5679.687617181064, 5684.033714268574, 5082.491750824925, 5151.536361727443, 5178.016176926372, 5218.269442278084, 5230.947690523084, 5203.817866374678, 5205.349331333583, 5223.71269580173, 5243.659162154467, 5267.446918073604, 5118.488151184889, 5261.526462618363, 5315.7873685052555, 5325.7869685212545, 5326.334208223972, 5194.091034069042, 5226.372835259755, 5231.529162375405, 5254.31693879797, 5255.106631872591, 5044.646874718735, 5057.039162559102, 5073.949260507385, 5097.006083813658, 5196.0, 5597.692126933017, 5598.580106491989, 5637.098064309691, 5692.17463467799, 5709.486146246858, 6287.339829317947, 6288.654124023177, 6288.9056664150075, 6293.559450838443, 6298.118263443122, 6152.78465253714, 6255.749770009194, 6288.245410550718, 6334.683265836689, 6356.141920840673, 5763.164341170549, 5798.94201057984, 5820.272465941757, 5826.6212696175035, 5885.176075349455, 6277.8744425111245, 6323.20959880015, 6324.873502529924, 6345.0, 6347.746090156435, 5857.297124345106, 6037.879242415127, 6173.876522469615, 6194.0, 6197.566170368031, 6043.607165534314, 6128.816135515942, 6208.0, 6253.218347706536, 6280.497560195174, 6253.968730156411, 6257.217847769029, 6264.310925798159, 6267.592606480564, 6272.090546870678, 6072.332043475214, 6112.327643959161, 6142.3759981611065, 6149.41580549856, 6254.593451425734, 5008.198688209869, 5028.472010438924, 5034.521720436553, 5072.568831649277, 5073.188289873677, 4406.603405693503, 4471.530489298641, 4477.261251893401, 4501.864944051684, 4523.231050721385, 4721.0, 5760.971195143998, 5797.913031304533, 5841.211436456109, 5849.561282903799, 6247.500199983991, 6281.937180628135, 6289.528285378524, 6292.465140463112, 6311.400416960473, 5023.844515761395, 5815.563832712479, 5818.679972601463, 5829.708514574254, 5832.387599302097, 5341.599380046512, 5372.1941708744, 5405.621606487587, 5409.107497262986, 5421.1055175895535, 6328.272248691459, 6351.93648063532, 6352.714127864165, 6360.49116070704, 6363.300036996019, 6223.471004964447, 6244.125822384779, 6251.562390632612, 6266.216722909637, 6285.528585356025, 6286.214223222098, 6295.622262664255, 6336.429721325103, 6346.524010699124, 6367.140436041261, 4914.0, 6113.415495409546, 6229.626222426669, 6241.937580624136, 6244.5316601256, 6109.725062372115, 6290.842728931813, 6307.842303942438, 6321.178246828067, 6338.207724034496, 5938.73275702603, 6000.249968753906, 6074.42292982166, 6113.908291375544, 6124.234470691164, 6017.458428741435, 6046.27444706638, 6051.243594550681, 6112.138751317827, 6122.733612273432, 5950.047992321208, 5951.91072133927, 5961.940380596312, 5963.671998040149, 5972.522198224218, 5921.0, 5966.552508561788, 5975.850603734768, 5989.580729348903, 6034.63792172471, 5845.941540584539, 5861.501772349398, 5912.881742365214, 5960.5231581474245, 5964.493018093337], "value": 5694.812792068365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.3403897329385, 455.1625009981633, 465.96039336656384, 486.8466433073579, 528.913083613175, 28736.425271494558, 40825.18349633009, 42590.0, 42690.359644605356, 42971.35542966858, 43869.561304387025, 44112.55887441125, 44238.0, 44355.33466997997, 44400.111997760025, 9325.207357374631, 9523.80952380952, 9530.332876698634, 9534.237261019101, 9560.760980975461, 8410.78973025673, 8684.13158684133, 11179.049780768644, 11471.19701620887, 11503.309801411942, 11397.544098236061, 11437.828432573519, 11442.313461192314, 11477.540898364055, 11483.253588516762, 11255.212135150543, 11313.547458101666, 11314.3211407315, 11322.264052836621, 11352.375619340974, 8432.873506897402, 8673.956630216808, 11044.116470682326, 11297.548098076068, 11375.772484550263, 41907.7904610475, 42294.78852605717, 42347.57652423467, 42388.94027649303, 42389.36415953763, 3452.4648679454726, 4023.3160362738404, 4032.0537342203015, 4106.691998100125, 4135.58644135587, 30931.536026959613, 31499.0, 31696.683033169604, 31779.52330715041, 32017.679823201703, 3222.291095958909, 3251.7398608111293, 3302.53764472974, 3357.6642335766473, 3363.814990175539, 446272.0, 452811.0, 455434.0, 456863.0, 457536.7123164396, 65219.0, 65445.0, 65632.34367656359, 65635.0, 65652.0, 57557.0, 66447.66776166185, 68785.96821047689, 68989.0, 69043.0, 13188.934055329662, 16519.421820236475, 16524.595409390095, 16528.338866445207, 16566.254518546695, 11342.092632589372, 12638.55765048219, 12734.61796146117, 12742.80885786714, 12780.0, 15527.378904843905, 16368.427105051265, 18440.35458758937, 18844.81155188458, 18873.716894246598, 6482.546221764525, 6523.478121750249, 6539.934600654028, 6557.540972131905, 6562.704678289489, 732.7362149626131, 869.1916517638657, 877.1842186766369, 880.7225723896952, 899.0694631056825, 29724.0, 30351.392972140875, 30397.696023039487, 31032.069037928897, 31094.378112437626, 1057.878343990451, 1059.6079450603327, 1081.5727787523883, 1082.5182793656747, 1195.2828303018293, 10491.148343279421, 12405.0, 15643.0, 15803.604909877115, 16069.35722571084, 236124.0, 236926.63073369046, 237067.0, 237663.81168094394, 237665.0, 62523.0, 62886.0, 62907.6854615724, 63101.68449157817, 63189.68405157945, 1392.276016471429, 1426.9571912842632, 1435.9928200358931, 1438.8129543159532, 1439.3163247457373, 25808.35479112962, 28731.425371492034, 29568.852155739085, 30383.088507344815, 30487.39025219439, 54519.0, 54805.067543921235, 54840.72579637076, 54958.0, 55153.72423137858, 486499.0, 488343.0, 488871.77820553345, 489866.0, 490639.0, 34700.0, 41497.79251103725, 42024.57975420329, 42277.78861105675, 42328.78835605802, 46805.531944680115, 47275.58173254808, 47559.28661070156, 47690.52309476861, 48091.75954120207, 38774.80612596919, 38866.805665971486, 38923.80538097292, 40628.59371406367, 40822.79588602038, 37922.2415551693, 38864.25110869961, 39361.60638393694, 39680.4313977154, 39940.800295998335, 38066.619333807415, 38666.226675466896, 38696.613033869304, 38859.805700971316, 38869.6113038866, 32071.83964080258, 32236.83881580577, 34131.48802767911, 34427.311453770286, 34451.65548344485, 20532.460065494848, 23022.84885755739, 23652.172173973828, 24036.51926961416, 24704.876475618225], "value": 19821.067548587678, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.9125564236762, 366.3095065800965, 378.4777007729333, 389.54034239597263, 405.541737836245, 15474.994125381842, 15597.84402155978, 18421.35525256616, 20764.792352076474, 21323.0, 20200.959808038413, 20900.686489702668, 21009.68485472719, 21640.350789476342, 21670.89164554179, 5318.6011049171275, 5318.867028324294, 5358.383785864637, 5440.156775699773, 6002.219711437507, 3933.567307596162, 5927.4072592740595, 6045.093236014611, 6047.969760151193, 6049.395060493959, 4155.2728272552185, 5764.625299355549, 5890.851283999622, 6041.9697901510435, 6064.423879731418, 5452.318460192476, 5846.415358464162, 6003.129546215774, 6075.635461872302, 6128.938710612903, 5916.615419997686, 5924.792632257893, 5930.851728706773, 5938.940610593882, 5943.762249510014, 13609.251491167981, 19507.609847802963, 23644.881775591184, 25371.873140634365, 26017.609735853977, 2594.7934210592166, 2619.4630100829286, 2631.223788982236, 2655.5618322976684, 2658.388570628747, 8693.565321733888, 9616.374935629161, 10117.797644047077, 10118.544665489997, 10556.313839600478, 1797.1104303369784, 1799.8230985579567, 1802.026905471044, 1810.7736532933384, 1816.3279586552928, 122824.0, 124235.0, 126043.0, 128504.7149528502, 128969.35515322458, 9878.110970012733, 10363.326383785181, 10401.68794936153, 10505.846301508172, 11829.763404731857, 12729.490820367268, 12823.038272129628, 12829.743405131845, 12847.357632118357, 12852.357382130856, 7232.276772322725, 7579.696812127453, 8025.197480252044, 8156.062052863878, 8168.469049511881, 8391.580420978926, 8400.537970411564, 8580.871286930702, 8606.44058136219, 8608.397412181212, 3979.801009949491, 4074.898127546835, 4079.6940229482907, 4081.714280000431, 4139.648129908992, 1977.1399441243104, 2000.0199205171552, 2005.4084045206698, 2010.416979076081, 2015.3147929703678, 959.3045042344384, 960.245440328313, 974.8878878928872, 977.5063592885547, 1000.7848312612823, 18645.296432017283, 18662.50699944001, 20664.17343306281, 21184.0, 21401.250956216456, 984.2568860510412, 995.5072239241622, 1003.8694969654044, 1013.6401577439902, 1038.6209033702796, 8745.239546994853, 11005.339679619248, 11328.32030078198, 11328.603498877499, 11334.716632084264, 689668.0, 695579.0, 697137.0, 708141.0, 711257.2764814191, 108968.0, 145419.0, 147433.26283368515, 149554.25222873816, 152783.0, 1000.4147573669485, 1019.7297716105238, 1062.8830828608848, 1071.796358691846, 1073.4739977411168, 18821.15304811314, 19595.0, 19666.704999424735, 20096.095675694338, 20161.798382015993, 56980.43019569917, 57222.0, 57700.55748606318, 61181.38818611757, 61553.69223153855, 87430.56284718536, 88943.55528222317, 91340.0, 92203.36286529891, 92467.53766231125, 7095.971084192866, 8231.506109633441, 8385.077641459313, 8463.619137138721, 8569.871451928351, 10865.239433239914, 12421.0, 12696.619101426972, 13361.465541378237, 13655.0, 11159.051480624237, 11638.06895448379, 11649.359285239054, 11784.882151178379, 11878.287302761863, 10642.574297028032, 11138.88611138912, 11334.979851813376, 11437.142214333791, 11897.94051029774, 11180.440977950908, 11617.6514704559, 11897.345645989553, 11957.0, 12097.455614497545, 8356.373272004746, 8619.741407757778, 8633.942047237788, 8644.654213831376, 8757.168069033432, 8057.597120144086, 9958.0, 10882.45587720595, 11524.82712759326, 11845.703857403634], "value": 9644.551639443069, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.0636392708666, 1467.112396999815, 1472.7054589082186, 1486.7844162596416, 1492.7686208637665, 7509.648263312602, 7979.840403191933, 8037.839243215132, 8403.327733781298, 8444.155584441569, 7504.212057733941, 7689.307962283393, 8011.399145064114, 8213.46612470189, 8221.91778082219, 2251.5046689728274, 2294.9311520654323, 2297.8506397084134, 2308.7806658367513, 2315.131825565413, 2300.091463871778, 2318.26974503031, 2319.5013072189477, 2326.8487548309304, 2329.4176455886027, 2270.0465804362125, 2280.669302951071, 2295.7819007194375, 2302.24026071396, 2310.792028717415, 2248.3704562722382, 2266.3427605994243, 2269.909203631853, 2272.6477396003647, 2277.2485079923586, 2201.1635578480236, 2278.5784629843365, 2281.3498153026308, 2287.3709729824263, 2288.439332363565, 8283.875741863876, 8348.33213342931, 8351.123132071105, 8354.958225208897, 8361.874571881426, 4987.800487980477, 5156.561692256163, 5157.690538567698, 5165.22521621756, 5172.27588137661, 3037.711417415342, 3208.6470488246273, 3266.3467306538787, 3394.8811791587177, 3460.3079384123275, 1193.6598069550223, 1203.554684766642, 1224.5163160551622, 1244.1539752967979, 1268.8160216768608, 8586.227239548409, 10171.694849154463, 10280.228982826318, 10284.228682848816, 10308.175345972379, 4295.52749197588, 4423.623991960655, 4528.547145285511, 4529.932051019237, 4625.398698169284, 9321.347505674674, 9344.766380840534, 9360.204382627417, 9361.391509551993, 9371.625134994523, 4468.374427580141, 5029.0947629427055, 5175.611829112831, 5185.455527169668, 5186.092433824066, 4246.320588705792, 4259.595338442843, 4636.79134438951, 4665.930011049837, 4775.761211939389, 3724.3110024645525, 3769.1707824278615, 3860.208657225262, 3866.168773713665, 3913.7651740895635, 1237.4369661803858, 1249.7562975219926, 1249.8562665293607, 1266.0, 1267.6070418170398, 906.1618003346878, 924.7179610218814, 927.2211342472356, 930.7068273493828, 964.5418426247617, 5492.1212605982855, 5572.637778544382, 5650.124230744241, 5745.511631511368, 5924.851878703067, 952.4428209497521, 1003.1523362758458, 1004.2066767253933, 1008.606643409071, 1021.382063851374, 3180.9204769880475, 3606.495090687253, 3814.275287695329, 3844.6732027777953, 3902.746321489094, 9607.279454040836, 9924.255680823968, 9929.602815887283, 9941.204703623693, 9955.601775928882, 9870.21038316933, 9872.111509964137, 9890.010998900052, 9898.960609135936, 9911.10800028001, 7282.672279747424, 7627.847443051219, 7631.961840190764, 7657.272559106876, 7741.18717534662, 4811.975940120277, 5364.168553874156, 5440.564754819526, 5525.254090697865, 5567.997760403005, 8692.434991725517, 8807.867881981903, 9153.359264851397, 9173.724788256362, 9247.0752924707, 9095.135962083592, 9244.936832264375, 9328.02055784133, 9436.858447123435, 9447.0, 6439.098526206241, 6630.336966303331, 6632.436242919406, 6775.288594697683, 6948.166220053626, 7506.399488041053, 7732.574708391093, 7759.030121234846, 7774.378049756119, 7809.906613074288, 6901.344372284625, 6957.095577575085, 6965.860682786417, 6992.580445173306, 7047.47143964215, 5739.8565035874435, 6812.0, 6900.2409734928115, 6902.137232845895, 6923.169219693669, 6217.378262173746, 6323.652199129092, 6388.233411990591, 6417.294097649348, 6433.420992110732, 4931.852044438672, 4972.453030166606, 4996.775145118551, 5015.974920125376, 5095.108356037753, 4645.256758918556, 4916.950830491649, 5016.698998060128, 5067.5185857343495, 5084.135696931605], "value": 4367.126024080916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.9191026512577, 309.3611691856315, 346.71742529838195, 349.54908168462686, 359.60443512136646, 4586.931196032058, 5231.718229033887, 5236.764345604447, 5246.003259380725, 5272.420033796279, 4046.4739583854057, 4594.931076033862, 4774.1645212087915, 4981.302617633534, 5003.3245511855885, 3317.336532693465, 3428.314337132571, 4026.8590599329027, 4066.8373265069363, 4110.383442483637, 4042.8787136385954, 4085.836566537335, 4091.9795401022952, 4104.835806567734, 4132.772697501636, 3116.579261799651, 3522.2488050226557, 3969.7221194516396, 4033.3143365627766, 4071.246819338432, 3082.33729748103, 3918.9804050979565, 3923.8234279457492, 3938.9803050984847, 3980.343243364856, 2951.8930401099587, 3058.690688530168, 3374.173327534745, 3407.9605720255313, 3425.383430982422, 5077.695338279715, 5089.211172268304, 5091.523458197118, 5115.948840511622, 5123.795048198068, 3821.99345343694, 4255.361695745632, 4490.483594386655, 4506.0, 4537.185125949613, 4706.788194531255, 4806.894414284734, 5292.338457692788, 5451.427600102012, 5462.661647896251, 3163.9242657496334, 3753.5120434343635, 3754.812259387047, 3762.7930463824478, 3764.7741135531955, 5444.564434845203, 5659.462351076641, 5703.5152012079025, 5761.8559536011935, 5763.567732420085, 3379.425497665403, 3795.373763329075, 3796.3166630006863, 3800.923981520354, 3812.504374431306, 3254.8372581370836, 3273.3126043531124, 3840.38703744428, 3863.265979463893, 3878.825452854628, 4307.300526226767, 4403.735775853459, 4498.595126438636, 4502.5047244803045, 4504.801590870518, 4766.833160839354, 5253.529011876681, 5338.813141540028, 5506.311711036121, 5527.917081243784, 1096.7587130831205, 1123.780697942725, 1125.1336470917347, 1229.8708635593314, 1250.7185883176394, 718.8059224009488, 805.5569436809732, 825.8472182646229, 849.7535714642685, 856.6573370651789, 4880.633952453509, 4897.681650692693, 4908.607311415079, 4938.0, 4972.72650004246, 4733.573978341966, 5217.660852044605, 5302.973485132627, 5360.4805741301525, 5399.973000134974, 3989.7406668567032, 4689.812407503661, 4821.493743156988, 4870.878228044327, 4880.633952453581, 2490.68866391701, 2688.6504754381804, 2718.5514390125804, 2777.180731684158, 2830.4480626277677, 5012.774425150877, 5016.0, 5541.944580554224, 5571.693556854412, 5590.825926555388, 5029.7736601853, 5412.83761487156, 5440.238366628675, 5440.836774896759, 5471.2887324647545, 4574.908501829945, 4842.176829938919, 5306.96514179739, 5527.143292789624, 5611.765411609439, 4506.639468842419, 5173.275741396133, 5174.430812610685, 5262.89474210506, 5337.879045400509, 5596.356419011866, 5622.662640241435, 5649.661020338793, 5662.688552129673, 5666.0, 5047.848564543069, 5451.318585176853, 5784.94215057844, 5953.9404605955115, 5974.014287642664, 3379.6451372606507, 3418.777779444328, 3634.1459756957624, 3822.464854920258, 3857.363535016691, 5385.3268341457315, 5617.354004289559, 5622.662640241599, 5645.858853528694, 5669.121286200645, 5484.341878974548, 5508.7521061553125, 5513.8345849624575, 5519.862003449785, 5547.1679248113105, 4814.614830813456, 5247.291615631993, 5391.406945236099, 5475.5072043516275, 5514.972425137848, 5119.283300337881, 5381.865453363541, 5412.296401467784, 5426.403095659395, 5456.48163424474, 3887.5119923248576, 4819.927701084556, 5056.924146137884, 5305.148380396957, 5338.679679219259, 4674.462436819809, 4743.667943244078, 4877.268409738567, 5405.108157154025, 5429.40276569585], "value": 3923.598141300839, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.0666719929695, 713.9143302803665, 772.5712229712507, 819.0, 828.8176601147748, 15036.473723419682, 15970.201489925501, 15977.600559986005, 15979.680406391864, 15999.920000399981, 14539.418423263083, 14604.0, 14607.561773146823, 14693.632659183526, 14731.042482238674, 852.7697521669161, 861.9267362274182, 870.2254993056185, 873.7553485024204, 876.1019954546578, 863.8056437301619, 865.8354912566592, 866.23338345564, 866.6749968761715, 866.8483015472267, 718.9928100718978, 743.4721347843038, 746.4513582516846, 915.7939463620698, 918.4764684130049, 745.0612228591986, 745.4520927118537, 869.1873098652717, 901.3645380007144, 901.9413738107068, 670.1589505170979, 670.9630970296631, 670.993290067098, 672.8149758816315, 673.0913267089439, 15030.023048501813, 15369.692606147926, 15404.92297538505, 15410.845891541165, 15437.228138593026, 13345.933270333684, 14011.633127475463, 14176.574702758933, 14232.644183895485, 14258.28708564578, 12751.10742248043, 12954.546590869368, 12977.0, 13076.280804555745, 13287.933560332232, 4465.084657645175, 4488.0, 4489.461264648263, 4566.223741963874, 4700.083483720676, 106147.0, 108096.4595177027, 108827.45586272098, 110544.0, 111021.0, 9974.501274936225, 11057.612983545538, 11147.498362573704, 11159.609413670645, 11373.829392559119, 22249.777502225093, 22419.327420177422, 22603.660945085838, 22667.88666056659, 22703.545929081327, 7728.806779830549, 7748.4188685848785, 7774.1837107104075, 7868.291853733192, 7941.801454963672, 4236.343366778155, 4263.552327005682, 4295.37717031035, 4311.965128369232, 4405.713628614129, 3473.8436770345397, 3518.2435776307707, 3539.0, 3559.928801423957, 3566.8751593694615, 646.5635695905245, 651.0949779806074, 654.6693919570681, 666.1706175811049, 667.1027468055457, 634.5621521150483, 643.719981807915, 648.4326214562258, 657.5495785387026, 668.5153263883645, 9366.250699943988, 9838.75403114928, 9921.603135874628, 10123.59505619767, 10350.223733220038, 516.7493765523718, 630.3255516597288, 647.7409036385484, 664.538145988543, 681.57401623985, 4100.712950093465, 4556.134334476439, 4794.6939646827, 4948.925766113512, 4969.346558341254, 101057.98942010633, 103306.96693033124, 103442.93114137676, 105629.0, 107922.0, 91407.08592914119, 94356.52821735847, 95269.5236523813, 96020.55969160468, 96371.51814240884, 69682.65158674275, 75849.0, 81070.18929810627, 81625.59187204145, 82005.0, 8049.055962578177, 10251.948740256252, 10478.685639430829, 10567.841482377617, 10622.73443163896, 50283.497165029345, 50409.99180016453, 51653.0, 51699.70750731262, 52247.47752522426, 63513.0, 66774.0, 69625.95561066487, 70189.64905175442, 72528.63735681288, 12992.0, 13473.595792126252, 13500.454385189385, 13559.661008474472, 13565.728685426038, 13347.866521334663, 14909.925450373112, 14973.475928342456, 15044.323005464561, 15927.203639818195, 13862.02965792385, 14022.649433764238, 14095.577132686036, 14169.929150354183, 14185.503507377192, 14002.789958150432, 14127.43490260378, 14133.363998620292, 14528.26606173845, 14586.781198282246, 13547.458101675822, 13926.721465570428, 14188.574342769733, 14650.267486625839, 15211.619709507351, 10275.763699037228, 11298.209125361145, 11668.649940501798, 11749.706257343634, 11800.704982375166, 11345.890206830833, 11348.773024539298, 11522.481488333213, 11730.472128754398, 11751.88248117542], "value": 7641.0680591504715, "unit": "score"}], "name": "dromaeo_css", "value": 7227.621701781304, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 112.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 112.0, 148.0, 120.0, 143.0, 142.0, 112.0, 131.0, 111.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 266.0, 215.0, 185.0, 183.0, 182.0, 182.0, 184.0, 180.0, 186.0], "value": 196.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 88.0, 61.0, 60.0, 59.0, 60.0, 74.0, 59.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 87.0, 70.0, 69.0, 69.0, 82.0, 69.0, 71.0, 84.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 104.0, 114.0, 87.0, 85.0, 90.0, 87.0, 88.0, 84.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 94.0, 97.0, 97.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 87.0, 85.0, 84.0, 86.0, 86.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 75.0, 72.0, 73.0, 70.0, 71.0, 71.0, 71.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 87.0, 91.0, 87.0, 85.0, 83.0, 75.0, 77.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 141.0, 140.0, 141.0, 128.0, 156.0, 149.0, 203.0, 154.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 174.0, 176.0, 178.0, 173.0, 175.0, 175.0, 176.0, 178.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1453.6, "alertThreshold": 2.0}]} 09:57:56 INFO - Return code: 0 09:57:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:57:56 ERROR - # TBPL SUCCESS # 09:57:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:57:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:57:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:57:56 INFO - 2017-01-22 09:57:56.844 screenresolution[1667:12364] starting screenresolution argv=screenresolution get 09:57:56 INFO - 2017-01-22 09:57:56.846 screenresolution[1667:12364] Display 0: 1600x1200x32@60 09:57:56 INFO - 2017-01-22 09:57:56.853 screenresolution[1668:12367] starting screenresolution argv=screenresolution list 09:57:56 INFO - Available Modes on Display 0 09:57:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:57:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:57:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:57:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:57:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:57:57 INFO - Intel Iris: 09:57:57 INFO - Chipset Model: Intel Iris 09:57:57 INFO - Type: GPU 09:57:57 INFO - Bus: Built-In 09:57:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:57:57 INFO - Vendor: Intel (0x8086) 09:57:57 INFO - Device ID: 0x0a2e 09:57:57 INFO - Revision ID: 0x0009 09:57:57 INFO - Displays: 09:57:57 INFO - Display: 09:57:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:57:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:57:57 INFO - Display Serial Number: 1600x1200 60 09:57:57 INFO - Main Display: Yes 09:57:57 INFO - Mirror: Off 09:57:57 INFO - Online: Yes 09:57:57 INFO - Rotation: Supported 09:57:57 INFO - Return code: 0 09:57:57 INFO - Running post-action listener: _resource_record_post_action 09:57:57 INFO - [mozharness: 2017-01-22 17:57:57.087471Z] Finished run-tests step (success) 09:57:57 INFO - Running post-run listener: _resource_record_post_run 09:57:57 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32332800; Write bytes: 553981440; Read time: 192; Write time: 1646 09:57:57 INFO - TinderboxPrint: CPU usage
53.7% 09:57:57 INFO - TinderboxPrint: I/O read bytes / time
32,332,800 / 192 09:57:57 INFO - TinderboxPrint: I/O write bytes / time
553,981,440 / 1,646 09:57:57 INFO - TinderboxPrint: CPU idle
2,227.0 (46.3%) 09:57:57 INFO - TinderboxPrint: CPU system
961.1 (20.0%) 09:57:57 INFO - TinderboxPrint: CPU user
1,621.5 (33.7%) 09:57:57 INFO - TinderboxPrint: Swap in / out
278,904,832 / 0 09:57:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252295680; Write bytes: 255084544; Read time: 18150; Write time: 550 09:57:57 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 28920832; Write bytes: 297303552; Read time: 169; Write time: 1091 09:57:57 INFO - Running post-run listener: _upload_blobber_files 09:57:57 INFO - Blob upload gear active. 09:57:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:57:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:57:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:57:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:57:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:59 INFO - (blobuploader) - INFO - Done attempting. 09:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:00 INFO - (blobuploader) - INFO - Done attempting. 09:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:01 INFO - (blobuploader) - INFO - Done attempting. 09:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:03 INFO - (blobuploader) - INFO - Done attempting. 09:58:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:58:03 INFO - Return code: 0 09:58:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:58:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:58:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0e5539855749cc2518127af1e36483964729202835c330614d1233617fe8405d15ce6df0b0587cd17b1fcb2cc9001935d554da4feb7c3c6dc07bf31a58ba5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36fa3b265bb671b749df6e6ef21744e81c5680c9eb3e6b06a646bcc98bc5c44a7c2eb7cb9a300ad7fd1c5217bb2d357b881d23e81bd3644747a3d520415f48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c6306a71c545a1be60d4b069fa277c00cc8256d9254a97721a7305f011b1da39720646dca4edd61fb4eb9f1fc48b58c54150d08d3da643540f42c0acae4ef9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26cfd364f51db8b91eab2528024e862cc79802097755540be6f157c4a7988cd99adda20541f5884cfe86b0d3b2f2023587c0a9c6ac7c1273e5318f8513fdc0a"} 09:58:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:58:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:58:03 INFO - Contents: 09:58:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0e5539855749cc2518127af1e36483964729202835c330614d1233617fe8405d15ce6df0b0587cd17b1fcb2cc9001935d554da4feb7c3c6dc07bf31a58ba5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36fa3b265bb671b749df6e6ef21744e81c5680c9eb3e6b06a646bcc98bc5c44a7c2eb7cb9a300ad7fd1c5217bb2d357b881d23e81bd3644747a3d520415f48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c6306a71c545a1be60d4b069fa277c00cc8256d9254a97721a7305f011b1da39720646dca4edd61fb4eb9f1fc48b58c54150d08d3da643540f42c0acae4ef9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26cfd364f51db8b91eab2528024e862cc79802097755540be6f157c4a7988cd99adda20541f5884cfe86b0d3b2f2023587c0a9c6ac7c1273e5318f8513fdc0a"} 09:58:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:58:03 INFO - Copying logs to upload dir... 09:58:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:58:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.326115 ========= master_lag: 0.81 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-22 09:58:04.034562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 09:58:04.037821) ========= 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.FPpecVvAkq/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.5RrfImNtEL/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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/a0e5539855749cc2518127af1e36483964729202835c330614d1233617fe8405d15ce6df0b0587cd17b1fcb2cc9001935d554da4feb7c3c6dc07bf31a58ba5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36fa3b265bb671b749df6e6ef21744e81c5680c9eb3e6b06a646bcc98bc5c44a7c2eb7cb9a300ad7fd1c5217bb2d357b881d23e81bd3644747a3d520415f48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c6306a71c545a1be60d4b069fa277c00cc8256d9254a97721a7305f011b1da39720646dca4edd61fb4eb9f1fc48b58c54150d08d3da643540f42c0acae4ef9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26cfd364f51db8b91eab2528024e862cc79802097755540be6f157c4a7988cd99adda20541f5884cfe86b0d3b2f2023587c0a9c6ac7c1273e5318f8513fdc0a"} build_url:https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/TJWVn1lmSZOvU9p33A7wOw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0e5539855749cc2518127af1e36483964729202835c330614d1233617fe8405d15ce6df0b0587cd17b1fcb2cc9001935d554da4feb7c3c6dc07bf31a58ba5b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36fa3b265bb671b749df6e6ef21744e81c5680c9eb3e6b06a646bcc98bc5c44a7c2eb7cb9a300ad7fd1c5217bb2d357b881d23e81bd3644747a3d520415f48e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c6306a71c545a1be60d4b069fa277c00cc8256d9254a97721a7305f011b1da39720646dca4edd61fb4eb9f1fc48b58c54150d08d3da643540f42c0acae4ef9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26cfd364f51db8b91eab2528024e862cc79802097755540be6f157c4a7988cd99adda20541f5884cfe86b0d3b2f2023587c0a9c6ac7c1273e5318f8513fdc0a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 09:58:04.074887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:58:04.075234) ========= 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.FPpecVvAkq/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.5RrfImNtEL/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005064 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 09:58:04.124232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 09:58:04.124589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 09:58:04.124943) ========= ========= Total master_lag: 1.55 =========