builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0225 starttime: 1490830987.67 results: success (0) buildid: 20170329114623 builduid: 6ac267caa2ed44d3b441eb09442f8043 revision: c3432ed0090b6165264953285276f69a8fd2b59a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.670559) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.671035) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.671312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.696133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.696479) ========= 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.TJIDe9k2De/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.zTsNOF4rmA/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-29 16:43:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.34M=0.001s 2017-03-29 16:43:07 (8.34 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.893745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.894076) ========= 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.TJIDe9k2De/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.zTsNOF4rmA/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.021340 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:07.941705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 16:43:07.942065) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev c3432ed0090b6165264953285276f69a8fd2b59a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev c3432ed0090b6165264953285276f69a8fd2b59a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TJIDe9k2De/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.zTsNOF4rmA/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-29 16:43:08,033 truncating revision to first 12 chars 2017-03-29 16:43:08,033 Setting DEBUG logging. 2017-03-29 16:43:08,033 attempt 1/10 2017-03-29 16:43:08,033 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/c3432ed0090b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 16:43:09,331 unpacking tar archive at: pine-c3432ed0090b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.578708 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 16:43:09.546226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:09.546756) ========= script_repo_revision: c3432ed0090b6165264953285276f69a8fd2b59a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:09.547432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:09.547880) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:43:09.568465) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-29 16:43:09.568889) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TJIDe9k2De/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.zTsNOF4rmA/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:43:09 INFO - MultiFileLogger online at 20170329 16:43:09 in /builds/slave/test 16:43:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 16:43:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:43:09 INFO - {'append_to_log': False, 16:43:09 INFO - 'base_work_dir': '/builds/slave/test', 16:43:09 INFO - 'blob_upload_branch': 'Pine', 16:43:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:43:09 INFO - 'branch': 'Pine', 16:43:09 INFO - 'buildbot_json_path': 'buildprops.json', 16:43:09 INFO - 'config_files': ('talos/mac_config.py',), 16:43:09 INFO - 'default_actions': ('clobber', 16:43:09 INFO - 'read-buildbot-config', 16:43:09 INFO - 'download-and-extract', 16:43:09 INFO - 'populate-webroot', 16:43:09 INFO - 'create-virtualenv', 16:43:09 INFO - 'install', 16:43:09 INFO - 'run-tests'), 16:43:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:43:09 INFO - 'download_minidump_stackwalk': True, 16:43:09 INFO - 'download_symbols': 'ondemand', 16:43:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:43:09 INFO - 'tooltool.py': '/tools/tooltool.py', 16:43:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:43:09 INFO - '/tools/misc-python/virtualenv.py')}, 16:43:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:43:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:43:09 INFO - 'gecko_profile': False, 16:43:09 INFO - 'gecko_profile_interval': 0, 16:43:09 INFO - 'installer_path': 'installer.exe', 16:43:09 INFO - 'log_level': 'info', 16:43:09 INFO - 'log_name': 'talos', 16:43:09 INFO - 'log_to_console': True, 16:43:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:43:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:43:09 INFO - 'opt_config_files': (), 16:43:09 INFO - 'pip_index': False, 16:43:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:43:09 INFO - 'cmd': ('bash', 16:43:09 INFO - '-c', 16:43:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:43:09 INFO - 'enabled': True, 16:43:09 INFO - 'halt_on_failure': False, 16:43:09 INFO - 'name': 'check_screen_resolution'},), 16:43:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:43:09 INFO - 'cmd': ('bash', 16:43:09 INFO - '-c', 16:43:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:43:09 INFO - 'enabled': True, 16:43:09 INFO - 'halt_on_failure': False, 16:43:09 INFO - 'name': 'check_screen_resolution'},), 16:43:09 INFO - 'run_cmd_checks_enabled': True, 16:43:09 INFO - 'suite': 'dromaeojs', 16:43:09 INFO - 'system_bits': '32', 16:43:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:43:09 INFO - 'title': 't-yosemite-r7-0225', 16:43:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:43:09 INFO - 'use_talos_json': True, 16:43:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:43:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:43:09 INFO - 'work_dir': 'build'} 16:43:09 INFO - [mozharness: 2017-03-29 23:43:09.783274Z] Running clobber step. 16:43:09 INFO - Running pre-action listener: _resource_record_pre_action 16:43:09 INFO - Running main action method: clobber 16:43:09 INFO - rmtree: /builds/slave/test/build 16:43:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:43:13 INFO - Running post-action listener: _resource_record_post_action 16:43:13 INFO - [mozharness: 2017-03-29 23:43:13.050622Z] Finished clobber step (success) 16:43:13 INFO - [mozharness: 2017-03-29 23:43:13.050771Z] Running read-buildbot-config step. 16:43:13 INFO - Running pre-action listener: _resource_record_pre_action 16:43:13 INFO - Running main action method: read_buildbot_config 16:43:13 INFO - Using buildbot properties: 16:43:13 INFO - { 16:43:13 INFO - "project": "", 16:43:13 INFO - "product": "firefox", 16:43:13 INFO - "script_repo_revision": "default", 16:43:13 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 16:43:13 INFO - "repository": "", 16:43:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 16:43:13 INFO - "buildid": "20170329114623", 16:43:13 INFO - "pgo_build": "False", 16:43:13 INFO - "basedir": "/builds/slave/test", 16:43:13 INFO - "buildnumber": 1, 16:43:13 INFO - "slavename": "t-yosemite-r7-0225", 16:43:13 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:43:13 INFO - "platform": "yosemite_r7", 16:43:13 INFO - "scheduler": "tests-pine-macosx64-talos", 16:43:13 INFO - "branch": "pine", 16:43:13 INFO - "repo_path": "projects/pine", 16:43:13 INFO - "revision": "c3432ed0090b6165264953285276f69a8fd2b59a", 16:43:13 INFO - "stage_platform": "macosx64", 16:43:13 INFO - "builduid": "6ac267caa2ed44d3b441eb09442f8043", 16:43:13 INFO - "slavebuilddir": "test" 16:43:13 INFO - } 16:43:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:43:13 INFO - Running post-action listener: _resource_record_post_action 16:43:13 INFO - [mozharness: 2017-03-29 23:43:13.054102Z] Finished read-buildbot-config step (success) 16:43:13 INFO - [mozharness: 2017-03-29 23:43:13.054245Z] Running download-and-extract step. 16:43:13 INFO - Running pre-action listener: _resource_record_pre_action 16:43:13 INFO - Running main action method: download_and_extract 16:43:13 INFO - mkdir: /builds/slave/test/build/tests 16:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:13 INFO - trying https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:43:13 INFO - Downloading https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:43:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:43:14 INFO - Downloaded 1325 bytes. 16:43:14 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:43:14 INFO - Using the following test package requirements: 16:43:14 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:43:14 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:43:14 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:43:14 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:43:14 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'jsshell-mac.zip'], 16:43:14 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:43:14 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:43:14 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:43:14 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:43:14 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:43:14 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:43:14 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:43:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:43:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:43:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:43:14 INFO - Fetch https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:43:16 INFO - Expected file size: 52504711 16:43:16 INFO - Obtained file size: 52504711 16:43:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:43:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:43:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:43:32 INFO - Fetch https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:43:34 INFO - Expected file size: 52504711 16:43:34 INFO - Obtained file size: 52504711 16:43:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:43:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:43:49 INFO - Fetch https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:43:50 INFO - Expected file size: 14404171 16:43:50 INFO - Obtained file size: 14404171 16:43:51 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')]} 16:43:51 INFO - trying https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:43:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:43:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:43:53 INFO - Downloaded 75622764 bytes. 16:43:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:43:53 INFO - mkdir: /builds/slave/test/properties 16:43:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:53 INFO - Contents: 16:43:53 INFO - build_url:https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:43:53 INFO - Running post-action listener: _resource_record_post_action 16:43:53 INFO - Running post-action listener: set_extra_try_arguments 16:43:53 INFO - [mozharness: 2017-03-29 23:43:53.934701Z] Finished download-and-extract step (success) 16:43:53 INFO - [mozharness: 2017-03-29 23:43:53.934836Z] Running populate-webroot step. 16:43:53 INFO - Running pre-action listener: _resource_record_pre_action 16:43:53 INFO - Running main action method: populate_webroot 16:43:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:53 INFO - '--tppagecycles', 16:43:53 INFO - '7'], 16:43:53 INFO - 'tests': ['tsvgm']}}, 16:43:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:43:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:43:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:43:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:43:53 INFO - 'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:43:53 INFO - 'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['damp', 'tps']}, 16:43:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:43:53 INFO - 'tests': ['damp', 'tps']}, 16:43:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['dromaeo_dom']}, 16:43:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['basic_compositor_video']}, 16:43:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:43:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['a11yr', 16:43:53 INFO - 'ts_paint', 16:43:53 INFO - 'tpaint', 16:43:53 INFO - 'sessionrestore', 16:43:53 INFO - 'sessionrestore_no_auto_restore', 16:43:53 INFO - 'tabpaint']}, 16:43:53 INFO - 'other-e10s': {'tests': ['a11yr', 16:43:53 INFO - 'ts_paint', 16:43:53 INFO - 'tpaint', 16:43:53 INFO - 'sessionrestore', 16:43:53 INFO - 'sessionrestore_no_auto_restore', 16:43:53 INFO - 'tabpaint']}, 16:43:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:43:53 INFO - 'ts_paint', 16:43:53 INFO - 'tpaint', 16:43:53 INFO - 'sessionrestore', 16:43:53 INFO - 'sessionrestore_no_auto_restore', 16:43:53 INFO - 'tabpaint']}, 16:43:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:43:53 INFO - 'ts_paint', 16:43:53 INFO - 'tpaint', 16:43:53 INFO - 'sessionrestore', 16:43:53 INFO - 'sessionrestore_no_auto_restore', 16:43:53 INFO - 'tabpaint']}, 16:43:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['a11yr', 16:43:53 INFO - 'ts_paint', 16:43:53 INFO - 'tpaint', 16:43:53 INFO - 'sessionrestore', 16:43:53 INFO - 'sessionrestore_no_auto_restore', 16:43:53 INFO - 'tabpaint']}, 16:43:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['a11yr', 16:43:53 INFO - 'ts_paint', 16:43:53 INFO - 'tpaint', 16:43:53 INFO - 'sessionrestore', 16:43:53 INFO - 'sessionrestore_no_auto_restore', 16:43:53 INFO - 'tabpaint']}, 16:43:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['tsvgx', 16:43:53 INFO - 'tsvgr_opacity', 16:43:53 INFO - 'tart', 16:43:53 INFO - 'tscrollx', 16:43:53 INFO - 'cart', 16:43:53 INFO - 'tsvg_static']}, 16:43:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:43:53 INFO - 'tsvgr_opacity', 16:43:53 INFO - 'tart', 16:43:53 INFO - 'tscrollx', 16:43:53 INFO - 'cart', 16:43:53 INFO - 'tsvg_static']}, 16:43:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:43:53 INFO - 'talos_options': ['--disable-e10s'], 16:43:53 INFO - 'tests': ['tp5o']}, 16:43:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:43:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:43:53 INFO - 'talos_options': ['--disable-e10s', 16:43:53 INFO - '--xperf_path', 16:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:53 INFO - 'tests': ['tp5n']}, 16:43:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:43:53 INFO - 'talos_options': ['--xperf_path', 16:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:53 INFO - 'tests': ['tp5n']}}, 16:43:53 INFO - 'talos.zip': {'path': '', 16:43:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:53 INFO - Running post-action listener: _resource_record_post_action 16:43:53 INFO - [mozharness: 2017-03-29 23:43:53.953116Z] Finished populate-webroot step (success) 16:43:53 INFO - [mozharness: 2017-03-29 23:43:53.953252Z] Running create-virtualenv step. 16:43:53 INFO - Running pre-action listener: _resource_record_pre_action 16:43:53 INFO - Running main action method: create_virtualenv 16:43:53 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:53 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 16:43:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:54 INFO - Using real prefix '/tools/python27' 16:43:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:54 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:57 INFO - Installing pip.................done. 16:43:57 INFO - Return code: 0 16:43:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:43:57 INFO - Reading from file tmpfile_stdout 16:43:57 INFO - Output received: 16:43:57 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) 16:43:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:43:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:43:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:57 INFO - 'HOME': '/Users/cltbld', 16:43:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:57 INFO - 'LOGNAME': 'cltbld', 16:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:57 INFO - 'MOZ_NO_REMOTE': '1', 16:43:57 INFO - 'NO_EM_RESTART': '1', 16:43:57 INFO - 'PAGER': '/bin/cat', 16:43:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:57 INFO - 'PWD': '/builds/slave/test', 16:43:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:57 INFO - 'SHELL': '/bin/bash', 16:43:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:43:57 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:43:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:57 INFO - 'USER': 'cltbld', 16:43:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:57 INFO - 'XPC_FLAGS': '0x0', 16:43:57 INFO - 'XPC_SERVICE_NAME': '0', 16:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:58 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 16:43:58 INFO - Cleaning up... 16:43:58 INFO - Return code: 0 16:43:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:43:58 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')]} 16:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 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')]} 16:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:43:58 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 16:43:58 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 16:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:58 INFO - 'HOME': '/Users/cltbld', 16:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:58 INFO - 'LOGNAME': 'cltbld', 16:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:58 INFO - 'MOZ_NO_REMOTE': '1', 16:43:58 INFO - 'NO_EM_RESTART': '1', 16:43:58 INFO - 'PAGER': '/bin/cat', 16:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:58 INFO - 'PWD': '/builds/slave/test', 16:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:58 INFO - 'SHELL': '/bin/bash', 16:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:43:58 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:58 INFO - 'USER': 'cltbld', 16:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:58 INFO - 'XPC_FLAGS': '0x0', 16:43:58 INFO - 'XPC_SERVICE_NAME': '0', 16:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:58 INFO - Downloading/unpacking psutil>=3.1.1 16:43:58 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 16:43:58 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 16:43:58 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 16:43:58 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 16:43:58 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 16:43:58 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 16:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:01 INFO - Installing collected packages: psutil 16:44:01 INFO - Running setup.py install for psutil 16:44:02 INFO - building 'psutil._psutil_osx' extension 16:44:02 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 16:44:02 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 16:44:02 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 16:44:02 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 16:44:02 INFO - building 'psutil._psutil_posix' extension 16:44:02 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 16:44:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:44:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:44:02 INFO - ^ 16:44:02 INFO - 1 warning generated. 16:44:02 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 16:44:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:02 INFO - Successfully installed psutil 16:44:02 INFO - Cleaning up... 16:44:02 INFO - Return code: 0 16:44:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:02 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:02 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 16:44:02 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 16:44:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:02 INFO - 'HOME': '/Users/cltbld', 16:44:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:02 INFO - 'LOGNAME': 'cltbld', 16:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:02 INFO - 'MOZ_NO_REMOTE': '1', 16:44:02 INFO - 'NO_EM_RESTART': '1', 16:44:02 INFO - 'PAGER': '/bin/cat', 16:44:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:02 INFO - 'PWD': '/builds/slave/test', 16:44:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:02 INFO - 'SHELL': '/bin/bash', 16:44:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:02 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:02 INFO - 'USER': 'cltbld', 16:44:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:02 INFO - 'XPC_FLAGS': '0x0', 16:44:02 INFO - 'XPC_SERVICE_NAME': '0', 16:44:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:44:03 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 16:44:03 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 16:44:03 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 16:44:03 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 16:44:03 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 16:44:03 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 16:44:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:44:05 INFO - Installing collected packages: mozsystemmonitor 16:44:05 INFO - Running setup.py install for mozsystemmonitor 16:44:06 INFO - Successfully installed mozsystemmonitor 16:44:06 INFO - Cleaning up... 16:44:06 INFO - Return code: 0 16:44:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:06 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:06 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 16:44:06 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 16:44:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:06 INFO - 'HOME': '/Users/cltbld', 16:44:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:06 INFO - 'LOGNAME': 'cltbld', 16:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:06 INFO - 'MOZ_NO_REMOTE': '1', 16:44:06 INFO - 'NO_EM_RESTART': '1', 16:44:06 INFO - 'PAGER': '/bin/cat', 16:44:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:06 INFO - 'PWD': '/builds/slave/test', 16:44:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:06 INFO - 'SHELL': '/bin/bash', 16:44:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:06 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:06 INFO - 'USER': 'cltbld', 16:44:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:06 INFO - 'XPC_FLAGS': '0x0', 16:44:06 INFO - 'XPC_SERVICE_NAME': '0', 16:44:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:07 INFO - Downloading/unpacking jsonschema==2.5.1 16:44:07 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 16:44:07 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 16:44:07 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 16:44:07 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 16:44:07 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 16:44:07 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 16:44:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:44:10 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 16:44:10 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 16:44:10 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 16:44:10 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 16:44:10 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 16:44:10 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 16:44:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:10 INFO - warning: no files found matching '*.txt' 16:44:10 INFO - no previously-included directories found matching 'build' 16:44:10 INFO - no previously-included directories found matching 'dist' 16:44:10 INFO - no previously-included directories found matching '.git*' 16:44:10 INFO - Installing collected packages: jsonschema, functools32 16:44:10 INFO - Running setup.py install for functools32 16:44:10 INFO - warning: no files found matching '*.txt' 16:44:10 INFO - no previously-included directories found matching 'build' 16:44:10 INFO - no previously-included directories found matching 'dist' 16:44:10 INFO - no previously-included directories found matching '.git*' 16:44:10 INFO - Successfully installed jsonschema functools32 16:44:10 INFO - Cleaning up... 16:44:11 INFO - Return code: 0 16:44:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:44:11 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')]} 16:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:11 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')]} 16:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:11 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:11 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 16:44:11 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 16:44:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:11 INFO - 'HOME': '/Users/cltbld', 16:44:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:11 INFO - 'LOGNAME': 'cltbld', 16:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:11 INFO - 'MOZ_NO_REMOTE': '1', 16:44:11 INFO - 'NO_EM_RESTART': '1', 16:44:11 INFO - 'PAGER': '/bin/cat', 16:44:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:11 INFO - 'PWD': '/builds/slave/test', 16:44:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:11 INFO - 'SHELL': '/bin/bash', 16:44:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:11 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:11 INFO - 'USER': 'cltbld', 16:44:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:11 INFO - 'XPC_FLAGS': '0x0', 16:44:11 INFO - 'XPC_SERVICE_NAME': '0', 16:44:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:44:11 INFO - Cleaning up... 16:44:11 INFO - Return code: 0 16:44:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44:11 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')]} 16:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:11 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')]} 16:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:11 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:11 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 16:44:11 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 16:44:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:11 INFO - 'HOME': '/Users/cltbld', 16:44:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:11 INFO - 'LOGNAME': 'cltbld', 16:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:11 INFO - 'MOZ_NO_REMOTE': '1', 16:44:11 INFO - 'NO_EM_RESTART': '1', 16:44:11 INFO - 'PAGER': '/bin/cat', 16:44:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:11 INFO - 'PWD': '/builds/slave/test', 16:44:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:11 INFO - 'SHELL': '/bin/bash', 16:44:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:11 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:11 INFO - 'USER': 'cltbld', 16:44:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:11 INFO - 'XPC_FLAGS': '0x0', 16:44:11 INFO - 'XPC_SERVICE_NAME': '0', 16:44:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:11 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:11 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 16:44:11 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 16:44:11 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 16:44:11 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 16:44:11 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 16:44:11 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 16:44:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:14 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 16:44:14 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 16:44:14 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 16:44:14 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 16:44:14 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 16:44:14 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 16:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44:14 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 16:44:14 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 16:44:14 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 16:44:14 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 16:44:14 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 16:44:14 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 16:44:15 INFO - Downloading docopt-0.6.1.tar.gz 16:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:15 INFO - Running setup.py install for blobuploader 16:44:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:15 INFO - Running setup.py install for requests 16:44:16 INFO - Running setup.py install for docopt 16:44:16 INFO - Successfully installed blobuploader requests docopt 16:44:16 INFO - Cleaning up... 16:44:16 INFO - Return code: 0 16:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:16 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:16 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 16:44:16 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 16:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:16 INFO - 'HOME': '/Users/cltbld', 16:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:16 INFO - 'LOGNAME': 'cltbld', 16:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:16 INFO - 'MOZ_NO_REMOTE': '1', 16:44:16 INFO - 'NO_EM_RESTART': '1', 16:44:16 INFO - 'PAGER': '/bin/cat', 16:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:16 INFO - 'PWD': '/builds/slave/test', 16:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:16 INFO - 'SHELL': '/bin/bash', 16:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:16 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:16 INFO - 'USER': 'cltbld', 16:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:16 INFO - 'XPC_FLAGS': '0x0', 16:44:16 INFO - 'XPC_SERVICE_NAME': '0', 16:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:16 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-GoNpRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:16 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_JID56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:16 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-eiMvM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:16 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Yn5Lr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-47oxkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-qftSdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-DmFK7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Q_ORK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-OCvabO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-IUw547-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-hf5KtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-CJLYQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-6S6N3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-5Smdfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-HYwUzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-0wJri_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-7WD3tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:18 INFO - Running setup.py install for manifestparser 16:44:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:18 INFO - Running setup.py install for mozcrash 16:44:18 INFO - Running setup.py install for mozdebug 16:44:18 INFO - Running setup.py install for mozdevice 16:44:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:18 INFO - Running setup.py install for mozfile 16:44:19 INFO - Running setup.py install for mozhttpd 16:44:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:19 INFO - Running setup.py install for mozinfo 16:44:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:19 INFO - Running setup.py install for mozInstall 16:44:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:19 INFO - Running setup.py install for mozleak 16:44:19 INFO - Running setup.py install for mozlog 16:44:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:19 INFO - Running setup.py install for moznetwork 16:44:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:20 INFO - Running setup.py install for mozprocess 16:44:20 INFO - Running setup.py install for mozprofile 16:44:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:20 INFO - Running setup.py install for mozrunner 16:44:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:20 INFO - Running setup.py install for mozscreenshot 16:44:20 INFO - Running setup.py install for moztest 16:44:20 INFO - Running setup.py install for mozversion 16:44:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:20 INFO - Cleaning up... 16:44:20 INFO - Return code: 0 16:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:20 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')]} 16:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:20 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')]} 16:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:20 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:20 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 16:44:20 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 16:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:20 INFO - 'HOME': '/Users/cltbld', 16:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:20 INFO - 'LOGNAME': 'cltbld', 16:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:20 INFO - 'MOZ_NO_REMOTE': '1', 16:44:20 INFO - 'NO_EM_RESTART': '1', 16:44:20 INFO - 'PAGER': '/bin/cat', 16:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:20 INFO - 'PWD': '/builds/slave/test', 16:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:20 INFO - 'SHELL': '/bin/bash', 16:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:20 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:20 INFO - 'USER': 'cltbld', 16:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:20 INFO - 'XPC_FLAGS': '0x0', 16:44:20 INFO - 'XPC_SERVICE_NAME': '0', 16:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:21 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Nys934-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:21 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)) 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:21 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-xp5uGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:21 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)) 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:21 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-5OMRyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:21 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)) 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:21 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-HJuao7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:21 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)) 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:21 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-v2biq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:21 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)) 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:21 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-KoNG0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:21 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)) 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:21 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-paCfyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:21 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)) 16:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-DPiMsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-bXfK1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-SNAjuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-s7DKKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-a6mCU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-2PPWhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-GYmyeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-fyMrJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-uKKf9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:22 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)) 16:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-46cGQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:23 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)) 16:44:23 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)) 16:44:23 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)) 16:44:23 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)) 16:44:23 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)) 16:44:23 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)) 16:44:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:23 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 16:44:23 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 16:44:23 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 16:44:23 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 16:44:23 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 16:44:23 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 16:44:25 INFO - Downloading blessings-1.6.tar.gz 16:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:25 INFO - Installing collected packages: blessings 16:44:25 INFO - Running setup.py install for blessings 16:44:25 INFO - Successfully installed blessings 16:44:25 INFO - Cleaning up... 16:44:26 INFO - Return code: 0 16:44:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:26 INFO - Reading from file tmpfile_stdout 16:44:26 INFO - Current package versions: 16:44:26 INFO - blessings == 1.6 16:44:26 INFO - blobuploader == 1.2.4 16:44:26 INFO - docopt == 0.6.1 16:44:26 INFO - functools32 == 3.2.3-2 16:44:26 INFO - jsonschema == 2.5.1 16:44:26 INFO - manifestparser == 1.1 16:44:26 INFO - mozInstall == 1.12 16:44:26 INFO - mozcrash == 1.0 16:44:26 INFO - mozdebug == 0.1 16:44:26 INFO - mozdevice == 0.49 16:44:26 INFO - mozfile == 1.2 16:44:26 INFO - mozhttpd == 0.7 16:44:26 INFO - mozinfo == 0.9 16:44:26 INFO - mozleak == 0.1 16:44:26 INFO - mozlog == 3.4 16:44:26 INFO - moznetwork == 0.27 16:44:26 INFO - mozprocess == 0.25 16:44:26 INFO - mozprofile == 0.28 16:44:26 INFO - mozrunner == 6.13 16:44:26 INFO - mozscreenshot == 0.1 16:44:26 INFO - mozsystemmonitor == 0.3 16:44:26 INFO - moztest == 0.8 16:44:26 INFO - mozversion == 1.4 16:44:26 INFO - psutil == 3.1.1 16:44:26 INFO - requests == 1.2.3 16:44:26 INFO - wsgiref == 0.1.2 16:44:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:26 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 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:26 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 16:44:26 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 16:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:26 INFO - 'HOME': '/Users/cltbld', 16:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:26 INFO - 'LOGNAME': 'cltbld', 16:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:26 INFO - 'MOZ_NO_REMOTE': '1', 16:44:26 INFO - 'NO_EM_RESTART': '1', 16:44:26 INFO - 'PAGER': '/bin/cat', 16:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:26 INFO - 'PWD': '/builds/slave/test', 16:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:26 INFO - 'SHELL': '/bin/bash', 16:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:26 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:26 INFO - 'USER': 'cltbld', 16:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:26 INFO - 'XPC_FLAGS': '0x0', 16:44:26 INFO - 'XPC_SERVICE_NAME': '0', 16:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 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)) 16:44:26 INFO - Cleaning up... 16:44:26 INFO - Return code: 0 16:44:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102d25b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d28768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ea45d470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, '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.TJIDe9k2De/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.zTsNOF4rmA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 16:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:26 INFO - 'HOME': '/Users/cltbld', 16:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:26 INFO - 'LOGNAME': 'cltbld', 16:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:26 INFO - 'MOZ_NO_REMOTE': '1', 16:44:26 INFO - 'NO_EM_RESTART': '1', 16:44:26 INFO - 'PAGER': '/bin/cat', 16:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:26 INFO - 'PWD': '/builds/slave/test', 16:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:26 INFO - 'SHELL': '/bin/bash', 16:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:26 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:26 INFO - 'USER': 'cltbld', 16:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:26 INFO - 'XPC_FLAGS': '0x0', 16:44:26 INFO - 'XPC_SERVICE_NAME': '0', 16:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:44:26 INFO - Cleaning up... 16:44:26 INFO - Return code: 0 16:44:26 INFO - Running post-action listener: _resource_record_post_action 16:44:26 INFO - Running post-action listener: _start_resource_monitoring 16:44:26 INFO - Starting resource monitoring. 16:44:26 INFO - [mozharness: 2017-03-29 23:44:26.870092Z] Finished create-virtualenv step (success) 16:44:26 INFO - [mozharness: 2017-03-29 23:44:26.871125Z] Running install step. 16:44:26 INFO - Running pre-action listener: _resource_record_pre_action 16:44:26 INFO - Running main action method: install 16:44:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:27 INFO - Reading from file tmpfile_stdout 16:44:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:27 INFO - Reading from file tmpfile_stdout 16:44:27 INFO - Output received: 16:44:27 INFO - Usage: mozinstall [options] installer 16:44:27 INFO - Options: 16:44:27 INFO - -h, --help show this help message and exit 16:44:27 INFO - -d DEST, --destination=DEST 16:44:27 INFO - Directory to install application into. [default: 16:44:27 INFO - "/builds/slave/test"] 16:44:27 INFO - --app=APP Application being installed. [default: firefox] 16:44:27 INFO - mkdir: /builds/slave/test/build/application 16:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:44:47 INFO - Reading from file tmpfile_stdout 16:44:47 INFO - Output received: 16:44:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:44:47 INFO - Running post-action listener: _resource_record_post_action 16:44:47 INFO - [mozharness: 2017-03-29 23:44:47.502022Z] Finished install step (success) 16:44:47 INFO - [mozharness: 2017-03-29 23:44:47.502165Z] Running run-tests step. 16:44:47 INFO - Running pre-action listener: _resource_record_pre_action 16:44:47 INFO - Running main action method: run_tests 16:44:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:44:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:44:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:44:47 INFO - 2017-03-29 16:44:47.517 screenresolution[1904:60168] starting screenresolution argv=screenresolution get 16:44:47 INFO - 2017-03-29 16:44:47.520 screenresolution[1904:60168] Display 0: 1600x1200x32@60 16:44:47 INFO - 2017-03-29 16:44:47.526 screenresolution[1905:60171] starting screenresolution argv=screenresolution list 16:44:47 INFO - Available Modes on Display 0 16:44:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:44:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:44:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:44:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:44:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:44:47 INFO - Intel Iris: 16:44:47 INFO - Chipset Model: Intel Iris 16:44:47 INFO - Type: GPU 16:44:47 INFO - Bus: Built-In 16:44:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:44:47 INFO - Vendor: Intel (0x8086) 16:44:47 INFO - Device ID: 0x0a2e 16:44:47 INFO - Revision ID: 0x0009 16:44:47 INFO - Displays: 16:44:47 INFO - Display: 16:44:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:44:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:44:47 INFO - Display Serial Number: 1600x1200 60 16:44:47 INFO - Main Display: Yes 16:44:47 INFO - Mirror: Off 16:44:47 INFO - Online: Yes 16:44:47 INFO - Rotation: Supported 16:44:47 INFO - Return code: 0 16:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:44:47 INFO - Python 2.7.3 16:44:47 INFO - Return code: 0 16:44:47 INFO - grabbing minidump binary from tooltool 16:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:47 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 0x102b03d30>, '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 0x102a2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:44:47 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 16:44:47 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 16:44:47 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 16:44:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:47 INFO - Return code: 0 16:44:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:44:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:47 INFO - ENV: RUST_BACKTRACE is now 1 16:44:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:44:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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 16:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0225 --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 16:44:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TJIDe9k2De/Render', 16:44:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:47 INFO - 'HOME': '/Users/cltbld', 16:44:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:47 INFO - 'LOGNAME': 'cltbld', 16:44:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:47 INFO - 'MOZ_NO_REMOTE': '1', 16:44:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:47 INFO - 'NO_EM_RESTART': '1', 16:44:47 INFO - 'PAGER': '/bin/cat', 16:44:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:47 INFO - 'PWD': '/builds/slave/test', 16:44:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:47 INFO - 'RUST_BACKTRACE': '1', 16:44:47 INFO - 'SHELL': '/bin/bash', 16:44:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zTsNOF4rmA/Listeners', 16:44:47 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:44:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:47 INFO - 'USER': 'cltbld', 16:44:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:47 INFO - 'XPC_FLAGS': '0x0', 16:44:47 INFO - 'XPC_SERVICE_NAME': '0', 16:44:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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 16:44:48 INFO - mozversion application_buildid: 20170329114623 16:44:48 INFO - mozversion application_changeset: c3432ed0090b6165264953285276f69a8fd2b59a 16:44:48 INFO - mozversion application_display_name: Nightly 16:44:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:48 INFO - mozversion application_name: Firefox 16:44:48 INFO - mozversion application_remotingname: firefox 16:44:48 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 16:44:48 INFO - mozversion application_vendor: Mozilla 16:44:48 INFO - mozversion application_version: 55.0a1 16:44:48 INFO - mozversion platform_buildid: 20170329114623 16:44:48 INFO - mozversion platform_changeset: c3432ed0090b6165264953285276f69a8fd2b59a 16:44:48 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 16:44:48 INFO - mozversion platform_version: 55.0a1 16:44:48 INFO - using testdate: 1490831088 16:44:48 INFO - actual date: 1490831088 16:44:48 INFO - starting webserver on 'localhost:64821' 16:44:48 INFO - SUITE-START | Running 2 tests 16:44:48 INFO - TEST-START | dromaeo_css 16:44:48 INFO - operating with platform_type : mac_ 16:44:48 INFO - Initialising browser for dromaeo_css test... 16:44:48 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpeI0Fwe/profile http://localhost:64821/getInfo.html) 16:44:50 INFO - PID 1915 | __metrics Screen width/height:1600/1200 16:44:50 INFO - PID 1915 | colorDepth:24 16:44:50 INFO - PID 1915 | Browser inner width/height: 1024/689 16:44:50 INFO - PID 1915 | __metrics 16:44:50 ERROR - PID 1915 | 1490831090692 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 16:44:50 INFO - PID 1915 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:44:50 INFO - PID 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:44:51 INFO - TEST-INFO | 1915: exit 0 16:44:51 INFO - Browser initialized. 16:44:51 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:51 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpeI0Fwe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:03 INFO - PID 1917 | RSS: Main: 234491904 16:45:03 INFO - PID 1917 | 16:48:09 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:64821/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64821/tests/dromaeo/cssquery-ext.html) 16:48:11 INFO - PID 1917 | RSS: Main: 420061184 16:48:11 INFO - PID 1917 | 16:49:53 INFO - PID 1917 | ************************* 16:49:53 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 16:49:53 INFO - PID 1917 | 16:49:53 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:53 INFO - PID 1917 | Full stack: 16:49:53 INFO - PID 1917 | ************************* 16:49:53 INFO - PID 1917 | ************************* 16:49:53 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 16:49:53 INFO - PID 1917 | 16:49:53 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:53 INFO - PID 1917 | Full stack: 16:49:53 INFO - PID 1917 | ************************* 16:49:53 INFO - PID 1917 | ************************* 16:49:53 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 16:49:53 INFO - PID 1917 | 16:49:53 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:53 INFO - PID 1917 | Full stack: 16:49:53 INFO - PID 1917 | ************************* 16:49:53 INFO - PID 1917 | ************************* 16:49:53 INFO - PID 1917 | A coding exception was thrown and uncaught in a Task. 16:49:53 INFO - PID 1917 | 16:49:53 ERROR - PID 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:53 INFO - PID 1917 | Full stack: 16:49:53 INFO - PID 1917 | ************************* 16:51:14 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:64821/tests/dromaeo/cssquery-ext.html (next: http://localhost:64821/tests/dromaeo/cssquery-jquery.html) 16:51:15 INFO - PID 1917 | RSS: Main: 367030272 16:51:15 INFO - PID 1917 | 16:54:17 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:64821/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64821/tests/dromaeo/cssquery-mootools.html) 16:54:18 INFO - PID 1917 | RSS: Main: 331558912 16:54:18 INFO - PID 1917 | 16:57:20 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:64821/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64821/tests/dromaeo/cssquery-prototype.html) 16:57:21 INFO - PID 1917 | RSS: Main: 337059840 16:57:21 INFO - PID 1917 | 17:00:25 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:64821/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64821/tests/dromaeo/cssquery-yui.html) 17:00:25 INFO - PID 1917 | RSS: Main: 343445504 17:00:25 INFO - PID 1917 | 17:03:29 INFO - PID 1917 | Cycle 1(1): loaded http://localhost:64821/tests/dromaeo/cssquery-yui.html (next: http://localhost:64821/tests/dromaeo/cssquery-dojo.html) 17:03:30 INFO - PID 1917 | RSS: Main: 423178240 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | __start_tp_report 17:03:30 INFO - PID 1917 | _x_x_mozilla_page_load 17:03:30 INFO - PID 1917 | _x_x_mozilla_page_load_details 17:03:30 INFO - PID 1917 | |i|pagename|runs| 17:03:30 INFO - PID 1917 | |0;dojo.html;3471.6354782747826;3482.2513159670666;3490.2670439207764;3506.5441492605955;3539.4867744177095;6103.115048317991;6165.044418115188;6273.37266273373;6274.27845797734;6274.811755647333;6107.34053441714;6172.074188871671;6202.317745048041;6247.531435142359;6249.812505624827;5132.800231704615;5448.291722076145;5597.580181486384;5602.579806514507;5618.690971996539;5672.262605861232;5692.8861422771515;5729;5742.196092547026;5785.971070144644;5488.780448782044;5581;5585.190147428641;5587.1339942309005;5588.245586845765;5573.303337082864;5591.7483713233005;5601.075822489325;5604.439556044363;5614.438556144394;5447.891042179174;5568.638038527482;5569.248151499536;5571.247881535981;5573.442655734394;6139.8601398601395;6142.385761423867;6164.938350616526;6208.286047104551;6233.283172435137;6613.768518101843;6617.04052912325;6618.238902526223;6620.668966551653;6628.237752658458;5288.286081379003;6640.966795165993;6705.966470167667;6707.865842683168;6709.027191057318;6137.402292535542;6195.380461953859;6208.4722798561725;6322.9051564226575;6333.1450254216015;6742.5280230383405;6797.830054248683;6816.182058153054;6817.625030623264;6831.419329356961;6365.49076073913;6428.4214420702365;6432.388923052303;6434.7104380303;6552.672366381662;5559.555235581144;6645.734170633121;6688.531802773857;6693.799186024427;6710;6587.83530411734;6599.571027883172;6602.405783479414;6602.7689030883685;6607.735690572324;6392.105105285264;6392.808215753535;6463.256725476536;6561.2782593914635;6577.21073471177;5315.920261196085;5364.114921037985;5372;5389.003034438641;5412.052890744183;4753.524647535219;4754.7147171169145;4770;4775.880602984953;4811.639127065484;6131.896637733196;6169.352218017133;6216.347283535254;6295.622262664255;6301.275353334334;6470.676466176672;6490.253620833664;6505.154329937078;6515.967420162963;6528.608283503005;6179.876402471926;6245.469135123474;6291.1192433059405;6301.558890877686;6303.401176888188;5948.494377977834;5953.672548009815;5959.493443057302;5968.582199246011;5990.460858522754;6285.68000719854;6538.542302038812;6892.793216203622;6954.09596752429;6966.895496567454;6512.251091124392;6587.670616469253;6596.274409815012;6605.933940660532;6746.987951807072;6888;6905.585664860125;6918.757843475454;6922.723091076502;6934.341237582422;6595.142631457879;6608.207015158212;6613.867722645617;6622.4702023838945;6622.70197841108;6445.484361251182;6500.772472963424;6668.099806526056;6688.665566721742;6709.630970296681;5565.721713914207;6325.652089135142;6345.619262844244;6418.326075761977;6469.353064693493;6432.324605916311;6436.645984470899;6443.516736244706;6445.065465507569;6445.613263204223;6266.248050234001;6294;6375.458086062551;6377.681115944091;6382.042693595998;6392.296847346881;6405.679716014088;6454.903176452263;6520.250171230369;6530.967345163243;6343.143675603735;6357.491400688026;6360.268569114611;6365;6370.713317900613 17:03:30 INFO - PID 1917 | |1;ext.html;776.8407476467324;810.7648781853263;1127.379941032432;1143.6626195272404;1148.9827652585207;36954.630453695456;37476.81261593691;37481.43777843335;37556;37637;39359;39581.40627890584;39678.00804979877;39681.8095457136;39685;6128.846778830521;8588.098249683788;8746.300295976307;8752.8687069694;8757.25563327118;6246.843828904268;8470.957645211765;8654.65381384747;8673.176048275436;8676.52279124648;8708.695195668153;8749.912500874974;8763.255123314526;8763.649454021832;8795;8628;8653.653853845839;8703.390762646586;8725.040245573045;8733;8421.536815475147;8578.313734901192;8630.223279904838;8639.52482613456;8641.567921603895;37113;37216.62783372186;37231.441528376825;37308;37356.81321593375;2925.765938724897;2989.7907146499756;3006.3686625808605;3008.0975707287726;3062.7549796016265;26685.111292006062;26970.056048038223;27118.864405677847;27531;28020;2772.9584056239173;2791.4417116576765;2811.4658214939095;2878.42431513696;2930.912072637824;302940;303121;303473;303591;304336;39401.80299098486;40003.79998099991;47331.290030649565;47620.28569571459;47765;52357.2146417804;53086.73456632692;53193.46806531963;53245.46754532483;53303.46696532985;14016.369263383172;14214.933879959044;14238.786418203736;14240.359183836752;14263.001589888609;11505.424728763528;11520.366379849022;11523.942380288045;11526.538938442536;11564.826527602092;11611.129165312635;11798.174127811142;13442.663933401547;13700.87636416357;13707.657308567366;4935.950640493621;5793.333766616893;5858.179854820329;5916.645001299936;5930.436608522184;855.50808285235;929.5491686532026;959.3764053365369;962.4177372689562;1003.3578509753763;19928.90035549842;22683;24121.879390602935;24130.276091717278;24160.91275892554;891.6923661336829;999.3204620857741;1063.5905176507101;1080.0657431322006;1088.2056099047738;11492.770144597229;12163.939180304218;12318.75362492745;12386.31875246852;12413.93793031047;481617;485678;485931;486280;487477;55042.449575504535;55180.89638207293;55583.99999999919;55624;55729.60675983133;1458.0959804920806;1498.7826765119214;1511.5389806109022;1517.0973270904014;1526.1682383101015;23474;23635.88182059079;23704.288871333887;23805.642915355937;23823.880880595487;38244;38363.616363836;38433;38497;38635;388609.5377124052;388947;389159;389745;389880;26462.338441539116;31759.682403175673;32507.674923250466;32678.183045424055;32679.509807353385;31970.88101916422;39846.800765995984;40836.183276333715;42099.57900420957;42142.57857421387;27119.72880271251;28778;29066.12801615955;29360.41279174362;29801.701982979892;28287.868485261184;28576;28639.856800715865;29387.11838644844;29835.254118647208;33562;34461.65538344685;34844;34899.825500872335;35391.33738601812;29001.419971600873;29461.85269073641;30020.699793002663;30167;30187.396252074395;23204.651930221396;23444.296671099895;23521.882390587936;23573.764262357843;23620.8818955911 17:03:30 INFO - PID 1917 | |2;jquery.html;413.1221155045528;415.86276528745515;424.5139315483771;430.19124046792035;441.32477309716126;21141.260055898027;21325.57348853022;22006.779932200672;22342.882855857224;22658.09367625293;21874.48443429006;22276.777232227672;22502.88748556259;22609.095636174534;22811.31566053017;6099.817005489843;6346.4288214060725;6360.872782544347;6364.077208804743;6372.490200783949;5918;6175.969120154393;6242.719077641495;6246.094316324153;6259.687015649222;6033.155358249848;6220.564560480768;6221.626702397871;6221.657808820513;6249.218847644044;5966.582339236255;6357.809265722036;6366.713497892606;6367.076773867763;6374.266959299694;5527.170924361378;5547.11246200606;5622.212890195335;5625.38120806711;5655.095184770458;26582.73417265822;28017.299567510974;28276.43447131046;28364.007259746017;28654;1723.388197189992;1962.107241205248;1967.6261510313138;1985.622731680976;2051.7230173926478;13237.536686215935;15022.924885375503;16252.349906003745;16587.751183732253;16774.49676509707;1602.3190144188673;1617.6602913388203;1641.0891954964989;1644.843739844713;1681.5964168599571;142068.28965855105;150278;152383.9999999989;153599;155421;11911.821322680167;12075.154739168174;12122.333271670142;12237.877621223852;12377.62867113988;11873.465694043789;16262.024278543326;16313.184340782913;16349.673006539802;16451.6709665806;8540.487570745776;8812.651192546919;8835.690750823818;8957.955210223907;8958.507282099547;7370.710125727976;8011.799705007422;8315.168483151636;8341.41610087288;8481.491110533389;6234.625922444668;7451.813704657318;7562.205968373351;7591.924080759121;7600.2779735925;2070.86700698281;2084.8749075055543;2086.4366621012546;2091.4144039668918;2234.9106035758386;784.4038530716582;898.4878619187001;915.1397686174975;954.3128947158035;958.5303201431249;19770.703439448418;20666.380008599765;20679.379618611467;20696.793032069487;20821.37535873926;935.4714586258742;939.6335429182624;978.6574698855344;980.1717548671361;987.5605355616825;10350.275480716278;10674.679759607225;10744.194185436123;10746.73133171677;10805;716821;718540;725152;752189;756602;103363.4831825836;108672;145522;154911;157723;977.7653363192783;1127.053275248795;1161.5005547614608;1164.3479651395246;1166.3526742657907;18036.188371523574;20077.899610501852;21625.13499460004;21871.343859684235;21982.560348792616;59820.70089649698;61512.46218844565;61779.63066146571;63246.68376658087;63485;76239.47521049659;81353.59323203345;83037.58481207555;84373.57813210895;84625.57687211524;8210.794730131794;8299.709510167115;8443.66225350979;8741.475511469333;8788.472691638523;12523.93738031304;12774.42515086842;13700.862991369959;13708.86291137076;13821.032527722962;10035.197184225099;11438.656840294805;11534.423278836193;11843.913849721832;11970;10249.641262555775;10512.369257844553;10643.840342395026;10886.020258176803;11025.44872756343;9737.464439455898;11433.970942615204;11618.70953226176;12015.158938874194;12106.636800895987;6374.394432528902;8401.831963360577;8647.351448641251;8698.826023479369;8819.897512810898;9894.208463322773;11099.39058836448;11281.43592820372;11767.646970590897;11955.342456164994 17:03:30 INFO - PID 1917 | |3;mootools.html;1223.614561413155;1414.9151050936944;1431.0412023943957;1436.2316160853943;1446.399744106196;10405.791884162312;10927.235093543455;10931.125509959204;10934.289271197367;10966.396848173357;10687.625933092344;10765.892341076587;11050.005499505043;11078.889211107886;11098.889011109886;2102.9474263143393;2454.8036157107476;2497.3506888209013;2499.3751562109474;2499.9750002500014;2314.143766806284;2466.9753302466925;2479.5164942836154;2489.80081593473;2492.028109037477;2063.814256716895;2147.795959383856;2160.4382860456317;2161.146347192858;2161.794629510194;2138.8075073243403;2168.1544197762887;2386.4153282445914;2480.268320845355;2488.9253322400177;2472.295395812185;2478.1574264749893;2479.776820086201;2479.987600062006;2480.8015358771254;10927.726806829893;11031.338119712844;11038.613648522343;11040.447977601169;11061.396097565808;5418.4039755626845;5625.54995600351;5641.266635337421;6191.2570491540855;6234.438900498932;3989.4414781930554;4057.0871553900433;4126.525449573308;4143.8135283912;4175.331946888514;1184.6209213051827;1184.8045072563016;1186.4423720851187;1196.8803119687961;1220.560598184653;15262.694746105126;15316;15378.231088445533;15392.30734616945;15414.537563873213;5130.281760553526;5335.759890804923;5393.649412788156;5393.83818485446;5455.018096742624;11396.373199474108;11400.087992960709;11402.828957565644;11406.42967851604;11410.087193024538;6055.515558755289;6305.464035556937;6312.43188113072;6322.557420980579;6323.336049714806;5662.688552129673;5816.82549523515;5905.173275741399;5909.881802363929;5913.76344946206;4036.475258216472;4175.185838761412;4176;4217.261979153697;4228.302330115496;1026;1236.9567065152855;1251.1367156661875;1261.6278197931633;1263.9761792947743;764.8776195808643;768.738628866177;785.4148659248896;790.4545863354382;801.2148094866947;5927.003227477446;5960.37416071315;6076.787312444043;6191.597546159485;6201.255849298022;547.8822053258568;566.4710638445654;572.2932178759229;583.5594126434514;586.9559783016291;3625.728070394731;3967.3652215645357;4020.19596080785;4085.22380747657;4169.437125987953;13443.46226150943;14140.787888181685;14170.645733856736;14179.361928713233;14185.858141418661;13571.86428135706;14030.719385612434;14045.157290562598;14052.71894562103;14054.227017514135;9987.201023918069;10295.845562316572;10296.22778291631;10303.793924121475;10309.74225644365;6074.3318234994995;6166.537509686702;6179.721912514037;6261.718222680081;6345.96827015862;12358.44387002569;12546.121771476273;12591.24452532851;12595.433205505591;12644.241345519298;12647.87352126467;13049;13111.27887966171;13129.277889715775;13131.474741010252;8521.573921304034;8751.64993400257;8862.778430539289;9022.639094436148;9271.76820579491;10001.799964000826;10141.949290253502;10238.897611023795;10253.128484078938;10260.897391025994;8543.572821358783;8662.263707584925;8678.78303042429;9024.142706442877;9067;8812.07473215303;8915.242204412698;8944.821103578022;8949.731508054769;8995.145461181177;6941.34057264559;7407.555546667218;7785.610719463891;7903.328217101611;7911.762647120596;3542.787432754043;5939.198208241832;6080.391960803884;6083.209182806207;6086.360932102242;5775.9133612996675;5918.224532640277;6052;6097;6213.844653883508 17:03:30 INFO - PID 1917 | |4;prototype.html;338.39934116942425;386.14661597868707;393.4098851722416;397.75736800551675;401.35382034923765;5128.256402821593;5689.345725241598;5973.522118230542;6070.332263451017;6087.239095113111;5689.459501347365;5817.650940943547;5864.442877926601;5960.0761881908375;5967.8209653710455;3799.335116354641;4672.205725026736;4685.25035994241;4702.999999999992;4717.1037502874515;3821.477824635741;4691.413573303337;4691.624670026406;4729.787159577827;4737.668363214576;3820.7516511426807;4536.5236650151755;4646.279826626878;4675.929861052087;4694.436667599875;4622.699524530894;4646.767661616906;4648.1865673507;4671.743054132038;4682.836100736475;3119.82840943748;4036.798160092013;4090.6727461802984;4121.887090485582;4136.420901073852;4265.957340426587;5049.762808111999;5203.4796520348045;5404;5914.733836977303;4735.147673418784;5097.5667068299235;5383;5384.91922621161;5387.542058924996;6369.6496692681885;6404.1674582304;6404.48764098871;6427.967860160716;6455.644939528324;4201.432806571135;4401.207782599131;4520.350072223648;4542.795574199169;4561.452625684906;5379.67721936685;5630.198336532352;6316.905246421307;6531.4448271896945;6613.00804879272;3806.3909774435956;4564.42944631921;4564.927242098104;4669.836555720602;4683.110209060268;4767.332573439721;4780.760961951889;4804.6876952997945;4809.9038019240115;4836.153673107263;4927.630427717864;5040.445550989388;5431.864203394868;5442.891142177214;5444.564434845203;5710.457506536873;6464.385883341075;6481;6508.9023664645065;6521.8695626088165;1385.3281158638054;1487.4050379848147;1556.9688606227812;1615.6930183265142;1668.516130322193;1049.6063976008998;1068.3322923173016;1134.3137401871913;1148.2192109365712;1157.5369852059243;6099.664518451439;6104.267487901391;6106.664133472613;6121.816345509642;6148.784792532329;6221.564490485623;6426.4216220540375;6645.60126392418;6664.83337916556;6773.254941956381;4976.328195693535;5313.920291195635;5720;6073.210482637317;6106.755729770759;2914.741075666333;3300.3069355435628;3486.267883744442;3487.337405892872;3513.314903593826;5705.087186050212;6082.543809214327;6246.312905580383;6308.653024083719;6529.151210342625;5623.437656234426;6057.757689692363;6310.274318453345;6841.521093523405;6848.9726541019245;5569.805056822992;6517.608943463408;6520.934790652128;6611.867762644816;6895.827604309932;6366.93633063682;6751.223609284995;6778.864422711419;6801.659917004031;6804.149481314836;5631.7703062333485;5665.20687103814;6278.6546739929745;6675.766348177791;6678.365555272241;6404.231492220963;6965.582065075909;6971.5468494547695;6985.812411890092;7008.264132266038;4202;4357.433533640607;4364.9127017460105;4389.758563279051;4434.312681534368;5600.4959553640365;6707.295733947865;6731.596104233761;6754.459643228628;6761.222459417033;6393.114031360667;6490.981693512539;6499.610023398611;6541.542092053701;6542.705578248895;6246.437820596168;6389.9680501597195;6412.895746722194;6529.33501957017;6556.967215163893;6382.936170638234;6386.042093685798;6389.2652344980925;6399.7440102395385;6409.551331406757;5979.701014949148;6244.937550624436;6444.355564443518;6523.18460192476;6534.183227096613;6295.401936815995;6325.272593651789;6340.556161068866;6350.682465876595;6359.551572644473 17:03:30 INFO - PID 1917 | |5;yui.html;712.252135257979;714.9392301654359;730.7077169132347;737.3437640499955;765.720512013115;14862.702745945075;15210.923945380258;15446.536603901874;15482.922585387072;15486.612834679125;13660;14241.928790356034;14372.209528475929;14459.132452052883;14508.27458627067;950.96196152154;979.2900147393119;982.5136557404095;985.6599473181741;986.1617625018713;965.7247684409945;990.326577927013;996.0238965813508;999.2605471950777;1016.9440680762555;1063.7978784031047;1065.7602039541118;1066.9733256668567;1067.8238090715022;1068.5832525315134;1057.9471026448723;1058.5077938758436;1058.925875188737;1059.1738444013681;1059.2214722179192;785.077533897668;785.305005070511;785.4933567848706;786.7875673568162;786.9095054068798;15397.692046159125;15812.367505299775;15865.286062127116;15887.52337429879;16252.674946501122;13338.666533336647;13550.59348219545;13679.179249245077;13935.303234838217;13976.93011534946;11254.099672026217;11402.600908968228;11486.597969071043;11545.307281563133;12116.333601651906;2952.217662319487;2958.097780177045;2992.2369795702175;3048.878044878202;3051.771117166199;107332.24384687825;111515;111723;112162;114623;10462.163026957978;10513.579456821795;10572.841407378895;10622.256442048982;10944.507497162647;23447.882760586428;23784.40538986539;23940.52118957611;23945.28164155078;23958.640620390706;7177;7242.855142897112;7279.12650481935;7289.744858929912;7441.725640718067;3850.730448868608;3928.3910993796007;3983.382575700771;3984.023914141054;3988;3906.7655940643654;3988.202359528106;4019.437278780973;4020.195960807792;4020.8190631421658;651.46905272203;768.3315515501549;789.5302295134386;800.9879851802227;814.5804910471112;520.4613225311784;547.1549429799151;552.6186931017666;570.8460754332347;588.0502987674874;9165.450072995642;9440.57517411718;9569.3779904306;9569.569369378394;9582.377145485661;536.4118130022579;555.8193587084214;584.9795257166064;588.1413136820205;610.2402508876477;4406.162829062468;4463.776811159494;4497.662675299365;4587.128445595326;4657.371254880615;101227;106974;107888.38167427495;108580;108703.36944945832;38693.61306386956;73190.63404682942;77078;91781.54109229545;93159.53420232855;71529.6423517879;72450.9132363015;73069;73594.63202683952;74642.62678686572;9917.553710083208;10078.8488172676;10612.310199836986;10695.518701658288;10716.73208169802;33628.32743345071;35441.64558354383;36209.81895090508;36940.26119477649;37399.62600373961;48918.77703057452;48935.372432170756;68053.65973170103;69167.65416172887;70357;13079.738405232032;13152.408141633457;13563.525276615272;13591.52429664957;13783.793243101562;11450.080229541747;14139.363728632443;14388.856111438752;14474.34865431037;14862.777058343918;13095.607131786062;13336.933315333361;13366.532171373956;13416.597502074954;14132.929335353258;13385.19688818635;13518.596630523627;13582.117162384413;13834.23911684867;14236.786448203493;13115.737685246433;13209.405576748877;13281.269530175932;13288.534901278408;13849.930750346184;9413.717588472357;9596.424214547149;9602.32783705134;9675.71025851214;10163.847542286723;9737.274302002073;11052.791307419491;11151.776964460827;11260.84255001864;11403.258788178742 17:03:30 INFO - PID 1917 | __end_tp_report 17:03:30 INFO - PID 1917 | __start_cc_report 17:03:30 INFO - PID 1917 | _x_x_mozilla_cycle_collect,2256 17:03:30 INFO - PID 1917 | __end_cc_report 17:03:30 INFO - PID 1917 | __startTimestamp1490832210148__endTimestamp 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | ------- Summary: start ------- 17:03:30 INFO - PID 1917 | Number of tests: 6 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | [#0] dojo.html Cycles:165 Average:6134.60 Median:6343.14 stddev:680.32 (10.7%) stddev-sans-first:649.54 17:03:30 INFO - PID 1917 | Values: 3471.6 3482.3 3490.3 3506.5 3539.5 6103.1 6165.0 6273.4 6274.3 6274.8 6107.3 6172.1 6202.3 6247.5 6249.8 5132.8 5448.3 5597.6 5602.6 5618.7 5672.3 5692.9 5729.0 5742.2 5786.0 5488.8 5581.0 5585.2 5587.1 5588.2 5573.3 5591.7 5601.1 5604.4 5614.4 5447.9 5568.6 5569.2 5571.2 5573.4 6139.9 6142.4 6164.9 6208.3 6233.3 6613.8 6617.0 6618.2 6620.7 6628.2 5288.3 6641.0 6706.0 6707.9 6709.0 6137.4 6195.4 6208.5 6322.9 6333.1 6742.5 6797.8 6816.2 6817.6 6831.4 6365.5 6428.4 6432.4 6434.7 6552.7 5559.6 6645.7 6688.5 6693.8 6710.0 6587.8 6599.6 6602.4 6602.8 6607.7 6392.1 6392.8 6463.3 6561.3 6577.2 5315.9 5364.1 5372.0 5389.0 5412.1 4753.5 4754.7 4770.0 4775.9 4811.6 6131.9 6169.4 6216.3 6295.6 6301.3 6470.7 6490.3 6505.2 6516.0 6528.6 6179.9 6245.5 6291.1 6301.6 6303.4 5948.5 5953.7 5959.5 5968.6 5990.5 6285.7 6538.5 6892.8 6954.1 6966.9 6512.3 6587.7 6596.3 6605.9 6747.0 6888.0 6905.6 6918.8 6922.7 6934.3 6595.1 6608.2 6613.9 6622.5 6622.7 6445.5 6500.8 6668.1 6688.7 6709.6 5565.7 6325.7 6345.6 6418.3 6469.4 6432.3 6436.6 6443.5 6445.1 6445.6 6266.2 6294.0 6375.5 6377.7 6382.0 6392.3 6405.7 6454.9 6520.3 6531.0 6343.1 6357.5 6360.3 6365.0 6370.7 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | [#1] ext.html Cycles:180 Average:52306.56 Median:34871.91 stddev:106259.00 (304.7%) stddev-sans-first:106486.65 17:03:30 INFO - PID 1917 | Values: 776.8 810.8 1127.4 1143.7 1149.0 36954.6 37476.8 37481.4 37556.0 37637.0 39359.0 39581.4 39678.0 39681.8 39685.0 6128.8 8588.1 8746.3 8752.9 8757.3 6246.8 8471.0 8654.7 8673.2 8676.5 8708.7 8749.9 8763.3 8763.6 8795.0 8628.0 8653.7 8703.4 8725.0 8733.0 8421.5 8578.3 8630.2 8639.5 8641.6 37113.0 37216.6 37231.4 37308.0 37356.8 2925.8 2989.8 3006.4 3008.1 3062.8 26685.1 26970.1 27118.9 27531.0 28020.0 2773.0 2791.4 2811.5 2878.4 2930.9 302940.0 303121.0 303473.0 303591.0 304336.0 39401.8 40003.8 47331.3 47620.3 47765.0 52357.2 53086.7 53193.5 53245.5 53303.5 14016.4 14214.9 14238.8 14240.4 14263.0 11505.4 11520.4 11523.9 11526.5 11564.8 11611.1 11798.2 13442.7 13700.9 13707.7 4936.0 5793.3 5858.2 5916.6 5930.4 855.5 929.5 959.4 962.4 1003.4 19928.9 22683.0 24121.9 24130.3 24160.9 891.7 999.3 1063.6 1080.1 1088.2 11492.8 12163.9 12318.8 12386.3 12413.9 481617.0 485678.0 485931.0 486280.0 487477.0 55042.4 55180.9 55584.0 55624.0 55729.6 1458.1 1498.8 1511.5 1517.1 1526.2 23474.0 23635.9 23704.3 23805.6 23823.9 38244.0 38363.6 38433.0 38497.0 38635.0 388609.5 388947.0 389159.0 389745.0 389880.0 26462.3 31759.7 32507.7 32678.2 32679.5 31970.9 39846.8 40836.2 42099.6 42142.6 27119.7 28778.0 29066.1 29360.4 29801.7 28287.9 28576.0 28639.9 29387.1 29835.3 33562.0 34461.7 34844.0 34899.8 35391.3 29001.4 29461.9 30020.7 30167.0 30187.4 23204.7 23444.3 23521.9 23573.8 23620.9 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | [#2] jquery.html Cycles:180 Average:40788.20 Median:22734.70 stddev:122286.28 (537.9%) stddev-sans-first:122591.75 17:03:30 INFO - PID 1917 | Values: 413.1 415.9 424.5 430.2 441.3 21141.3 21325.6 22006.8 22342.9 22658.1 21874.5 22276.8 22502.9 22609.1 22811.3 6099.8 6346.4 6360.9 6364.1 6372.5 5918.0 6176.0 6242.7 6246.1 6259.7 6033.2 6220.6 6221.6 6221.7 6249.2 5966.6 6357.8 6366.7 6367.1 6374.3 5527.2 5547.1 5622.2 5625.4 5655.1 26582.7 28017.3 28276.4 28364.0 28654.0 1723.4 1962.1 1967.6 1985.6 2051.7 13237.5 15022.9 16252.3 16587.8 16774.5 1602.3 1617.7 1641.1 1644.8 1681.6 142068.3 150278.0 152384.0 153599.0 155421.0 11911.8 12075.2 12122.3 12237.9 12377.6 11873.5 16262.0 16313.2 16349.7 16451.7 8540.5 8812.7 8835.7 8958.0 8958.5 7370.7 8011.8 8315.2 8341.4 8481.5 6234.6 7451.8 7562.2 7591.9 7600.3 2070.9 2084.9 2086.4 2091.4 2234.9 784.4 898.5 915.1 954.3 958.5 19770.7 20666.4 20679.4 20696.8 20821.4 935.5 939.6 978.7 980.2 987.6 10350.3 10674.7 10744.2 10746.7 10805.0 716821.0 718540.0 725152.0 752189.0 756602.0 103363.5 108672.0 145522.0 154911.0 157723.0 977.8 1127.1 1161.5 1164.3 1166.4 18036.2 20077.9 21625.1 21871.3 21982.6 59820.7 61512.5 61779.6 63246.7 63485.0 76239.5 81353.6 83037.6 84373.6 84625.6 8210.8 8299.7 8443.7 8741.5 8788.5 12523.9 12774.4 13700.9 13708.9 13821.0 10035.2 11438.7 11534.4 11843.9 11970.0 10249.6 10512.4 10643.8 10886.0 11025.4 9737.5 11434.0 11618.7 12015.2 12106.6 6374.4 8401.8 8647.4 8698.8 8819.9 9894.2 11099.4 11281.4 11767.6 11955.3 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | [#3] mootools.html Cycles:180 Average:6777.56 Median:2494.69 stddev:4274.49 (171.3%) stddev-sans-first:4266.11 17:03:30 INFO - PID 1917 | Values: 1223.6 1414.9 1431.0 1436.2 1446.4 10405.8 10927.2 10931.1 10934.3 10966.4 10687.6 10765.9 11050.0 11078.9 11098.9 2102.9 2454.8 2497.4 2499.4 2500.0 2314.1 2467.0 2479.5 2489.8 2492.0 2063.8 2147.8 2160.4 2161.1 2161.8 2138.8 2168.2 2386.4 2480.3 2488.9 2472.3 2478.2 2479.8 2480.0 2480.8 10927.7 11031.3 11038.6 11040.4 11061.4 5418.4 5625.5 5641.3 6191.3 6234.4 3989.4 4057.1 4126.5 4143.8 4175.3 1184.6 1184.8 1186.4 1196.9 1220.6 15262.7 15316.0 15378.2 15392.3 15414.5 5130.3 5335.8 5393.6 5393.8 5455.0 11396.4 11400.1 11402.8 11406.4 11410.1 6055.5 6305.5 6312.4 6322.6 6323.3 5662.7 5816.8 5905.2 5909.9 5913.8 4036.5 4175.2 4176.0 4217.3 4228.3 1026.0 1237.0 1251.1 1261.6 1264.0 764.9 768.7 785.4 790.5 801.2 5927.0 5960.4 6076.8 6191.6 6201.3 547.9 566.5 572.3 583.6 587.0 3625.7 3967.4 4020.2 4085.2 4169.4 13443.5 14140.8 14170.6 14179.4 14185.9 13571.9 14030.7 14045.2 14052.7 14054.2 9987.2 10295.8 10296.2 10303.8 10309.7 6074.3 6166.5 6179.7 6261.7 6346.0 12358.4 12546.1 12591.2 12595.4 12644.2 12647.9 13049.0 13111.3 13129.3 13131.5 8521.6 8751.6 8862.8 9022.6 9271.8 10001.8 10141.9 10238.9 10253.1 10260.9 8543.6 8662.3 8678.8 9024.1 9067.0 8812.1 8915.2 8944.8 8949.7 8995.1 6941.3 7407.6 7785.6 7903.3 7911.8 3542.8 5939.2 6080.4 6083.2 6086.4 5775.9 5918.2 6052.0 6097.0 6213.8 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | [#4] prototype.html Cycles:180 Average:5225.56 Median:5697.27 stddev:1593.52 (28.0%) stddev-sans-first:1555.20 17:03:30 INFO - PID 1917 | Values: 338.4 386.1 393.4 397.8 401.4 5128.3 5689.3 5973.5 6070.3 6087.2 5689.5 5817.7 5864.4 5960.1 5967.8 3799.3 4672.2 4685.3 4703.0 4717.1 3821.5 4691.4 4691.6 4729.8 4737.7 3820.8 4536.5 4646.3 4675.9 4694.4 4622.7 4646.8 4648.2 4671.7 4682.8 3119.8 4036.8 4090.7 4121.9 4136.4 4266.0 5049.8 5203.5 5404.0 5914.7 4735.1 5097.6 5383.0 5384.9 5387.5 6369.6 6404.2 6404.5 6428.0 6455.6 4201.4 4401.2 4520.4 4542.8 4561.5 5379.7 5630.2 6316.9 6531.4 6613.0 3806.4 4564.4 4564.9 4669.8 4683.1 4767.3 4780.8 4804.7 4809.9 4836.2 4927.6 5040.4 5431.9 5442.9 5444.6 5710.5 6464.4 6481.0 6508.9 6521.9 1385.3 1487.4 1557.0 1615.7 1668.5 1049.6 1068.3 1134.3 1148.2 1157.5 6099.7 6104.3 6106.7 6121.8 6148.8 6221.6 6426.4 6645.6 6664.8 6773.3 4976.3 5313.9 5720.0 6073.2 6106.8 2914.7 3300.3 3486.3 3487.3 3513.3 5705.1 6082.5 6246.3 6308.7 6529.2 5623.4 6057.8 6310.3 6841.5 6849.0 5569.8 6517.6 6520.9 6611.9 6895.8 6366.9 6751.2 6778.9 6801.7 6804.1 5631.8 5665.2 6278.7 6675.8 6678.4 6404.2 6965.6 6971.5 6985.8 7008.3 4202.0 4357.4 4364.9 4389.8 4434.3 5600.5 6707.3 6731.6 6754.5 6761.2 6393.1 6491.0 6499.6 6541.5 6542.7 6246.4 6390.0 6412.9 6529.3 6557.0 6382.9 6386.0 6389.3 6399.7 6409.6 5979.7 6244.9 6444.4 6523.2 6534.2 6295.4 6325.3 6340.6 6350.7 6359.6 17:03:30 INFO - PID 1917 | 17:03:30 INFO - PID 1917 | [#5] yui.html Cycles:180 Average:19629.02 Median:2955.16 stddev:28721.80 (971.9%) stddev-sans-first:28767.25 17:03:30 INFO - PID 1917 | Values: 712.3 714.9 730.7 737.3 765.7 14862.7 15210.9 15446.5 15482.9 15486.6 13660.0 14241.9 14372.2 14459.1 14508.3 951.0 979.3 982.5 985.7 986.2 965.7 990.3 996.0 999.3 1016.9 1063.8 1065.8 1067.0 1067.8 1068.6 1057.9 1058.5 1058.9 1059.2 1059.2 785.1 785.3 785.5 786.8 786.9 15397.7 15812.4 15865.3 15887.5 16252.7 13338.7 13550.6 13679.2 13935.3 13976.9 11254.1 11402.6 11486.6 11545.3 12116.3 2952.2 2958.1 2992.2 3048.9 3051.8 107332.2 111515.0 111723.0 112162.0 114623.0 10462.2 10513.6 10572.8 10622.3 10944.5 23447.9 23784.4 23940.5 23945.3 23958.6 7177.0 7242.9 7279.1 7289.7 7441.7 3850.7 3928.4 3983.4 3984.0 3988.0 3906.8 3988.2 4019.4 4020.2 4020.8 651.5 768.3 789.5 801.0 814.6 520.5 547.2 552.6 570.8 588.1 9165.5 9440.6 9569.4 9569.6 9582.4 536.4 555.8 585.0 588.1 610.2 4406.2 4463.8 4497.7 4587.1 4657.4 101227.0 106974.0 107888.4 108580.0 108703.4 38693.6 73190.6 77078.0 91781.5 93159.5 71529.6 72450.9 73069.0 73594.6 74642.6 9917.6 10078.8 10612.3 10695.5 10716.7 33628.3 35441.6 36209.8 36940.3 37399.6 48918.8 48935.4 68053.7 69167.7 70357.0 13079.7 13152.4 13563.5 13591.5 13783.8 11450.1 14139.4 14388.9 14474.3 14862.8 13095.6 13336.9 13366.5 13416.6 14132.9 13385.2 13518.6 13582.1 13834.2 14236.8 13115.7 13209.4 13281.3 13288.5 13849.9 9413.7 9596.4 9602.3 9675.7 10163.8 9737.3 11052.8 11151.8 11260.8 11403.3 17:03:30 INFO - PID 1917 | -------- Summary: end -------- 17:03:30 INFO - PID 1917 | 17:03:30 INFO - TEST-INFO | 1917: exit 0 17:03:30 INFO - TEST-OK | dromaeo_css | took 1122699ms 17:03:30 INFO - TEST-START | kraken 17:03:30 INFO - operating with platform_type : mac_ 17:03:30 INFO - Initialising browser for kraken test... 17:03:30 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpnw28sW/profile http://localhost:64821/getInfo.html) 17:03:33 INFO - PID 1919 | __metrics Screen width/height:1600/1200 17:03:33 INFO - PID 1919 | colorDepth:24 17:03:33 INFO - PID 1919 | Browser inner width/height: 1024/689 17:03:33 INFO - PID 1919 | __metrics 17:03:33 ERROR - PID 1919 | 1490832213424 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:03:33 INFO - PID 1919 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:03:33 INFO - PID 1919 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:03:34 INFO - TEST-INFO | 1919: exit 0 17:03:34 INFO - Browser initialized. 17:03:34 INFO - Running cycle 1/1 for kraken test... 17:03:34 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpnw28sW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:46 INFO - PID 1920 | RSS: Main: 234668032 17:03:46 INFO - PID 1920 | 17:03:49 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64821/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:50 INFO - PID 1920 | RSS: Main: 287256576 17:03:50 INFO - PID 1920 | 17:03:53 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64821/tests/kraken/driver.html?testName=audio-dft) 17:03:53 INFO - PID 1920 | RSS: Main: 289800192 17:03:53 INFO - PID 1920 | 17:03:57 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64821/tests/kraken/driver.html?testName=audio-fft) 17:03:57 INFO - PID 1920 | RSS: Main: 382525440 17:03:57 INFO - PID 1920 | 17:04:00 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64821/tests/kraken/driver.html?testName=audio-oscillator) 17:04:00 INFO - PID 1920 | RSS: Main: 284913664 17:04:00 INFO - PID 1920 | 17:04:02 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64821/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:03 INFO - PID 1920 | RSS: Main: 287207424 17:04:03 INFO - PID 1920 | 17:04:06 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64821/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:07 INFO - PID 1920 | RSS: Main: 329748480 17:04:07 INFO - PID 1920 | 17:04:10 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64821/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:11 INFO - PID 1920 | RSS: Main: 335183872 17:04:11 INFO - PID 1920 | 17:04:14 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64821/tests/kraken/driver.html?testName=json-parse-financial) 17:04:15 INFO - PID 1920 | RSS: Main: 336277504 17:04:15 INFO - PID 1920 | 17:04:17 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64821/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:17 INFO - PID 1920 | RSS: Main: 305786880 17:04:17 INFO - PID 1920 | 17:04:19 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:20 INFO - PID 1920 | RSS: Main: 310624256 17:04:20 INFO - PID 1920 | 17:04:22 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:04:23 INFO - PID 1920 | RSS: Main: 313131008 17:04:23 INFO - PID 1920 | 17:04:26 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:27 INFO - PID 1920 | RSS: Main: 327733248 17:04:27 INFO - PID 1920 | 17:04:30 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:31 INFO - PID 1920 | RSS: Main: 311345152 17:04:31 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | Cycle 1(1): loaded http://localhost:64821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64821/tests/kraken/driver.html?testName=ai-astar) 17:04:33 INFO - PID 1920 | RSS: Main: 378142720 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | __start_tp_report 17:04:33 INFO - PID 1920 | _x_x_mozilla_page_load 17:04:33 INFO - PID 1920 | _x_x_mozilla_page_load_details 17:04:33 INFO - PID 1920 | |i|pagename|runs| 17:04:33 INFO - PID 1920 | |0;ai-astar;122;122;124;124;123;124;124;122;124;123 17:04:33 INFO - PID 1920 | |1;audio-beat-detection;157;125;118;167;121;117;114;120;144;118 17:04:33 INFO - PID 1920 | |2;audio-dft;212;211;218;215;211;219;210;216;218;214 17:04:33 INFO - PID 1920 | |3;audio-fft;85;67;66;102;70;92;94;63;84;66 17:04:33 INFO - PID 1920 | |4;audio-oscillator;97;76;99;75;75;75;91;76;74;94 17:04:33 INFO - PID 1920 | |5;imaging-gaussian-blur;96;97;95;95;94;96;95;96;95;91 17:04:33 INFO - PID 1920 | |6;imaging-darkroom;125;150;101;100;100;100;100;101;106;143 17:04:33 INFO - PID 1920 | |7;imaging-desaturate;97;101;101;102;103;106;101;102;102;102 17:04:33 INFO - PID 1920 | |8;json-parse-financial;63;62;64;64;61;96;103;103;104;83 17:04:33 INFO - PID 1920 | |9;json-stringify-tinderbox;61;72;116;107;68;67;68;66;67;67 17:04:33 INFO - PID 1920 | |10;stanford-crypto-aes;90;89;88;83;91;90;89;92;89;90 17:04:33 INFO - PID 1920 | |11;stanford-crypto-ccm;155;189;156;170;143;168;171;155;188;165 17:04:33 INFO - PID 1920 | |12;stanford-crypto-pbkdf2;205;203;267;209;199;211;223;203;199;203 17:04:33 INFO - PID 1920 | |13;stanford-crypto-sha256-iterative;74;77;72;74;73;81;99;100;88;74 17:04:33 INFO - PID 1920 | __end_tp_report 17:04:33 INFO - PID 1920 | __start_cc_report 17:04:33 INFO - PID 1920 | _x_x_mozilla_cycle_collect,2215 17:04:33 INFO - PID 1920 | __end_cc_report 17:04:33 INFO - PID 1920 | __startTimestamp1490832273748__endTimestamp 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | ------- Summary: start ------- 17:04:33 INFO - PID 1920 | Number of tests: 14 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#0] ai-astar Cycles:10 Average:123.20 Median:124.00 stddev:0.92 (0.7%) stddev-sans-first:0.87 17:04:33 INFO - PID 1920 | Values: 122.0 122.0 124.0 124.0 123.0 124.0 124.0 122.0 124.0 123.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:123.00 stddev:18.89 (15.4%) stddev-sans-first:17.35 17:04:33 INFO - PID 1920 | Values: 157.0 125.0 118.0 167.0 121.0 117.0 114.0 120.0 144.0 118.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#2] audio-dft Cycles:10 Average:214.40 Median:215.50 stddev:3.31 (1.5%) stddev-sans-first:3.39 17:04:33 INFO - PID 1920 | Values: 212.0 211.0 218.0 215.0 211.0 219.0 210.0 216.0 218.0 214.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#3] audio-fft Cycles:10 Average:78.90 Median:77.00 stddev:14.15 (18.4%) stddev-sans-first:14.84 17:04:33 INFO - PID 1920 | Values: 85.0 67.0 66.0 102.0 70.0 92.0 94.0 63.0 84.0 66.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#4] audio-oscillator Cycles:10 Average:83.20 Median:83.50 stddev:10.58 (12.7%) stddev-sans-first:9.97 17:04:33 INFO - PID 1920 | Values: 97.0 76.0 99.0 75.0 75.0 75.0 91.0 76.0 74.0 94.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:95.50 stddev:1.63 (1.7%) stddev-sans-first:1.69 17:04:33 INFO - PID 1920 | Values: 96.0 97.0 95.0 95.0 94.0 96.0 95.0 96.0 95.0 91.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#6] imaging-darkroom Cycles:10 Average:112.60 Median:103.50 stddev:19.51 (18.8%) stddev-sans-first:20.17 17:04:33 INFO - PID 1920 | Values: 125.0 150.0 101.0 100.0 100.0 100.0 100.0 101.0 106.0 143.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:102.00 stddev:2.21 (2.2%) stddev-sans-first:1.56 17:04:33 INFO - PID 1920 | Values: 97.0 101.0 101.0 102.0 103.0 106.0 101.0 102.0 102.0 102.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#8] json-parse-financial Cycles:10 Average:80.30 Median:63.50 stddev:19.39 (30.5%) stddev-sans-first:19.53 17:04:33 INFO - PID 1920 | Values: 63.0 62.0 64.0 64.0 61.0 96.0 103.0 103.0 104.0 83.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:67.00 stddev:19.07 (28.5%) stddev-sans-first:19.45 17:04:33 INFO - PID 1920 | Values: 61.0 72.0 116.0 107.0 68.0 67.0 68.0 66.0 67.0 67.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:90.00 stddev:2.42 (2.7%) stddev-sans-first:2.55 17:04:33 INFO - PID 1920 | Values: 90.0 89.0 88.0 83.0 91.0 90.0 89.0 92.0 89.0 90.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#11] stanford-crypto-ccm Cycles:10 Average:166.00 Median:169.00 stddev:14.64 (8.7%) stddev-sans-first:14.98 17:04:33 INFO - PID 1920 | Values: 155.0 189.0 156.0 170.0 143.0 168.0 171.0 155.0 188.0 165.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:212.20 Median:207.00 stddev:20.51 (9.9%) stddev-sans-first:21.59 17:04:33 INFO - PID 1920 | Values: 205.0 203.0 267.0 209.0 199.0 211.0 223.0 203.0 199.0 203.0 17:04:33 INFO - PID 1920 | 17:04:33 INFO - PID 1920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.20 Median:75.50 stddev:10.76 (14.2%) stddev-sans-first:11.09 17:04:33 INFO - PID 1920 | Values: 74.0 77.0 72.0 74.0 73.0 81.0 99.0 100.0 88.0 74.0 17:04:33 INFO - PID 1920 | -------- Summary: end -------- 17:04:33 INFO - PID 1920 | 17:04:34 INFO - TEST-INFO | 1920: exit 0 17:04:34 INFO - TEST-OK | kraken | took 63877ms 17:04:34 INFO - SUITE-END | took 1186s 17:04:34 INFO - Completed test suite (00:19:46) 17:04:34 INFO - javascript benchmark 17:04:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7609.4599840582805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3471.6354782747826, 3482.2513159670666, 3490.2670439207764, 3506.5441492605955, 3539.4867744177095, 6103.115048317991, 6165.044418115188, 6273.37266273373, 6274.27845797734, 6274.811755647333, 6107.34053441714, 6172.074188871671, 6202.317745048041, 6247.531435142359, 6249.812505624827, 5132.800231704615, 5448.291722076145, 5597.580181486384, 5602.579806514507, 5618.690971996539, 5672.262605861232, 5692.8861422771515, 5729.0, 5742.196092547026, 5785.971070144644, 5488.780448782044, 5581.0, 5585.190147428641, 5587.1339942309005, 5588.245586845765, 5573.303337082864, 5591.7483713233005, 5601.075822489325, 5604.439556044363, 5614.438556144394, 5447.891042179174, 5568.638038527482, 5569.248151499536, 5571.247881535981, 5573.442655734394, 6139.8601398601395, 6142.385761423867, 6164.938350616526, 6208.286047104551, 6233.283172435137, 6613.768518101843, 6617.04052912325, 6618.238902526223, 6620.668966551653, 6628.237752658458, 5288.286081379003, 6640.966795165993, 6705.966470167667, 6707.865842683168, 6709.027191057318, 6137.402292535542, 6195.380461953859, 6208.4722798561725, 6322.9051564226575, 6333.1450254216015, 6742.5280230383405, 6797.830054248683, 6816.182058153054, 6817.625030623264, 6831.419329356961, 6365.49076073913, 6428.4214420702365, 6432.388923052303, 6434.7104380303, 6552.672366381662, 5559.555235581144, 6645.734170633121, 6688.531802773857, 6693.799186024427, 6710.0, 6587.83530411734, 6599.571027883172, 6602.405783479414, 6602.7689030883685, 6607.735690572324, 6392.105105285264, 6392.808215753535, 6463.256725476536, 6561.2782593914635, 6577.21073471177, 5315.920261196085, 5364.114921037985, 5372.0, 5389.003034438641, 5412.052890744183, 4753.524647535219, 4754.7147171169145, 4770.0, 4775.880602984953, 4811.639127065484, 6131.896637733196, 6169.352218017133, 6216.347283535254, 6295.622262664255, 6301.275353334334, 6470.676466176672, 6490.253620833664, 6505.154329937078, 6515.967420162963, 6528.608283503005, 6179.876402471926, 6245.469135123474, 6291.1192433059405, 6301.558890877686, 6303.401176888188, 5948.494377977834, 5953.672548009815, 5959.493443057302, 5968.582199246011, 5990.460858522754, 6285.68000719854, 6538.542302038812, 6892.793216203622, 6954.09596752429, 6966.895496567454, 6512.251091124392, 6587.670616469253, 6596.274409815012, 6605.933940660532, 6746.987951807072, 6888.0, 6905.585664860125, 6918.757843475454, 6922.723091076502, 6934.341237582422, 6595.142631457879, 6608.207015158212, 6613.867722645617, 6622.4702023838945, 6622.70197841108, 6445.484361251182, 6500.772472963424, 6668.099806526056, 6688.665566721742, 6709.630970296681, 5565.721713914207, 6325.652089135142, 6345.619262844244, 6418.326075761977, 6469.353064693493, 6432.324605916311, 6436.645984470899, 6443.516736244706, 6445.065465507569, 6445.613263204223, 6266.248050234001, 6294.0, 6375.458086062551, 6377.681115944091, 6382.042693595998, 6392.296847346881, 6405.679716014088, 6454.903176452263, 6520.250171230369, 6530.967345163243, 6343.143675603735, 6357.491400688026, 6360.268569114611, 6365.0, 6370.713317900613], "value": 6091.131178853191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.8407476467324, 810.7648781853263, 1127.379941032432, 1143.6626195272404, 1148.9827652585207, 36954.630453695456, 37476.81261593691, 37481.43777843335, 37556.0, 37637.0, 39359.0, 39581.40627890584, 39678.00804979877, 39681.8095457136, 39685.0, 6128.846778830521, 8588.098249683788, 8746.300295976307, 8752.8687069694, 8757.25563327118, 6246.843828904268, 8470.957645211765, 8654.65381384747, 8673.176048275436, 8676.52279124648, 8708.695195668153, 8749.912500874974, 8763.255123314526, 8763.649454021832, 8795.0, 8628.0, 8653.653853845839, 8703.390762646586, 8725.040245573045, 8733.0, 8421.536815475147, 8578.313734901192, 8630.223279904838, 8639.52482613456, 8641.567921603895, 37113.0, 37216.62783372186, 37231.441528376825, 37308.0, 37356.81321593375, 2925.765938724897, 2989.7907146499756, 3006.3686625808605, 3008.0975707287726, 3062.7549796016265, 26685.111292006062, 26970.056048038223, 27118.864405677847, 27531.0, 28020.0, 2772.9584056239173, 2791.4417116576765, 2811.4658214939095, 2878.42431513696, 2930.912072637824, 302940.0, 303121.0, 303473.0, 303591.0, 304336.0, 39401.80299098486, 40003.79998099991, 47331.290030649565, 47620.28569571459, 47765.0, 52357.2146417804, 53086.73456632692, 53193.46806531963, 53245.46754532483, 53303.46696532985, 14016.369263383172, 14214.933879959044, 14238.786418203736, 14240.359183836752, 14263.001589888609, 11505.424728763528, 11520.366379849022, 11523.942380288045, 11526.538938442536, 11564.826527602092, 11611.129165312635, 11798.174127811142, 13442.663933401547, 13700.87636416357, 13707.657308567366, 4935.950640493621, 5793.333766616893, 5858.179854820329, 5916.645001299936, 5930.436608522184, 855.50808285235, 929.5491686532026, 959.3764053365369, 962.4177372689562, 1003.3578509753763, 19928.90035549842, 22683.0, 24121.879390602935, 24130.276091717278, 24160.91275892554, 891.6923661336829, 999.3204620857741, 1063.5905176507101, 1080.0657431322006, 1088.2056099047738, 11492.770144597229, 12163.939180304218, 12318.75362492745, 12386.31875246852, 12413.93793031047, 481617.0, 485678.0, 485931.0, 486280.0, 487477.0, 55042.449575504535, 55180.89638207293, 55583.99999999919, 55624.0, 55729.60675983133, 1458.0959804920806, 1498.7826765119214, 1511.5389806109022, 1517.0973270904014, 1526.1682383101015, 23474.0, 23635.88182059079, 23704.288871333887, 23805.642915355937, 23823.880880595487, 38244.0, 38363.616363836, 38433.0, 38497.0, 38635.0, 388609.5377124052, 388947.0, 389159.0, 389745.0, 389880.0, 26462.338441539116, 31759.682403175673, 32507.674923250466, 32678.183045424055, 32679.509807353385, 31970.88101916422, 39846.800765995984, 40836.183276333715, 42099.57900420957, 42142.57857421387, 27119.72880271251, 28778.0, 29066.12801615955, 29360.41279174362, 29801.701982979892, 28287.868485261184, 28576.0, 28639.856800715865, 29387.11838644844, 29835.254118647208, 33562.0, 34461.65538344685, 34844.0, 34899.825500872335, 35391.33738601812, 29001.419971600873, 29461.85269073641, 30020.699793002663, 30167.0, 30187.396252074395, 23204.651930221396, 23444.296671099895, 23521.882390587936, 23573.764262357843, 23620.8818955911], "value": 17403.684114004725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.1221155045528, 415.86276528745515, 424.5139315483771, 430.19124046792035, 441.32477309716126, 21141.260055898027, 21325.57348853022, 22006.779932200672, 22342.882855857224, 22658.09367625293, 21874.48443429006, 22276.777232227672, 22502.88748556259, 22609.095636174534, 22811.31566053017, 6099.817005489843, 6346.4288214060725, 6360.872782544347, 6364.077208804743, 6372.490200783949, 5918.0, 6175.969120154393, 6242.719077641495, 6246.094316324153, 6259.687015649222, 6033.155358249848, 6220.564560480768, 6221.626702397871, 6221.657808820513, 6249.218847644044, 5966.582339236255, 6357.809265722036, 6366.713497892606, 6367.076773867763, 6374.266959299694, 5527.170924361378, 5547.11246200606, 5622.212890195335, 5625.38120806711, 5655.095184770458, 26582.73417265822, 28017.299567510974, 28276.43447131046, 28364.007259746017, 28654.0, 1723.388197189992, 1962.107241205248, 1967.6261510313138, 1985.622731680976, 2051.7230173926478, 13237.536686215935, 15022.924885375503, 16252.349906003745, 16587.751183732253, 16774.49676509707, 1602.3190144188673, 1617.6602913388203, 1641.0891954964989, 1644.843739844713, 1681.5964168599571, 142068.28965855105, 150278.0, 152383.9999999989, 153599.0, 155421.0, 11911.821322680167, 12075.154739168174, 12122.333271670142, 12237.877621223852, 12377.62867113988, 11873.465694043789, 16262.024278543326, 16313.184340782913, 16349.673006539802, 16451.6709665806, 8540.487570745776, 8812.651192546919, 8835.690750823818, 8957.955210223907, 8958.507282099547, 7370.710125727976, 8011.799705007422, 8315.168483151636, 8341.41610087288, 8481.491110533389, 6234.625922444668, 7451.813704657318, 7562.205968373351, 7591.924080759121, 7600.2779735925, 2070.86700698281, 2084.8749075055543, 2086.4366621012546, 2091.4144039668918, 2234.9106035758386, 784.4038530716582, 898.4878619187001, 915.1397686174975, 954.3128947158035, 958.5303201431249, 19770.703439448418, 20666.380008599765, 20679.379618611467, 20696.793032069487, 20821.37535873926, 935.4714586258742, 939.6335429182624, 978.6574698855344, 980.1717548671361, 987.5605355616825, 10350.275480716278, 10674.679759607225, 10744.194185436123, 10746.73133171677, 10805.0, 716821.0, 718540.0, 725152.0, 752189.0, 756602.0, 103363.4831825836, 108672.0, 145522.0, 154911.0, 157723.0, 977.7653363192783, 1127.053275248795, 1161.5005547614608, 1164.3479651395246, 1166.3526742657907, 18036.188371523574, 20077.899610501852, 21625.13499460004, 21871.343859684235, 21982.560348792616, 59820.70089649698, 61512.46218844565, 61779.63066146571, 63246.68376658087, 63485.0, 76239.47521049659, 81353.59323203345, 83037.58481207555, 84373.57813210895, 84625.57687211524, 8210.794730131794, 8299.709510167115, 8443.66225350979, 8741.475511469333, 8788.472691638523, 12523.93738031304, 12774.42515086842, 13700.862991369959, 13708.86291137076, 13821.032527722962, 10035.197184225099, 11438.656840294805, 11534.423278836193, 11843.913849721832, 11970.0, 10249.641262555775, 10512.369257844553, 10643.840342395026, 10886.020258176803, 11025.44872756343, 9737.464439455898, 11433.970942615204, 11618.70953226176, 12015.158938874194, 12106.636800895987, 6374.394432528902, 8401.831963360577, 8647.351448641251, 8698.826023479369, 8819.897512810898, 9894.208463322773, 11099.39058836448, 11281.43592820372, 11767.646970590897, 11955.342456164994], "value": 10248.025501924658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.614561413155, 1414.9151050936944, 1431.0412023943957, 1436.2316160853943, 1446.399744106196, 10405.791884162312, 10927.235093543455, 10931.125509959204, 10934.289271197367, 10966.396848173357, 10687.625933092344, 10765.892341076587, 11050.005499505043, 11078.889211107886, 11098.889011109886, 2102.9474263143393, 2454.8036157107476, 2497.3506888209013, 2499.3751562109474, 2499.9750002500014, 2314.143766806284, 2466.9753302466925, 2479.5164942836154, 2489.80081593473, 2492.028109037477, 2063.814256716895, 2147.795959383856, 2160.4382860456317, 2161.146347192858, 2161.794629510194, 2138.8075073243403, 2168.1544197762887, 2386.4153282445914, 2480.268320845355, 2488.9253322400177, 2472.295395812185, 2478.1574264749893, 2479.776820086201, 2479.987600062006, 2480.8015358771254, 10927.726806829893, 11031.338119712844, 11038.613648522343, 11040.447977601169, 11061.396097565808, 5418.4039755626845, 5625.54995600351, 5641.266635337421, 6191.2570491540855, 6234.438900498932, 3989.4414781930554, 4057.0871553900433, 4126.525449573308, 4143.8135283912, 4175.331946888514, 1184.6209213051827, 1184.8045072563016, 1186.4423720851187, 1196.8803119687961, 1220.560598184653, 15262.694746105126, 15316.0, 15378.231088445533, 15392.30734616945, 15414.537563873213, 5130.281760553526, 5335.759890804923, 5393.649412788156, 5393.83818485446, 5455.018096742624, 11396.373199474108, 11400.087992960709, 11402.828957565644, 11406.42967851604, 11410.087193024538, 6055.515558755289, 6305.464035556937, 6312.43188113072, 6322.557420980579, 6323.336049714806, 5662.688552129673, 5816.82549523515, 5905.173275741399, 5909.881802363929, 5913.76344946206, 4036.475258216472, 4175.185838761412, 4176.0, 4217.261979153697, 4228.302330115496, 1026.0, 1236.9567065152855, 1251.1367156661875, 1261.6278197931633, 1263.9761792947743, 764.8776195808643, 768.738628866177, 785.4148659248896, 790.4545863354382, 801.2148094866947, 5927.003227477446, 5960.37416071315, 6076.787312444043, 6191.597546159485, 6201.255849298022, 547.8822053258568, 566.4710638445654, 572.2932178759229, 583.5594126434514, 586.9559783016291, 3625.728070394731, 3967.3652215645357, 4020.19596080785, 4085.22380747657, 4169.437125987953, 13443.46226150943, 14140.787888181685, 14170.645733856736, 14179.361928713233, 14185.858141418661, 13571.86428135706, 14030.719385612434, 14045.157290562598, 14052.71894562103, 14054.227017514135, 9987.201023918069, 10295.845562316572, 10296.22778291631, 10303.793924121475, 10309.74225644365, 6074.3318234994995, 6166.537509686702, 6179.721912514037, 6261.718222680081, 6345.96827015862, 12358.44387002569, 12546.121771476273, 12591.24452532851, 12595.433205505591, 12644.241345519298, 12647.87352126467, 13049.0, 13111.27887966171, 13129.277889715775, 13131.474741010252, 8521.573921304034, 8751.64993400257, 8862.778430539289, 9022.639094436148, 9271.76820579491, 10001.799964000826, 10141.949290253502, 10238.897611023795, 10253.128484078938, 10260.897391025994, 8543.572821358783, 8662.263707584925, 8678.78303042429, 9024.142706442877, 9067.0, 8812.07473215303, 8915.242204412698, 8944.821103578022, 8949.731508054769, 8995.145461181177, 6941.34057264559, 7407.555546667218, 7785.610719463891, 7903.328217101611, 7911.762647120596, 3542.787432754043, 5939.198208241832, 6080.391960803884, 6083.209182806207, 6086.360932102242, 5775.9133612996675, 5918.224532640277, 6052.0, 6097.0, 6213.844653883508], "value": 5079.499434483223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.39934116942425, 386.14661597868707, 393.4098851722416, 397.75736800551675, 401.35382034923765, 5128.256402821593, 5689.345725241598, 5973.522118230542, 6070.332263451017, 6087.239095113111, 5689.459501347365, 5817.650940943547, 5864.442877926601, 5960.0761881908375, 5967.8209653710455, 3799.335116354641, 4672.205725026736, 4685.25035994241, 4702.999999999992, 4717.1037502874515, 3821.477824635741, 4691.413573303337, 4691.624670026406, 4729.787159577827, 4737.668363214576, 3820.7516511426807, 4536.5236650151755, 4646.279826626878, 4675.929861052087, 4694.436667599875, 4622.699524530894, 4646.767661616906, 4648.1865673507, 4671.743054132038, 4682.836100736475, 3119.82840943748, 4036.798160092013, 4090.6727461802984, 4121.887090485582, 4136.420901073852, 4265.957340426587, 5049.762808111999, 5203.4796520348045, 5404.0, 5914.733836977303, 4735.147673418784, 5097.5667068299235, 5383.0, 5384.91922621161, 5387.542058924996, 6369.6496692681885, 6404.1674582304, 6404.48764098871, 6427.967860160716, 6455.644939528324, 4201.432806571135, 4401.207782599131, 4520.350072223648, 4542.795574199169, 4561.452625684906, 5379.67721936685, 5630.198336532352, 6316.905246421307, 6531.4448271896945, 6613.00804879272, 3806.3909774435956, 4564.42944631921, 4564.927242098104, 4669.836555720602, 4683.110209060268, 4767.332573439721, 4780.760961951889, 4804.6876952997945, 4809.9038019240115, 4836.153673107263, 4927.630427717864, 5040.445550989388, 5431.864203394868, 5442.891142177214, 5444.564434845203, 5710.457506536873, 6464.385883341075, 6481.0, 6508.9023664645065, 6521.8695626088165, 1385.3281158638054, 1487.4050379848147, 1556.9688606227812, 1615.6930183265142, 1668.516130322193, 1049.6063976008998, 1068.3322923173016, 1134.3137401871913, 1148.2192109365712, 1157.5369852059243, 6099.664518451439, 6104.267487901391, 6106.664133472613, 6121.816345509642, 6148.784792532329, 6221.564490485623, 6426.4216220540375, 6645.60126392418, 6664.83337916556, 6773.254941956381, 4976.328195693535, 5313.920291195635, 5720.0, 6073.210482637317, 6106.755729770759, 2914.741075666333, 3300.3069355435628, 3486.267883744442, 3487.337405892872, 3513.314903593826, 5705.087186050212, 6082.543809214327, 6246.312905580383, 6308.653024083719, 6529.151210342625, 5623.437656234426, 6057.757689692363, 6310.274318453345, 6841.521093523405, 6848.9726541019245, 5569.805056822992, 6517.608943463408, 6520.934790652128, 6611.867762644816, 6895.827604309932, 6366.93633063682, 6751.223609284995, 6778.864422711419, 6801.659917004031, 6804.149481314836, 5631.7703062333485, 5665.20687103814, 6278.6546739929745, 6675.766348177791, 6678.365555272241, 6404.231492220963, 6965.582065075909, 6971.5468494547695, 6985.812411890092, 7008.264132266038, 4202.0, 4357.433533640607, 4364.9127017460105, 4389.758563279051, 4434.312681534368, 5600.4959553640365, 6707.295733947865, 6731.596104233761, 6754.459643228628, 6761.222459417033, 6393.114031360667, 6490.981693512539, 6499.610023398611, 6541.542092053701, 6542.705578248895, 6246.437820596168, 6389.9680501597195, 6412.895746722194, 6529.33501957017, 6556.967215163893, 6382.936170638234, 6386.042093685798, 6389.2652344980925, 6399.7440102395385, 6409.551331406757, 5979.701014949148, 6244.937550624436, 6444.355564443518, 6523.18460192476, 6534.183227096613, 6295.401936815995, 6325.272593651789, 6340.556161068866, 6350.682465876595, 6359.551572644473], "value": 4733.631841027297, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.252135257979, 714.9392301654359, 730.7077169132347, 737.3437640499955, 765.720512013115, 14862.702745945075, 15210.923945380258, 15446.536603901874, 15482.922585387072, 15486.612834679125, 13660.0, 14241.928790356034, 14372.209528475929, 14459.132452052883, 14508.27458627067, 950.96196152154, 979.2900147393119, 982.5136557404095, 985.6599473181741, 986.1617625018713, 965.7247684409945, 990.326577927013, 996.0238965813508, 999.2605471950777, 1016.9440680762555, 1063.7978784031047, 1065.7602039541118, 1066.9733256668567, 1067.8238090715022, 1068.5832525315134, 1057.9471026448723, 1058.5077938758436, 1058.925875188737, 1059.1738444013681, 1059.2214722179192, 785.077533897668, 785.305005070511, 785.4933567848706, 786.7875673568162, 786.9095054068798, 15397.692046159125, 15812.367505299775, 15865.286062127116, 15887.52337429879, 16252.674946501122, 13338.666533336647, 13550.59348219545, 13679.179249245077, 13935.303234838217, 13976.93011534946, 11254.099672026217, 11402.600908968228, 11486.597969071043, 11545.307281563133, 12116.333601651906, 2952.217662319487, 2958.097780177045, 2992.2369795702175, 3048.878044878202, 3051.771117166199, 107332.24384687825, 111515.0, 111723.0, 112162.0, 114623.0, 10462.163026957978, 10513.579456821795, 10572.841407378895, 10622.256442048982, 10944.507497162647, 23447.882760586428, 23784.40538986539, 23940.52118957611, 23945.28164155078, 23958.640620390706, 7177.0, 7242.855142897112, 7279.12650481935, 7289.744858929912, 7441.725640718067, 3850.730448868608, 3928.3910993796007, 3983.382575700771, 3984.023914141054, 3988.0, 3906.7655940643654, 3988.202359528106, 4019.437278780973, 4020.195960807792, 4020.8190631421658, 651.46905272203, 768.3315515501549, 789.5302295134386, 800.9879851802227, 814.5804910471112, 520.4613225311784, 547.1549429799151, 552.6186931017666, 570.8460754332347, 588.0502987674874, 9165.450072995642, 9440.57517411718, 9569.3779904306, 9569.569369378394, 9582.377145485661, 536.4118130022579, 555.8193587084214, 584.9795257166064, 588.1413136820205, 610.2402508876477, 4406.162829062468, 4463.776811159494, 4497.662675299365, 4587.128445595326, 4657.371254880615, 101227.0, 106974.0, 107888.38167427495, 108580.0, 108703.36944945832, 38693.61306386956, 73190.63404682942, 77078.0, 91781.54109229545, 93159.53420232855, 71529.6423517879, 72450.9132363015, 73069.0, 73594.63202683952, 74642.62678686572, 9917.553710083208, 10078.8488172676, 10612.310199836986, 10695.518701658288, 10716.73208169802, 33628.32743345071, 35441.64558354383, 36209.81895090508, 36940.26119477649, 37399.62600373961, 48918.77703057452, 48935.372432170756, 68053.65973170103, 69167.65416172887, 70357.0, 13079.738405232032, 13152.408141633457, 13563.525276615272, 13591.52429664957, 13783.793243101562, 11450.080229541747, 14139.363728632443, 14388.856111438752, 14474.34865431037, 14862.777058343918, 13095.607131786062, 13336.933315333361, 13366.532171373956, 13416.597502074954, 14132.929335353258, 13385.19688818635, 13518.596630523627, 13582.117162384413, 13834.23911684867, 14236.786448203493, 13115.737685246433, 13209.405576748877, 13281.269530175932, 13288.534901278408, 13849.930750346184, 9413.717588472357, 9596.424214547149, 9602.32783705134, 9675.71025851214, 10163.847542286723, 9737.274302002073, 11052.791307419491, 11151.776964460827, 11260.84255001864, 11403.258788178742], "value": 7431.84118295965, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1643.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 124.0, 124.0, 123.0, 124.0, 124.0, 122.0, 124.0, 123.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 118.0, 167.0, 121.0, 117.0, 114.0, 120.0, 144.0, 118.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 211.0, 218.0, 215.0, 211.0, 219.0, 210.0, 216.0, 218.0, 214.0], "value": 214.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 67.0, 66.0, 102.0, 70.0, 92.0, 94.0, 63.0, 84.0, 66.0], "value": 78.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 76.0, 99.0, 75.0, 75.0, 75.0, 91.0, 76.0, 74.0, 94.0], "value": 83.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0, 91.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 150.0, 101.0, 100.0, 100.0, 100.0, 100.0, 101.0, 106.0, 143.0], "value": 112.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 101.0, 101.0, 102.0, 103.0, 106.0, 101.0, 102.0, 102.0, 102.0], "value": 101.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 64.0, 61.0, 96.0, 103.0, 103.0, 104.0, 83.0], "value": 80.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 72.0, 116.0, 107.0, 68.0, 67.0, 68.0, 66.0, 67.0, 67.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 88.0, 83.0, 91.0, 90.0, 89.0, 92.0, 89.0, 90.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 189.0, 156.0, 170.0, 143.0, 168.0, 171.0, 155.0, 188.0, 165.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 203.0, 267.0, 209.0, 199.0, 211.0, 223.0, 203.0, 199.0, 203.0], "value": 212.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 72.0, 74.0, 73.0, 81.0, 99.0, 100.0, 88.0, 74.0], "value": 81.2, "unit": "score"}]}]} 17:04:35 INFO - Return code: 0 17:04:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:04:35 ERROR - # TBPL SUCCESS # 17:04:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:04:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:04:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:04:35 INFO - 2017-03-29 17:04:35.093 screenresolution[1924:62197] starting screenresolution argv=screenresolution get 17:04:35 INFO - 2017-03-29 17:04:35.097 screenresolution[1924:62197] Display 0: 1600x1200x32@60 17:04:35 INFO - 2017-03-29 17:04:35.102 screenresolution[1925:62200] starting screenresolution argv=screenresolution list 17:04:35 INFO - Available Modes on Display 0 17:04:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:04:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:04:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:04:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:04:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:04:35 INFO - Intel Iris: 17:04:35 INFO - Chipset Model: Intel Iris 17:04:35 INFO - Type: GPU 17:04:35 INFO - Bus: Built-In 17:04:35 INFO - VRAM (Dynamic, Max): 1536 MB 17:04:35 INFO - Vendor: Intel (0x8086) 17:04:35 INFO - Device ID: 0x0a2e 17:04:35 INFO - Revision ID: 0x0009 17:04:35 INFO - Displays: 17:04:35 INFO - Display: 17:04:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:04:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:04:35 INFO - Display Serial Number: 1600x1200 60 17:04:35 INFO - Main Display: Yes 17:04:35 INFO - Mirror: Off 17:04:35 INFO - Online: Yes 17:04:35 INFO - Rotation: Supported 17:04:35 INFO - Return code: 0 17:04:35 INFO - Running post-action listener: _resource_record_post_action 17:04:35 INFO - [mozharness: 2017-03-30 00:04:35.353822Z] Finished run-tests step (success) 17:04:35 INFO - Running post-run listener: _resource_record_post_run 17:04:35 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 49152; Write bytes: 512827904; Read time: 2; Write time: 1579 17:04:35 INFO - TinderboxPrint: CPU usage
53.4% 17:04:35 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 2 17:04:35 INFO - TinderboxPrint: I/O write bytes / time
512,827,904 / 1,579 17:04:35 INFO - TinderboxPrint: CPU idle
2,250.3 (46.6%) 17:04:35 INFO - TinderboxPrint: CPU system
967.3 (20.0%) 17:04:35 INFO - TinderboxPrint: CPU user
1,616.0 (33.4%) 17:04:35 INFO - TinderboxPrint: Swap in / out
211,062,784 / 0 17:04:35 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204890624; Write bytes: 204634112; Read time: 15561; Write time: 442 17:04:35 INFO - run-tests - Wall time: 1188s; CPU: 53.0%; Read bytes: 49152; Write bytes: 297363968; Read time: 2; Write time: 1097 17:04:35 INFO - Running post-run listener: _upload_blobber_files 17:04:35 INFO - Blob upload gear active. 17:04:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:35 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 17:04:35 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:04:35 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:04:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:04:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:37 INFO - (blobuploader) - INFO - Done attempting. 17:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:04:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:37 INFO - (blobuploader) - INFO - Done attempting. 17:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:04:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:38 INFO - (blobuploader) - INFO - Done attempting. 17:04:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:40 INFO - (blobuploader) - INFO - Done attempting. 17:04:40 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:40 INFO - Return code: 0 17:04:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c3cf481bc55cf9a15d99053062c2f0c8d274c60623a38d352693a32c791c0d17644f76a70d69dad83275d2dead5dae8936c26d72bb4671e797854e878e088b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/2c546195aee1b8e16afd706dd4fc15e1052a025abbd5a6846ab3300250bfe94832f372ccb9ddb7ced29282cd769bb911da58dba151cdf789b1d229c5e35eaaf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/27581b00a3980500d962b80b2c572a2410fdd5569300bf8246894f7b806b676cea198632fa62a1272e96aa581dd2ddc9eea9f226eb6a2be80772d0835dd5dbd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc372a6ded418f8d22bf1113bb8d1cdfb5cd7a3c4f847ef6911b92824857646d96c3f0865e8c6ada597c98406826f75c12197e943e4b27a1b0329d571e87caac"} 17:04:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:40 INFO - Contents: 17:04:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c3cf481bc55cf9a15d99053062c2f0c8d274c60623a38d352693a32c791c0d17644f76a70d69dad83275d2dead5dae8936c26d72bb4671e797854e878e088b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/2c546195aee1b8e16afd706dd4fc15e1052a025abbd5a6846ab3300250bfe94832f372ccb9ddb7ced29282cd769bb911da58dba151cdf789b1d229c5e35eaaf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/27581b00a3980500d962b80b2c572a2410fdd5569300bf8246894f7b806b676cea198632fa62a1272e96aa581dd2ddc9eea9f226eb6a2be80772d0835dd5dbd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc372a6ded418f8d22bf1113bb8d1cdfb5cd7a3c4f847ef6911b92824857646d96c3f0865e8c6ada597c98406826f75c12197e943e4b27a1b0329d571e87caac"} 17:04:40 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:41 INFO - Copying logs to upload dir... 17:04:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.445280 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-29 17:04:41.055531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 17:04:41.059371) ========= 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.TJIDe9k2De/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.zTsNOF4rmA/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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/Pine/sha512/c3cf481bc55cf9a15d99053062c2f0c8d274c60623a38d352693a32c791c0d17644f76a70d69dad83275d2dead5dae8936c26d72bb4671e797854e878e088b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/2c546195aee1b8e16afd706dd4fc15e1052a025abbd5a6846ab3300250bfe94832f372ccb9ddb7ced29282cd769bb911da58dba151cdf789b1d229c5e35eaaf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/27581b00a3980500d962b80b2c572a2410fdd5569300bf8246894f7b806b676cea198632fa62a1272e96aa581dd2ddc9eea9f226eb6a2be80772d0835dd5dbd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc372a6ded418f8d22bf1113bb8d1cdfb5cd7a3c4f847ef6911b92824857646d96c3f0865e8c6ada597c98406826f75c12197e943e4b27a1b0329d571e87caac"} build_url:https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/GvMkOw8CRTuMXxHvU7spnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c3cf481bc55cf9a15d99053062c2f0c8d274c60623a38d352693a32c791c0d17644f76a70d69dad83275d2dead5dae8936c26d72bb4671e797854e878e088b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/2c546195aee1b8e16afd706dd4fc15e1052a025abbd5a6846ab3300250bfe94832f372ccb9ddb7ced29282cd769bb911da58dba151cdf789b1d229c5e35eaaf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/27581b00a3980500d962b80b2c572a2410fdd5569300bf8246894f7b806b676cea198632fa62a1272e96aa581dd2ddc9eea9f226eb6a2be80772d0835dd5dbd7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/bc372a6ded418f8d22bf1113bb8d1cdfb5cd7a3c4f847ef6911b92824857646d96c3f0865e8c6ada597c98406826f75c12197e943e4b27a1b0329d571e87caac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 17:04:41.094890) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:04:41.095245) ========= 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.TJIDe9k2De/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.zTsNOF4rmA/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005235 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:04:41.143982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 17:04:41.144307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 17:04:41.144665) ========= ========= Total master_lag: 0.18 =========