builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0127 starttime: 1484105265.14 results: success (0) buildid: 20170110181205 builduid: 39a4aec397a14d7cba1f9f7566eeeb6f revision: 2963cf6be7f830c0d2155e2968cfc53585868a76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.141927) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.142336) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.142633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.167778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.168040) ========= 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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-10 19:27:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.35M=0.001s 2017-01-10 19:27:45 (8.35 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115783 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.306763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.307060) ========= 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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.021495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:45.354881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-10 19:27:45.355197) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2963cf6be7f830c0d2155e2968cfc53585868a76 --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 2963cf6be7f830c0d2155e2968cfc53585868a76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NjiJmPXkma/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.Ma4jGpvr6W/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-10 19:27:45,431 truncating revision to first 12 chars 2017-01-10 19:27:45,431 Setting DEBUG logging. 2017-01-10 19:27:45,431 attempt 1/10 2017-01-10 19:27:45,431 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2963cf6be7f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 19:27:47,285 unpacking tar archive at: mozilla-central-2963cf6be7f8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.113574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-10 19:27:47.492772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:47.493090) ========= script_repo_revision: 2963cf6be7f830c0d2155e2968cfc53585868a76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:47.493509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:47.493774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 19:27:47.513757) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-10 19:27:47.514017) ========= /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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:27:47 INFO - MultiFileLogger online at 20170110 19:27:47 in /builds/slave/test 19:27:47 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 19:27:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:27:47 INFO - {'append_to_log': False, 19:27:47 INFO - 'base_work_dir': '/builds/slave/test', 19:27:47 INFO - 'blob_upload_branch': 'Firefox', 19:27:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:27:47 INFO - 'branch': 'Firefox', 19:27:47 INFO - 'buildbot_json_path': 'buildprops.json', 19:27:47 INFO - 'config_files': ('talos/mac_config.py',), 19:27:47 INFO - 'default_actions': ('clobber', 19:27:47 INFO - 'read-buildbot-config', 19:27:47 INFO - 'download-and-extract', 19:27:47 INFO - 'populate-webroot', 19:27:47 INFO - 'create-virtualenv', 19:27:47 INFO - 'install', 19:27:47 INFO - 'run-tests'), 19:27:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:27:47 INFO - 'download_minidump_stackwalk': True, 19:27:47 INFO - 'download_symbols': 'ondemand', 19:27:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:27:47 INFO - 'tooltool.py': '/tools/tooltool.py', 19:27:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:27:47 INFO - '/tools/misc-python/virtualenv.py')}, 19:27:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:27:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:27:47 INFO - 'installer_path': 'installer.exe', 19:27:47 INFO - 'log_level': 'info', 19:27:47 INFO - 'log_name': 'talos', 19:27:47 INFO - 'log_to_console': True, 19:27:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:27:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:27:47 INFO - 'opt_config_files': (), 19:27:47 INFO - 'pip_index': False, 19:27:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:27:47 INFO - 'cmd': ('bash', 19:27:47 INFO - '-c', 19:27:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:27:47 INFO - 'enabled': True, 19:27:47 INFO - 'halt_on_failure': False, 19:27:47 INFO - 'name': 'check_screen_resolution'},), 19:27:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:27:47 INFO - 'cmd': ('bash', 19:27:47 INFO - '-c', 19:27:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:27:47 INFO - 'enabled': True, 19:27:47 INFO - 'halt_on_failure': False, 19:27:47 INFO - 'name': 'check_screen_resolution'},), 19:27:47 INFO - 'run_cmd_checks_enabled': True, 19:27:47 INFO - 'sps_profile': False, 19:27:47 INFO - 'sps_profile_interval': 0, 19:27:47 INFO - 'suite': 'dromaeojs', 19:27:47 INFO - 'system_bits': '32', 19:27:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:27:47 INFO - 'title': 't-yosemite-r7-0127', 19:27:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:27:47 INFO - 'use_talos_json': True, 19:27:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:27:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:27:47 INFO - 'work_dir': 'build'} 19:27:47 INFO - [mozharness: 2017-01-11 03:27:47.720395Z] Running clobber step. 19:27:47 INFO - Running pre-action listener: _resource_record_pre_action 19:27:47 INFO - Running main action method: clobber 19:27:47 INFO - rmtree: /builds/slave/test/build 19:27:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:27:49 INFO - Running post-action listener: _resource_record_post_action 19:27:49 INFO - [mozharness: 2017-01-11 03:27:49.439063Z] Finished clobber step (success) 19:27:49 INFO - [mozharness: 2017-01-11 03:27:49.439191Z] Running read-buildbot-config step. 19:27:49 INFO - Running pre-action listener: _resource_record_pre_action 19:27:49 INFO - Running main action method: read_buildbot_config 19:27:49 INFO - Using buildbot properties: 19:27:49 INFO - { 19:27:49 INFO - "project": "", 19:27:49 INFO - "product": "firefox", 19:27:49 INFO - "script_repo_revision": "production", 19:27:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:27:49 INFO - "repository": "", 19:27:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:27:49 INFO - "buildid": "20170110181205", 19:27:49 INFO - "pgo_build": "False", 19:27:49 INFO - "basedir": "/builds/slave/test", 19:27:49 INFO - "buildnumber": 51, 19:27:49 INFO - "slavename": "t-yosemite-r7-0127", 19:27:49 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:27:49 INFO - "platform": "yosemite_r7", 19:27:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:27:49 INFO - "branch": "mozilla-central", 19:27:49 INFO - "repo_path": "mozilla-central", 19:27:49 INFO - "revision": "2963cf6be7f830c0d2155e2968cfc53585868a76", 19:27:49 INFO - "stage_platform": "macosx64", 19:27:49 INFO - "builduid": "39a4aec397a14d7cba1f9f7566eeeb6f", 19:27:49 INFO - "slavebuilddir": "test" 19:27:49 INFO - } 19:27:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:27:49 INFO - Running post-action listener: _resource_record_post_action 19:27:49 INFO - [mozharness: 2017-01-11 03:27:49.442523Z] Finished read-buildbot-config step (success) 19:27:49 INFO - [mozharness: 2017-01-11 03:27:49.442633Z] Running download-and-extract step. 19:27:49 INFO - Running pre-action listener: _resource_record_pre_action 19:27:49 INFO - Running main action method: download_and_extract 19:27:49 INFO - mkdir: /builds/slave/test/build/tests 19:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:49 INFO - trying https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:27:49 INFO - Downloading https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/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 19:27:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/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 19:27:50 INFO - Downloaded 1199 bytes. 19:27:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:27:50 INFO - Using the following test package requirements: 19:27:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:27:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:27:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:27:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'jsshell-mac.zip'], 19:27:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:27:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:27:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:27:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:27:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:27:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:27:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:27:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:27:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:27:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:27:50 INFO - Fetch https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:27:51 INFO - Expected file size: 16311490 19:27:51 INFO - Obtained file size: 16311490 19:27:58 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 19:27:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:27:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:27:58 INFO - Fetch https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:27:59 INFO - Expected file size: 16311490 19:27:59 INFO - Obtained file size: 16311490 19:28:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:28:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:28:05 INFO - Fetch https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:28:06 INFO - Expected file size: 14403529 19:28:06 INFO - Obtained file size: 14403529 19:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:06 INFO - trying https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:28:06 INFO - Downloading https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:28:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/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 19:28:08 INFO - Downloaded 69836130 bytes. 19:28:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:28:08 INFO - mkdir: /builds/slave/test/properties 19:28:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:28:08 INFO - Writing to file /builds/slave/test/properties/build_url 19:28:08 INFO - Contents: 19:28:08 INFO - build_url:https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:28:09 INFO - Running post-action listener: _resource_record_post_action 19:28:09 INFO - Running post-action listener: set_extra_try_arguments 19:28:09 INFO - [mozharness: 2017-01-11 03:28:09.112019Z] Finished download-and-extract step (success) 19:28:09 INFO - [mozharness: 2017-01-11 03:28:09.112179Z] Running populate-webroot step. 19:28:09 INFO - Running pre-action listener: _resource_record_pre_action 19:28:09 INFO - Running main action method: populate_webroot 19:28:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:28:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:28:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:28:09 INFO - '--tppagecycles', 19:28:09 INFO - '7'], 19:28:09 INFO - 'tests': ['tsvgm']}}, 19:28:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:28:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:28:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:28:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:28:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:28:09 INFO - 'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:28:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:28:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:28:09 INFO - 'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['damp', 'tps']}, 19:28:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:28:09 INFO - 'tests': ['damp', 'tps']}, 19:28:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['dromaeo_dom']}, 19:28:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:28:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['basic_compositor_video']}, 19:28:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:28:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['a11yr', 19:28:09 INFO - 'ts_paint', 19:28:09 INFO - 'tpaint', 19:28:09 INFO - 'sessionrestore', 19:28:09 INFO - 'sessionrestore_no_auto_restore', 19:28:09 INFO - 'tabpaint']}, 19:28:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:28:09 INFO - 'ts_paint', 19:28:09 INFO - 'tpaint', 19:28:09 INFO - 'sessionrestore', 19:28:09 INFO - 'sessionrestore_no_auto_restore', 19:28:09 INFO - 'tabpaint']}, 19:28:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:28:09 INFO - 'ts_paint', 19:28:09 INFO - 'tpaint', 19:28:09 INFO - 'sessionrestore', 19:28:09 INFO - 'sessionrestore_no_auto_restore', 19:28:09 INFO - 'tabpaint']}, 19:28:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:28:09 INFO - 'ts_paint', 19:28:09 INFO - 'tpaint', 19:28:09 INFO - 'sessionrestore', 19:28:09 INFO - 'sessionrestore_no_auto_restore', 19:28:09 INFO - 'tabpaint']}, 19:28:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['a11yr', 19:28:09 INFO - 'ts_paint', 19:28:09 INFO - 'tpaint', 19:28:09 INFO - 'sessionrestore', 19:28:09 INFO - 'sessionrestore_no_auto_restore', 19:28:09 INFO - 'tabpaint']}, 19:28:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['a11yr', 19:28:09 INFO - 'ts_paint', 19:28:09 INFO - 'tpaint', 19:28:09 INFO - 'sessionrestore', 19:28:09 INFO - 'sessionrestore_no_auto_restore', 19:28:09 INFO - 'tabpaint']}, 19:28:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['tsvgx', 19:28:09 INFO - 'tsvgr_opacity', 19:28:09 INFO - 'tart', 19:28:09 INFO - 'tscrollx', 19:28:09 INFO - 'cart', 19:28:09 INFO - 'tsvg_static']}, 19:28:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:28:09 INFO - 'tsvgr_opacity', 19:28:09 INFO - 'tart', 19:28:09 INFO - 'tscrollx', 19:28:09 INFO - 'cart', 19:28:09 INFO - 'tsvg_static']}, 19:28:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:28:09 INFO - 'talos_options': ['--disable-e10s'], 19:28:09 INFO - 'tests': ['tp5o']}, 19:28:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:28:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:28:09 INFO - 'talos_options': ['--disable-e10s', 19:28:09 INFO - '--xperf_path', 19:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:28:09 INFO - 'tests': ['tp5n']}, 19:28:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:28:09 INFO - 'talos_options': ['--xperf_path', 19:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:28:09 INFO - 'tests': ['tp5n']}}, 19:28:09 INFO - 'talos.zip': {'path': '', 19:28:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:28:09 INFO - Running post-action listener: _resource_record_post_action 19:28:09 INFO - [mozharness: 2017-01-11 03:28:09.130533Z] Finished populate-webroot step (success) 19:28:09 INFO - [mozharness: 2017-01-11 03:28:09.130624Z] Running create-virtualenv step. 19:28:09 INFO - Running pre-action listener: _resource_record_pre_action 19:28:09 INFO - Running main action method: create_virtualenv 19:28:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:28:09 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 19:28:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:28:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:28:09 INFO - Using real prefix '/tools/python27' 19:28:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:28:09 INFO - Installing distribute.............................................................................................................................................................................................done. 19:28:13 INFO - Installing pip.................done. 19:28:13 INFO - Return code: 0 19:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:28:13 INFO - Reading from file tmpfile_stdout 19:28:13 INFO - Output received: 19:28:13 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) 19:28:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:13 INFO - 'HOME': '/Users/cltbld', 19:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:13 INFO - 'LOGNAME': 'cltbld', 19:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:13 INFO - 'MOZ_NO_REMOTE': '1', 19:28:13 INFO - 'NO_EM_RESTART': '1', 19:28:13 INFO - 'PAGER': '/bin/cat', 19:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:13 INFO - 'PWD': '/builds/slave/test', 19:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:13 INFO - 'SHELL': '/bin/bash', 19:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:13 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:13 INFO - 'USER': 'cltbld', 19:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:13 INFO - 'XPC_FLAGS': '0x0', 19:28:13 INFO - 'XPC_SERVICE_NAME': '0', 19:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:13 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 19:28:13 INFO - Cleaning up... 19:28:13 INFO - Return code: 0 19:28:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:13 INFO - 'HOME': '/Users/cltbld', 19:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:13 INFO - 'LOGNAME': 'cltbld', 19:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:13 INFO - 'MOZ_NO_REMOTE': '1', 19:28:13 INFO - 'NO_EM_RESTART': '1', 19:28:13 INFO - 'PAGER': '/bin/cat', 19:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:13 INFO - 'PWD': '/builds/slave/test', 19:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:13 INFO - 'SHELL': '/bin/bash', 19:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:13 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:13 INFO - 'USER': 'cltbld', 19:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:13 INFO - 'XPC_FLAGS': '0x0', 19:28:13 INFO - 'XPC_SERVICE_NAME': '0', 19:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:13 INFO - Downloading/unpacking psutil>=3.1.1 19:28:13 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 19:28:13 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 19:28:13 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 19:28:13 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 19:28:13 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 19:28:13 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 19:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:28:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:28:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:28:17 INFO - Installing collected packages: psutil 19:28:17 INFO - Running setup.py install for psutil 19:28:17 INFO - building 'psutil._psutil_osx' extension 19:28:17 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 19:28:17 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 19:28:17 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 19:28:17 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 19:28:17 INFO - building 'psutil._psutil_posix' extension 19:28:17 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 19:28:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:28:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:28:17 INFO - ^ 19:28:17 INFO - 1 warning generated. 19:28:17 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 19:28:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:28:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:28:18 INFO - Successfully installed psutil 19:28:18 INFO - Cleaning up... 19:28:18 INFO - Return code: 0 19:28:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:28: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')]} 19:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28: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')]} 19:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:18 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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:18 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 19:28:18 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 19:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:18 INFO - 'HOME': '/Users/cltbld', 19:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:18 INFO - 'LOGNAME': 'cltbld', 19:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:18 INFO - 'MOZ_NO_REMOTE': '1', 19:28:18 INFO - 'NO_EM_RESTART': '1', 19:28:18 INFO - 'PAGER': '/bin/cat', 19:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:18 INFO - 'PWD': '/builds/slave/test', 19:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:18 INFO - 'SHELL': '/bin/bash', 19:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:18 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:18 INFO - 'USER': 'cltbld', 19:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:18 INFO - 'XPC_FLAGS': '0x0', 19:28:18 INFO - 'XPC_SERVICE_NAME': '0', 19:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:28:18 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 19:28:18 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 19:28:18 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 19:28:18 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 19:28:18 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 19:28:18 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 19:28:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:28:21 INFO - Installing collected packages: mozsystemmonitor 19:28:21 INFO - Running setup.py install for mozsystemmonitor 19:28:21 INFO - Successfully installed mozsystemmonitor 19:28:21 INFO - Cleaning up... 19:28:21 INFO - Return code: 0 19:28:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:21 INFO - 'HOME': '/Users/cltbld', 19:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:21 INFO - 'LOGNAME': 'cltbld', 19:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:21 INFO - 'MOZ_NO_REMOTE': '1', 19:28:21 INFO - 'NO_EM_RESTART': '1', 19:28:21 INFO - 'PAGER': '/bin/cat', 19:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:21 INFO - 'PWD': '/builds/slave/test', 19:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:21 INFO - 'SHELL': '/bin/bash', 19:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:21 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:21 INFO - 'USER': 'cltbld', 19:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:21 INFO - 'XPC_FLAGS': '0x0', 19:28:21 INFO - 'XPC_SERVICE_NAME': '0', 19:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:21 INFO - Downloading/unpacking jsonschema==2.5.1 19:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:28:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:24 INFO - Downloading functools32-3.2.3-2.tar.gz 19:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:28:24 INFO - warning: no files found matching '*.txt' 19:28:24 INFO - no previously-included directories found matching 'build' 19:28:24 INFO - no previously-included directories found matching 'dist' 19:28:24 INFO - no previously-included directories found matching '.git*' 19:28:24 INFO - Installing collected packages: jsonschema, functools32 19:28:24 INFO - Running setup.py install for functools32 19:28:24 INFO - warning: no files found matching '*.txt' 19:28:24 INFO - no previously-included directories found matching 'build' 19:28:24 INFO - no previously-included directories found matching 'dist' 19:28:24 INFO - no previously-included directories found matching '.git*' 19:28:24 INFO - Successfully installed jsonschema functools32 19:28:24 INFO - Cleaning up... 19:28:25 INFO - Return code: 0 19:28:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:28: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')]} 19:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28: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')]} 19:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28: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', '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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:28: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 functools32==3.2.3-2 19:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:25 INFO - 'HOME': '/Users/cltbld', 19:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:25 INFO - 'LOGNAME': 'cltbld', 19:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:25 INFO - 'MOZ_NO_REMOTE': '1', 19:28:25 INFO - 'NO_EM_RESTART': '1', 19:28:25 INFO - 'PAGER': '/bin/cat', 19:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:25 INFO - 'PWD': '/builds/slave/test', 19:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:25 INFO - 'SHELL': '/bin/bash', 19:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:25 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:25 INFO - 'USER': 'cltbld', 19:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:25 INFO - 'XPC_FLAGS': '0x0', 19:28:25 INFO - 'XPC_SERVICE_NAME': '0', 19:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:28:25 INFO - Cleaning up... 19:28:25 INFO - Return code: 0 19:28:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:28: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')]} 19:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28: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')]} 19:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28: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', '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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:28: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 blobuploader==1.2.4 19:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:25 INFO - 'HOME': '/Users/cltbld', 19:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:25 INFO - 'LOGNAME': 'cltbld', 19:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:25 INFO - 'MOZ_NO_REMOTE': '1', 19:28:25 INFO - 'NO_EM_RESTART': '1', 19:28:25 INFO - 'PAGER': '/bin/cat', 19:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:25 INFO - 'PWD': '/builds/slave/test', 19:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:25 INFO - 'SHELL': '/bin/bash', 19:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:25 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:25 INFO - 'USER': 'cltbld', 19:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:25 INFO - 'XPC_FLAGS': '0x0', 19:28:25 INFO - 'XPC_SERVICE_NAME': '0', 19:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:25 INFO - Downloading/unpacking blobuploader==1.2.4 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28:28 INFO - Downloading blobuploader-1.2.4.tar.gz 19:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:28:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:28:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:29 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 19:28:29 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 19:28:29 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 19:28:29 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 19:28:29 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 19:28:29 INFO - Downloading docopt-0.6.1.tar.gz 19:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:28:29 INFO - Installing collected packages: blobuploader, requests, docopt 19:28:29 INFO - Running setup.py install for blobuploader 19:28:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:28:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:28:29 INFO - Running setup.py install for requests 19:28:30 INFO - Running setup.py install for docopt 19:28:30 INFO - Successfully installed blobuploader requests docopt 19:28:30 INFO - Cleaning up... 19:28:30 INFO - Return code: 0 19:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:30 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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:30 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 19:28:30 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 19:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:30 INFO - 'HOME': '/Users/cltbld', 19:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:30 INFO - 'LOGNAME': 'cltbld', 19:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:30 INFO - 'MOZ_NO_REMOTE': '1', 19:28:30 INFO - 'NO_EM_RESTART': '1', 19:28:30 INFO - 'PAGER': '/bin/cat', 19:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:30 INFO - 'PWD': '/builds/slave/test', 19:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:30 INFO - 'SHELL': '/bin/bash', 19:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:30 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:30 INFO - 'USER': 'cltbld', 19:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:30 INFO - 'XPC_FLAGS': '0x0', 19:28:30 INFO - 'XPC_SERVICE_NAME': '0', 19:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:28:30 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-fo711A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:28:30 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-N0EuNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:28:30 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-uphDFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:28:30 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-U2mdBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-gJv1Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-U0V5JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-zxG7wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-S9C4Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-CYXw1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-kZudj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-Ac9llW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-c4867a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:28:31 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-HW_Uhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:28:32 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-HBR86a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:32 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-5eyZ1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:28:32 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-Yrb60Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:28:32 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-sq5ZZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:28:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:28:32 INFO - Running setup.py install for manifestparser 19:28:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:28:32 INFO - Running setup.py install for mozcrash 19:28:32 INFO - Running setup.py install for mozdebug 19:28:32 INFO - Running setup.py install for mozdevice 19:28:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Running setup.py install for mozfile 19:28:33 INFO - Running setup.py install for mozhttpd 19:28:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Running setup.py install for mozinfo 19:28:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Running setup.py install for mozInstall 19:28:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Running setup.py install for mozleak 19:28:33 INFO - Running setup.py install for mozlog 19:28:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:28:33 INFO - Running setup.py install for moznetwork 19:28:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:28:34 INFO - Running setup.py install for mozprocess 19:28:34 INFO - Running setup.py install for mozprofile 19:28:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:28:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:28:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:28:34 INFO - Running setup.py install for mozrunner 19:28:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:28:34 INFO - Running setup.py install for mozscreenshot 19:28:34 INFO - Running setup.py install for moztest 19:28:34 INFO - Running setup.py install for mozversion 19:28:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:28:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:28:35 INFO - Cleaning up... 19:28:35 INFO - Return code: 0 19:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:35 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')]} 19:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:35 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')]} 19:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:35 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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:35 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 19:28:35 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 19:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:35 INFO - 'HOME': '/Users/cltbld', 19:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:35 INFO - 'LOGNAME': 'cltbld', 19:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:35 INFO - 'MOZ_NO_REMOTE': '1', 19:28:35 INFO - 'NO_EM_RESTART': '1', 19:28:35 INFO - 'PAGER': '/bin/cat', 19:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:35 INFO - 'PWD': '/builds/slave/test', 19:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:35 INFO - 'SHELL': '/bin/bash', 19:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:35 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:35 INFO - 'USER': 'cltbld', 19:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:35 INFO - 'XPC_FLAGS': '0x0', 19:28:35 INFO - 'XPC_SERVICE_NAME': '0', 19:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:28:35 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-fQ1G1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:28:35 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)) 19:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:28:35 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-b69_qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:28:35 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)) 19:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:28:35 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-WBEfDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:28:35 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)) 19:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:28:35 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ORZw4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:28:35 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)) 19:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:28:35 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-8N8xc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:28:35 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)) 19:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:28:35 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-X0qS_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-vZiLOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-f9CckG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-A6OMGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-zymTZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-sXz7Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-imvjO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-2COtK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-sXUNbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-TEGuj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:36 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)) 19:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:28:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-9vDulC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:28:37 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)) 19:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:28:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-GbD3jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:28:37 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)) 19:28:37 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)) 19:28:37 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)) 19:28:37 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)) 19:28:37 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)) 19:28:37 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)) 19:28:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28: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 19:28:40 INFO - Downloading blessings-1.6.tar.gz 19:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:28:40 INFO - Installing collected packages: blessings 19:28:40 INFO - Running setup.py install for blessings 19:28:41 INFO - Successfully installed blessings 19:28:41 INFO - Cleaning up... 19:28:41 INFO - Return code: 0 19:28:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:41 INFO - Reading from file tmpfile_stdout 19:28:41 INFO - Current package versions: 19:28:41 INFO - blessings == 1.6 19:28:41 INFO - blobuploader == 1.2.4 19:28:41 INFO - docopt == 0.6.1 19:28:41 INFO - functools32 == 3.2.3-2 19:28:41 INFO - jsonschema == 2.5.1 19:28:41 INFO - manifestparser == 1.1 19:28:41 INFO - mozInstall == 1.12 19:28:41 INFO - mozcrash == 1.0 19:28:41 INFO - mozdebug == 0.1 19:28:41 INFO - mozdevice == 0.49 19:28:41 INFO - mozfile == 1.2 19:28:41 INFO - mozhttpd == 0.7 19:28:41 INFO - mozinfo == 0.9 19:28:41 INFO - mozleak == 0.1 19:28:41 INFO - mozlog == 3.4 19:28:41 INFO - moznetwork == 0.27 19:28:41 INFO - mozprocess == 0.24 19:28:41 INFO - mozprofile == 0.28 19:28:41 INFO - mozrunner == 6.13 19:28:41 INFO - mozscreenshot == 0.1 19:28:41 INFO - mozsystemmonitor == 0.3 19:28:41 INFO - moztest == 0.8 19:28:41 INFO - mozversion == 1.4 19:28:41 INFO - psutil == 3.1.1 19:28:41 INFO - requests == 1.2.3 19:28:41 INFO - wsgiref == 0.1.2 19:28:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:41 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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:41 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 19:28:41 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 19:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:41 INFO - 'HOME': '/Users/cltbld', 19:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:41 INFO - 'LOGNAME': 'cltbld', 19:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:41 INFO - 'MOZ_NO_REMOTE': '1', 19:28:41 INFO - 'NO_EM_RESTART': '1', 19:28:41 INFO - 'PAGER': '/bin/cat', 19:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:41 INFO - 'PWD': '/builds/slave/test', 19:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:41 INFO - 'SHELL': '/bin/bash', 19:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:41 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:41 INFO - 'USER': 'cltbld', 19:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:41 INFO - 'XPC_FLAGS': '0x0', 19:28:41 INFO - 'XPC_SERVICE_NAME': '0', 19:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 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)) 19:28:41 INFO - Cleaning up... 19:28:41 INFO - Return code: 0 19:28:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:41 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 0x104731b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104734768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb73156bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, '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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 19:28:41 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 19:28:41 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 19:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:41 INFO - 'HOME': '/Users/cltbld', 19:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:41 INFO - 'LOGNAME': 'cltbld', 19:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:41 INFO - 'MOZ_NO_REMOTE': '1', 19:28:41 INFO - 'NO_EM_RESTART': '1', 19:28:41 INFO - 'PAGER': '/bin/cat', 19:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:41 INFO - 'PWD': '/builds/slave/test', 19:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:41 INFO - 'SHELL': '/bin/bash', 19:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:28:41 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:41 INFO - 'USER': 'cltbld', 19:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:41 INFO - 'XPC_FLAGS': '0x0', 19:28:41 INFO - 'XPC_SERVICE_NAME': '0', 19:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:28:42 INFO - Cleaning up... 19:28:42 INFO - Return code: 0 19:28:42 INFO - Running post-action listener: _resource_record_post_action 19:28:42 INFO - Running post-action listener: _start_resource_monitoring 19:28:42 INFO - Starting resource monitoring. 19:28:42 INFO - [mozharness: 2017-01-11 03:28:42.066654Z] Finished create-virtualenv step (success) 19:28:42 INFO - [mozharness: 2017-01-11 03:28:42.067763Z] Running install step. 19:28:42 INFO - Running pre-action listener: _resource_record_pre_action 19:28:42 INFO - Running main action method: install 19:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:42 INFO - Reading from file tmpfile_stdout 19:28:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:28:42 INFO - Reading from file tmpfile_stdout 19:28:42 INFO - Output received: 19:28:42 INFO - Usage: mozinstall [options] installer 19:28:42 INFO - Options: 19:28:42 INFO - -h, --help show this help message and exit 19:28:42 INFO - -d DEST, --destination=DEST 19:28:42 INFO - Directory to install application into. [default: 19:28:42 INFO - "/builds/slave/test"] 19:28:42 INFO - --app=APP Application being installed. [default: firefox] 19:28:42 INFO - mkdir: /builds/slave/test/build/application 19:28:42 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'] 19:28:42 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 19:29:04 INFO - Reading from file tmpfile_stdout 19:29:04 INFO - Output received: 19:29:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:29:04 INFO - Running post-action listener: _resource_record_post_action 19:29:04 INFO - [mozharness: 2017-01-11 03:29:04.507763Z] Finished install step (success) 19:29:04 INFO - [mozharness: 2017-01-11 03:29:04.507883Z] Running run-tests step. 19:29:04 INFO - Running pre-action listener: _resource_record_pre_action 19:29:04 INFO - Running main action method: run_tests 19:29:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:29:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:29:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:29:04 INFO - 2017-01-10 19:29:04.523 screenresolution[6670:121763] starting screenresolution argv=screenresolution get 19:29:04 INFO - 2017-01-10 19:29:04.526 screenresolution[6670:121763] Display 0: 1600x1200x32@60 19:29:04 INFO - 2017-01-10 19:29:04.532 screenresolution[6671:121766] starting screenresolution argv=screenresolution list 19:29:04 INFO - Available Modes on Display 0 19:29:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:29:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:29:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:29:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:29:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:29:04 INFO - Intel Iris: 19:29:04 INFO - Chipset Model: Intel Iris 19:29:04 INFO - Type: GPU 19:29:04 INFO - Bus: Built-In 19:29:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:29:04 INFO - Vendor: Intel (0x8086) 19:29:04 INFO - Device ID: 0x0a2e 19:29:04 INFO - Revision ID: 0x0009 19:29:04 INFO - Displays: 19:29:04 INFO - Display: 19:29:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:29:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:29:04 INFO - Display Serial Number: 1600x1200 60 19:29:04 INFO - Main Display: Yes 19:29:04 INFO - Mirror: Off 19:29:04 INFO - Online: Yes 19:29:04 INFO - Rotation: Supported 19:29:04 INFO - Return code: 0 19:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:29:04 INFO - Python 2.7.3 19:29:04 INFO - Return code: 0 19:29:04 INFO - grabbing minidump binary from tooltool 19:29:04 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')]} 19:29:04 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 0x10450fd30>, '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 0x104436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104504be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:29:04 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 19:29:04 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 19:29:04 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 19:29:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:29:04 INFO - Return code: 0 19:29:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:29:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:29:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:29:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:29:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:29:04 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/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 19:29:04 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/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0127 --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 19:29:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NjiJmPXkma/Render', 19:29:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:29:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:29:04 INFO - 'HOME': '/Users/cltbld', 19:29:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:29:04 INFO - 'LOGNAME': 'cltbld', 19:29:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:29:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:04 INFO - 'MOZ_NO_REMOTE': '1', 19:29:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:29:04 INFO - 'NO_EM_RESTART': '1', 19:29:04 INFO - 'PAGER': '/bin/cat', 19:29:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:04 INFO - 'PWD': '/builds/slave/test', 19:29:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:29:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:29:04 INFO - 'SHELL': '/bin/bash', 19:29:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ma4jGpvr6W/Listeners', 19:29:04 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 19:29:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:29:04 INFO - 'USER': 'cltbld', 19:29:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:29:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:04 INFO - 'XPC_FLAGS': '0x0', 19:29:04 INFO - 'XPC_SERVICE_NAME': '0', 19:29:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:29:04 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/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 19:29:05 INFO - mozversion application_buildid: 20170110181205 19:29:05 INFO - mozversion application_changeset: 2963cf6be7f830c0d2155e2968cfc53585868a76 19:29:05 INFO - mozversion application_display_name: Nightly 19:29:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:29:05 INFO - mozversion application_name: Firefox 19:29:05 INFO - mozversion application_remotingname: firefox 19:29:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:29:05 INFO - mozversion application_vendor: Mozilla 19:29:05 INFO - mozversion application_version: 53.0a1 19:29:05 INFO - mozversion platform_buildid: 20170110181205 19:29:05 INFO - mozversion platform_changeset: 2963cf6be7f830c0d2155e2968cfc53585868a76 19:29:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:29:05 INFO - mozversion platform_version: 53.0a1 19:29:05 INFO - using testdate: 1484105345 19:29:05 INFO - actual date: 1484105345 19:29:05 INFO - starting webserver on 'localhost:59680' 19:29:05 INFO - SUITE-START | Running 2 tests 19:29:05 INFO - TEST-START | dromaeo_css 19:29:05 INFO - operating with platform_type : mac_ 19:29:05 INFO - Initialising browser for dromaeo_css test... 19:29:05 INFO - TEST-INFO | started process 6681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpKhcQbu/profile http://localhost:59680/getInfo.html) 19:29:07 INFO - PROCESS | 6681 | __metrics Screen width/height:1600/1200 19:29:07 INFO - PROCESS | 6681 | colorDepth:24 19:29:07 INFO - PROCESS | 6681 | Browser inner width/height: 1024/689 19:29:07 INFO - PROCESS | 6681 | __metrics 19:29:07 INFO - PROCESS | 6681 | 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" 19:29:07 INFO - PROCESS | 6681 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:29:08 INFO - TEST-INFO | 6681: exit 0 19:29:08 INFO - Browser initialized. 19:29:08 INFO - Running cycle 1/1 for dromaeo_css test... 19:29:08 INFO - TEST-INFO | started process 6683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpKhcQbu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:20 INFO - PROCESS | 6683 | RSS: Main: 233918464 19:29:20 INFO - PROCESS | 6683 | 19:32:23 INFO - PROCESS | 6683 | Cycle 1(1): loaded http://localhost:59680/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59680/tests/dromaeo/cssquery-ext.html) 19:32:25 INFO - PROCESS | 6683 | RSS: Main: 351793152 19:32:25 INFO - PROCESS | 6683 | 19:34:09 INFO - PROCESS | 6683 | ************************* 19:34:09 INFO - PROCESS | 6683 | A coding exception was thrown and uncaught in a Task. 19:34:09 INFO - PROCESS | 6683 | 19:34:09 INFO - PROCESS | 6683 | Full message: ReferenceError: fetch is not defined 19:34:09 INFO - PROCESS | 6683 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:34:09 INFO - PROCESS | 6683 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:34:09 INFO - PROCESS | 6683 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:34:09 INFO - PROCESS | 6683 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:34:09 INFO - PROCESS | 6683 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:34:09 INFO - PROCESS | 6683 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:34:09 INFO - PROCESS | 6683 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:34:09 INFO - PROCESS | 6683 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:34:09 INFO - PROCESS | 6683 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:34:09 INFO - PROCESS | 6683 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:34:09 INFO - PROCESS | 6683 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:34:09 INFO - PROCESS | 6683 | 19:34:09 INFO - PROCESS | 6683 | ************************* 19:35:28 INFO - PROCESS | 6683 | Cycle 1(1): loaded http://localhost:59680/tests/dromaeo/cssquery-ext.html (next: http://localhost:59680/tests/dromaeo/cssquery-jquery.html) 19:35:28 INFO - PROCESS | 6683 | RSS: Main: 363732992 19:35:28 INFO - PROCESS | 6683 | 19:38:31 INFO - PROCESS | 6683 | Cycle 1(1): loaded http://localhost:59680/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59680/tests/dromaeo/cssquery-mootools.html) 19:38:31 INFO - PROCESS | 6683 | RSS: Main: 359415808 19:38:31 INFO - PROCESS | 6683 | 19:41:34 INFO - PROCESS | 6683 | Cycle 1(1): loaded http://localhost:59680/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59680/tests/dromaeo/cssquery-prototype.html) 19:41:34 INFO - PROCESS | 6683 | RSS: Main: 353517568 19:41:34 INFO - PROCESS | 6683 | 19:44:38 INFO - PROCESS | 6683 | Cycle 1(1): loaded http://localhost:59680/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59680/tests/dromaeo/cssquery-yui.html) 19:44:38 INFO - PROCESS | 6683 | RSS: Main: 328773632 19:44:38 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | Cycle 1(1): loaded http://localhost:59680/tests/dromaeo/cssquery-yui.html (next: http://localhost:59680/tests/dromaeo/cssquery-dojo.html) 19:47:42 INFO - PROCESS | 6683 | RSS: Main: 380100608 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | __start_tp_report 19:47:42 INFO - PROCESS | 6683 | _x_x_mozilla_page_load 19:47:42 INFO - PROCESS | 6683 | _x_x_mozilla_page_load_details 19:47:42 INFO - PROCESS | 6683 | |i|pagename|runs| 19:47:42 INFO - PROCESS | 6683 | |0;dojo.html;3247.3505298940217;3251.3334766372896;3256.5929258842652;3257.804531728095;3333.649966753491;5483.643563168392;5580.972095139528;5602.187682785999;5636.070048442008;5647.887042259153;5557.555395568355;5589.077802162638;5598.636088654234;5599.916001259974;5626.859328516779;5062.721550314741;5111.923321150167;5118.07874582575;5166.896662066756;5210.452902445246;5098.5921126309995;5145.408278048017;5211.296474975887;5219.5041471060185;5225.242339860718;5154.329937108189;5166.199239117943;5233.136532472137;5245.501677340666;5283.735813209343;5193.246979187997;5197.194434862602;5216.165413533854;5219.73901304937;5240.318758561381;321.13703866066965;5087.872803179913;5157.922631160535;5179.430262671103;5227.242049902743;4148.838325268899;4962.727050012248;5607.074832652607;5698.316202055738;5721.7711291548285;6201.81394558164;6217.098520714516;6218.284897236786;6223.875522489525;6232.3144454110015;6243.344448832852;6284.214473190851;6292.528060395489;6299.338569450233;6299.905501417483;5591.7483713233005;5642.125470552071;5673.177389278531;5702.7718891243885;5777.653340799481;6241.313455519889;6264;6264.091706702594;6273.811785646438;6280.874382512324;6053.334133245339;6070.757169713251;6099.573029887954;6103.786367477117;6108.694565271719;6077.787277445268;6113.810786210604;6137.438273608292;6149.108379284979;6233.532485063638;6137.726793749332;6173.444390004921;6180.783672571439;6192.195014648067;6210.7515699372425;6223.96888015557;6228.5017198624;6236.656983865931;6238.656873871981;6246.187995560548;4789;4871.537203965618;4901.362822833009;4949.257611358325;4977.776000080005;4319.632831209319;4396.032872767986;4396.978015109904;4400.405945197422;4448.132614140276;5560.582956278296;5706.828795136153;5709.543236541067;5720.141978703145;5751.769929202868;6121.209103132296;6175.722092505848;6189.566730328834;6193.504519638418;6202.069689546604;5628.268325117709;5688.488036076773;5712.514436272881;5712.714364281769;5773.162891380726;4585.610223131004;4630.560096790799;5348.812791552355;5393.056215162409;5403.891922161535;6189.226346706661;6199.411055949678;6221.720022598904;6230.439260466489;6243.43809057187;6119.776756597957;6150.800593884329;6190.783322583688;6192.349803270592;6201.503879689704;6191.102290167811;6227.595206311576;6239.407256310643;6240.469560087444;6267.749290028348;6168.414000669929;6171.321154673072;6176.752929882754;6186.319504854372;6191.81424557264;6092;6138.539609529393;6139.386061394003;6147.139400483847;6248.281447633581;5991.460768530853;6085.847853803691;6094.939050609437;6096.664683442275;6116.327204007466;5888.440598143169;6005.219321488178;6059.0608455689435;6095;6098.5426093042315;5684.431556844448;5760.740766665594;5768.1636162757;5806.506446952057;5849.590528663123;4939.259111133359;6019.638821670714;6050.42520960508;6053.606515576474;6108;5843.970780146072;5858.179854820243;5870.324912635102;5871.4715675589405;5878.823635290948 19:47:42 INFO - PROCESS | 6683 | |1;ext.html;448.89002194462364;457.95814521962535;469.5656517721107;498.77056553985165;501.5636396335187;37483.81258093709;39939.20121597566;39971.2005759885;39992;40102.799486002565;40718;41142.794286028526;41165.79417102918;41235.381469277985;41339;8464.23821856033;8683.652653893869;9220.677276295331;9414.199793017602;9427.858582121273;11165.162612804072;11420.143489238299;11432.771344573104;11541;11631.418429078554;11061.225714200009;11140.220184587082;11151.052160566362;11198.160137989642;11277.32336059835;8536.701215457491;8733.737987860375;11194;11280.717982050432;11379.431028448627;11087.279326843729;11309.49107290174;11329.546818127264;11329.830052549218;11347.262427942158;38868.416973745414;39184.41223381652;39201.215975680614;39235.21529569421;39359;3986.960130398688;4018.8995275118064;4019.9598004019876;4033.132876431552;4161.3549899765585;29217.561736573967;29663.813447462293;29801.2848649295;30227.848860755774;30371;3114.314850732835;3116.8909088181804;3131.3580715953176;3148.3703259347994;3204.1829333519804;452915.9999999967;459440;459566;459625;459897;57425.13862292069;57883;57892.71053644789;57948;57974.7101264491;60811;60817.08774368388;60928.695356522934;60967.39032609706;61102.69448652728;15293;15872.52382428506;15894;15909;15923.283452244677;10011.849822252672;11131.332120072822;11337.093032557375;12211.023118150704;12336.444859981322;15438.22808859575;15439.61400964985;15451.072935623899;15461.14963676986;15510.224488775517;5980.744043750861;6766.898496522556;6856;6923.792286231321;7060.364567188978;735.7204262380368;772.1236396689685;861.7543999959981;876.9824603507894;893.7140115163086;25577.488450231263;26075.9569617217;28775.85612071926;29309;30172.94394696175;877.4472082588056;1022.9897701023043;1045.5086109528509;1050.7373156710823;1064.6220591689994;13261.204327740366;14991;15224.771628425582;15613.453529126426;16074.276657550437;625414;626448;631335;631396;632572;57085;57259.71370143206;57260.71369643125;57432.13851792226;57490.712546437;1305.5822136916095;1362.2439546052037;1369.486442584051;1369.7741170597778;1390.2562129260798;28735;28935.85532072326;28992.275193120342;29748;29827.552586710783;44129.896752581444;45324.187032518326;48663.27005094856;48744.26883596678;48773.512264878314;541092;543498;544108;544210;544719.3820154528;33286.50070248997;38042.048948775395;40853.59146408498;40970.38544421776;41019.58980410277;38028.42957355586;43624.34563481487;44776.104477909605;45304;46542;37266;37534;37863.62136378601;38569.228615426975;38617.03457413587;36978.815105924295;37164.81417592895;38246;38477.6152238474;38586.42120368253;36503;36799.44800827936;37315.62684373122;37547.678202750205;37729.245415091;30001.999600080508;31779.364412711155;31909.521357180125;32330.191745206557;32881.50677739788;21200.4699882498;22613.321600352017;23906.880465597562;24170.516589667757;24313.635295470227 19:47:42 INFO - PROCESS | 6683 | |2;jquery.html;383.955845077816;385.6991546593656;391.44805823788465;392.56229304325666;418.32022962685636;13296.734065318687;19594;20805.583888322224;21229.575408491823;21241.68137477939;16598.83401165988;16748;20301.796982030177;20639.071241794118;20982.05580748866;5618.269624948751;5900.144479050557;5914.201582786333;5916.881662366772;5924.466797988181;5575.414581468948;5749.856253593652;5762;5859.6777177255235;5893.263342082239;5652.717364131798;5733.799317023905;5765.682887441189;5767.134929760548;5774.220480235177;5566.387697353308;5751.654900705971;5771.336296325934;5775.104858746901;5847.619904706181;5047.470015648378;5058.822941197041;5059.482155353379;5156.5561642740095;5171.991461664977;25265.873670631714;25576.849041793164;25634.871825640937;25976.480470390485;26317.868410658015;2682.8122031457806;2778.749912507864;2787.2892412434903;2790.1629511146575;2791.1766029021487;14803.527589795698;15442.613934651612;15508.673698945136;15723.68552628941;16000.359985600562;1779.8576113910856;1783.8840475369188;1813.6191399805925;1830.3044842959723;1877.8028307027703;120443.59112817695;121297;122529.77470225273;124695;125974.74025259721;9581;11206.38364889939;11245.83131253032;11464.541418343173;11468.254563453349;14165;14295.57113286603;14299.57101286963;14319.928400357932;14342.426302947973;6431.903521447182;7433.479656423999;7810.6875724971505;7953.443258971816;8005.119436861941;8187.3040791533385;8258.25675689191;8274.834503310021;8343.791405214919;8369.83260334802;5641.19219526826;5893.852653683606;5933.495652869468;6991.930080699128;7008.649567521706;1615.5961009747564;1777.3423833181805;1856.2853301479029;1901.695728683404;1904.3905950095836;887.2768693514894;903.9457632542069;1007.2948935745007;1027.9383237005804;1067.4769363012067;22246.88876555607;22474.88762556177;22636.320910372717;22643.547129057657;22664.886675566515;949.7625593601599;994.955227014786;1039.5114296280735;1070.9410982395887;1071.0200166847249;9849.162821160138;11207.150820114754;11406.600768973047;11740.647780566596;12010.699732506582;591756;605583;618422;678638;768872;120208;144175;144833;146490.53509464982;147531;1017.8066167428314;1041.7343577387717;1050.873895132589;1051.353417648141;1063.0645032371463;18902.810971890103;19606.60786784285;19800.504987375432;19827.30604428838;19865.702014469505;52422.73788631032;54467;60368.39631603628;61041;62150;74074;89524;91232;91774.54112729394;92412.53793730988;7139.393151582174;7164.2119366868565;7356.742514011984;7398.186199517941;8175.877361839458;10494.580216791242;10669.41318227505;12293.87706122963;12667.80998285045;13290.667733306746;9800.65697700577;11122.61070862516;11131.833022504507;11703.414829258674;11857.34784586856;11151.944240278746;11222.55109795599;11261.380624065756;11590.594329198437;11792.469338879599;11510.654680359603;11597.536098555964;11712.590059348222;11852.348120853436;11983.28100313984;7258.383037441877;7510.173880873209;7510.849783004419;7641.197674244125;7710.575918324322;10629.521671524646;10815.891841081488;10946.616868409568;11267.718307042389;11446.37044962535 19:47:42 INFO - PROCESS | 6683 | |3;mootools.html;1406.8498563393616;1441.819772528434;1445.4435042508635;1447.1895738386502;1464.7363474574572;8045.477043992137;8448.11294814045;8453.61958711858;8460.619272132746;8461.153884611536;7379.55722656641;7650.579218143014;7943.086545047321;8191.139930307321;8262.42163048587;2274.715660542436;2315.9421014474606;2318.6522021696796;2324.5699545584034;2325.476767727265;2293.117149897293;2321.1643808229023;2322.1640209524558;2331.8017968472614;2334.5914464968646;2030.3807338761671;2110.48293168174;2112.514121751998;2124.4051665533675;2229.7881701238357;1852.5739080011672;2083.291680828518;2093.026742564707;2289.8053665438456;2293.6559516072557;2296.873671948042;2299;2300.332903457995;2301.9641161477234;2307.976920230793;7146.714131434736;8261.917380826235;8315.04376996647;8323.791905202357;8337.874931876027;5041.420236672793;5180.922286165711;5200.193969934666;5200.349956255468;5203.9219411708855;2759.7240275972445;3133.1697100268448;3383.813890236036;3421.7433692472914;3432.0733401981324;1026.8870424253325;1210.0198838940398;1239.2316763606532;1240.2434514945876;1259.8929091027182;9050.7284781456;10570.841437378445;10597.364158150536;10617.522211500502;10690.62582809598;4334.306510958231;4573.176828170895;4637.86086417408;4659.394278743809;4661.673682842168;9374.343795934219;9390.906090939003;9395.436273823592;9414.29392795543;9423.293253006052;5105.2342148678;5194.1429664105;5215.504527069922;5217.139172036647;5218.8956220876125;4553.430821147356;4680.110778951988;4741.241401375763;4760.166970780099;4788.018456216468;3737.588865224823;3776.86780962665;3857.556381016163;3861.8841434757;3868.8527867033504;1225.66906935127;1230.5939040116739;1233.8704436034086;1246.3581255653346;1252.768237875996;789.9842003159905;794.5232860283899;806.1092492795494;812.387410989186;817.1705718695529;5648.971755141198;5650.124230744241;5753.913691294634;5787.160861675117;5794.420557944172;562.1511517608441;578.7655999320282;580.9136913970901;592.0852283222346;601.744258690055;3393.372226138172;4052.696047796427;4130.297849365615;4197.18154959786;4244.766537840448;9789.608415663437;9910.30627856043;10016.699499015042;10033.849492257623;10048.196144308438;9972.700818975442;9979.700608981742;9981;9984.201263899016;10003.2997690161;7472.215417381205;7679.808004799925;7716.845663086707;7838.137804841463;7900.407469439815;5848.122781582797;5894.852628684317;5898.262717160355;5921.171036055042;5986.640801551921;9083.818323633623;9218.723438296862;9219.907800921905;9224.677136300197;9229.400088994194;6813.318668133147;9252.95373523128;9291.070892910655;9293.977662457259;9382;7095.751648692271;7134.357907788324;7250.969728476035;7265.418766498773;7278.381337586153;7815.570143642154;7867.685292588232;7877.094134174414;7892.4869883457395;7908;7020.824479388056;7032.5077244592385;7090.07828982229;7165.856682866209;7230.6384680764695;6952.44380449573;6980.720771169096;6996.545224560387;7046.929530704832;7048.541844780278;6241.282252541016;6365.363463653597;6444.967775161094;6457.903131452938;6472.029195620695;4209.305464598429;4836.709797412166;4854;4918.213085906238;4950.554450099508;4719.952800471951;4814.253790662453;4819.132556139928;4831.96112835742;4853.4418541868135 19:47:42 INFO - PROCESS | 6683 | |4;prototype.html;350.7790092241887;357.9087332730155;364.32963347440705;374.977501349919;375.56246972277296;4315.93526097108;5225.137852254383;5245.7377131143485;5286.682799032061;5336.612480755002;4861.711646413703;5065.772040258188;5103.030424219396;5134.512221338976;5136.460671629481;3328.6837750413733;3652.4886515887665;3813.161104556993;4131.648809851166;4141.7514949103;3700.945974983883;3881.1279653056677;4031.468042143981;4087.4073259377374;4210.62104410603;3586;3982.9843389935672;4057.4725285712816;4076.8776936691947;4153.131091009043;3501.91245218869;3744.5770607169375;4017.8995525111814;4072.2466343726505;4112.588741125864;3243.8540265688102;3402.3705614461405;3648.6533779290926;3658.5426821647293;3665.780053196817;4858.854234372974;5019.042573396378;5138.409082955471;5192.558632516203;5242.580593552507;3946.131850992777;4335.804888780012;4560.22476179047;4698.365720627706;4699.882502937419;5344.812931547416;5472.644278121909;5501.614886957915;5593.818410819784;5623.831285061414;3692.5568931728094;3763.8682646107527;3878.553966293884;3955.7562798505237;3998.3207053037795;5500.4499550045075;5694.1458781183155;5704.635953495579;5710.972025035492;5731.168980497846;3455.8444869980913;4006.859759908389;4055.2903241932545;4074.3888416737727;4092.46797916269;3346.397648423307;3601.991442396133;3928.5678575356687;4113.4035564843525;4129.421880936671;4528.773561321921;4535.818567257339;4537.8411755588395;4548.975705810883;4564.835966828437;5646.2942132233475;5684.943150568524;5709;5724.164809577593;5736.254286942671;1171.7407224738138;1190.5713144226963;1233.4079641772;1259.7102666386781;1275.43880692495;747.880339145745;853.7353420439683;862.2024627219797;864.3992425264381;869.8129902071086;4190.266703326966;4387.846425375161;4687.367205427292;4856.15466122871;4886.828960986349;5089.338386009795;5300.189925112418;5346.251524786533;5398.946010539844;5419.864503387447;3967.3652215645357;4172.332426811757;4628.722276663411;4803.951960480351;4811.831585894477;2597.7790438493876;2649;2807.298175456136;2815.4369126174847;2834.929126771847;4610.423697037871;4994.400671919393;5381.327334083239;5486.862828429242;5545.861353466115;5176.197689358156;5465.535429488458;5522.420145884705;5538.44615538451;5551.8341148359295;4996.675216110941;5053.761828352077;5099.1331473648825;5313.601479888946;5545.140503222007;5287.788488460573;5327.520523152934;5336.866578335573;5340.819405176972;5374.892502150014;5349.208015314913;5660.632058916157;5672.290963629382;5674.659520428788;5696.297406685688;5038.178619972827;5935.495482884004;5981.052505346451;6006.279246490274;6027.698615069141;2970.4653162430104;3291;3298.455754800431;3393.8776325780836;3813.485179500843;5068.732816795801;5146.588272938081;5628.943710563006;5648.717564121695;5667.319921609434;5120.84780924304;5288.550473209666;5565.860853478695;5587.69267690281;5601.243832082617;4913.70517768935;5148.845534633967;5370.818419947605;5533.699580598636;5628.144720866219;4313.029568347222;4872.342233798392;5140.450701129453;5329.653572517774;5498.697571633598;5526.253955715927;5564.248826408383;5588.972055139699;5614.41048689898;5656.981743286084;4578.381918440968;4782.0435912818275;5383.492622065828;5400.9459905400445;5431.456854314537 19:47:42 INFO - PROCESS | 6683 | |5;yui.html;705.5202462325617;707.3951771235596;773;793.2741541489537;816.5549775372422;14542.345594448248;15301.617459563517;15595.1422671753;15602.921985390058;15626.062436253833;14023.64940876476;14265.71468570628;14402.423903043866;14549.054311469774;14566.781498277534;851.0638297872322;851.0808327006848;866.6879923227633;869.482657818597;870.0168809245544;680.6766785776741;701.9719211231545;832.238501770882;858.159004175908;867.7223288547667;917.4403613795579;927.9953600232024;928.0626567167176;928.5774972387547;929.1637526226416;920.907909209077;921.5714692667874;923.4413180026122;924.5377311344328;924.990750092504;522.9790808367661;535.9866003349908;662.9071929929813;687.2577616174519;688.5352387138662;14973.176475293854;15489.612759681098;15523.534293971199;15528.378864845392;15558.844411555852;13688;13739.587812365646;13896.791548126786;13959.302034898214;13968.58094257174;12656.68358291041;12705.809412858815;12773.29746863922;12930.48278068876;13033.934830325883;4388.42950416447;4397.2304846651705;4578.244589642705;4579.519150489217;4583.72497650142;109155;109452;110589;113983.43008284988;115014;10782.975617316342;10892.891071089347;10943.507542160622;11049.834252486218;11340.546378144947;20084.096215670328;20899.850508222193;21220.681689774665;22177.445563861034;22237.888810555844;7469.551826890404;7626.69493220276;7748.92251077482;7757.379409647215;7984.560849153352;4291.2275790358035;4311;4317.028668549551;4408.25059739845;4479.395281637003;3095.767817413703;3492.5983511896457;3596.694280986093;3598.172420343283;3598.298331825269;642.489221069251;652.2108249018646;657.6185812228896;670.902719105727;674.3256743256743;586.3608666553478;657.4871600151889;693.8959156126521;711.3597762014228;737.3106145753737;8903.765523895794;10021.949890250502;10367.481625918674;10767.892321076846;11034.724131896606;593.9910901336483;595.3120419004227;598.4673640459907;609.5641616244407;705.4004096517918;4431.24578590408;4751.287306903992;5363.946360536423;5631.887362252732;5694.6583205007;104356.47821760994;106062.4090638641;107119;107696;110139.39163650207;79547;96038;97171;97583;98106.52840207402;67001;67076.32923670701;80012;82869;84611.5769421149;10572.947135264274;10723;10781.191410644076;10822.67531974042;11011.339319640847;45643.315350269106;50213;50840.72898177575;51639;52800.73599632131;66969.99545006927;68665.65667171632;69497;71179;73781;12569.371531423576;12775.744485110432;12804.679883002627;12824.23054616726;13314.267715275753;14637.780433293296;14723.190224537324;14779.778303325244;14830.555083347517;14957.027793193407;13245.403956821774;13305.002124840868;13435.932820335836;13600;14051.718965620836;10841.048611250051;12895.548655797002;13478.73042539124;13759.793603096161;13869.237191954539;11586;11775.116866235237;12195.878041219474;12224.022078233898;12239.143259972072;11256.887431125584;11346.262492937933;11517;11547.13396495283;11879.58421455245;10694.786104277715;10801.513931872927;10877.836832447361;10974.890251097388;10990.780184396428 19:47:42 INFO - PROCESS | 6683 | __end_tp_report 19:47:42 INFO - PROCESS | 6683 | __start_cc_report 19:47:42 INFO - PROCESS | 6683 | _x_x_mozilla_cycle_collect,1590 19:47:42 INFO - PROCESS | 6683 | __end_cc_report 19:47:42 INFO - PROCESS | 6683 | __startTimestamp1484106462563__endTimestamp 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | ------- Summary: start ------- 19:47:42 INFO - PROCESS | 6683 | Number of tests: 6 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | [#0] dojo.html Cycles:165 Average:5641.58 Median:5858.18 stddev:784.00 (13.4%) stddev-sans-first:763.58 19:47:42 INFO - PROCESS | 6683 | Values: 3247.4 3251.3 3256.6 3257.8 3333.6 5483.6 5581.0 5602.2 5636.1 5647.9 5557.6 5589.1 5598.6 5599.9 5626.9 5062.7 5111.9 5118.1 5166.9 5210.5 5098.6 5145.4 5211.3 5219.5 5225.2 5154.3 5166.2 5233.1 5245.5 5283.7 5193.2 5197.2 5216.2 5219.7 5240.3 321.1 5087.9 5157.9 5179.4 5227.2 4148.8 4962.7 5607.1 5698.3 5721.8 6201.8 6217.1 6218.3 6223.9 6232.3 6243.3 6284.2 6292.5 6299.3 6299.9 5591.7 5642.1 5673.2 5702.8 5777.7 6241.3 6264.0 6264.1 6273.8 6280.9 6053.3 6070.8 6099.6 6103.8 6108.7 6077.8 6113.8 6137.4 6149.1 6233.5 6137.7 6173.4 6180.8 6192.2 6210.8 6224.0 6228.5 6236.7 6238.7 6246.2 4789.0 4871.5 4901.4 4949.3 4977.8 4319.6 4396.0 4397.0 4400.4 4448.1 5560.6 5706.8 5709.5 5720.1 5751.8 6121.2 6175.7 6189.6 6193.5 6202.1 5628.3 5688.5 5712.5 5712.7 5773.2 4585.6 4630.6 5348.8 5393.1 5403.9 6189.2 6199.4 6221.7 6230.4 6243.4 6119.8 6150.8 6190.8 6192.3 6201.5 6191.1 6227.6 6239.4 6240.5 6267.7 6168.4 6171.3 6176.8 6186.3 6191.8 6092.0 6138.5 6139.4 6147.1 6248.3 5991.5 6085.8 6094.9 6096.7 6116.3 5888.4 6005.2 6059.1 6095.0 6098.5 5684.4 5760.7 5768.2 5806.5 5849.6 4939.3 6019.6 6050.4 6053.6 6108.0 5844.0 5858.2 5870.3 5871.5 5878.8 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | [#1] ext.html Cycles:180 Average:67785.07 Median:38144.02 stddev:146357.98 (383.7%) stddev-sans-first:146681.23 19:47:42 INFO - PROCESS | 6683 | Values: 448.9 458.0 469.6 498.8 501.6 37483.8 39939.2 39971.2 39992.0 40102.8 40718.0 41142.8 41165.8 41235.4 41339.0 8464.2 8683.7 9220.7 9414.2 9427.9 11165.2 11420.1 11432.8 11541.0 11631.4 11061.2 11140.2 11151.1 11198.2 11277.3 8536.7 8733.7 11194.0 11280.7 11379.4 11087.3 11309.5 11329.5 11329.8 11347.3 38868.4 39184.4 39201.2 39235.2 39359.0 3987.0 4018.9 4020.0 4033.1 4161.4 29217.6 29663.8 29801.3 30227.8 30371.0 3114.3 3116.9 3131.4 3148.4 3204.2 452916.0 459440.0 459566.0 459625.0 459897.0 57425.1 57883.0 57892.7 57948.0 57974.7 60811.0 60817.1 60928.7 60967.4 61102.7 15293.0 15872.5 15894.0 15909.0 15923.3 10011.8 11131.3 11337.1 12211.0 12336.4 15438.2 15439.6 15451.1 15461.1 15510.2 5980.7 6766.9 6856.0 6923.8 7060.4 735.7 772.1 861.8 877.0 893.7 25577.5 26076.0 28775.9 29309.0 30172.9 877.4 1023.0 1045.5 1050.7 1064.6 13261.2 14991.0 15224.8 15613.5 16074.3 625414.0 626448.0 631335.0 631396.0 632572.0 57085.0 57259.7 57260.7 57432.1 57490.7 1305.6 1362.2 1369.5 1369.8 1390.3 28735.0 28935.9 28992.3 29748.0 29827.6 44129.9 45324.2 48663.3 48744.3 48773.5 541092.0 543498.0 544108.0 544210.0 544719.4 33286.5 38042.0 40853.6 40970.4 41019.6 38028.4 43624.3 44776.1 45304.0 46542.0 37266.0 37534.0 37863.6 38569.2 38617.0 36978.8 37164.8 38246.0 38477.6 38586.4 36503.0 36799.4 37315.6 37547.7 37729.2 30002.0 31779.4 31909.5 32330.2 32881.5 21200.5 22613.3 23906.9 24170.5 24313.6 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | [#2] jquery.html Cycles:180 Average:37573.86 Median:22639.93 stddev:109551.96 (483.9%) stddev-sans-first:109823.70 19:47:42 INFO - PROCESS | 6683 | Values: 384.0 385.7 391.4 392.6 418.3 13296.7 19594.0 20805.6 21229.6 21241.7 16598.8 16748.0 20301.8 20639.1 20982.1 5618.3 5900.1 5914.2 5916.9 5924.5 5575.4 5749.9 5762.0 5859.7 5893.3 5652.7 5733.8 5765.7 5767.1 5774.2 5566.4 5751.7 5771.3 5775.1 5847.6 5047.5 5058.8 5059.5 5156.6 5172.0 25265.9 25576.8 25634.9 25976.5 26317.9 2682.8 2778.7 2787.3 2790.2 2791.2 14803.5 15442.6 15508.7 15723.7 16000.4 1779.9 1783.9 1813.6 1830.3 1877.8 120443.6 121297.0 122529.8 124695.0 125974.7 9581.0 11206.4 11245.8 11464.5 11468.3 14165.0 14295.6 14299.6 14319.9 14342.4 6431.9 7433.5 7810.7 7953.4 8005.1 8187.3 8258.3 8274.8 8343.8 8369.8 5641.2 5893.9 5933.5 6991.9 7008.6 1615.6 1777.3 1856.3 1901.7 1904.4 887.3 903.9 1007.3 1027.9 1067.5 22246.9 22474.9 22636.3 22643.5 22664.9 949.8 995.0 1039.5 1070.9 1071.0 9849.2 11207.2 11406.6 11740.6 12010.7 591756.0 605583.0 618422.0 678638.0 768872.0 120208.0 144175.0 144833.0 146490.5 147531.0 1017.8 1041.7 1050.9 1051.4 1063.1 18902.8 19606.6 19800.5 19827.3 19865.7 52422.7 54467.0 60368.4 61041.0 62150.0 74074.0 89524.0 91232.0 91774.5 92412.5 7139.4 7164.2 7356.7 7398.2 8175.9 10494.6 10669.4 12293.9 12667.8 13290.7 9800.7 11122.6 11131.8 11703.4 11857.3 11151.9 11222.6 11261.4 11590.6 11792.5 11510.7 11597.5 11712.6 11852.3 11983.3 7258.4 7510.2 7510.8 7641.2 7710.6 10629.5 10815.9 10946.6 11267.7 11446.4 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | [#3] mootools.html Cycles:180 Average:5378.23 Median:5216.32 stddev:2943.10 (56.4%) stddev-sans-first:2936.22 19:47:42 INFO - PROCESS | 6683 | Values: 1406.8 1441.8 1445.4 1447.2 1464.7 8045.5 8448.1 8453.6 8460.6 8461.2 7379.6 7650.6 7943.1 8191.1 8262.4 2274.7 2315.9 2318.7 2324.6 2325.5 2293.1 2321.2 2322.2 2331.8 2334.6 2030.4 2110.5 2112.5 2124.4 2229.8 1852.6 2083.3 2093.0 2289.8 2293.7 2296.9 2299.0 2300.3 2302.0 2308.0 7146.7 8261.9 8315.0 8323.8 8337.9 5041.4 5180.9 5200.2 5200.3 5203.9 2759.7 3133.2 3383.8 3421.7 3432.1 1026.9 1210.0 1239.2 1240.2 1259.9 9050.7 10570.8 10597.4 10617.5 10690.6 4334.3 4573.2 4637.9 4659.4 4661.7 9374.3 9390.9 9395.4 9414.3 9423.3 5105.2 5194.1 5215.5 5217.1 5218.9 4553.4 4680.1 4741.2 4760.2 4788.0 3737.6 3776.9 3857.6 3861.9 3868.9 1225.7 1230.6 1233.9 1246.4 1252.8 790.0 794.5 806.1 812.4 817.2 5649.0 5650.1 5753.9 5787.2 5794.4 562.2 578.8 580.9 592.1 601.7 3393.4 4052.7 4130.3 4197.2 4244.8 9789.6 9910.3 10016.7 10033.8 10048.2 9972.7 9979.7 9981.0 9984.2 10003.3 7472.2 7679.8 7716.8 7838.1 7900.4 5848.1 5894.9 5898.3 5921.2 5986.6 9083.8 9218.7 9219.9 9224.7 9229.4 6813.3 9253.0 9291.1 9294.0 9382.0 7095.8 7134.4 7251.0 7265.4 7278.4 7815.6 7867.7 7877.1 7892.5 7908.0 7020.8 7032.5 7090.1 7165.9 7230.6 6952.4 6980.7 6996.5 7046.9 7048.5 6241.3 6365.4 6445.0 6457.9 6472.0 4209.3 4836.7 4854.0 4918.2 4950.6 4720.0 4814.3 4819.1 4832.0 4853.4 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | [#4] prototype.html Cycles:180 Average:4425.89 Median:5007.86 stddev:1358.07 (27.1%) stddev-sans-first:1326.99 19:47:42 INFO - PROCESS | 6683 | Values: 350.8 357.9 364.3 375.0 375.6 4315.9 5225.1 5245.7 5286.7 5336.6 4861.7 5065.8 5103.0 5134.5 5136.5 3328.7 3652.5 3813.2 4131.6 4141.8 3700.9 3881.1 4031.5 4087.4 4210.6 3586.0 3983.0 4057.5 4076.9 4153.1 3501.9 3744.6 4017.9 4072.2 4112.6 3243.9 3402.4 3648.7 3658.5 3665.8 4858.9 5019.0 5138.4 5192.6 5242.6 3946.1 4335.8 4560.2 4698.4 4699.9 5344.8 5472.6 5501.6 5593.8 5623.8 3692.6 3763.9 3878.6 3955.8 3998.3 5500.4 5694.1 5704.6 5711.0 5731.2 3455.8 4006.9 4055.3 4074.4 4092.5 3346.4 3602.0 3928.6 4113.4 4129.4 4528.8 4535.8 4537.8 4549.0 4564.8 5646.3 5684.9 5709.0 5724.2 5736.3 1171.7 1190.6 1233.4 1259.7 1275.4 747.9 853.7 862.2 864.4 869.8 4190.3 4387.8 4687.4 4856.2 4886.8 5089.3 5300.2 5346.3 5398.9 5419.9 3967.4 4172.3 4628.7 4804.0 4811.8 2597.8 2649.0 2807.3 2815.4 2834.9 4610.4 4994.4 5381.3 5486.9 5545.9 5176.2 5465.5 5522.4 5538.4 5551.8 4996.7 5053.8 5099.1 5313.6 5545.1 5287.8 5327.5 5336.9 5340.8 5374.9 5349.2 5660.6 5672.3 5674.7 5696.3 5038.2 5935.5 5981.1 6006.3 6027.7 2970.5 3291.0 3298.5 3393.9 3813.5 5068.7 5146.6 5628.9 5648.7 5667.3 5120.8 5288.6 5565.9 5587.7 5601.2 4913.7 5148.8 5370.8 5533.7 5628.1 4313.0 4872.3 5140.5 5329.7 5498.7 5526.3 5564.2 5589.0 5614.4 5657.0 4578.4 4782.0 5383.5 5400.9 5431.5 19:47:42 INFO - PROCESS | 6683 | 19:47:42 INFO - PROCESS | 6683 | [#5] yui.html Cycles:180 Average:20962.82 Median:3544.65 stddev:30532.47 (861.4%) stddev-sans-first:30580.23 19:47:42 INFO - PROCESS | 6683 | Values: 705.5 707.4 773.0 793.3 816.6 14542.3 15301.6 15595.1 15602.9 15626.1 14023.6 14265.7 14402.4 14549.1 14566.8 851.1 851.1 866.7 869.5 870.0 680.7 702.0 832.2 858.2 867.7 917.4 928.0 928.1 928.6 929.2 920.9 921.6 923.4 924.5 925.0 523.0 536.0 662.9 687.3 688.5 14973.2 15489.6 15523.5 15528.4 15558.8 13688.0 13739.6 13896.8 13959.3 13968.6 12656.7 12705.8 12773.3 12930.5 13033.9 4388.4 4397.2 4578.2 4579.5 4583.7 109155.0 109452.0 110589.0 113983.4 115014.0 10783.0 10892.9 10943.5 11049.8 11340.5 20084.1 20899.9 21220.7 22177.4 22237.9 7469.6 7626.7 7748.9 7757.4 7984.6 4291.2 4311.0 4317.0 4408.3 4479.4 3095.8 3492.6 3596.7 3598.2 3598.3 642.5 652.2 657.6 670.9 674.3 586.4 657.5 693.9 711.4 737.3 8903.8 10021.9 10367.5 10767.9 11034.7 594.0 595.3 598.5 609.6 705.4 4431.2 4751.3 5363.9 5631.9 5694.7 104356.5 106062.4 107119.0 107696.0 110139.4 79547.0 96038.0 97171.0 97583.0 98106.5 67001.0 67076.3 80012.0 82869.0 84611.6 10572.9 10723.0 10781.2 10822.7 11011.3 45643.3 50213.0 50840.7 51639.0 52800.7 66970.0 68665.7 69497.0 71179.0 73781.0 12569.4 12775.7 12804.7 12824.2 13314.3 14637.8 14723.2 14779.8 14830.6 14957.0 13245.4 13305.0 13435.9 13600.0 14051.7 10841.0 12895.5 13478.7 13759.8 13869.2 11586.0 11775.1 12195.9 12224.0 12239.1 11256.9 11346.3 11517.0 11547.1 11879.6 10694.8 10801.5 10877.8 10974.9 10990.8 19:47:42 INFO - PROCESS | 6683 | -------- Summary: end -------- 19:47:42 INFO - PROCESS | 6683 | 19:47:43 INFO - TEST-INFO | 6683: exit 0 19:47:43 INFO - TEST-OK | dromaeo_css | took 1118084ms 19:47:43 INFO - TEST-START | kraken 19:47:43 INFO - operating with platform_type : mac_ 19:47:43 INFO - Initialising browser for kraken test... 19:47:43 INFO - TEST-INFO | started process 6687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpfLAGAl/profile http://localhost:59680/getInfo.html) 19:47:45 INFO - PROCESS | 6687 | __metrics Screen width/height:1600/1200 19:47:45 INFO - PROCESS | 6687 | colorDepth:24 19:47:45 INFO - PROCESS | 6687 | Browser inner width/height: 1024/689 19:47:45 INFO - PROCESS | 6687 | __metrics 19:47:45 INFO - PROCESS | 6687 | 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" 19:47:45 INFO - PROCESS | 6687 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:46 INFO - TEST-INFO | 6687: exit 0 19:47:46 INFO - Browser initialized. 19:47:46 INFO - Running cycle 1/1 for kraken test... 19:47:46 INFO - TEST-INFO | started process 6688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpfLAGAl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:58 INFO - PROCESS | 6688 | RSS: Main: 234008576 19:47:58 INFO - PROCESS | 6688 | 19:48:01 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59680/tests/kraken/driver.html?testName=audio-beat-detection) 19:48:02 INFO - PROCESS | 6688 | RSS: Main: 288636928 19:48:02 INFO - PROCESS | 6688 | 19:48:04 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59680/tests/kraken/driver.html?testName=audio-dft) 19:48:05 INFO - PROCESS | 6688 | RSS: Main: 287678464 19:48:05 INFO - PROCESS | 6688 | 19:48:09 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59680/tests/kraken/driver.html?testName=audio-fft) 19:48:09 INFO - PROCESS | 6688 | RSS: Main: 380149760 19:48:09 INFO - PROCESS | 6688 | 19:48:11 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59680/tests/kraken/driver.html?testName=audio-oscillator) 19:48:12 INFO - PROCESS | 6688 | RSS: Main: 283549696 19:48:12 INFO - PROCESS | 6688 | 19:48:14 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59680/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:48:15 INFO - PROCESS | 6688 | RSS: Main: 287105024 19:48:15 INFO - PROCESS | 6688 | 19:48:17 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59680/tests/kraken/driver.html?testName=imaging-darkroom) 19:48:18 INFO - PROCESS | 6688 | RSS: Main: 328015872 19:48:18 INFO - PROCESS | 6688 | 19:48:21 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59680/tests/kraken/driver.html?testName=imaging-desaturate) 19:48:22 INFO - PROCESS | 6688 | RSS: Main: 330756096 19:48:22 INFO - PROCESS | 6688 | 19:48:24 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59680/tests/kraken/driver.html?testName=json-parse-financial) 19:48:25 INFO - PROCESS | 6688 | RSS: Main: 326500352 19:48:25 INFO - PROCESS | 6688 | 19:48:27 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59680/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:48:27 INFO - PROCESS | 6688 | RSS: Main: 304177152 19:48:27 INFO - PROCESS | 6688 | 19:48:29 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:48:30 INFO - PROCESS | 6688 | RSS: Main: 308686848 19:48:30 INFO - PROCESS | 6688 | 19:48:32 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:48:33 INFO - PROCESS | 6688 | RSS: Main: 314155008 19:48:33 INFO - PROCESS | 6688 | 19:48:36 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:48:37 INFO - PROCESS | 6688 | RSS: Main: 325447680 19:48:37 INFO - PROCESS | 6688 | 19:48:39 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:48:40 INFO - PROCESS | 6688 | RSS: Main: 319868928 19:48:40 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:59680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59680/tests/kraken/driver.html?testName=ai-astar) 19:48:42 INFO - PROCESS | 6688 | RSS: Main: 364097536 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | __start_tp_report 19:48:42 INFO - PROCESS | 6688 | _x_x_mozilla_page_load 19:48:42 INFO - PROCESS | 6688 | _x_x_mozilla_page_load_details 19:48:42 INFO - PROCESS | 6688 | |i|pagename|runs| 19:48:42 INFO - PROCESS | 6688 | |0;ai-astar;113;121;171;155;115;113;113;113;113;113 19:48:42 INFO - PROCESS | 6688 | |1;audio-beat-detection;148;109;106;146;112;110;109;109;133;109 19:48:42 INFO - PROCESS | 6688 | |2;audio-dft;197;261;201;184;185;185;184;184;185;184 19:48:42 INFO - PROCESS | 6688 | |3;audio-fft;84;58;59;106;85;83;70;60;75;58 19:48:42 INFO - PROCESS | 6688 | |4;audio-oscillator;86;71;86;70;70;70;84;69;68;85 19:48:42 INFO - PROCESS | 6688 | |5;imaging-gaussian-blur;90;86;89;87;89;87;89;87;90;89 19:48:42 INFO - PROCESS | 6688 | |6;imaging-darkroom;96;95;96;95;94;95;95;95;95;94 19:48:42 INFO - PROCESS | 6688 | |7;imaging-desaturate;83;69;129;130;90;85;84;90;86;86 19:48:42 INFO - PROCESS | 6688 | |8;json-parse-financial;59;54;55;54;54;55;54;56;55;55 19:48:42 INFO - PROCESS | 6688 | |9;json-stringify-tinderbox;68;72;76;79;74;69;73;72;72;79 19:48:42 INFO - PROCESS | 6688 | |10;stanford-crypto-aes;91;90;88;87;88;88;89;91;91;89 19:48:42 INFO - PROCESS | 6688 | |11;stanford-crypto-ccm;141;137;158;151;147;141;140;141;206;160 19:48:42 INFO - PROCESS | 6688 | |12;stanford-crypto-pbkdf2;175;179;174;173;177;171;174;177;173;175 19:48:42 INFO - PROCESS | 6688 | |13;stanford-crypto-sha256-iterative;67;67;69;66;68;67;66;67;67;66 19:48:42 INFO - PROCESS | 6688 | __end_tp_report 19:48:42 INFO - PROCESS | 6688 | __start_cc_report 19:48:42 INFO - PROCESS | 6688 | _x_x_mozilla_cycle_collect,2034 19:48:42 INFO - PROCESS | 6688 | __end_cc_report 19:48:42 INFO - PROCESS | 6688 | __startTimestamp1484106522606__endTimestamp 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | ------- Summary: start ------- 19:48:42 INFO - PROCESS | 6688 | Number of tests: 14 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#0] ai-astar Cycles:10 Average:124.00 Median:114.00 stddev:21.04 (18.5%) stddev-sans-first:21.94 19:48:42 INFO - PROCESS | 6688 | Values: 113.0 121.0 171.0 155.0 115.0 113.0 113.0 113.0 113.0 113.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:111.00 stddev:16.55 (14.9%) stddev-sans-first:13.86 19:48:42 INFO - PROCESS | 6688 | Values: 148.0 109.0 106.0 146.0 112.0 110.0 109.0 109.0 133.0 109.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#2] audio-dft Cycles:10 Average:195.00 Median:185.00 stddev:23.99 (13.0%) stddev-sans-first:25.44 19:48:42 INFO - PROCESS | 6688 | Values: 197.0 261.0 201.0 184.0 185.0 185.0 184.0 184.0 185.0 184.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#3] audio-fft Cycles:10 Average:73.80 Median:72.50 stddev:15.90 (21.9%) stddev-sans-first:16.43 19:48:42 INFO - PROCESS | 6688 | Values: 84.0 58.0 59.0 106.0 85.0 83.0 70.0 60.0 75.0 58.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:77.50 stddev:8.10 (10.5%) stddev-sans-first:7.73 19:48:42 INFO - PROCESS | 6688 | Values: 86.0 71.0 86.0 70.0 70.0 70.0 84.0 69.0 68.0 85.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.42 (1.6%) stddev-sans-first:1.36 19:48:42 INFO - PROCESS | 6688 | Values: 90.0 86.0 89.0 87.0 89.0 87.0 89.0 87.0 90.0 89.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 19:48:42 INFO - PROCESS | 6688 | Values: 96.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:85.50 stddev:20.00 (23.4%) stddev-sans-first:20.87 19:48:42 INFO - PROCESS | 6688 | Values: 83.0 69.0 129.0 130.0 90.0 85.0 84.0 90.0 86.0 86.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.52 (2.8%) stddev-sans-first:0.71 19:48:42 INFO - PROCESS | 6688 | Values: 59.0 54.0 55.0 54.0 54.0 55.0 54.0 56.0 55.0 55.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:73.50 stddev:3.72 (5.1%) stddev-sans-first:3.39 19:48:42 INFO - PROCESS | 6688 | Values: 68.0 72.0 76.0 79.0 74.0 69.0 73.0 72.0 72.0 79.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:89.50 stddev:1.48 (1.6%) stddev-sans-first:1.41 19:48:42 INFO - PROCESS | 6688 | Values: 91.0 90.0 88.0 87.0 88.0 88.0 89.0 91.0 91.0 89.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:149.00 stddev:20.48 (13.7%) stddev-sans-first:21.31 19:48:42 INFO - PROCESS | 6688 | Values: 141.0 137.0 158.0 151.0 147.0 141.0 140.0 141.0 206.0 160.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:2.35 (1.3%) stddev-sans-first:2.49 19:48:42 INFO - PROCESS | 6688 | Values: 175.0 179.0 174.0 173.0 177.0 171.0 174.0 177.0 173.0 175.0 19:48:42 INFO - PROCESS | 6688 | 19:48:42 INFO - PROCESS | 6688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 19:48:42 INFO - PROCESS | 6688 | Values: 67.0 67.0 69.0 66.0 68.0 67.0 66.0 67.0 67.0 66.0 19:48:42 INFO - PROCESS | 6688 | -------- Summary: end -------- 19:48:42 INFO - PROCESS | 6688 | 19:48:43 INFO - TEST-INFO | 6688: exit 0 19:48:43 INFO - TEST-OK | kraken | took 60217ms 19:48:43 INFO - SUITE-END | took 1178s 19:48:43 INFO - Completed test suite (00:19:38) 19:48:43 INFO - javascript benchmark 19:48:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.3505298940217, 3251.3334766372896, 3256.5929258842652, 3257.804531728095, 3333.649966753491, 5483.643563168392, 5580.972095139528, 5602.187682785999, 5636.070048442008, 5647.887042259153, 5557.555395568355, 5589.077802162638, 5598.636088654234, 5599.916001259974, 5626.859328516779, 5062.721550314741, 5111.923321150167, 5118.07874582575, 5166.896662066756, 5210.452902445246, 5098.5921126309995, 5145.408278048017, 5211.296474975887, 5219.5041471060185, 5225.242339860718, 5154.329937108189, 5166.199239117943, 5233.136532472137, 5245.501677340666, 5283.735813209343, 5193.246979187997, 5197.194434862602, 5216.165413533854, 5219.73901304937, 5240.318758561381, 321.13703866066965, 5087.872803179913, 5157.922631160535, 5179.430262671103, 5227.242049902743, 4148.838325268899, 4962.727050012248, 5607.074832652607, 5698.316202055738, 5721.7711291548285, 6201.81394558164, 6217.098520714516, 6218.284897236786, 6223.875522489525, 6232.3144454110015, 6243.344448832852, 6284.214473190851, 6292.528060395489, 6299.338569450233, 6299.905501417483, 5591.7483713233005, 5642.125470552071, 5673.177389278531, 5702.7718891243885, 5777.653340799481, 6241.313455519889, 6264.0, 6264.091706702594, 6273.811785646438, 6280.874382512324, 6053.334133245339, 6070.757169713251, 6099.573029887954, 6103.786367477117, 6108.694565271719, 6077.787277445268, 6113.810786210604, 6137.438273608292, 6149.108379284979, 6233.532485063638, 6137.726793749332, 6173.444390004921, 6180.783672571439, 6192.195014648067, 6210.7515699372425, 6223.96888015557, 6228.5017198624, 6236.656983865931, 6238.656873871981, 6246.187995560548, 4789.0, 4871.537203965618, 4901.362822833009, 4949.257611358325, 4977.776000080005, 4319.632831209319, 4396.032872767986, 4396.978015109904, 4400.405945197422, 4448.132614140276, 5560.582956278296, 5706.828795136153, 5709.543236541067, 5720.141978703145, 5751.769929202868, 6121.209103132296, 6175.722092505848, 6189.566730328834, 6193.504519638418, 6202.069689546604, 5628.268325117709, 5688.488036076773, 5712.514436272881, 5712.714364281769, 5773.162891380726, 4585.610223131004, 4630.560096790799, 5348.812791552355, 5393.056215162409, 5403.891922161535, 6189.226346706661, 6199.411055949678, 6221.720022598904, 6230.439260466489, 6243.43809057187, 6119.776756597957, 6150.800593884329, 6190.783322583688, 6192.349803270592, 6201.503879689704, 6191.102290167811, 6227.595206311576, 6239.407256310643, 6240.469560087444, 6267.749290028348, 6168.414000669929, 6171.321154673072, 6176.752929882754, 6186.319504854372, 6191.81424557264, 6092.0, 6138.539609529393, 6139.386061394003, 6147.139400483847, 6248.281447633581, 5991.460768530853, 6085.847853803691, 6094.939050609437, 6096.664683442275, 6116.327204007466, 5888.440598143169, 6005.219321488178, 6059.0608455689435, 6095.0, 6098.5426093042315, 5684.431556844448, 5760.740766665594, 5768.1636162757, 5806.506446952057, 5849.590528663123, 4939.259111133359, 6019.638821670714, 6050.42520960508, 6053.606515576474, 6108.0, 5843.970780146072, 5858.179854820243, 5870.324912635102, 5871.4715675589405, 5878.823635290948], "value": 5591.946283677382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.89002194462364, 457.95814521962535, 469.5656517721107, 498.77056553985165, 501.5636396335187, 37483.81258093709, 39939.20121597566, 39971.2005759885, 39992.0, 40102.799486002565, 40718.0, 41142.794286028526, 41165.79417102918, 41235.381469277985, 41339.0, 8464.23821856033, 8683.652653893869, 9220.677276295331, 9414.199793017602, 9427.858582121273, 11165.162612804072, 11420.143489238299, 11432.771344573104, 11541.0, 11631.418429078554, 11061.225714200009, 11140.220184587082, 11151.052160566362, 11198.160137989642, 11277.32336059835, 8536.701215457491, 8733.737987860375, 11194.0, 11280.717982050432, 11379.431028448627, 11087.279326843729, 11309.49107290174, 11329.546818127264, 11329.830052549218, 11347.262427942158, 38868.416973745414, 39184.41223381652, 39201.215975680614, 39235.21529569421, 39359.0, 3986.960130398688, 4018.8995275118064, 4019.9598004019876, 4033.132876431552, 4161.3549899765585, 29217.561736573967, 29663.813447462293, 29801.2848649295, 30227.848860755774, 30371.0, 3114.314850732835, 3116.8909088181804, 3131.3580715953176, 3148.3703259347994, 3204.1829333519804, 452915.9999999967, 459440.0, 459566.0, 459625.0, 459897.0, 57425.13862292069, 57883.0, 57892.71053644789, 57948.0, 57974.7101264491, 60811.0, 60817.08774368388, 60928.695356522934, 60967.39032609706, 61102.69448652728, 15293.0, 15872.52382428506, 15894.0, 15909.0, 15923.283452244677, 10011.849822252672, 11131.332120072822, 11337.093032557375, 12211.023118150704, 12336.444859981322, 15438.22808859575, 15439.61400964985, 15451.072935623899, 15461.14963676986, 15510.224488775517, 5980.744043750861, 6766.898496522556, 6856.0, 6923.792286231321, 7060.364567188978, 735.7204262380368, 772.1236396689685, 861.7543999959981, 876.9824603507894, 893.7140115163086, 25577.488450231263, 26075.9569617217, 28775.85612071926, 29309.0, 30172.94394696175, 877.4472082588056, 1022.9897701023043, 1045.5086109528509, 1050.7373156710823, 1064.6220591689994, 13261.204327740366, 14991.0, 15224.771628425582, 15613.453529126426, 16074.276657550437, 625414.0, 626448.0, 631335.0, 631396.0, 632572.0, 57085.0, 57259.71370143206, 57260.71369643125, 57432.13851792226, 57490.712546437, 1305.5822136916095, 1362.2439546052037, 1369.486442584051, 1369.7741170597778, 1390.2562129260798, 28735.0, 28935.85532072326, 28992.275193120342, 29748.0, 29827.552586710783, 44129.896752581444, 45324.187032518326, 48663.27005094856, 48744.26883596678, 48773.512264878314, 541092.0, 543498.0, 544108.0, 544210.0, 544719.3820154528, 33286.50070248997, 38042.048948775395, 40853.59146408498, 40970.38544421776, 41019.58980410277, 38028.42957355586, 43624.34563481487, 44776.104477909605, 45304.0, 46542.0, 37266.0, 37534.0, 37863.62136378601, 38569.228615426975, 38617.03457413587, 36978.815105924295, 37164.81417592895, 38246.0, 38477.6152238474, 38586.42120368253, 36503.0, 36799.44800827936, 37315.62684373122, 37547.678202750205, 37729.245415091, 30001.999600080508, 31779.364412711155, 31909.521357180125, 32330.191745206557, 32881.50677739788, 21200.4699882498, 22613.321600352017, 23906.880465597562, 24170.516589667757, 24313.635295470227], "value": 19704.670823665714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.955845077816, 385.6991546593656, 391.44805823788465, 392.56229304325666, 418.32022962685636, 13296.734065318687, 19594.0, 20805.583888322224, 21229.575408491823, 21241.68137477939, 16598.83401165988, 16748.0, 20301.796982030177, 20639.071241794118, 20982.05580748866, 5618.269624948751, 5900.144479050557, 5914.201582786333, 5916.881662366772, 5924.466797988181, 5575.414581468948, 5749.856253593652, 5762.0, 5859.6777177255235, 5893.263342082239, 5652.717364131798, 5733.799317023905, 5765.682887441189, 5767.134929760548, 5774.220480235177, 5566.387697353308, 5751.654900705971, 5771.336296325934, 5775.104858746901, 5847.619904706181, 5047.470015648378, 5058.822941197041, 5059.482155353379, 5156.5561642740095, 5171.991461664977, 25265.873670631714, 25576.849041793164, 25634.871825640937, 25976.480470390485, 26317.868410658015, 2682.8122031457806, 2778.749912507864, 2787.2892412434903, 2790.1629511146575, 2791.1766029021487, 14803.527589795698, 15442.613934651612, 15508.673698945136, 15723.68552628941, 16000.359985600562, 1779.8576113910856, 1783.8840475369188, 1813.6191399805925, 1830.3044842959723, 1877.8028307027703, 120443.59112817695, 121297.0, 122529.77470225273, 124695.0, 125974.74025259721, 9581.0, 11206.38364889939, 11245.83131253032, 11464.541418343173, 11468.254563453349, 14165.0, 14295.57113286603, 14299.57101286963, 14319.928400357932, 14342.426302947973, 6431.903521447182, 7433.479656423999, 7810.6875724971505, 7953.443258971816, 8005.119436861941, 8187.3040791533385, 8258.25675689191, 8274.834503310021, 8343.791405214919, 8369.83260334802, 5641.19219526826, 5893.852653683606, 5933.495652869468, 6991.930080699128, 7008.649567521706, 1615.5961009747564, 1777.3423833181805, 1856.2853301479029, 1901.695728683404, 1904.3905950095836, 887.2768693514894, 903.9457632542069, 1007.2948935745007, 1027.9383237005804, 1067.4769363012067, 22246.88876555607, 22474.88762556177, 22636.320910372717, 22643.547129057657, 22664.886675566515, 949.7625593601599, 994.955227014786, 1039.5114296280735, 1070.9410982395887, 1071.0200166847249, 9849.162821160138, 11207.150820114754, 11406.600768973047, 11740.647780566596, 12010.699732506582, 591756.0, 605583.0, 618422.0, 678638.0, 768872.0, 120208.0, 144175.0, 144833.0, 146490.53509464982, 147531.0, 1017.8066167428314, 1041.7343577387717, 1050.873895132589, 1051.353417648141, 1063.0645032371463, 18902.810971890103, 19606.60786784285, 19800.504987375432, 19827.30604428838, 19865.702014469505, 52422.73788631032, 54467.0, 60368.39631603628, 61041.0, 62150.0, 74074.0, 89524.0, 91232.0, 91774.54112729394, 92412.53793730988, 7139.393151582174, 7164.2119366868565, 7356.742514011984, 7398.186199517941, 8175.877361839458, 10494.580216791242, 10669.41318227505, 12293.87706122963, 12667.80998285045, 13290.667733306746, 9800.65697700577, 11122.61070862516, 11131.833022504507, 11703.414829258674, 11857.34784586856, 11151.944240278746, 11222.55109795599, 11261.380624065756, 11590.594329198437, 11792.469338879599, 11510.654680359603, 11597.536098555964, 11712.590059348222, 11852.348120853436, 11983.28100313984, 7258.383037441877, 7510.173880873209, 7510.849783004419, 7641.197674244125, 7710.575918324322, 10629.521671524646, 10815.891841081488, 10946.616868409568, 11267.718307042389, 11446.37044962535], "value": 9861.42099272231, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.8498563393616, 1441.819772528434, 1445.4435042508635, 1447.1895738386502, 1464.7363474574572, 8045.477043992137, 8448.11294814045, 8453.61958711858, 8460.619272132746, 8461.153884611536, 7379.55722656641, 7650.579218143014, 7943.086545047321, 8191.139930307321, 8262.42163048587, 2274.715660542436, 2315.9421014474606, 2318.6522021696796, 2324.5699545584034, 2325.476767727265, 2293.117149897293, 2321.1643808229023, 2322.1640209524558, 2331.8017968472614, 2334.5914464968646, 2030.3807338761671, 2110.48293168174, 2112.514121751998, 2124.4051665533675, 2229.7881701238357, 1852.5739080011672, 2083.291680828518, 2093.026742564707, 2289.8053665438456, 2293.6559516072557, 2296.873671948042, 2299.0, 2300.332903457995, 2301.9641161477234, 2307.976920230793, 7146.714131434736, 8261.917380826235, 8315.04376996647, 8323.791905202357, 8337.874931876027, 5041.420236672793, 5180.922286165711, 5200.193969934666, 5200.349956255468, 5203.9219411708855, 2759.7240275972445, 3133.1697100268448, 3383.813890236036, 3421.7433692472914, 3432.0733401981324, 1026.8870424253325, 1210.0198838940398, 1239.2316763606532, 1240.2434514945876, 1259.8929091027182, 9050.7284781456, 10570.841437378445, 10597.364158150536, 10617.522211500502, 10690.62582809598, 4334.306510958231, 4573.176828170895, 4637.86086417408, 4659.394278743809, 4661.673682842168, 9374.343795934219, 9390.906090939003, 9395.436273823592, 9414.29392795543, 9423.293253006052, 5105.2342148678, 5194.1429664105, 5215.504527069922, 5217.139172036647, 5218.8956220876125, 4553.430821147356, 4680.110778951988, 4741.241401375763, 4760.166970780099, 4788.018456216468, 3737.588865224823, 3776.86780962665, 3857.556381016163, 3861.8841434757, 3868.8527867033504, 1225.66906935127, 1230.5939040116739, 1233.8704436034086, 1246.3581255653346, 1252.768237875996, 789.9842003159905, 794.5232860283899, 806.1092492795494, 812.387410989186, 817.1705718695529, 5648.971755141198, 5650.124230744241, 5753.913691294634, 5787.160861675117, 5794.420557944172, 562.1511517608441, 578.7655999320282, 580.9136913970901, 592.0852283222346, 601.744258690055, 3393.372226138172, 4052.696047796427, 4130.297849365615, 4197.18154959786, 4244.766537840448, 9789.608415663437, 9910.30627856043, 10016.699499015042, 10033.849492257623, 10048.196144308438, 9972.700818975442, 9979.700608981742, 9981.0, 9984.201263899016, 10003.2997690161, 7472.215417381205, 7679.808004799925, 7716.845663086707, 7838.137804841463, 7900.407469439815, 5848.122781582797, 5894.852628684317, 5898.262717160355, 5921.171036055042, 5986.640801551921, 9083.818323633623, 9218.723438296862, 9219.907800921905, 9224.677136300197, 9229.400088994194, 6813.318668133147, 9252.95373523128, 9291.070892910655, 9293.977662457259, 9382.0, 7095.751648692271, 7134.357907788324, 7250.969728476035, 7265.418766498773, 7278.381337586153, 7815.570143642154, 7867.685292588232, 7877.094134174414, 7892.4869883457395, 7908.0, 7020.824479388056, 7032.5077244592385, 7090.07828982229, 7165.856682866209, 7230.6384680764695, 6952.44380449573, 6980.720771169096, 6996.545224560387, 7046.929530704832, 7048.541844780278, 6241.282252541016, 6365.363463653597, 6444.967775161094, 6457.903131452938, 6472.029195620695, 4209.305464598429, 4836.709797412166, 4854.0, 4918.213085906238, 4950.554450099508, 4719.952800471951, 4814.253790662453, 4819.132556139928, 4831.96112835742, 4853.4418541868135], "value": 4313.199485101636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7790092241887, 357.9087332730155, 364.32963347440705, 374.977501349919, 375.56246972277296, 4315.93526097108, 5225.137852254383, 5245.7377131143485, 5286.682799032061, 5336.612480755002, 4861.711646413703, 5065.772040258188, 5103.030424219396, 5134.512221338976, 5136.460671629481, 3328.6837750413733, 3652.4886515887665, 3813.161104556993, 4131.648809851166, 4141.7514949103, 3700.945974983883, 3881.1279653056677, 4031.468042143981, 4087.4073259377374, 4210.62104410603, 3586.0, 3982.9843389935672, 4057.4725285712816, 4076.8776936691947, 4153.131091009043, 3501.91245218869, 3744.5770607169375, 4017.8995525111814, 4072.2466343726505, 4112.588741125864, 3243.8540265688102, 3402.3705614461405, 3648.6533779290926, 3658.5426821647293, 3665.780053196817, 4858.854234372974, 5019.042573396378, 5138.409082955471, 5192.558632516203, 5242.580593552507, 3946.131850992777, 4335.804888780012, 4560.22476179047, 4698.365720627706, 4699.882502937419, 5344.812931547416, 5472.644278121909, 5501.614886957915, 5593.818410819784, 5623.831285061414, 3692.5568931728094, 3763.8682646107527, 3878.553966293884, 3955.7562798505237, 3998.3207053037795, 5500.4499550045075, 5694.1458781183155, 5704.635953495579, 5710.972025035492, 5731.168980497846, 3455.8444869980913, 4006.859759908389, 4055.2903241932545, 4074.3888416737727, 4092.46797916269, 3346.397648423307, 3601.991442396133, 3928.5678575356687, 4113.4035564843525, 4129.421880936671, 4528.773561321921, 4535.818567257339, 4537.8411755588395, 4548.975705810883, 4564.835966828437, 5646.2942132233475, 5684.943150568524, 5709.0, 5724.164809577593, 5736.254286942671, 1171.7407224738138, 1190.5713144226963, 1233.4079641772, 1259.7102666386781, 1275.43880692495, 747.880339145745, 853.7353420439683, 862.2024627219797, 864.3992425264381, 869.8129902071086, 4190.266703326966, 4387.846425375161, 4687.367205427292, 4856.15466122871, 4886.828960986349, 5089.338386009795, 5300.189925112418, 5346.251524786533, 5398.946010539844, 5419.864503387447, 3967.3652215645357, 4172.332426811757, 4628.722276663411, 4803.951960480351, 4811.831585894477, 2597.7790438493876, 2649.0, 2807.298175456136, 2815.4369126174847, 2834.929126771847, 4610.423697037871, 4994.400671919393, 5381.327334083239, 5486.862828429242, 5545.861353466115, 5176.197689358156, 5465.535429488458, 5522.420145884705, 5538.44615538451, 5551.8341148359295, 4996.675216110941, 5053.761828352077, 5099.1331473648825, 5313.601479888946, 5545.140503222007, 5287.788488460573, 5327.520523152934, 5336.866578335573, 5340.819405176972, 5374.892502150014, 5349.208015314913, 5660.632058916157, 5672.290963629382, 5674.659520428788, 5696.297406685688, 5038.178619972827, 5935.495482884004, 5981.052505346451, 6006.279246490274, 6027.698615069141, 2970.4653162430104, 3291.0, 3298.455754800431, 3393.8776325780836, 3813.485179500843, 5068.732816795801, 5146.588272938081, 5628.943710563006, 5648.717564121695, 5667.319921609434, 5120.84780924304, 5288.550473209666, 5565.860853478695, 5587.69267690281, 5601.243832082617, 4913.70517768935, 5148.845534633967, 5370.818419947605, 5533.699580598636, 5628.144720866219, 4313.029568347222, 4872.342233798392, 5140.450701129453, 5329.653572517774, 5498.697571633598, 5526.253955715927, 5564.248826408383, 5588.972055139699, 5614.41048689898, 5656.981743286084, 4578.381918440968, 4782.0435912818275, 5383.492622065828, 5400.9459905400445, 5431.456854314537], "value": 4005.1820301081466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.5202462325617, 707.3951771235596, 773.0, 793.2741541489537, 816.5549775372422, 14542.345594448248, 15301.617459563517, 15595.1422671753, 15602.921985390058, 15626.062436253833, 14023.64940876476, 14265.71468570628, 14402.423903043866, 14549.054311469774, 14566.781498277534, 851.0638297872322, 851.0808327006848, 866.6879923227633, 869.482657818597, 870.0168809245544, 680.6766785776741, 701.9719211231545, 832.238501770882, 858.159004175908, 867.7223288547667, 917.4403613795579, 927.9953600232024, 928.0626567167176, 928.5774972387547, 929.1637526226416, 920.907909209077, 921.5714692667874, 923.4413180026122, 924.5377311344328, 924.990750092504, 522.9790808367661, 535.9866003349908, 662.9071929929813, 687.2577616174519, 688.5352387138662, 14973.176475293854, 15489.612759681098, 15523.534293971199, 15528.378864845392, 15558.844411555852, 13688.0, 13739.587812365646, 13896.791548126786, 13959.302034898214, 13968.58094257174, 12656.68358291041, 12705.809412858815, 12773.29746863922, 12930.48278068876, 13033.934830325883, 4388.42950416447, 4397.2304846651705, 4578.244589642705, 4579.519150489217, 4583.72497650142, 109155.0, 109452.0, 110589.0, 113983.43008284988, 115014.0, 10782.975617316342, 10892.891071089347, 10943.507542160622, 11049.834252486218, 11340.546378144947, 20084.096215670328, 20899.850508222193, 21220.681689774665, 22177.445563861034, 22237.888810555844, 7469.551826890404, 7626.69493220276, 7748.92251077482, 7757.379409647215, 7984.560849153352, 4291.2275790358035, 4311.0, 4317.028668549551, 4408.25059739845, 4479.395281637003, 3095.767817413703, 3492.5983511896457, 3596.694280986093, 3598.172420343283, 3598.298331825269, 642.489221069251, 652.2108249018646, 657.6185812228896, 670.902719105727, 674.3256743256743, 586.3608666553478, 657.4871600151889, 693.8959156126521, 711.3597762014228, 737.3106145753737, 8903.765523895794, 10021.949890250502, 10367.481625918674, 10767.892321076846, 11034.724131896606, 593.9910901336483, 595.3120419004227, 598.4673640459907, 609.5641616244407, 705.4004096517918, 4431.24578590408, 4751.287306903992, 5363.946360536423, 5631.887362252732, 5694.6583205007, 104356.47821760994, 106062.4090638641, 107119.0, 107696.0, 110139.39163650207, 79547.0, 96038.0, 97171.0, 97583.0, 98106.52840207402, 67001.0, 67076.32923670701, 80012.0, 82869.0, 84611.5769421149, 10572.947135264274, 10723.0, 10781.191410644076, 10822.67531974042, 11011.339319640847, 45643.315350269106, 50213.0, 50840.72898177575, 51639.0, 52800.73599632131, 66969.99545006927, 68665.65667171632, 69497.0, 71179.0, 73781.0, 12569.371531423576, 12775.744485110432, 12804.679883002627, 12824.23054616726, 13314.267715275753, 14637.780433293296, 14723.190224537324, 14779.778303325244, 14830.555083347517, 14957.027793193407, 13245.403956821774, 13305.002124840868, 13435.932820335836, 13600.0, 14051.718965620836, 10841.048611250051, 12895.548655797002, 13478.73042539124, 13759.793603096161, 13869.237191954539, 11586.0, 11775.116866235237, 12195.878041219474, 12224.022078233898, 12239.143259972072, 11256.887431125584, 11346.262492937933, 11517.0, 11547.13396495283, 11879.58421455245, 10694.786104277715, 10801.513931872927, 10877.836832447361, 10974.890251097388, 10990.780184396428], "value": 7590.308048592974, "unit": "score"}], "name": "dromaeo_css", "value": 7227.149961648857, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 121.0, 171.0, 155.0, 115.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 106.0, 146.0, 112.0, 110.0, 109.0, 109.0, 133.0, 109.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 261.0, 201.0, 184.0, 185.0, 185.0, 184.0, 184.0, 185.0, 184.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 106.0, 85.0, 83.0, 70.0, 60.0, 75.0, 58.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 86.0, 70.0, 70.0, 70.0, 84.0, 69.0, 68.0, 85.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 87.0, 89.0, 87.0, 89.0, 87.0, 90.0, 89.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 129.0, 130.0, 90.0, 85.0, 84.0, 90.0, 86.0, 86.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 56.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 76.0, 79.0, 74.0, 69.0, 73.0, 72.0, 72.0, 79.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 88.0, 87.0, 88.0, 88.0, 89.0, 91.0, 91.0, 89.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 158.0, 151.0, 147.0, 141.0, 140.0, 141.0, 206.0, 160.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 174.0, 173.0, 177.0, 171.0, 174.0, 177.0, 173.0, 175.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1476.0, "alertThreshold": 2.0}]} 19:48:43 INFO - Return code: 0 19:48:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:48:43 INFO - # TBPL SUCCESS # 19:48:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:48:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:48:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:48:43 INFO - 2017-01-10 19:48:43.925 screenresolution[6692:123794] starting screenresolution argv=screenresolution get 19:48:43 INFO - 2017-01-10 19:48:43.928 screenresolution[6692:123794] Display 0: 1600x1200x32@60 19:48:43 INFO - 2017-01-10 19:48:43.935 screenresolution[6693:123797] starting screenresolution argv=screenresolution list 19:48:43 INFO - Available Modes on Display 0 19:48:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:48:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:48:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:48:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:48:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:48:44 INFO - Intel Iris: 19:48:44 INFO - Chipset Model: Intel Iris 19:48:44 INFO - Type: GPU 19:48:44 INFO - Bus: Built-In 19:48:44 INFO - VRAM (Dynamic, Max): 1536 MB 19:48:44 INFO - Vendor: Intel (0x8086) 19:48:44 INFO - Device ID: 0x0a2e 19:48:44 INFO - Revision ID: 0x0009 19:48:44 INFO - Displays: 19:48:44 INFO - Display: 19:48:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:48:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:48:44 INFO - Display Serial Number: 1600x1200 60 19:48:44 INFO - Main Display: Yes 19:48:44 INFO - Mirror: Off 19:48:44 INFO - Online: Yes 19:48:44 INFO - Rotation: Supported 19:48:44 INFO - Return code: 0 19:48:44 INFO - Running post-action listener: _resource_record_post_action 19:48:44 INFO - [mozharness: 2017-01-11 03:48:44.177512Z] Finished run-tests step (success) 19:48:44 INFO - Running post-run listener: _resource_record_post_run 19:48:44 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 573952; Write bytes: 551506432; Read time: 6; Write time: 2464 19:48:44 INFO - TinderboxPrint: CPU usage
53.8% 19:48:44 INFO - TinderboxPrint: I/O read bytes / time
573,952 / 6 19:48:44 INFO - TinderboxPrint: I/O write bytes / time
551,506,432 / 2,464 19:48:44 INFO - TinderboxPrint: CPU idle
2,220.0 (46.2%) 19:48:44 INFO - TinderboxPrint: CPU system
964.5 (20.1%) 19:48:44 INFO - TinderboxPrint: CPU user
1,621.3 (33.7%) 19:48:44 INFO - TinderboxPrint: Swap in / out
250,195,968 / 0 19:48:44 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 244068864; Write bytes: 239802368; Read time: 17800; Write time: 547 19:48:44 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 573440; Write bytes: 296466944; Read time: 6; Write time: 1825 19:48:44 INFO - Running post-run listener: _upload_blobber_files 19:48:44 INFO - Blob upload gear active. 19:48:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:48:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:48:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:46 INFO - (blobuploader) - INFO - Done attempting. 19:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:48:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:47 INFO - (blobuploader) - INFO - Done attempting. 19:48:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:48:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:48:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:48 INFO - (blobuploader) - INFO - Done attempting. 19:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:48:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:50 INFO - (blobuploader) - INFO - Done attempting. 19:48:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:48:50 INFO - Return code: 0 19:48:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:48:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:48:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b168d8723488318ff9d162ccd5f0e27b2878798c08c0ad44f85c9ac88af6ef104175ac0c582fe1a1620c34d3795fb2af8664ad62401a1466c77d72cfee76b6e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66341d6bfb349400e5c6c7693f5503bf83e4bf713129ee3342f6ed7673f24f2a96cce6d7826f8a09e36be4642337484ef02058428beea7a180f07b975d4903fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16b8c7a3bc1e2376ed21d4e8e8738958879bc32be4a1beca563d2cda4a067facb56fa803891e31a9fee45249c115932f7899fe82211a73c5d79318a19f177d52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e07faef75897dfec24428375821157d56f2a8c028b1e65dbe8a8342de5b421d723aa503f9d0f323eff36927f5702809620a4f89978e7842377877fe83661cbf9"} 19:48:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:48:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:48:50 INFO - Contents: 19:48:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b168d8723488318ff9d162ccd5f0e27b2878798c08c0ad44f85c9ac88af6ef104175ac0c582fe1a1620c34d3795fb2af8664ad62401a1466c77d72cfee76b6e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66341d6bfb349400e5c6c7693f5503bf83e4bf713129ee3342f6ed7673f24f2a96cce6d7826f8a09e36be4642337484ef02058428beea7a180f07b975d4903fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16b8c7a3bc1e2376ed21d4e8e8738958879bc32be4a1beca563d2cda4a067facb56fa803891e31a9fee45249c115932f7899fe82211a73c5d79318a19f177d52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e07faef75897dfec24428375821157d56f2a8c028b1e65dbe8a8342de5b421d723aa503f9d0f323eff36927f5702809620a4f89978e7842377877fe83661cbf9"} 19:48:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:48:50 INFO - Copying logs to upload dir... 19:48:50 INFO - mkdir: /builds/slave/test/build/upload/logs 19:48:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.807500 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-10 19:48:50.373800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 19:48:50.380766) ========= 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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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/b168d8723488318ff9d162ccd5f0e27b2878798c08c0ad44f85c9ac88af6ef104175ac0c582fe1a1620c34d3795fb2af8664ad62401a1466c77d72cfee76b6e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66341d6bfb349400e5c6c7693f5503bf83e4bf713129ee3342f6ed7673f24f2a96cce6d7826f8a09e36be4642337484ef02058428beea7a180f07b975d4903fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16b8c7a3bc1e2376ed21d4e8e8738958879bc32be4a1beca563d2cda4a067facb56fa803891e31a9fee45249c115932f7899fe82211a73c5d79318a19f177d52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e07faef75897dfec24428375821157d56f2a8c028b1e65dbe8a8342de5b421d723aa503f9d0f323eff36927f5702809620a4f89978e7842377877fe83661cbf9"} build_url:https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010233 build_url: 'https://queue.taskcluster.net/v1/task/J6C9fpdJSluJF_BeC_0vvQ/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/b168d8723488318ff9d162ccd5f0e27b2878798c08c0ad44f85c9ac88af6ef104175ac0c582fe1a1620c34d3795fb2af8664ad62401a1466c77d72cfee76b6e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66341d6bfb349400e5c6c7693f5503bf83e4bf713129ee3342f6ed7673f24f2a96cce6d7826f8a09e36be4642337484ef02058428beea7a180f07b975d4903fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16b8c7a3bc1e2376ed21d4e8e8738958879bc32be4a1beca563d2cda4a067facb56fa803891e31a9fee45249c115932f7899fe82211a73c5d79318a19f177d52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e07faef75897dfec24428375821157d56f2a8c028b1e65dbe8a8342de5b421d723aa503f9d0f323eff36927f5702809620a4f89978e7842377877fe83661cbf9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 19:48:50.414599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 19:48:50.414879) ========= 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.NjiJmPXkma/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.Ma4jGpvr6W/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.004880 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 19:48:50.462740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 19:48:50.463004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 19:48:50.463267) ========= ========= Total master_lag: 0.19 =========