builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0055 starttime: 1486868114.35 results: success (0) buildid: 20170211174340 builduid: a50694ebde08436997d111e53097a940 revision: 09ef6a4f41186ea6951830d1506f741005dcc46f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.353039) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.353511) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.353797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.379315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.379824) ========= 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.v9JBSvorp1/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.70ikqYV9k6/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-11 18:55:14-- 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% 153M=0s 2017-02-11 18:55:14 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.513317 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.916801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.917109) ========= 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.v9JBSvorp1/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.70ikqYV9k6/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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.019959 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:14.966229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-11 18:55:14.966605) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 09ef6a4f41186ea6951830d1506f741005dcc46f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 09ef6a4f41186ea6951830d1506f741005dcc46f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v9JBSvorp1/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.70ikqYV9k6/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-11 18:55:15,053 truncating revision to first 12 chars 2017-02-11 18:55:15,053 Setting DEBUG logging. 2017-02-11 18:55:15,053 attempt 1/10 2017-02-11 18:55:15,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/09ef6a4f4118?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-11 18:55:16,692 unpacking tar archive at: mozilla-central-09ef6a4f4118/testing/mozharness/ program finished with exit code 0 elapsedTime=1.906441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-11 18:55:16.896298) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:16.896599) ========= script_repo_revision: 09ef6a4f41186ea6951830d1506f741005dcc46f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:16.896974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:16.897235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-11 18:55:16.917125) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-02-11 18:55:16.917530) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v9JBSvorp1/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.70ikqYV9k6/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:55:17 INFO - MultiFileLogger online at 20170211 18:55:17 in /builds/slave/test 18:55:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:55:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:55:17 INFO - {'append_to_log': False, 18:55:17 INFO - 'base_work_dir': '/builds/slave/test', 18:55:17 INFO - 'blob_upload_branch': 'Firefox', 18:55:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:55:17 INFO - 'branch': 'Firefox', 18:55:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:55:17 INFO - 'config_files': ('talos/mac_config.py',), 18:55:17 INFO - 'default_actions': ('clobber', 18:55:17 INFO - 'read-buildbot-config', 18:55:17 INFO - 'download-and-extract', 18:55:17 INFO - 'populate-webroot', 18:55:17 INFO - 'create-virtualenv', 18:55:17 INFO - 'install', 18:55:17 INFO - 'run-tests'), 18:55:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:55:17 INFO - 'download_minidump_stackwalk': True, 18:55:17 INFO - 'download_symbols': 'ondemand', 18:55:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:55:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:55:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:55:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:55:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:55:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:55:17 INFO - 'installer_path': 'installer.exe', 18:55:17 INFO - 'log_level': 'info', 18:55:17 INFO - 'log_name': 'talos', 18:55:17 INFO - 'log_to_console': True, 18:55:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:55:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:55:17 INFO - 'opt_config_files': (), 18:55:17 INFO - 'pip_index': False, 18:55:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:55:17 INFO - 'cmd': ('bash', 18:55:17 INFO - '-c', 18:55:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:55:17 INFO - 'enabled': True, 18:55:17 INFO - 'halt_on_failure': False, 18:55:17 INFO - 'name': 'check_screen_resolution'},), 18:55:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:55:17 INFO - 'cmd': ('bash', 18:55:17 INFO - '-c', 18:55:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:55:17 INFO - 'enabled': True, 18:55:17 INFO - 'halt_on_failure': False, 18:55:17 INFO - 'name': 'check_screen_resolution'},), 18:55:17 INFO - 'run_cmd_checks_enabled': True, 18:55:17 INFO - 'sps_profile': False, 18:55:17 INFO - 'sps_profile_interval': 0, 18:55:17 INFO - 'suite': 'dromaeojs', 18:55:17 INFO - 'system_bits': '32', 18:55:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:55:17 INFO - 'title': 't-yosemite-r7-0055', 18:55:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:55:17 INFO - 'use_talos_json': True, 18:55:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:55:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:55:17 INFO - 'work_dir': 'build'} 18:55:17 INFO - [mozharness: 2017-02-12 02:55:17.124177Z] Running clobber step. 18:55:17 INFO - Running pre-action listener: _resource_record_pre_action 18:55:17 INFO - Running main action method: clobber 18:55:17 INFO - rmtree: /builds/slave/test/build 18:55:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:55:18 INFO - Running post-action listener: _resource_record_post_action 18:55:18 INFO - [mozharness: 2017-02-12 02:55:18.874050Z] Finished clobber step (success) 18:55:18 INFO - [mozharness: 2017-02-12 02:55:18.874224Z] Running read-buildbot-config step. 18:55:18 INFO - Running pre-action listener: _resource_record_pre_action 18:55:18 INFO - Running main action method: read_buildbot_config 18:55:18 INFO - Using buildbot properties: 18:55:18 INFO - { 18:55:18 INFO - "project": "", 18:55:18 INFO - "product": "firefox", 18:55:18 INFO - "script_repo_revision": "production", 18:55:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:55:18 INFO - "repository": "", 18:55:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:55:18 INFO - "buildid": "20170211174340", 18:55:18 INFO - "pgo_build": "False", 18:55:18 INFO - "basedir": "/builds/slave/test", 18:55:18 INFO - "buildnumber": 31, 18:55:18 INFO - "slavename": "t-yosemite-r7-0055", 18:55:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:55:18 INFO - "platform": "yosemite_r7", 18:55:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:55:18 INFO - "branch": "mozilla-central", 18:55:18 INFO - "repo_path": "mozilla-central", 18:55:18 INFO - "revision": "09ef6a4f41186ea6951830d1506f741005dcc46f", 18:55:18 INFO - "stage_platform": "macosx64", 18:55:18 INFO - "builduid": "a50694ebde08436997d111e53097a940", 18:55:18 INFO - "slavebuilddir": "test" 18:55:18 INFO - } 18:55:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 18:55:18 INFO - Running post-action listener: _resource_record_post_action 18:55:18 INFO - [mozharness: 2017-02-12 02:55:18.879736Z] Finished read-buildbot-config step (success) 18:55:18 INFO - [mozharness: 2017-02-12 02:55:18.879936Z] Running download-and-extract step. 18:55:18 INFO - Running pre-action listener: _resource_record_pre_action 18:55:18 INFO - Running main action method: download_and_extract 18:55:18 INFO - mkdir: /builds/slave/test/build/tests 18:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:55:18 INFO - trying https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 18:55:18 INFO - Downloading https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:55:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 18:55:19 INFO - Downloaded 1199 bytes. 18:55:19 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:55:19 INFO - Using the following test package requirements: 18:55:19 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:55:19 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 18:55:19 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 18:55:19 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'jsshell-mac.zip'], 18:55:19 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 18:55:19 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:55:19 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 18:55:19 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 18:55:19 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 18:55:19 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:55:19 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 18:55:19 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:55:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:55:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:55:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:55:21 INFO - Expected file size: 51502720 18:55:21 INFO - Obtained file size: 51502720 18:55:36 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:55:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:55:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:55:36 INFO - Fetch https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:55:38 INFO - Expected file size: 51502720 18:55:38 INFO - Obtained file size: 51502720 18:55:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 18:55:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:55:54 INFO - Fetch https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 18:55:54 INFO - Expected file size: 14403647 18:55:54 INFO - Obtained file size: 14403647 18:55:55 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')]} 18:55:55 INFO - trying https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:55:55 INFO - Downloading https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 18:55:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 18:55:57 INFO - Downloaded 70472462 bytes. 18:55:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:55:57 INFO - mkdir: /builds/slave/test/properties 18:55:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:55:57 INFO - Writing to file /builds/slave/test/properties/build_url 18:55:57 INFO - Contents: 18:55:57 INFO - build_url:https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:55:58 INFO - Running post-action listener: _resource_record_post_action 18:55:58 INFO - Running post-action listener: set_extra_try_arguments 18:55:58 INFO - [mozharness: 2017-02-12 02:55:58.386285Z] Finished download-and-extract step (success) 18:55:58 INFO - [mozharness: 2017-02-12 02:55:58.386433Z] Running populate-webroot step. 18:55:58 INFO - Running pre-action listener: _resource_record_pre_action 18:55:58 INFO - Running main action method: populate_webroot 18:55:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:55:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:55:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:55:58 INFO - '--tppagecycles', 18:55:58 INFO - '7'], 18:55:58 INFO - 'tests': ['tsvgm']}}, 18:55:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:55:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:55:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:55:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:55:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:55:58 INFO - 'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:55:58 INFO - 'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['damp', 'tps']}, 18:55:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:55:58 INFO - 'tests': ['damp', 'tps']}, 18:55:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['dromaeo_dom']}, 18:55:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:55:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['basic_compositor_video']}, 18:55:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:55:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['a11yr', 18:55:58 INFO - 'ts_paint', 18:55:58 INFO - 'tpaint', 18:55:58 INFO - 'sessionrestore', 18:55:58 INFO - 'sessionrestore_no_auto_restore', 18:55:58 INFO - 'tabpaint']}, 18:55:58 INFO - 'other-e10s': {'tests': ['a11yr', 18:55:58 INFO - 'ts_paint', 18:55:58 INFO - 'tpaint', 18:55:58 INFO - 'sessionrestore', 18:55:58 INFO - 'sessionrestore_no_auto_restore', 18:55:58 INFO - 'tabpaint']}, 18:55:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:55:58 INFO - 'ts_paint', 18:55:58 INFO - 'tpaint', 18:55:58 INFO - 'sessionrestore', 18:55:58 INFO - 'sessionrestore_no_auto_restore', 18:55:58 INFO - 'tabpaint']}, 18:55:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:55:58 INFO - 'ts_paint', 18:55:58 INFO - 'tpaint', 18:55:58 INFO - 'sessionrestore', 18:55:58 INFO - 'sessionrestore_no_auto_restore', 18:55:58 INFO - 'tabpaint']}, 18:55:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['a11yr', 18:55:58 INFO - 'ts_paint', 18:55:58 INFO - 'tpaint', 18:55:58 INFO - 'sessionrestore', 18:55:58 INFO - 'sessionrestore_no_auto_restore', 18:55:58 INFO - 'tabpaint']}, 18:55:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['a11yr', 18:55:58 INFO - 'ts_paint', 18:55:58 INFO - 'tpaint', 18:55:58 INFO - 'sessionrestore', 18:55:58 INFO - 'sessionrestore_no_auto_restore', 18:55:58 INFO - 'tabpaint']}, 18:55:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['tsvgx', 18:55:58 INFO - 'tsvgr_opacity', 18:55:58 INFO - 'tart', 18:55:58 INFO - 'tscrollx', 18:55:58 INFO - 'cart', 18:55:58 INFO - 'tsvg_static']}, 18:55:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:55:58 INFO - 'tsvgr_opacity', 18:55:58 INFO - 'tart', 18:55:58 INFO - 'tscrollx', 18:55:58 INFO - 'cart', 18:55:58 INFO - 'tsvg_static']}, 18:55:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:55:58 INFO - 'talos_options': ['--disable-e10s'], 18:55:58 INFO - 'tests': ['tp5o']}, 18:55:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:55:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:55:58 INFO - 'talos_options': ['--disable-e10s', 18:55:58 INFO - '--xperf_path', 18:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:58 INFO - 'tests': ['tp5n']}, 18:55:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:55:58 INFO - 'talos_options': ['--xperf_path', 18:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:58 INFO - 'tests': ['tp5n']}}, 18:55:58 INFO - 'talos.zip': {'path': '', 18:55:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:58 INFO - Running post-action listener: _resource_record_post_action 18:55:58 INFO - [mozharness: 2017-02-12 02:55:58.404494Z] Finished populate-webroot step (success) 18:55:58 INFO - [mozharness: 2017-02-12 02:55:58.404623Z] Running create-virtualenv step. 18:55:58 INFO - Running pre-action listener: _resource_record_pre_action 18:55:58 INFO - Running main action method: create_virtualenv 18:55:58 INFO - Creating virtualenv /builds/slave/test/build/venv 18:55:58 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 18:55:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:55:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:55:58 INFO - Using real prefix '/tools/python27' 18:55:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:55:59 INFO - Installing distribute.............................................................................................................................................................................................done. 18:56:02 INFO - Installing pip.................done. 18:56:02 INFO - Return code: 0 18:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:56:02 INFO - Reading from file tmpfile_stdout 18:56:02 INFO - Output received: 18:56:02 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) 18:56:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:56: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')]} 18:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56: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', 'pip>=1.5'] in /builds/slave/test/build 18:56: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 pip>=1.5 18:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:02 INFO - 'HOME': '/Users/cltbld', 18:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:02 INFO - 'LOGNAME': 'cltbld', 18:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:02 INFO - 'MOZ_NO_REMOTE': '1', 18:56:02 INFO - 'NO_EM_RESTART': '1', 18:56:02 INFO - 'PAGER': '/bin/cat', 18:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:02 INFO - 'PWD': '/builds/slave/test', 18:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:02 INFO - 'SHELL': '/bin/bash', 18:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:02 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:02 INFO - 'USER': 'cltbld', 18:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:02 INFO - 'XPC_FLAGS': '0x0', 18:56:02 INFO - 'XPC_SERVICE_NAME': '0', 18:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:02 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 18:56:02 INFO - Cleaning up... 18:56:02 INFO - Return code: 0 18:56:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:56: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')]} 18:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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', '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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:56: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 psutil>=3.1.1 18:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:02 INFO - 'HOME': '/Users/cltbld', 18:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:02 INFO - 'LOGNAME': 'cltbld', 18:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:02 INFO - 'MOZ_NO_REMOTE': '1', 18:56:02 INFO - 'NO_EM_RESTART': '1', 18:56:02 INFO - 'PAGER': '/bin/cat', 18:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:02 INFO - 'PWD': '/builds/slave/test', 18:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:02 INFO - 'SHELL': '/bin/bash', 18:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:02 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:02 INFO - 'USER': 'cltbld', 18:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:02 INFO - 'XPC_FLAGS': '0x0', 18:56:02 INFO - 'XPC_SERVICE_NAME': '0', 18:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:02 INFO - Downloading/unpacking psutil>=3.1.1 18:56:02 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 18:56:02 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 18:56:02 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 18:56:02 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 18:56:02 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 18:56:02 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 18:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:56:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:07 INFO - Installing collected packages: psutil 18:56:07 INFO - Running setup.py install for psutil 18:56:07 INFO - building 'psutil._psutil_osx' extension 18:56:07 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 18:56:07 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 18:56:07 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 18:56:07 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 18:56:07 INFO - building 'psutil._psutil_posix' extension 18:56:07 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 18:56:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:56:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:56:07 INFO - ^ 18:56:07 INFO - 1 warning generated. 18:56:07 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 18:56:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:07 INFO - Successfully installed psutil 18:56:07 INFO - Cleaning up... 18:56:07 INFO - Return code: 0 18:56:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:56:07 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')]} 18:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:07 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')]} 18:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:07 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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56:07 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 18:56:07 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 18:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:07 INFO - 'HOME': '/Users/cltbld', 18:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:07 INFO - 'LOGNAME': 'cltbld', 18:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:07 INFO - 'MOZ_NO_REMOTE': '1', 18:56:07 INFO - 'NO_EM_RESTART': '1', 18:56:07 INFO - 'PAGER': '/bin/cat', 18:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:07 INFO - 'PWD': '/builds/slave/test', 18:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:07 INFO - 'SHELL': '/bin/bash', 18:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:07 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:07 INFO - 'USER': 'cltbld', 18:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:07 INFO - 'XPC_FLAGS': '0x0', 18:56:07 INFO - 'XPC_SERVICE_NAME': '0', 18:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:56:08 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 18:56:08 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 18:56:08 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 18:56:08 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 18:56:08 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 18:56:08 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 18:56:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:56:10 INFO - Installing collected packages: mozsystemmonitor 18:56:10 INFO - Running setup.py install for mozsystemmonitor 18:56:11 INFO - Successfully installed mozsystemmonitor 18:56:11 INFO - Cleaning up... 18:56:11 INFO - Return code: 0 18:56:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:56: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')]} 18:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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', '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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:56: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 jsonschema==2.5.1 18:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:11 INFO - 'HOME': '/Users/cltbld', 18:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:11 INFO - 'LOGNAME': 'cltbld', 18:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:11 INFO - 'MOZ_NO_REMOTE': '1', 18:56:11 INFO - 'NO_EM_RESTART': '1', 18:56:11 INFO - 'PAGER': '/bin/cat', 18:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:11 INFO - 'PWD': '/builds/slave/test', 18:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:11 INFO - 'SHELL': '/bin/bash', 18:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:11 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:11 INFO - 'USER': 'cltbld', 18:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:11 INFO - 'XPC_FLAGS': '0x0', 18:56:11 INFO - 'XPC_SERVICE_NAME': '0', 18:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:11 INFO - Downloading/unpacking jsonschema==2.5.1 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:56:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56: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 18:56:14 INFO - Downloading functools32-3.2.3-2.tar.gz 18:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:56:14 INFO - warning: no files found matching '*.txt' 18:56:14 INFO - no previously-included directories found matching 'build' 18:56:14 INFO - no previously-included directories found matching 'dist' 18:56:14 INFO - no previously-included directories found matching '.git*' 18:56:14 INFO - Installing collected packages: jsonschema, functools32 18:56:14 INFO - Running setup.py install for functools32 18:56:14 INFO - warning: no files found matching '*.txt' 18:56:14 INFO - no previously-included directories found matching 'build' 18:56:14 INFO - no previously-included directories found matching 'dist' 18:56:14 INFO - no previously-included directories found matching '.git*' 18:56:14 INFO - Successfully installed jsonschema functools32 18:56:14 INFO - Cleaning up... 18:56:14 INFO - Return code: 0 18:56:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:14 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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56:14 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 18:56:14 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 18:56:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:14 INFO - 'HOME': '/Users/cltbld', 18:56:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:14 INFO - 'LOGNAME': 'cltbld', 18:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:14 INFO - 'MOZ_NO_REMOTE': '1', 18:56:14 INFO - 'NO_EM_RESTART': '1', 18:56:14 INFO - 'PAGER': '/bin/cat', 18:56:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:14 INFO - 'PWD': '/builds/slave/test', 18:56:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:14 INFO - 'SHELL': '/bin/bash', 18:56:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:14 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:14 INFO - 'USER': 'cltbld', 18:56:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:14 INFO - 'XPC_FLAGS': '0x0', 18:56:14 INFO - 'XPC_SERVICE_NAME': '0', 18:56:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:56:15 INFO - Cleaning up... 18:56:15 INFO - Return code: 0 18:56:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:56:15 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')]} 18:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:15 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')]} 18:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:15 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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56:15 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 18:56:15 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 18:56:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:15 INFO - 'HOME': '/Users/cltbld', 18:56:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:15 INFO - 'LOGNAME': 'cltbld', 18:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:15 INFO - 'MOZ_NO_REMOTE': '1', 18:56:15 INFO - 'NO_EM_RESTART': '1', 18:56:15 INFO - 'PAGER': '/bin/cat', 18:56:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:15 INFO - 'PWD': '/builds/slave/test', 18:56:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:15 INFO - 'SHELL': '/bin/bash', 18:56:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:15 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:15 INFO - 'USER': 'cltbld', 18:56:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:15 INFO - 'XPC_FLAGS': '0x0', 18:56:15 INFO - 'XPC_SERVICE_NAME': '0', 18:56:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:15 INFO - Downloading/unpacking blobuploader==1.2.4 18:56:15 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 18:56:15 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 18:56:15 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 18:56:15 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 18:56:15 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 18:56:15 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 18:56:17 INFO - Downloading blobuploader-1.2.4.tar.gz 18:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:56:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:56:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:19 INFO - Downloading docopt-0.6.1.tar.gz 18:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:56:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:56:19 INFO - Running setup.py install for blobuploader 18:56:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:56:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:56:19 INFO - Running setup.py install for requests 18:56:19 INFO - Running setup.py install for docopt 18:56:20 INFO - Successfully installed blobuploader requests docopt 18:56:20 INFO - Cleaning up... 18:56:20 INFO - Return code: 0 18:56:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56: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')]} 18:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56: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')]} 18:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:20 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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56:20 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 18:56:20 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 18:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:20 INFO - 'HOME': '/Users/cltbld', 18:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:20 INFO - 'LOGNAME': 'cltbld', 18:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:20 INFO - 'MOZ_NO_REMOTE': '1', 18:56:20 INFO - 'NO_EM_RESTART': '1', 18:56:20 INFO - 'PAGER': '/bin/cat', 18:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:20 INFO - 'PWD': '/builds/slave/test', 18:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:20 INFO - 'SHELL': '/bin/bash', 18:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:20 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:20 INFO - 'USER': 'cltbld', 18:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:20 INFO - 'XPC_FLAGS': '0x0', 18:56:20 INFO - 'XPC_SERVICE_NAME': '0', 18:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:56:20 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-eaTEa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:56:20 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-dSa7MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:56:20 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-x5WuV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:56:20 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-ABhcWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:56:20 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-7FRlzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:56:20 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-Fg57LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-R4Hx8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-LWXDWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-sX78lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-ZTtOKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-EZbTWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-J7P6Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-nyohFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-9yHnRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-IxiCj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:21 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-_Nzwau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:22 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-E64R8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:56:22 INFO - Running setup.py install for manifestparser 18:56:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:56:22 INFO - Running setup.py install for mozcrash 18:56:22 INFO - Running setup.py install for mozdebug 18:56:22 INFO - Running setup.py install for mozdevice 18:56:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:56:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:56:22 INFO - Running setup.py install for mozfile 18:56:22 INFO - Running setup.py install for mozhttpd 18:56:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Running setup.py install for mozinfo 18:56:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Running setup.py install for mozInstall 18:56:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Running setup.py install for mozleak 18:56:23 INFO - Running setup.py install for mozlog 18:56:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Running setup.py install for moznetwork 18:56:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:56:23 INFO - Running setup.py install for mozprocess 18:56:23 INFO - Running setup.py install for mozprofile 18:56:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:56:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:56:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:56:24 INFO - Running setup.py install for mozrunner 18:56:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:56:24 INFO - Running setup.py install for mozscreenshot 18:56:24 INFO - Running setup.py install for moztest 18:56:24 INFO - Running setup.py install for mozversion 18:56:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:56:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:56:24 INFO - Cleaning up... 18:56:24 INFO - Return code: 0 18:56:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:24 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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56:24 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 18:56:24 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 18:56:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:24 INFO - 'HOME': '/Users/cltbld', 18:56:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:24 INFO - 'LOGNAME': 'cltbld', 18:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:24 INFO - 'MOZ_NO_REMOTE': '1', 18:56:24 INFO - 'NO_EM_RESTART': '1', 18:56:24 INFO - 'PAGER': '/bin/cat', 18:56:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:24 INFO - 'PWD': '/builds/slave/test', 18:56:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:24 INFO - 'SHELL': '/bin/bash', 18:56:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:24 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:24 INFO - 'USER': 'cltbld', 18:56:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:24 INFO - 'XPC_FLAGS': '0x0', 18:56:24 INFO - 'XPC_SERVICE_NAME': '0', 18:56:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-hF9zE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-m_2CtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-EGyA5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-HP9aKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-alOtgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-kUTQZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-nxdIkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-IVCg4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-tnNjKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:56:25 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)) 18:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:56:25 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-I_d54o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:56:26 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)) 18:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:56:26 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-41frif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:26 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)) 18:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:26 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-jRVD3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:26 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-HB1ZlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:26 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)) 18:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:26 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-bjnCUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:26 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)) 18:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:26 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-Vrqe6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:26 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)) 18:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:26 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-FCOsyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:26 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)) 18:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:26 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-G76miW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:26 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)) 18:56:26 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)) 18:56:26 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)) 18:56:26 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)) 18:56:26 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)) 18:56:26 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)) 18:56:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:56:26 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 18:56:26 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 18:56:26 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 18:56:26 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 18:56:26 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 18:56:26 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 18:56:29 INFO - Downloading blessings-1.6.tar.gz 18:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:56:29 INFO - Installing collected packages: blessings 18:56:29 INFO - Running setup.py install for blessings 18:56:29 INFO - Successfully installed blessings 18:56:29 INFO - Cleaning up... 18:56:29 INFO - Return code: 0 18:56:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:30 INFO - Reading from file tmpfile_stdout 18:56:30 INFO - Current package versions: 18:56:30 INFO - blessings == 1.6 18:56:30 INFO - blobuploader == 1.2.4 18:56:30 INFO - docopt == 0.6.1 18:56:30 INFO - functools32 == 3.2.3-2 18:56:30 INFO - jsonschema == 2.5.1 18:56:30 INFO - manifestparser == 1.1 18:56:30 INFO - mozInstall == 1.12 18:56:30 INFO - mozcrash == 1.0 18:56:30 INFO - mozdebug == 0.1 18:56:30 INFO - mozdevice == 0.49 18:56:30 INFO - mozfile == 1.2 18:56:30 INFO - mozhttpd == 0.7 18:56:30 INFO - mozinfo == 0.9 18:56:30 INFO - mozleak == 0.1 18:56:30 INFO - mozlog == 3.4 18:56:30 INFO - moznetwork == 0.27 18:56:30 INFO - mozprocess == 0.24 18:56:30 INFO - mozprofile == 0.28 18:56:30 INFO - mozrunner == 6.13 18:56:30 INFO - mozscreenshot == 0.1 18:56:30 INFO - mozsystemmonitor == 0.3 18:56:30 INFO - moztest == 0.8 18:56:30 INFO - mozversion == 1.4 18:56:30 INFO - psutil == 3.1.1 18:56:30 INFO - requests == 1.2.3 18:56:30 INFO - wsgiref == 0.1.2 18:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:30 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 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56:30 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 18:56:30 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 18:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:30 INFO - 'HOME': '/Users/cltbld', 18:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:30 INFO - 'LOGNAME': 'cltbld', 18:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:30 INFO - 'MOZ_NO_REMOTE': '1', 18:56:30 INFO - 'NO_EM_RESTART': '1', 18:56:30 INFO - 'PAGER': '/bin/cat', 18:56:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:30 INFO - 'PWD': '/builds/slave/test', 18:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:30 INFO - 'SHELL': '/bin/bash', 18:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:30 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:30 INFO - 'USER': 'cltbld', 18:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:30 INFO - 'XPC_FLAGS': '0x0', 18:56:30 INFO - 'XPC_SERVICE_NAME': '0', 18:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 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)) 18:56:30 INFO - Cleaning up... 18:56:30 INFO - Return code: 0 18:56:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322c6b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, '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.v9JBSvorp1/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.70ikqYV9k6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 18:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:30 INFO - 'HOME': '/Users/cltbld', 18:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:30 INFO - 'LOGNAME': 'cltbld', 18:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:30 INFO - 'MOZ_NO_REMOTE': '1', 18:56:30 INFO - 'NO_EM_RESTART': '1', 18:56:30 INFO - 'PAGER': '/bin/cat', 18:56:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:30 INFO - 'PWD': '/builds/slave/test', 18:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:30 INFO - 'SHELL': '/bin/bash', 18:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:30 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:30 INFO - 'USER': 'cltbld', 18:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:30 INFO - 'XPC_FLAGS': '0x0', 18:56:30 INFO - 'XPC_SERVICE_NAME': '0', 18:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:56:30 INFO - Cleaning up... 18:56:30 INFO - Return code: 0 18:56:30 INFO - Running post-action listener: _resource_record_post_action 18:56:30 INFO - Running post-action listener: _start_resource_monitoring 18:56:30 INFO - Starting resource monitoring. 18:56:30 INFO - [mozharness: 2017-02-12 02:56:30.696906Z] Finished create-virtualenv step (success) 18:56:30 INFO - [mozharness: 2017-02-12 02:56:30.697976Z] Running install step. 18:56:30 INFO - Running pre-action listener: _resource_record_pre_action 18:56:30 INFO - Running main action method: install 18:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:30 INFO - Reading from file tmpfile_stdout 18:56:30 INFO - Detecting whether we're running mozinstall >=1.0... 18:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:56:31 INFO - Reading from file tmpfile_stdout 18:56:31 INFO - Output received: 18:56:31 INFO - Usage: mozinstall [options] installer 18:56:31 INFO - Options: 18:56:31 INFO - -h, --help show this help message and exit 18:56:31 INFO - -d DEST, --destination=DEST 18:56:31 INFO - Directory to install application into. [default: 18:56:31 INFO - "/builds/slave/test"] 18:56:31 INFO - --app=APP Application being installed. [default: firefox] 18:56:31 INFO - mkdir: /builds/slave/test/build/application 18:56:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:56:52 INFO - Reading from file tmpfile_stdout 18:56:52 INFO - Output received: 18:56:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:56:52 INFO - Running post-action listener: _resource_record_post_action 18:56:52 INFO - [mozharness: 2017-02-12 02:56:52.760003Z] Finished install step (success) 18:56:52 INFO - [mozharness: 2017-02-12 02:56:52.760150Z] Running run-tests step. 18:56:52 INFO - Running pre-action listener: _resource_record_pre_action 18:56:52 INFO - Running main action method: run_tests 18:56:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:56:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:56:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:56:52 INFO - 2017-02-11 18:56:52.775 screenresolution[1916:18275] starting screenresolution argv=screenresolution get 18:56:52 INFO - 2017-02-11 18:56:52.777 screenresolution[1916:18275] Display 0: 1600x1200x32@60 18:56:52 INFO - 2017-02-11 18:56:52.783 screenresolution[1917:18277] starting screenresolution argv=screenresolution list 18:56:52 INFO - Available Modes on Display 0 18:56:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:56:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:56:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:56:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:56:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:56:53 INFO - Intel Iris: 18:56:53 INFO - Chipset Model: Intel Iris 18:56:53 INFO - Type: GPU 18:56:53 INFO - Bus: Built-In 18:56:53 INFO - VRAM (Dynamic, Max): 1536 MB 18:56:53 INFO - Vendor: Intel (0x8086) 18:56:53 INFO - Device ID: 0x0a2e 18:56:53 INFO - Revision ID: 0x0009 18:56:53 INFO - Displays: 18:56:53 INFO - Display: 18:56:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:56:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:56:53 INFO - Display Serial Number: 1600x1200 60 18:56:53 INFO - Main Display: Yes 18:56:53 INFO - Mirror: Off 18:56:53 INFO - Online: Yes 18:56:53 INFO - Rotation: Supported 18:56:53 INFO - Return code: 0 18:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:56:53 INFO - Python 2.7.3 18:56:53 INFO - Return code: 0 18:56:53 INFO - grabbing minidump binary from tooltool 18:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:53 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 0x10b3aed30>, '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 0x10b2d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:56:53 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 18:56:53 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 18:56:53 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 18:56:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:56:53 INFO - Return code: 0 18:56:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:56:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:56:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:56:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:56:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--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 18:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0055 --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 18:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v9JBSvorp1/Render', 18:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:56:53 INFO - 'HOME': '/Users/cltbld', 18:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:56:53 INFO - 'LOGNAME': 'cltbld', 18:56:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:56:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:53 INFO - 'MOZ_NO_REMOTE': '1', 18:56:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:56:53 INFO - 'NO_EM_RESTART': '1', 18:56:53 INFO - 'PAGER': '/bin/cat', 18:56:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:53 INFO - 'PWD': '/builds/slave/test', 18:56:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:56:53 INFO - 'SHELL': '/bin/bash', 18:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.70ikqYV9k6/Listeners', 18:56:53 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 18:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:56:53 INFO - 'USER': 'cltbld', 18:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:53 INFO - 'XPC_FLAGS': '0x0', 18:56:53 INFO - 'XPC_SERVICE_NAME': '0', 18:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:56:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--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 18:56:53 INFO - mozversion application_buildid: 20170211174340 18:56:53 INFO - mozversion application_changeset: 09ef6a4f41186ea6951830d1506f741005dcc46f 18:56:53 INFO - mozversion application_display_name: Nightly 18:56:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:56:53 INFO - mozversion application_name: Firefox 18:56:53 INFO - mozversion application_remotingname: firefox 18:56:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:56:53 INFO - mozversion application_vendor: Mozilla 18:56:53 INFO - mozversion application_version: 54.0a1 18:56:53 INFO - mozversion platform_buildid: 20170211174340 18:56:53 INFO - mozversion platform_changeset: 09ef6a4f41186ea6951830d1506f741005dcc46f 18:56:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:56:53 INFO - mozversion platform_version: 54.0a1 18:56:53 INFO - using testdate: 1486868213 18:56:53 INFO - actual date: 1486868213 18:56:53 INFO - starting webserver on 'localhost:52700' 18:56:53 INFO - SUITE-START | Running 2 tests 18:56:53 INFO - TEST-START | dromaeo_css 18:56:53 INFO - operating with platform_type : mac_ 18:56:53 INFO - Initialising browser for dromaeo_css test... 18:56:53 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmpHJuA6h/profile http://localhost:52700/getInfo.html) 18:56:55 INFO - PROCESS | 1927 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 18:56:55 INFO - PROCESS | 1927 | __metrics Screen width/height:1600/1200 18:56:55 INFO - PROCESS | 1927 | colorDepth:24 18:56:55 INFO - PROCESS | 1927 | Browser inner width/height: 1024/689 18:56:55 INFO - PROCESS | 1927 | __metrics 18:56:55 INFO - PROCESS | 1927 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:56:55 INFO - PROCESS | 1927 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:56:56 INFO - TEST-INFO | 1927: exit 0 18:56:56 INFO - Browser initialized. 18:56:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:56:56 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmpHJuA6h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:08 INFO - PROCESS | 1929 | RSS: Main: 237006848 18:57:08 INFO - PROCESS | 1929 | 19:00:10 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52700/tests/dromaeo/cssquery-ext.html) 19:00:12 INFO - PROCESS | 1929 | RSS: Main: 455528448 19:00:12 INFO - PROCESS | 1929 | 19:01:58 INFO - PROCESS | 1929 | ************************* 19:01:58 INFO - PROCESS | 1929 | A coding exception was thrown and uncaught in a Task. 19:01:58 INFO - PROCESS | 1929 | 19:01:58 ERROR - PROCESS | 1929 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:01:58 INFO - PROCESS | 1929 | Full stack: 19:01:58 INFO - PROCESS | 1929 | ************************* 19:03:16 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52700/tests/dromaeo/cssquery-ext.html (next: http://localhost:52700/tests/dromaeo/cssquery-jquery.html) 19:03:16 INFO - PROCESS | 1929 | RSS: Main: 375705600 19:03:16 INFO - PROCESS | 1929 | 19:06:19 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52700/tests/dromaeo/cssquery-mootools.html) 19:06:19 INFO - PROCESS | 1929 | RSS: Main: 355454976 19:06:19 INFO - PROCESS | 1929 | 19:09:22 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52700/tests/dromaeo/cssquery-prototype.html) 19:09:22 INFO - PROCESS | 1929 | RSS: Main: 350281728 19:09:22 INFO - PROCESS | 1929 | 19:12:26 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52700/tests/dromaeo/cssquery-yui.html) 19:12:26 INFO - PROCESS | 1929 | RSS: Main: 341000192 19:12:26 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52700/tests/dromaeo/cssquery-yui.html (next: http://localhost:52700/tests/dromaeo/cssquery-dojo.html) 19:15:29 INFO - PROCESS | 1929 | RSS: Main: 543080448 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | __start_tp_report 19:15:29 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 19:15:29 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 19:15:29 INFO - PROCESS | 1929 | |i|pagename|runs| 19:15:29 INFO - PROCESS | 1929 | |0;dojo.html;2577.2654793383886;3065.0038737410346;3071.308955485015;3081.969180308198;3114.6573876873554;5443.074677304858;5518.668879867211;5570.8607284817845;5650.208970744099;5681.517071048961;5577.52591029763;5581.6930068846195;5584.497395234428;5633.380328163898;5633.577481688869;4917.975410122945;4988.4762099979525;4999.9500004999845;5159.922601160985;5205.531502164805;5068.72122033288;5087.79648814047;5161.793528258865;5162.638615296931;5167.7932882684645;4900.9754951225195;4968.279599458095;4972.129877271481;4978.975105124451;4983.825566105169;5032.220005899091;5032.4212715537815;5034.647574669774;5095.923561146586;5135.6148288878485;4928.186849169882;5007.749612519396;5019.322391477177;5025.648204625678;5046.965372098711;5264.341957255343;5286.814961476368;5306.257124002643;5609.102543593006;5627.155926611;6051.818445446644;6093;6105.938940610581;6123.984276525883;6124.757675881256;6141.631502109843;6154.84612884677;6188.659623720693;6204.038374051984;6214.751409943597;5385.461453854661;5676.801311954062;5688.11834165705;5690.032694441955;5718.199452076713;6102.664353460514;6105.52039974972;6111.166351794787;6119.8681629442035;6161.44546990773;5700.771969121189;5751.482366587027;5759.827205183851;5832.445917637818;6001.699915004232;6062.302835174011;6104.890867003831;6111.591738512237;6118.284172697687;6141.017437210115;6014;6040.788572399945;6056.515478761688;6056.788012419544;6069.2716873975405;5868.237129173265;5922.052471604523;6061.848453788691;6061.939380606225;6134.4172303631085;4088.34586466164;4799.736014519165;4850.175470170079;4853.708777473363;4880.170371036932;4059.594040595976;4063.045184381668;4083.244599749056;4084.2852500812833;4110.506739191316;5395.136778115482;5442.428545002796;5511.641743286674;5617;5635.774569017275;6135;6224.782132625336;6229.190205273376;6230.43926046658;6233.065040243909;5450.100733379028;5535.446455354432;5599.60802743804;5604.915926261109;5646.237757902631;5161.406438259573;5244.816431424882;5375.354957405137;5389.272448219519;5403.5136837684795;6151.292601350902;6161.876762464815;6188.195534580475;6204.069389591597;6215.96892015537;6182.938170618237;6194.752209911733;6195.597286176384;6211.65835879013;6214.098955651496;6139.877202455837;6203.8138855834395;6208.751649933952;6217.626942383471;6222.408871157233;5743.655380677173;5808.273965754281;5878.500327472042;5878.500327472213;5882.205902203319;6067.726952287069;6068.241469816273;6070.0591408331775;6071.150038994632;6076.422739839708;5851.180834683233;5860.531157507304;5865.706714664165;5891.293044834647;5925.881482370414;5965.552583556164;5969.373215812451;5978.342382338026;5983;6005.759769609342;5798.623089499169;5801.941980580309;5802.65184088956;5835.387284335084;5899.115132730125;5719.399463056486;5753.942460575341;5758.740856661544;5836.037053886062;5864.266966629171;4428.911421771482;5727.11229759388;5753.3958934311295;5754.625949313281;5781.277340332458 19:15:29 INFO - PROCESS | 1929 | |1;ext.html;469.567997442353;472.56287933661355;484.2228223700962;498.95468992460803;504.2310476523304;37595.4961801528;38543.80728096359;38757;38810.611893881054;38837.02907427316;38771.03072423191;39507.407388889114;39951.60048399522;39987.60012399875;39998.60001399992;7627.466077374558;8883.46699198047;9116.635334586608;9135.497547634877;9148.405353652024;7810.648520816549;9162.221211197022;10559;10839.945800270987;10977.39624320662;10872.955572439729;10895.455227238646;10991.450427478634;10993.670189894316;10996.780064398707;7744;10806.135509159287;10811.378293255995;10885.18361122919;10936.56253749857;7748.031496062992;10532.315399499084;10732.302400343953;10801.83797243042;10825.025747682668;37080.62919370799;37946.62053379486;38002.61997380018;38045.85862424104;38264.61735382666;3478.467690386662;3484.6689564491335;3507.929841403183;3536.469529570559;3602.9099272518133;24247.03011879523;27203.86398068017;27934.301642458897;28056.579151312748;28119.859400702866;2789;2821.604975303459;2891.6963718809643;2897.985510072457;2991.6559595646563;397278;397346;398818;399114;399491;48189.5181048192;49986.250206246936;58227.4177258222;58598;58832.11751823726;51858.74070629698;62503.37496624976;63605.681971589845;63787.36212637814;63848.36151638517;14643.92678036603;14826.110433373817;14833.480828170963;14850.2574871256;14858.702825943421;11324.094072474183;11388.544458221744;11413.42932853354;11437.085033197323;11458.026067784165;13007;14264.215468149145;14874.181919994504;15785.21073946298;16054.839451605334;5889.9692553802915;6251.28110267316;6381.1385462962835;6424;6443.5167362448;770.5068755996167;811.1199348706601;811.8877138320539;842.6966292134827;848.1772680499905;24394.634080488806;25071.498570028496;28023.43953120926;28911.7108828909;29707.851460742557;961.6393852305386;965.2229954886244;999.9900000999897;1000.9949950250348;1022.943738094412;13302.66743331405;14133.85866141346;14158.212982859386;14481.420743170154;15083.773743393858;443161;629294;638827;639630;786867;51462.22806657903;52116;52207.73896130495;52242;52373.47626523762;1289.9161554499115;1314.80277958307;1330.7272009238084;1333.1601091312605;1334.8998825087963;25104;27099;27428;27430.862845685642;28190;37661.81169094137;44573;44585.554144459435;44617.88455288514;44635.330470042325;411612;415337;415968;417493;417499;19357.741746786414;20436.693449598566;21222.78777212208;23546.646800297665;23692.8815355929;36722.63277367192;37004;38092.04769880775;39058.60941390663;39168.412473813485;30938.381232375676;31514.684853151175;31810.840945795124;32641.34717305688;32857.671423285465;22462.88768556147;29637.337535242954;30377.392452151274;31470.68529314769;31548.842255789492;31184.532232016085;31610.36779264356;31636.576354064582;31752.206194845312;31999;21723.34829955104;25625.871870640527;27601.861990690722;27639.894404223607;28084.719152809026;19721.21115155435;20310;21155.365339039854;22148.114075437446;22258.77741222567 19:15:29 INFO - PROCESS | 1929 | |2;jquery.html;363.13935971746963;390.7538250901931;394.1879727760811;399.9180168065547;424.7409080460918;13835.654108647277;14009.719805603881;16441.50675479736;19290.4212873614;20003.599928001433;11986.041116710643;15062.171580563065;18289.725654115166;20433.28483503074;20667.1733130675;5172.586193104561;5392.514673679368;5397.78408863645;5400.83797486076;5405;5087.898242035157;5234.816781412651;5268.998890210867;5313.73431328434;5329.626926115174;5310.176922577007;5312.787488500456;5317.9468205318035;5321.3348331458565;5325.627206095575;5252.5010124038345;5323.760430780624;5692.37383887772;5741.655500669973;5745.597808153431;5023.648344615878;5076.18780995039;5110.28456016158;5118;5144.099782538041;12998.805017924738;13147.605571832764;13170.802437963439;13222.537211197658;16107.355705771755;2000.9399718008483;2406.9638955415685;2410.457647029422;2426.720927093389;2445.29086564896;9270.44377337362;9569.425834449885;9971.650992215238;10119.595216191343;10199.592016319339;1627.9593010174722;1665.6734207389702;1670.7076261654283;1676.9413070542473;1725.2753843385683;87260;99919;113027.43486282598;122582.38708806399;128128;9505.809883802423;10380.896191038144;10519.84220236697;11514.19400641947;11727.941360293144;15403.768943465857;15409.768853467207;15415.383384664712;15431.459898903484;15436.536903892902;8010.719624813103;8270.462419942805;8299.253067223979;8437.451565648213;8446;6808.863822723518;7667.156612772591;7886.960565197137;7901.60491975399;8100.392470564731;4659.930101048487;4682.145241450944;4685.461171965268;4692.6245900327895;4810.542998415145;1698.4989428118736;1928.1227041695995;2004;2004.7446622549633;2006.6789313709737;834.7954751085902;849.9702510412229;866.5017614871474;873.6811063961735;879.0374539878823;17049.48851534431;20439.284625038053;20835.79164208369;21613.776993613603;21681.02315386506;847.8897743293332;862.7368652561029;876.6361959786744;884.9513276769711;894.4990805149138;8466;10344.32761870491;11200.663980080612;11203.887961120448;11277.436128193722;666551;675887;688723;690033;695832.5208373925;100148;124077;136154;139035;144303.5569644311;378.99431508527397;454.7953420960581;458.3102430841629;458.37889659511546;460.1693942433872;10808.621698240524;11015.889841101487;11055.115590752559;11209.271397359145;11262;53104.20343694925;54691.179632306346;57991;59151.11273330989;59170;82985.17014829775;83566.64333566594;85179;85523.14476855152;87432;8028.59857007159;8123.228293312126;8262.793430164294;8345.624446900025;8368.20502052304;10299.485025748532;12158.635240942785;12320.322382269062;12640.30478323701;12645.367731613567;10517.212938571132;10549.314294570828;10576.312539684895;10727.249092563447;10794.40630765284;10426.791464170523;10520.736981575521;10605.098566621924;10830.67507974762;10851;10622.309549879234;10716.892831071902;10928.672139835817;10981.450927453436;11080.279781814157;7972.601369931596;8102.918970810217;8156.632951517315;8203.179682031749;8215.630296636546;9137.634494620406;10170.440625765654;10672.83990740124;10837.428572857048;11014.44927753625 19:15:29 INFO - PROCESS | 1929 | |3;mootools.html;1400.145910994294;1408.68304631458;1410.1891412437847;1419.708959663269;1420.8579142085794;8057.556834374107;8455.619497122629;8457.830843383128;8458.196471335228;8458.407911446202;7985;8309.626066826992;8312.210340017704;8398.454100483465;8415.579221038954;1688.5103320037174;2273.318004598622;2277.9202727904526;2279.0200213908015;2287.828412869033;1987.801219878008;2164.2425151197112;2223.344113486525;2224.2993457061057;2228.55428914217;1981.4154824326858;2196.3959911024435;2264.1509433962265;2267;2268.5689718953427;2227.3652009177467;2252.8197744180507;2257.762934891829;2261.5589959957897;2264.4112530742127;2269.614165591853;2284.817214622826;2290.358699564125;2293.312006398074;2293.3578597992587;8404.453710508858;8446.197611226986;8485.0666426693;8496.872546911802;8516.616752246164;4973.651844370896;5063.367079115111;5129.589632829365;5130.640855140142;5155.639105262633;3169.5404166395742;3179.952300715491;3306.1404034950847;3339.215284408162;3431;1161.3264306702092;1168.5559487394821;1169.9883001170049;1188.4889497516065;1223.3516236394726;10650.520726567323;10736.570537178504;10754.946225268903;10782;10834.945825270823;3582.659647333499;4114.958850411457;4321.222180007629;4342.261815491374;4425.911481770347;8636.913630863737;8764.342674299325;8771.254443372258;8792.076831932683;8792.692255771017;5097.719625420564;5100.48995100487;5101.107306221471;5106.540411362995;5119.692818430832;4220.472440944882;4571.954280457219;4713.8350157745;4717.150912835654;4723.881902952454;3570.285942811448;3615.5661320641693;3640.5449318835144;3671.6695497405362;3673.2286219893585;1019.5972590826582;1119.5409881948362;1135.0635725526474;1135.517405102828;1138.8747237803834;753.6231884057971;783.8957727399448;821.4373154389262;878.0955615715823;892.0588778838259;4510.481294651091;5295.523402893681;5344.518993290622;5577.860553486195;5677.886442271131;854.6154230596256;952.6618050592078;968.1915600473543;1007.1741172238841;1022.9437380943971;2991;3575.4994300797907;3626.1869065467267;3762.398016317376;3772.660460558563;9629.807403851884;10081.949590252001;10088.949555252177;10110.848337274947;10114.696559103239;10025.799484010278;10043.598256069676;10048.397096174253;10049.346792458467;10070.899291006996;7767.766966990999;7837.529748215012;7847.568383738949;7850.057993040871;7865.095514015847;4795.760211989456;5105.2086926526445;5218.321618189763;5504.449555044624;5544.805931792368;8906.599203036008;9058.682946096855;9101.590428430603;9124.361294709306;9264.95367523158;9151.679691210775;9276.1651451367;9343.486108264111;9425.858612120686;9480.004599516951;6570.5400621956005;6663.067170596023;6670.433013193739;6675.532712710258;6683.164604424447;7718.768436946901;7730.80172573252;7749.845003100019;7775;7816.609169541386;5491.807786727445;6943.861122777617;7069.858602828018;7072.71709131629;7084.149902011792;5417.756200970887;5472.50747432733;6819.522633415613;6977.581345119106;7007.283215612208;6271.43557079865;6393.904091438725;6406.135171751754;6413.0701048348665;6415.550911436155;4700.623950084054;4870.829520966749;4925.655204135676;4972.204447288416;5003.849884503471;3761.830717617659;4829.782659780389;4938.30863679078;4974.801007959641;4983.277424773315 19:15:29 INFO - PROCESS | 1929 | |4;prototype.html;310.5822668510853;344.5160393562415;363.9727020473465;364.37509670914375;364.94890715299846;5289.814856480024;5317.627766056368;5333.866653333659;5336.2123688564325;5367.946320536798;4250.9160164158175;5008.949910500894;5206.505381988714;5253.474652534745;5292.941411717662;3449.413599688059;3914.4911161548957;3945.7768091891608;3963.346047902093;3990.687729184784;3996.200759848042;4006.9799651001704;4007.83968641254;4010.2981978153853;4010.6189911958318;3473.4095203815286;3495.91260218494;3634.618365071669;3977.741446805963;3978.582248863871;2980.2730501591127;3636.2727454509204;3924.6852304478034;3925.489686340786;3938.15329704115;2777.250142461524;2785.5403858363547;3106.4874295741174;3384.4415671414185;3386.915327116817;4634.814607415699;4729.858104256878;4844.467108618049;5126.795477944483;5165.4172913543225;3937.208570100626;4259.233337999159;4309.4397728295435;4460.821567137311;4504.774761261924;5248.475152484721;5526.4078349073425;5535.640183388067;5540.750666220029;5574.219609254707;3743.4384842273876;3755.830987605564;3759.6240375962457;3767.6044015378266;3772.6793222576116;5095.414027386861;5462.918056229159;5819.156222347736;5846.450690567003;5872.7357268923;3379.8339572847326;3497.440409534462;3807.7815099168;3819.350710379242;3843.7693738375788;3250.7724459288097;3838.867534077454;3858.1704933439446;3860.3630400984084;3861.67175790061;4179.9462452450825;4513.232750432434;4513.796879140446;4515.367848501212;4552.795124219418;4537.773111344485;5602.215689803431;5604;5608.327000759935;5696.098172751678;1239.9504019839105;1241.9753703194901;1256.9245845249313;1263.4125131813566;1265.5127775806382;718.5365439291733;740.9666565004587;788.964496597643;797.8523973065002;847.2882778466118;4292.261634038219;4296.5273819879785;4444;4906.582940450102;4930.827421040246;4795.112904112751;5462.863428414322;5467.250479846491;5489.835304940858;5520.972395138079;4390.407295015196;4583.4041574595085;4913.290465698375;4964.425613558233;4992.750362481934;2431.33138386945;2466.3217615155977;2467.642191882167;2809.2555472799722;2856.671482779507;5552.833414997556;5628.467189764622;5679.914801277984;5681.437604658669;5754.338251101177;4690.554397332248;5206.210286536396;5259.002368649909;5296.993571221456;5832.737526811304;5169;5442.945570544244;5846.649201047951;5936.643801371932;5967.701614919237;4821.566059054702;5503.394626591152;5739.426057394227;5745.597808153556;5761.0700415361325;5116.313935184058;5647.063526965872;5696.857578560569;5718.714064296685;5728.598998070095;5076.36545431821;5359.222912677562;5947.609862378403;5950.851228719143;5961.76433837311;3671.9816400918894;3953.5058117735284;4084.6528045116497;4137.710360274752;4144.626983571493;5318.867028324323;5486.423925487767;5701.857453563694;5733.684647344436;5781.94218057814;5364.544013758874;5379.35447746273;5633.464820842013;5655.802046928502;5676.858078548069;4641.814327426865;4690.646187975613;5080.49195080489;5636.689982051026;5662.745176466987;4822.83956166898;5418.241446197614;5484;5518.530924871431;5529.612927095226;5130.384353877558;5166.966606678604;5409.783608655767;5610.5231055360755;5638.830835074954;4001.998501124157;4357.891052723708;4990.051890140861;4991.926735751686;5115.335006449138 19:15:29 INFO - PROCESS | 1929 | |5;yui.html;601.542827451137;635.8315046512672;662.7349060375849;727.428968259916;765.7128576783706;14034.368453419595;14387.352569134388;14688.971771975952;14827.555173344803;15161.848381516182;13138.802917956215;13313.400896959636;13556.254406007665;13613.047086703935;13617;850.7022542110259;877.6313948141795;877.9078196789341;882.095851751953;882.2060145868737;827.4538804389105;861.7543999960012;863.0549548244662;866.6879923227633;867.3408209760564;905.5834316214549;909.0046399192873;909.6588779207797;910.5947853205327;911.3574929674596;899.9685011024583;900.504722402676;901;901.5041727050162;905.7780843693272;670.587588632992;671.3856821008771;671.576906548876;671.8320419895026;674.5143496682381;14453;14544.2000689962;14676;14685.559433216913;14904.403823847033;12774.297413642245;12782.233066015975;12800.80798788019;13092.607221783363;13192.6701832454;10422.270441069128;10570.20723445737;10605.469726513644;10615.628453004108;10638.840417393745;3352.580927384077;3376.679215474526;3398;3440.70753985909;3488.3372159289906;98032.50983745107;98741;100264.99205023861;100294;101735;9175.678851240174;9271.768205794775;9282.90717092834;9377.202937750231;9492.430454172772;21041.842698651722;21803.781962180492;21814.345569632937;21815.23646672359;21842.89078554597;6834.316568343126;6866;6947.548409353376;7015.751974574668;7114.928850711427;3625.8005809680194;3633.563972323338;3644.526211592529;3647.1429214134655;3693.279810436939;3405.6934875860798;3445.672661097192;3459.273552553992;3521.2781379817075;3535.4520049392386;599.7241269016301;602.8432607522076;613.2732711736606;615.0773839241139;621.4034526854181;576.3573615418861;594.4976494861835;604.7853012180612;628.5537268539297;659.1069101367577;8271.710490132817;8367.874481882776;8385.95807020961;8434.57827108642;8501.914980850112;492.02081397139943;520.2482412913304;525.9526642602184;528.4530510921178;549.8927709096768;4093.099518106012;4351.521332653406;5062.291279220912;5090.211017292326;5099.617528685363;67069.66465167643;77135.22864771393;78200.04499887548;97791.1325320483;104959;87102.56448717717;87847;89300.6604900927;89917.55041224883;90680.63979040319;75548.15681334077;76210.61894690491;77590.61204694053;77864.61067694625;79254.60372698099;10108.545115469675;10120.190384769054;10140.594376224868;10157.238207134347;10208.897911020795;44674.55325446704;47992.760036199594;49144.75427622982;49732;50325;65905.1256542665;66989.33010669831;67672;68957;71493.28506714867;9447.763805904633;11696.590619328283;12005.279683219034;12105.81841272364;12529.248245105322;12981.870181298065;13263.403146858222;13589.32053397346;13660.521881734092;14069.859301406856;12637.431315590637;12662;12732;12816.423260953094;12943.870561294643;12308.276841242412;12794.232346059267;12796.808047879476;12927.030472714396;13272.402741876831;12446.37768111609;12482.875171248172;12505.749885002067;12663.366831658195;12938.935305323414;9696.369735967139;10074.395536267848;10244.136899010446;10322.329048611817;10513.167690070946;8171.896793932743;9979.351342163027;10318.845217321596;10431.582736690447;10794.514246859067 19:15:29 INFO - PROCESS | 1929 | __end_tp_report 19:15:29 INFO - PROCESS | 1929 | __start_cc_report 19:15:29 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,2511 19:15:29 INFO - PROCESS | 1929 | __end_cc_report 19:15:29 INFO - PROCESS | 1929 | __startTimestamp1486869329930__endTimestamp 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | ------- Summary: start ------- 19:15:29 INFO - PROCESS | 1929 | Number of tests: 6 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | [#0] dojo.html Cycles:165 Average:5564.87 Median:5753.94 stddev:692.57 (12.0%) stddev-sans-first:653.84 19:15:29 INFO - PROCESS | 1929 | Values: 2577.3 3065.0 3071.3 3082.0 3114.7 5443.1 5518.7 5570.9 5650.2 5681.5 5577.5 5581.7 5584.5 5633.4 5633.6 4918.0 4988.5 5000.0 5159.9 5205.5 5068.7 5087.8 5161.8 5162.6 5167.8 4901.0 4968.3 4972.1 4979.0 4983.8 5032.2 5032.4 5034.6 5095.9 5135.6 4928.2 5007.7 5019.3 5025.6 5047.0 5264.3 5286.8 5306.3 5609.1 5627.2 6051.8 6093.0 6105.9 6124.0 6124.8 6141.6 6154.8 6188.7 6204.0 6214.8 5385.5 5676.8 5688.1 5690.0 5718.2 6102.7 6105.5 6111.2 6119.9 6161.4 5700.8 5751.5 5759.8 5832.4 6001.7 6062.3 6104.9 6111.6 6118.3 6141.0 6014.0 6040.8 6056.5 6056.8 6069.3 5868.2 5922.1 6061.8 6061.9 6134.4 4088.3 4799.7 4850.2 4853.7 4880.2 4059.6 4063.0 4083.2 4084.3 4110.5 5395.1 5442.4 5511.6 5617.0 5635.8 6135.0 6224.8 6229.2 6230.4 6233.1 5450.1 5535.4 5599.6 5604.9 5646.2 5161.4 5244.8 5375.4 5389.3 5403.5 6151.3 6161.9 6188.2 6204.1 6216.0 6182.9 6194.8 6195.6 6211.7 6214.1 6139.9 6203.8 6208.8 6217.6 6222.4 5743.7 5808.3 5878.5 5878.5 5882.2 6067.7 6068.2 6070.1 6071.2 6076.4 5851.2 5860.5 5865.7 5891.3 5925.9 5965.6 5969.4 5978.3 5983.0 6005.8 5798.6 5801.9 5802.7 5835.4 5899.1 5719.4 5753.9 5758.7 5836.0 5864.3 4428.9 5727.1 5753.4 5754.6 5781.3 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | [#1] ext.html Cycles:180 Average:60311.99 Median:32320.17 stddev:132824.67 (411.0%) stddev-sans-first:133121.28 19:15:29 INFO - PROCESS | 1929 | Values: 469.6 472.6 484.2 499.0 504.2 37595.5 38543.8 38757.0 38810.6 38837.0 38771.0 39507.4 39951.6 39987.6 39998.6 7627.5 8883.5 9116.6 9135.5 9148.4 7810.6 9162.2 10559.0 10839.9 10977.4 10873.0 10895.5 10991.5 10993.7 10996.8 7744.0 10806.1 10811.4 10885.2 10936.6 7748.0 10532.3 10732.3 10801.8 10825.0 37080.6 37946.6 38002.6 38045.9 38264.6 3478.5 3484.7 3507.9 3536.5 3602.9 24247.0 27203.9 27934.3 28056.6 28119.9 2789.0 2821.6 2891.7 2898.0 2991.7 397278.0 397346.0 398818.0 399114.0 399491.0 48189.5 49986.3 58227.4 58598.0 58832.1 51858.7 62503.4 63605.7 63787.4 63848.4 14643.9 14826.1 14833.5 14850.3 14858.7 11324.1 11388.5 11413.4 11437.1 11458.0 13007.0 14264.2 14874.2 15785.2 16054.8 5890.0 6251.3 6381.1 6424.0 6443.5 770.5 811.1 811.9 842.7 848.2 24394.6 25071.5 28023.4 28911.7 29707.9 961.6 965.2 1000.0 1001.0 1022.9 13302.7 14133.9 14158.2 14481.4 15083.8 443161.0 629294.0 638827.0 639630.0 786867.0 51462.2 52116.0 52207.7 52242.0 52373.5 1289.9 1314.8 1330.7 1333.2 1334.9 25104.0 27099.0 27428.0 27430.9 28190.0 37661.8 44573.0 44585.6 44617.9 44635.3 411612.0 415337.0 415968.0 417493.0 417499.0 19357.7 20436.7 21222.8 23546.6 23692.9 36722.6 37004.0 38092.0 39058.6 39168.4 30938.4 31514.7 31810.8 32641.3 32857.7 22462.9 29637.3 30377.4 31470.7 31548.8 31184.5 31610.4 31636.6 31752.2 31999.0 21723.3 25625.9 27601.9 27639.9 28084.7 19721.2 20310.0 21155.4 22148.1 22258.8 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | [#2] jquery.html Cycles:180 Average:36564.43 Median:397.05 stddev:113549.47 (28598.1%) stddev-sans-first:113835.47 19:15:29 INFO - PROCESS | 1929 | Values: 363.1 390.8 394.2 399.9 424.7 13835.7 14009.7 16441.5 19290.4 20003.6 11986.0 15062.2 18289.7 20433.3 20667.2 5172.6 5392.5 5397.8 5400.8 5405.0 5087.9 5234.8 5269.0 5313.7 5329.6 5310.2 5312.8 5317.9 5321.3 5325.6 5252.5 5323.8 5692.4 5741.7 5745.6 5023.6 5076.2 5110.3 5118.0 5144.1 12998.8 13147.6 13170.8 13222.5 16107.4 2000.9 2407.0 2410.5 2426.7 2445.3 9270.4 9569.4 9971.7 10119.6 10199.6 1628.0 1665.7 1670.7 1676.9 1725.3 87260.0 99919.0 113027.4 122582.4 128128.0 9505.8 10380.9 10519.8 11514.2 11727.9 15403.8 15409.8 15415.4 15431.5 15436.5 8010.7 8270.5 8299.3 8437.5 8446.0 6808.9 7667.2 7887.0 7901.6 8100.4 4659.9 4682.1 4685.5 4692.6 4810.5 1698.5 1928.1 2004.0 2004.7 2006.7 834.8 850.0 866.5 873.7 879.0 17049.5 20439.3 20835.8 21613.8 21681.0 847.9 862.7 876.6 885.0 894.5 8466.0 10344.3 11200.7 11203.9 11277.4 666551.0 675887.0 688723.0 690033.0 695832.5 100148.0 124077.0 136154.0 139035.0 144303.6 379.0 454.8 458.3 458.4 460.2 10808.6 11015.9 11055.1 11209.3 11262.0 53104.2 54691.2 57991.0 59151.1 59170.0 82985.2 83566.6 85179.0 85523.1 87432.0 8028.6 8123.2 8262.8 8345.6 8368.2 10299.5 12158.6 12320.3 12640.3 12645.4 10517.2 10549.3 10576.3 10727.2 10794.4 10426.8 10520.7 10605.1 10830.7 10851.0 10622.3 10716.9 10928.7 10981.5 11080.3 7972.6 8102.9 8156.6 8203.2 8215.6 9137.6 10170.4 10672.8 10837.4 11014.4 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | [#3] mootools.html Cycles:180 Average:5302.15 Median:4974.23 stddev:2963.10 (59.6%) stddev-sans-first:2956.90 19:15:29 INFO - PROCESS | 1929 | Values: 1400.1 1408.7 1410.2 1419.7 1420.9 8057.6 8455.6 8457.8 8458.2 8458.4 7985.0 8309.6 8312.2 8398.5 8415.6 1688.5 2273.3 2277.9 2279.0 2287.8 1987.8 2164.2 2223.3 2224.3 2228.6 1981.4 2196.4 2264.2 2267.0 2268.6 2227.4 2252.8 2257.8 2261.6 2264.4 2269.6 2284.8 2290.4 2293.3 2293.4 8404.5 8446.2 8485.1 8496.9 8516.6 4973.7 5063.4 5129.6 5130.6 5155.6 3169.5 3180.0 3306.1 3339.2 3431.0 1161.3 1168.6 1170.0 1188.5 1223.4 10650.5 10736.6 10754.9 10782.0 10834.9 3582.7 4115.0 4321.2 4342.3 4425.9 8636.9 8764.3 8771.3 8792.1 8792.7 5097.7 5100.5 5101.1 5106.5 5119.7 4220.5 4572.0 4713.8 4717.2 4723.9 3570.3 3615.6 3640.5 3671.7 3673.2 1019.6 1119.5 1135.1 1135.5 1138.9 753.6 783.9 821.4 878.1 892.1 4510.5 5295.5 5344.5 5577.9 5677.9 854.6 952.7 968.2 1007.2 1022.9 2991.0 3575.5 3626.2 3762.4 3772.7 9629.8 10081.9 10088.9 10110.8 10114.7 10025.8 10043.6 10048.4 10049.3 10070.9 7767.8 7837.5 7847.6 7850.1 7865.1 4795.8 5105.2 5218.3 5504.4 5544.8 8906.6 9058.7 9101.6 9124.4 9265.0 9151.7 9276.2 9343.5 9425.9 9480.0 6570.5 6663.1 6670.4 6675.5 6683.2 7718.8 7730.8 7749.8 7775.0 7816.6 5491.8 6943.9 7069.9 7072.7 7084.1 5417.8 5472.5 6819.5 6977.6 7007.3 6271.4 6393.9 6406.1 6413.1 6415.6 4700.6 4870.8 4925.7 4972.2 5003.8 3761.8 4829.8 4938.3 4974.8 4983.3 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | [#4] prototype.html Cycles:180 Average:4409.62 Median:4947.63 stddev:1392.06 (28.1%) stddev-sans-first:1361.54 19:15:29 INFO - PROCESS | 1929 | Values: 310.6 344.5 364.0 364.4 364.9 5289.8 5317.6 5333.9 5336.2 5367.9 4250.9 5008.9 5206.5 5253.5 5292.9 3449.4 3914.5 3945.8 3963.3 3990.7 3996.2 4007.0 4007.8 4010.3 4010.6 3473.4 3495.9 3634.6 3977.7 3978.6 2980.3 3636.3 3924.7 3925.5 3938.2 2777.3 2785.5 3106.5 3384.4 3386.9 4634.8 4729.9 4844.5 5126.8 5165.4 3937.2 4259.2 4309.4 4460.8 4504.8 5248.5 5526.4 5535.6 5540.8 5574.2 3743.4 3755.8 3759.6 3767.6 3772.7 5095.4 5462.9 5819.2 5846.5 5872.7 3379.8 3497.4 3807.8 3819.4 3843.8 3250.8 3838.9 3858.2 3860.4 3861.7 4179.9 4513.2 4513.8 4515.4 4552.8 4537.8 5602.2 5604.0 5608.3 5696.1 1240.0 1242.0 1256.9 1263.4 1265.5 718.5 741.0 789.0 797.9 847.3 4292.3 4296.5 4444.0 4906.6 4930.8 4795.1 5462.9 5467.3 5489.8 5521.0 4390.4 4583.4 4913.3 4964.4 4992.8 2431.3 2466.3 2467.6 2809.3 2856.7 5552.8 5628.5 5679.9 5681.4 5754.3 4690.6 5206.2 5259.0 5297.0 5832.7 5169.0 5442.9 5846.6 5936.6 5967.7 4821.6 5503.4 5739.4 5745.6 5761.1 5116.3 5647.1 5696.9 5718.7 5728.6 5076.4 5359.2 5947.6 5950.9 5961.8 3672.0 3953.5 4084.7 4137.7 4144.6 5318.9 5486.4 5701.9 5733.7 5781.9 5364.5 5379.4 5633.5 5655.8 5676.9 4641.8 4690.6 5080.5 5636.7 5662.7 4822.8 5418.2 5484.0 5518.5 5529.6 5130.4 5167.0 5409.8 5610.5 5638.8 4002.0 4357.9 4990.1 4991.9 5115.3 19:15:29 INFO - PROCESS | 1929 | 19:15:29 INFO - PROCESS | 1929 | [#5] yui.html Cycles:180 Average:19323.90 Median:25112.01 stddev:27756.42 (110.5%) stddev-sans-first:27798.68 19:15:29 INFO - PROCESS | 1929 | Values: 601.5 635.8 662.7 727.4 765.7 14034.4 14387.4 14689.0 14827.6 15161.8 13138.8 13313.4 13556.3 13613.0 13617.0 850.7 877.6 877.9 882.1 882.2 827.5 861.8 863.1 866.7 867.3 905.6 909.0 909.7 910.6 911.4 900.0 900.5 901.0 901.5 905.8 670.6 671.4 671.6 671.8 674.5 14453.0 14544.2 14676.0 14685.6 14904.4 12774.3 12782.2 12800.8 13092.6 13192.7 10422.3 10570.2 10605.5 10615.6 10638.8 3352.6 3376.7 3398.0 3440.7 3488.3 98032.5 98741.0 100265.0 100294.0 101735.0 9175.7 9271.8 9282.9 9377.2 9492.4 21041.8 21803.8 21814.3 21815.2 21842.9 6834.3 6866.0 6947.5 7015.8 7114.9 3625.8 3633.6 3644.5 3647.1 3693.3 3405.7 3445.7 3459.3 3521.3 3535.5 599.7 602.8 613.3 615.1 621.4 576.4 594.5 604.8 628.6 659.1 8271.7 8367.9 8386.0 8434.6 8501.9 492.0 520.2 526.0 528.5 549.9 4093.1 4351.5 5062.3 5090.2 5099.6 67069.7 77135.2 78200.0 97791.1 104959.0 87102.6 87847.0 89300.7 89917.6 90680.6 75548.2 76210.6 77590.6 77864.6 79254.6 10108.5 10120.2 10140.6 10157.2 10208.9 44674.6 47992.8 49144.8 49732.0 50325.0 65905.1 66989.3 67672.0 68957.0 71493.3 9447.8 11696.6 12005.3 12105.8 12529.2 12981.9 13263.4 13589.3 13660.5 14069.9 12637.4 12662.0 12732.0 12816.4 12943.9 12308.3 12794.2 12796.8 12927.0 13272.4 12446.4 12482.9 12505.7 12663.4 12938.9 9696.4 10074.4 10244.1 10322.3 10513.2 8171.9 9979.4 10318.8 10431.6 10794.5 19:15:29 INFO - PROCESS | 1929 | -------- Summary: end -------- 19:15:29 INFO - PROCESS | 1929 | 19:15:30 INFO - TEST-INFO | 1929: exit 0 19:15:30 INFO - TEST-OK | dromaeo_css | took 1117244ms 19:15:30 INFO - TEST-START | kraken 19:15:30 INFO - operating with platform_type : mac_ 19:15:30 INFO - Initialising browser for kraken test... 19:15:30 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmpPh5SDN/profile http://localhost:52700/getInfo.html) 19:15:32 INFO - PROCESS | 1938 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 19:15:32 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 19:15:32 INFO - PROCESS | 1938 | colorDepth:24 19:15:32 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 19:15:32 INFO - PROCESS | 1938 | __metrics 19:15:32 INFO - PROCESS | 1938 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:15:32 INFO - PROCESS | 1938 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:15:33 INFO - TEST-INFO | 1938: exit 0 19:15:33 INFO - Browser initialized. 19:15:33 INFO - Running cycle 1/1 for kraken test... 19:15:33 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmpPh5SDN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:46 INFO - PROCESS | 1939 | RSS: Main: 237080576 19:15:46 INFO - PROCESS | 1939 | 19:15:48 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52700/tests/kraken/driver.html?testName=audio-beat-detection) 19:15:49 INFO - PROCESS | 1939 | RSS: Main: 289808384 19:15:49 INFO - PROCESS | 1939 | 19:15:52 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52700/tests/kraken/driver.html?testName=audio-dft) 19:15:53 INFO - PROCESS | 1939 | RSS: Main: 292593664 19:15:53 INFO - PROCESS | 1939 | 19:15:56 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52700/tests/kraken/driver.html?testName=audio-fft) 19:15:56 INFO - PROCESS | 1939 | RSS: Main: 381853696 19:15:56 INFO - PROCESS | 1939 | 19:15:58 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52700/tests/kraken/driver.html?testName=audio-oscillator) 19:15:59 INFO - PROCESS | 1939 | RSS: Main: 285196288 19:15:59 INFO - PROCESS | 1939 | 19:16:01 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:16:02 INFO - PROCESS | 1939 | RSS: Main: 288755712 19:16:02 INFO - PROCESS | 1939 | 19:16:05 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52700/tests/kraken/driver.html?testName=imaging-darkroom) 19:16:05 INFO - PROCESS | 1939 | RSS: Main: 330575872 19:16:05 INFO - PROCESS | 1939 | 19:16:08 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52700/tests/kraken/driver.html?testName=imaging-desaturate) 19:16:09 INFO - PROCESS | 1939 | RSS: Main: 333451264 19:16:09 INFO - PROCESS | 1939 | 19:16:12 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52700/tests/kraken/driver.html?testName=json-parse-financial) 19:16:12 INFO - PROCESS | 1939 | RSS: Main: 331354112 19:16:12 INFO - PROCESS | 1939 | 19:16:14 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:16:15 INFO - PROCESS | 1939 | RSS: Main: 307195904 19:16:15 INFO - PROCESS | 1939 | 19:16:16 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:16:17 INFO - PROCESS | 1939 | RSS: Main: 309764096 19:16:17 INFO - PROCESS | 1939 | 19:16:19 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:16:20 INFO - PROCESS | 1939 | RSS: Main: 311635968 19:16:20 INFO - PROCESS | 1939 | 19:16:23 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:16:24 INFO - PROCESS | 1939 | RSS: Main: 330129408 19:16:24 INFO - PROCESS | 1939 | 19:16:27 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:16:27 INFO - PROCESS | 1939 | RSS: Main: 323969024 19:16:27 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:52700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52700/tests/kraken/driver.html?testName=ai-astar) 19:16:29 INFO - PROCESS | 1939 | RSS: Main: 368959488 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | __start_tp_report 19:16:29 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 19:16:29 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 19:16:29 INFO - PROCESS | 1939 | |i|pagename|runs| 19:16:29 INFO - PROCESS | 1939 | |0;ai-astar;113;111;113;111;111;111;112;111;112;112 19:16:29 INFO - PROCESS | 1939 | |1;audio-beat-detection;146;111;107;153;114;112;112;121;163;104 19:16:29 INFO - PROCESS | 1939 | |2;audio-dft;187;183;185;186;183;181;184;186;182;185 19:16:29 INFO - PROCESS | 1939 | |3;audio-fft;79;60;59;89;60;58;59;59;75;59 19:16:29 INFO - PROCESS | 1939 | |4;audio-oscillator;92;71;85;70;69;69;86;68;67;87 19:16:29 INFO - PROCESS | 1939 | |5;imaging-gaussian-blur;86;85;85;85;86;86;85;85;87;87 19:16:29 INFO - PROCESS | 1939 | |6;imaging-darkroom;120;149;93;93;94;93;93;94;94;93 19:16:29 INFO - PROCESS | 1939 | |7;imaging-desaturate;90;125;87;87;87;87;82;87;85;86 19:16:29 INFO - PROCESS | 1939 | |8;json-parse-financial;58;59;59;59;59;58;57;58;59;58 19:16:29 INFO - PROCESS | 1939 | |9;json-stringify-tinderbox;66;75;76;75;72;71;69;71;70;70 19:16:29 INFO - PROCESS | 1939 | |10;stanford-crypto-aes;91;89;91;89;90;90;87;90;89;90 19:16:29 INFO - PROCESS | 1939 | |11;stanford-crypto-ccm;146;146;143;149;149;137;150;156;187;155 19:16:29 INFO - PROCESS | 1939 | |12;stanford-crypto-pbkdf2;176;170;172;152;222;236;184;177;175;176 19:16:29 INFO - PROCESS | 1939 | |13;stanford-crypto-sha256-iterative;68;68;68;67;65;67;66;67;67;67 19:16:29 INFO - PROCESS | 1939 | __end_tp_report 19:16:29 INFO - PROCESS | 1939 | __start_cc_report 19:16:29 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,2092 19:16:29 INFO - PROCESS | 1939 | __end_cc_report 19:16:29 INFO - PROCESS | 1939 | __startTimestamp1486869389912__endTimestamp 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | ------- Summary: start ------- 19:16:29 INFO - PROCESS | 1939 | Number of tests: 14 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 19:16:29 INFO - PROCESS | 1939 | Values: 113.0 111.0 113.0 111.0 111.0 111.0 112.0 111.0 112.0 112.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:117.50 stddev:21.34 (18.2%) stddev-sans-first:21.15 19:16:29 INFO - PROCESS | 1939 | Values: 146.0 111.0 107.0 153.0 114.0 112.0 112.0 121.0 163.0 104.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.93 (1.0%) stddev-sans-first:1.76 19:16:29 INFO - PROCESS | 1939 | Values: 187.0 183.0 185.0 186.0 183.0 181.0 184.0 186.0 182.0 185.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.00 stddev:11.11 (18.5%) stddev-sans-first:10.69 19:16:29 INFO - PROCESS | 1939 | Values: 79.0 60.0 59.0 89.0 60.0 58.0 59.0 59.0 75.0 59.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:78.00 stddev:9.78 (12.5%) stddev-sans-first:8.59 19:16:29 INFO - PROCESS | 1939 | Values: 92.0 71.0 85.0 70.0 69.0 69.0 86.0 68.0 67.0 87.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 19:16:29 INFO - PROCESS | 1939 | Values: 86.0 85.0 85.0 85.0 86.0 86.0 85.0 85.0 87.0 87.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:93.00 stddev:18.64 (20.0%) stddev-sans-first:18.55 19:16:29 INFO - PROCESS | 1939 | Values: 120.0 149.0 93.0 93.0 94.0 93.0 93.0 94.0 94.0 93.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#7] imaging-desaturate Cycles:10 Average:90.30 Median:87.00 stddev:12.36 (14.2%) stddev-sans-first:13.11 19:16:29 INFO - PROCESS | 1939 | Values: 90.0 125.0 87.0 87.0 87.0 87.0 82.0 87.0 85.0 86.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 19:16:29 INFO - PROCESS | 1939 | Values: 58.0 59.0 59.0 59.0 59.0 58.0 57.0 58.0 59.0 58.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.50 stddev:3.10 (4.3%) stddev-sans-first:2.57 19:16:29 INFO - PROCESS | 1939 | Values: 66.0 75.0 76.0 75.0 72.0 71.0 69.0 71.0 70.0 70.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:90.00 stddev:1.17 (1.3%) stddev-sans-first:1.13 19:16:29 INFO - PROCESS | 1939 | Values: 91.0 89.0 91.0 89.0 90.0 90.0 87.0 90.0 89.0 90.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:149.50 stddev:13.54 (9.1%) stddev-sans-first:14.20 19:16:29 INFO - PROCESS | 1939 | Values: 146.0 146.0 143.0 149.0 149.0 137.0 150.0 156.0 187.0 155.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:176.50 stddev:25.32 (14.3%) stddev-sans-first:26.69 19:16:29 INFO - PROCESS | 1939 | Values: 176.0 170.0 172.0 152.0 222.0 236.0 184.0 177.0 175.0 176.0 19:16:29 INFO - PROCESS | 1939 | 19:16:29 INFO - PROCESS | 1939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 19:16:29 INFO - PROCESS | 1939 | Values: 68.0 68.0 68.0 67.0 65.0 67.0 66.0 67.0 67.0 67.0 19:16:29 INFO - PROCESS | 1939 | -------- Summary: end -------- 19:16:29 INFO - PROCESS | 1939 | 19:16:30 INFO - TEST-INFO | 1939: exit 0 19:16:30 INFO - TEST-OK | kraken | took 60227ms 19:16:30 INFO - SUITE-END | took 1177s 19:16:31 INFO - Completed test suite (00:19:37) 19:16:31 INFO - javascript benchmark 19:16:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6858.928414793109, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.2654793383886, 3065.0038737410346, 3071.308955485015, 3081.969180308198, 3114.6573876873554, 5443.074677304858, 5518.668879867211, 5570.8607284817845, 5650.208970744099, 5681.517071048961, 5577.52591029763, 5581.6930068846195, 5584.497395234428, 5633.380328163898, 5633.577481688869, 4917.975410122945, 4988.4762099979525, 4999.9500004999845, 5159.922601160985, 5205.531502164805, 5068.72122033288, 5087.79648814047, 5161.793528258865, 5162.638615296931, 5167.7932882684645, 4900.9754951225195, 4968.279599458095, 4972.129877271481, 4978.975105124451, 4983.825566105169, 5032.220005899091, 5032.4212715537815, 5034.647574669774, 5095.923561146586, 5135.6148288878485, 4928.186849169882, 5007.749612519396, 5019.322391477177, 5025.648204625678, 5046.965372098711, 5264.341957255343, 5286.814961476368, 5306.257124002643, 5609.102543593006, 5627.155926611, 6051.818445446644, 6093.0, 6105.938940610581, 6123.984276525883, 6124.757675881256, 6141.631502109843, 6154.84612884677, 6188.659623720693, 6204.038374051984, 6214.751409943597, 5385.461453854661, 5676.801311954062, 5688.11834165705, 5690.032694441955, 5718.199452076713, 6102.664353460514, 6105.52039974972, 6111.166351794787, 6119.8681629442035, 6161.44546990773, 5700.771969121189, 5751.482366587027, 5759.827205183851, 5832.445917637818, 6001.699915004232, 6062.302835174011, 6104.890867003831, 6111.591738512237, 6118.284172697687, 6141.017437210115, 6014.0, 6040.788572399945, 6056.515478761688, 6056.788012419544, 6069.2716873975405, 5868.237129173265, 5922.052471604523, 6061.848453788691, 6061.939380606225, 6134.4172303631085, 4088.34586466164, 4799.736014519165, 4850.175470170079, 4853.708777473363, 4880.170371036932, 4059.594040595976, 4063.045184381668, 4083.244599749056, 4084.2852500812833, 4110.506739191316, 5395.136778115482, 5442.428545002796, 5511.641743286674, 5617.0, 5635.774569017275, 6135.0, 6224.782132625336, 6229.190205273376, 6230.43926046658, 6233.065040243909, 5450.100733379028, 5535.446455354432, 5599.60802743804, 5604.915926261109, 5646.237757902631, 5161.406438259573, 5244.816431424882, 5375.354957405137, 5389.272448219519, 5403.5136837684795, 6151.292601350902, 6161.876762464815, 6188.195534580475, 6204.069389591597, 6215.96892015537, 6182.938170618237, 6194.752209911733, 6195.597286176384, 6211.65835879013, 6214.098955651496, 6139.877202455837, 6203.8138855834395, 6208.751649933952, 6217.626942383471, 6222.408871157233, 5743.655380677173, 5808.273965754281, 5878.500327472042, 5878.500327472213, 5882.205902203319, 6067.726952287069, 6068.241469816273, 6070.0591408331775, 6071.150038994632, 6076.422739839708, 5851.180834683233, 5860.531157507304, 5865.706714664165, 5891.293044834647, 5925.881482370414, 5965.552583556164, 5969.373215812451, 5978.342382338026, 5983.0, 6005.759769609342, 5798.623089499169, 5801.941980580309, 5802.65184088956, 5835.387284335084, 5899.115132730125, 5719.399463056486, 5753.942460575341, 5758.740856661544, 5836.037053886062, 5864.266966629171, 4428.911421771482, 5727.11229759388, 5753.3958934311295, 5754.625949313281, 5781.277340332458], "value": 5513.807209649991, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.567997442353, 472.56287933661355, 484.2228223700962, 498.95468992460803, 504.2310476523304, 37595.4961801528, 38543.80728096359, 38757.0, 38810.611893881054, 38837.02907427316, 38771.03072423191, 39507.407388889114, 39951.60048399522, 39987.60012399875, 39998.60001399992, 7627.466077374558, 8883.46699198047, 9116.635334586608, 9135.497547634877, 9148.405353652024, 7810.648520816549, 9162.221211197022, 10559.0, 10839.945800270987, 10977.39624320662, 10872.955572439729, 10895.455227238646, 10991.450427478634, 10993.670189894316, 10996.780064398707, 7744.0, 10806.135509159287, 10811.378293255995, 10885.18361122919, 10936.56253749857, 7748.031496062992, 10532.315399499084, 10732.302400343953, 10801.83797243042, 10825.025747682668, 37080.62919370799, 37946.62053379486, 38002.61997380018, 38045.85862424104, 38264.61735382666, 3478.467690386662, 3484.6689564491335, 3507.929841403183, 3536.469529570559, 3602.9099272518133, 24247.03011879523, 27203.86398068017, 27934.301642458897, 28056.579151312748, 28119.859400702866, 2789.0, 2821.604975303459, 2891.6963718809643, 2897.985510072457, 2991.6559595646563, 397278.0, 397346.0, 398818.0, 399114.0, 399491.0, 48189.5181048192, 49986.250206246936, 58227.4177258222, 58598.0, 58832.11751823726, 51858.74070629698, 62503.37496624976, 63605.681971589845, 63787.36212637814, 63848.36151638517, 14643.92678036603, 14826.110433373817, 14833.480828170963, 14850.2574871256, 14858.702825943421, 11324.094072474183, 11388.544458221744, 11413.42932853354, 11437.085033197323, 11458.026067784165, 13007.0, 14264.215468149145, 14874.181919994504, 15785.21073946298, 16054.839451605334, 5889.9692553802915, 6251.28110267316, 6381.1385462962835, 6424.0, 6443.5167362448, 770.5068755996167, 811.1199348706601, 811.8877138320539, 842.6966292134827, 848.1772680499905, 24394.634080488806, 25071.498570028496, 28023.43953120926, 28911.7108828909, 29707.851460742557, 961.6393852305386, 965.2229954886244, 999.9900000999897, 1000.9949950250348, 1022.943738094412, 13302.66743331405, 14133.85866141346, 14158.212982859386, 14481.420743170154, 15083.773743393858, 443161.0, 629294.0, 638827.0, 639630.0, 786867.0, 51462.22806657903, 52116.0, 52207.73896130495, 52242.0, 52373.47626523762, 1289.9161554499115, 1314.80277958307, 1330.7272009238084, 1333.1601091312605, 1334.8998825087963, 25104.0, 27099.0, 27428.0, 27430.862845685642, 28190.0, 37661.81169094137, 44573.0, 44585.554144459435, 44617.88455288514, 44635.330470042325, 411612.0, 415337.0, 415968.0, 417493.0, 417499.0, 19357.741746786414, 20436.693449598566, 21222.78777212208, 23546.646800297665, 23692.8815355929, 36722.63277367192, 37004.0, 38092.04769880775, 39058.60941390663, 39168.412473813485, 30938.381232375676, 31514.684853151175, 31810.840945795124, 32641.34717305688, 32857.671423285465, 22462.88768556147, 29637.337535242954, 30377.392452151274, 31470.68529314769, 31548.842255789492, 31184.532232016085, 31610.36779264356, 31636.576354064582, 31752.206194845312, 31999.0, 21723.34829955104, 25625.871870640527, 27601.861990690722, 27639.894404223607, 28084.719152809026, 19721.21115155435, 20310.0, 21155.365339039854, 22148.114075437446, 22258.77741222567], "value": 17950.591310533786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.13935971746963, 390.7538250901931, 394.1879727760811, 399.9180168065547, 424.7409080460918, 13835.654108647277, 14009.719805603881, 16441.50675479736, 19290.4212873614, 20003.599928001433, 11986.041116710643, 15062.171580563065, 18289.725654115166, 20433.28483503074, 20667.1733130675, 5172.586193104561, 5392.514673679368, 5397.78408863645, 5400.83797486076, 5405.0, 5087.898242035157, 5234.816781412651, 5268.998890210867, 5313.73431328434, 5329.626926115174, 5310.176922577007, 5312.787488500456, 5317.9468205318035, 5321.3348331458565, 5325.627206095575, 5252.5010124038345, 5323.760430780624, 5692.37383887772, 5741.655500669973, 5745.597808153431, 5023.648344615878, 5076.18780995039, 5110.28456016158, 5118.0, 5144.099782538041, 12998.805017924738, 13147.605571832764, 13170.802437963439, 13222.537211197658, 16107.355705771755, 2000.9399718008483, 2406.9638955415685, 2410.457647029422, 2426.720927093389, 2445.29086564896, 9270.44377337362, 9569.425834449885, 9971.650992215238, 10119.595216191343, 10199.592016319339, 1627.9593010174722, 1665.6734207389702, 1670.7076261654283, 1676.9413070542473, 1725.2753843385683, 87260.0, 99919.0, 113027.43486282598, 122582.38708806399, 128128.0, 9505.809883802423, 10380.896191038144, 10519.84220236697, 11514.19400641947, 11727.941360293144, 15403.768943465857, 15409.768853467207, 15415.383384664712, 15431.459898903484, 15436.536903892902, 8010.719624813103, 8270.462419942805, 8299.253067223979, 8437.451565648213, 8446.0, 6808.863822723518, 7667.156612772591, 7886.960565197137, 7901.60491975399, 8100.392470564731, 4659.930101048487, 4682.145241450944, 4685.461171965268, 4692.6245900327895, 4810.542998415145, 1698.4989428118736, 1928.1227041695995, 2004.0, 2004.7446622549633, 2006.6789313709737, 834.7954751085902, 849.9702510412229, 866.5017614871474, 873.6811063961735, 879.0374539878823, 17049.48851534431, 20439.284625038053, 20835.79164208369, 21613.776993613603, 21681.02315386506, 847.8897743293332, 862.7368652561029, 876.6361959786744, 884.9513276769711, 894.4990805149138, 8466.0, 10344.32761870491, 11200.663980080612, 11203.887961120448, 11277.436128193722, 666551.0, 675887.0, 688723.0, 690033.0, 695832.5208373925, 100148.0, 124077.0, 136154.0, 139035.0, 144303.5569644311, 378.99431508527397, 454.7953420960581, 458.3102430841629, 458.37889659511546, 460.1693942433872, 10808.621698240524, 11015.889841101487, 11055.115590752559, 11209.271397359145, 11262.0, 53104.20343694925, 54691.179632306346, 57991.0, 59151.11273330989, 59170.0, 82985.17014829775, 83566.64333566594, 85179.0, 85523.14476855152, 87432.0, 8028.59857007159, 8123.228293312126, 8262.793430164294, 8345.624446900025, 8368.20502052304, 10299.485025748532, 12158.635240942785, 12320.322382269062, 12640.30478323701, 12645.367731613567, 10517.212938571132, 10549.314294570828, 10576.312539684895, 10727.249092563447, 10794.40630765284, 10426.791464170523, 10520.736981575521, 10605.098566621924, 10830.67507974762, 10851.0, 10622.309549879234, 10716.892831071902, 10928.672139835817, 10981.450927453436, 11080.279781814157, 7972.601369931596, 8102.918970810217, 8156.632951517315, 8203.179682031749, 8215.630296636546, 9137.634494620406, 10170.440625765654, 10672.83990740124, 10837.428572857048, 11014.44927753625], "value": 8779.06930246296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.145910994294, 1408.68304631458, 1410.1891412437847, 1419.708959663269, 1420.8579142085794, 8057.556834374107, 8455.619497122629, 8457.830843383128, 8458.196471335228, 8458.407911446202, 7985.0, 8309.626066826992, 8312.210340017704, 8398.454100483465, 8415.579221038954, 1688.5103320037174, 2273.318004598622, 2277.9202727904526, 2279.0200213908015, 2287.828412869033, 1987.801219878008, 2164.2425151197112, 2223.344113486525, 2224.2993457061057, 2228.55428914217, 1981.4154824326858, 2196.3959911024435, 2264.1509433962265, 2267.0, 2268.5689718953427, 2227.3652009177467, 2252.8197744180507, 2257.762934891829, 2261.5589959957897, 2264.4112530742127, 2269.614165591853, 2284.817214622826, 2290.358699564125, 2293.312006398074, 2293.3578597992587, 8404.453710508858, 8446.197611226986, 8485.0666426693, 8496.872546911802, 8516.616752246164, 4973.651844370896, 5063.367079115111, 5129.589632829365, 5130.640855140142, 5155.639105262633, 3169.5404166395742, 3179.952300715491, 3306.1404034950847, 3339.215284408162, 3431.0, 1161.3264306702092, 1168.5559487394821, 1169.9883001170049, 1188.4889497516065, 1223.3516236394726, 10650.520726567323, 10736.570537178504, 10754.946225268903, 10782.0, 10834.945825270823, 3582.659647333499, 4114.958850411457, 4321.222180007629, 4342.261815491374, 4425.911481770347, 8636.913630863737, 8764.342674299325, 8771.254443372258, 8792.076831932683, 8792.692255771017, 5097.719625420564, 5100.48995100487, 5101.107306221471, 5106.540411362995, 5119.692818430832, 4220.472440944882, 4571.954280457219, 4713.8350157745, 4717.150912835654, 4723.881902952454, 3570.285942811448, 3615.5661320641693, 3640.5449318835144, 3671.6695497405362, 3673.2286219893585, 1019.5972590826582, 1119.5409881948362, 1135.0635725526474, 1135.517405102828, 1138.8747237803834, 753.6231884057971, 783.8957727399448, 821.4373154389262, 878.0955615715823, 892.0588778838259, 4510.481294651091, 5295.523402893681, 5344.518993290622, 5577.860553486195, 5677.886442271131, 854.6154230596256, 952.6618050592078, 968.1915600473543, 1007.1741172238841, 1022.9437380943971, 2991.0, 3575.4994300797907, 3626.1869065467267, 3762.398016317376, 3772.660460558563, 9629.807403851884, 10081.949590252001, 10088.949555252177, 10110.848337274947, 10114.696559103239, 10025.799484010278, 10043.598256069676, 10048.397096174253, 10049.346792458467, 10070.899291006996, 7767.766966990999, 7837.529748215012, 7847.568383738949, 7850.057993040871, 7865.095514015847, 4795.760211989456, 5105.2086926526445, 5218.321618189763, 5504.449555044624, 5544.805931792368, 8906.599203036008, 9058.682946096855, 9101.590428430603, 9124.361294709306, 9264.95367523158, 9151.679691210775, 9276.1651451367, 9343.486108264111, 9425.858612120686, 9480.004599516951, 6570.5400621956005, 6663.067170596023, 6670.433013193739, 6675.532712710258, 6683.164604424447, 7718.768436946901, 7730.80172573252, 7749.845003100019, 7775.0, 7816.609169541386, 5491.807786727445, 6943.861122777617, 7069.858602828018, 7072.71709131629, 7084.149902011792, 5417.756200970887, 5472.50747432733, 6819.522633415613, 6977.581345119106, 7007.283215612208, 6271.43557079865, 6393.904091438725, 6406.135171751754, 6413.0701048348665, 6415.550911436155, 4700.623950084054, 4870.829520966749, 4925.655204135676, 4972.204447288416, 5003.849884503471, 3761.830717617659, 4829.782659780389, 4938.30863679078, 4974.801007959641, 4983.277424773315], "value": 4280.312464899392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.5822668510853, 344.5160393562415, 363.9727020473465, 364.37509670914375, 364.94890715299846, 5289.814856480024, 5317.627766056368, 5333.866653333659, 5336.2123688564325, 5367.946320536798, 4250.9160164158175, 5008.949910500894, 5206.505381988714, 5253.474652534745, 5292.941411717662, 3449.413599688059, 3914.4911161548957, 3945.7768091891608, 3963.346047902093, 3990.687729184784, 3996.200759848042, 4006.9799651001704, 4007.83968641254, 4010.2981978153853, 4010.6189911958318, 3473.4095203815286, 3495.91260218494, 3634.618365071669, 3977.741446805963, 3978.582248863871, 2980.2730501591127, 3636.2727454509204, 3924.6852304478034, 3925.489686340786, 3938.15329704115, 2777.250142461524, 2785.5403858363547, 3106.4874295741174, 3384.4415671414185, 3386.915327116817, 4634.814607415699, 4729.858104256878, 4844.467108618049, 5126.795477944483, 5165.4172913543225, 3937.208570100626, 4259.233337999159, 4309.4397728295435, 4460.821567137311, 4504.774761261924, 5248.475152484721, 5526.4078349073425, 5535.640183388067, 5540.750666220029, 5574.219609254707, 3743.4384842273876, 3755.830987605564, 3759.6240375962457, 3767.6044015378266, 3772.6793222576116, 5095.414027386861, 5462.918056229159, 5819.156222347736, 5846.450690567003, 5872.7357268923, 3379.8339572847326, 3497.440409534462, 3807.7815099168, 3819.350710379242, 3843.7693738375788, 3250.7724459288097, 3838.867534077454, 3858.1704933439446, 3860.3630400984084, 3861.67175790061, 4179.9462452450825, 4513.232750432434, 4513.796879140446, 4515.367848501212, 4552.795124219418, 4537.773111344485, 5602.215689803431, 5604.0, 5608.327000759935, 5696.098172751678, 1239.9504019839105, 1241.9753703194901, 1256.9245845249313, 1263.4125131813566, 1265.5127775806382, 718.5365439291733, 740.9666565004587, 788.964496597643, 797.8523973065002, 847.2882778466118, 4292.261634038219, 4296.5273819879785, 4444.0, 4906.582940450102, 4930.827421040246, 4795.112904112751, 5462.863428414322, 5467.250479846491, 5489.835304940858, 5520.972395138079, 4390.407295015196, 4583.4041574595085, 4913.290465698375, 4964.425613558233, 4992.750362481934, 2431.33138386945, 2466.3217615155977, 2467.642191882167, 2809.2555472799722, 2856.671482779507, 5552.833414997556, 5628.467189764622, 5679.914801277984, 5681.437604658669, 5754.338251101177, 4690.554397332248, 5206.210286536396, 5259.002368649909, 5296.993571221456, 5832.737526811304, 5169.0, 5442.945570544244, 5846.649201047951, 5936.643801371932, 5967.701614919237, 4821.566059054702, 5503.394626591152, 5739.426057394227, 5745.597808153556, 5761.0700415361325, 5116.313935184058, 5647.063526965872, 5696.857578560569, 5718.714064296685, 5728.598998070095, 5076.36545431821, 5359.222912677562, 5947.609862378403, 5950.851228719143, 5961.76433837311, 3671.9816400918894, 3953.5058117735284, 4084.6528045116497, 4137.710360274752, 4144.626983571493, 5318.867028324323, 5486.423925487767, 5701.857453563694, 5733.684647344436, 5781.94218057814, 5364.544013758874, 5379.35447746273, 5633.464820842013, 5655.802046928502, 5676.858078548069, 4641.814327426865, 4690.646187975613, 5080.49195080489, 5636.689982051026, 5662.745176466987, 4822.83956166898, 5418.241446197614, 5484.0, 5518.530924871431, 5529.612927095226, 5130.384353877558, 5166.966606678604, 5409.783608655767, 5610.5231055360755, 5638.830835074954, 4001.998501124157, 4357.891052723708, 4990.051890140861, 4991.926735751686, 5115.335006449138], "value": 3973.009202485547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.542827451137, 635.8315046512672, 662.7349060375849, 727.428968259916, 765.7128576783706, 14034.368453419595, 14387.352569134388, 14688.971771975952, 14827.555173344803, 15161.848381516182, 13138.802917956215, 13313.400896959636, 13556.254406007665, 13613.047086703935, 13617.0, 850.7022542110259, 877.6313948141795, 877.9078196789341, 882.095851751953, 882.2060145868737, 827.4538804389105, 861.7543999960012, 863.0549548244662, 866.6879923227633, 867.3408209760564, 905.5834316214549, 909.0046399192873, 909.6588779207797, 910.5947853205327, 911.3574929674596, 899.9685011024583, 900.504722402676, 901.0, 901.5041727050162, 905.7780843693272, 670.587588632992, 671.3856821008771, 671.576906548876, 671.8320419895026, 674.5143496682381, 14453.0, 14544.2000689962, 14676.0, 14685.559433216913, 14904.403823847033, 12774.297413642245, 12782.233066015975, 12800.80798788019, 13092.607221783363, 13192.6701832454, 10422.270441069128, 10570.20723445737, 10605.469726513644, 10615.628453004108, 10638.840417393745, 3352.580927384077, 3376.679215474526, 3398.0, 3440.70753985909, 3488.3372159289906, 98032.50983745107, 98741.0, 100264.99205023861, 100294.0, 101735.0, 9175.678851240174, 9271.768205794775, 9282.90717092834, 9377.202937750231, 9492.430454172772, 21041.842698651722, 21803.781962180492, 21814.345569632937, 21815.23646672359, 21842.89078554597, 6834.316568343126, 6866.0, 6947.548409353376, 7015.751974574668, 7114.928850711427, 3625.8005809680194, 3633.563972323338, 3644.526211592529, 3647.1429214134655, 3693.279810436939, 3405.6934875860798, 3445.672661097192, 3459.273552553992, 3521.2781379817075, 3535.4520049392386, 599.7241269016301, 602.8432607522076, 613.2732711736606, 615.0773839241139, 621.4034526854181, 576.3573615418861, 594.4976494861835, 604.7853012180612, 628.5537268539297, 659.1069101367577, 8271.710490132817, 8367.874481882776, 8385.95807020961, 8434.57827108642, 8501.914980850112, 492.02081397139943, 520.2482412913304, 525.9526642602184, 528.4530510921178, 549.8927709096768, 4093.099518106012, 4351.521332653406, 5062.291279220912, 5090.211017292326, 5099.617528685363, 67069.66465167643, 77135.22864771393, 78200.04499887548, 97791.1325320483, 104959.0, 87102.56448717717, 87847.0, 89300.6604900927, 89917.55041224883, 90680.63979040319, 75548.15681334077, 76210.61894690491, 77590.61204694053, 77864.61067694625, 79254.60372698099, 10108.545115469675, 10120.190384769054, 10140.594376224868, 10157.238207134347, 10208.897911020795, 44674.55325446704, 47992.760036199594, 49144.75427622982, 49732.0, 50325.0, 65905.1256542665, 66989.33010669831, 67672.0, 68957.0, 71493.28506714867, 9447.763805904633, 11696.590619328283, 12005.279683219034, 12105.81841272364, 12529.248245105322, 12981.870181298065, 13263.403146858222, 13589.32053397346, 13660.521881734092, 14069.859301406856, 12637.431315590637, 12662.0, 12732.0, 12816.423260953094, 12943.870561294643, 12308.276841242412, 12794.232346059267, 12796.808047879476, 12927.030472714396, 13272.402741876831, 12446.37768111609, 12482.875171248172, 12505.749885002067, 12663.366831658195, 12938.935305323414, 9696.369735967139, 10074.395536267848, 10244.136899010446, 10322.329048611817, 10513.167690070946, 8171.896793932743, 9979.351342163027, 10318.845217321596, 10431.582736690447, 10794.514246859067], "value": 7045.613925489066, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 111.0, 111.0, 111.0, 112.0, 111.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 107.0, 153.0, 114.0, 112.0, 112.0, 121.0, 163.0, 104.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 185.0, 186.0, 183.0, 181.0, 184.0, 186.0, 182.0, 185.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 89.0, 60.0, 58.0, 59.0, 59.0, 75.0, 59.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 71.0, 85.0, 70.0, 69.0, 69.0, 86.0, 68.0, 67.0, 87.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 85.0, 87.0, 87.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 149.0, 93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 125.0, 87.0, 87.0, 87.0, 87.0, 82.0, 87.0, 85.0, 86.0], "value": 90.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 57.0, 58.0, 59.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 76.0, 75.0, 72.0, 71.0, 69.0, 71.0, 70.0, 70.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 89.0, 90.0, 90.0, 87.0, 90.0, 89.0, 90.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 143.0, 149.0, 149.0, 137.0, 150.0, 156.0, 187.0, 155.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 172.0, 152.0, 222.0, 236.0, 184.0, 177.0, 175.0, 176.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 65.0, 67.0, 66.0, 67.0, 67.0, 67.0], "value": 67.0, "unit": "score"}]}]} 19:16:31 INFO - Return code: 0 19:16:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:16:31 ERROR - # TBPL SUCCESS # 19:16:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:16:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:16:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:16:31 INFO - 2017-02-11 19:16:31.251 screenresolution[1943:20460] starting screenresolution argv=screenresolution get 19:16:31 INFO - 2017-02-11 19:16:31.254 screenresolution[1943:20460] Display 0: 1600x1200x32@60 19:16:31 INFO - 2017-02-11 19:16:31.261 screenresolution[1944:20463] starting screenresolution argv=screenresolution list 19:16:31 INFO - Available Modes on Display 0 19:16:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:16:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:16:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:16:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:16:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:16:31 INFO - Intel Iris: 19:16:31 INFO - Chipset Model: Intel Iris 19:16:31 INFO - Type: GPU 19:16:31 INFO - Bus: Built-In 19:16:31 INFO - VRAM (Dynamic, Max): 1536 MB 19:16:31 INFO - Vendor: Intel (0x8086) 19:16:31 INFO - Device ID: 0x0a2e 19:16:31 INFO - Revision ID: 0x0009 19:16:31 INFO - Displays: 19:16:31 INFO - Display: 19:16:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:16:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:16:31 INFO - Display Serial Number: 1600x1200 60 19:16:31 INFO - Main Display: Yes 19:16:31 INFO - Mirror: Off 19:16:31 INFO - Online: Yes 19:16:31 INFO - Rotation: Supported 19:16:31 INFO - Return code: 0 19:16:31 INFO - Running post-action listener: _resource_record_post_action 19:16:31 INFO - [mozharness: 2017-02-12 03:16:31.496633Z] Finished run-tests step (success) 19:16:31 INFO - Running post-run listener: _resource_record_post_run 19:16:31 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 1261568; Write bytes: 561115648; Read time: 13; Write time: 1739 19:16:31 INFO - TinderboxPrint: CPU usage
53.7% 19:16:31 INFO - TinderboxPrint: I/O read bytes / time
1,261,568 / 13 19:16:31 INFO - TinderboxPrint: I/O write bytes / time
561,115,648 / 1,739 19:16:31 INFO - TinderboxPrint: CPU idle
2,224.7 (46.3%) 19:16:31 INFO - TinderboxPrint: CPU system
958.7 (20.0%) 19:16:31 INFO - TinderboxPrint: CPU user
1,618.3 (33.7%) 19:16:31 INFO - TinderboxPrint: Swap in / out
253,677,568 / 0 19:16:31 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 253770240; Write bytes: 256267776; Read time: 18197; Write time: 545 19:16:31 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1216512; Write bytes: 300282880; Read time: 12; Write time: 1144 19:16:31 INFO - Running post-run listener: _upload_blobber_files 19:16:31 INFO - Blob upload gear active. 19:16:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:16:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:16:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:16:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:16:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:33 INFO - (blobuploader) - INFO - Done attempting. 19:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:34 INFO - (blobuploader) - INFO - Done attempting. 19:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:16:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:36 INFO - (blobuploader) - INFO - Done attempting. 19:16:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:16:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:38 INFO - (blobuploader) - INFO - Done attempting. 19:16:38 INFO - (blobuploader) - INFO - Iteration through files over. 19:16:38 INFO - Return code: 0 19:16:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:16:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:16:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3b57905745922699480af14d2991268bf0320752c160c0019e9d0e258659cdbb449ba989132cf887e840d50a2c5e5138cc5ff113d1d69de400daad9ca4aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/425b742cccc200e5a5f0f042cc0cc6b45c7a118a3a88a45a7983e8f26895b636b1ff08156fcf97e9d0fdf5536d4091144af9eec0bf462b78ee6bf7c4dbbe3179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00baf1031b88e27690f7e32599ac91e68685f240e278a1821789bcd818ba05f9105bc695c53354bcaea91fe607c3428f3273b7fab08a557bc916c858596314d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722b0395ea6a79d749fe8d04817b33ef9e58d8174806ebeea25563a8f0d47d232388517cefbc03551cd79866cea70eac545395c68258836f35863697215cb4d0"} 19:16:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:16:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:16:38 INFO - Contents: 19:16:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3b57905745922699480af14d2991268bf0320752c160c0019e9d0e258659cdbb449ba989132cf887e840d50a2c5e5138cc5ff113d1d69de400daad9ca4aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/425b742cccc200e5a5f0f042cc0cc6b45c7a118a3a88a45a7983e8f26895b636b1ff08156fcf97e9d0fdf5536d4091144af9eec0bf462b78ee6bf7c4dbbe3179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00baf1031b88e27690f7e32599ac91e68685f240e278a1821789bcd818ba05f9105bc695c53354bcaea91fe607c3428f3273b7fab08a557bc916c858596314d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722b0395ea6a79d749fe8d04817b33ef9e58d8174806ebeea25563a8f0d47d232388517cefbc03551cd79866cea70eac545395c68258836f35863697215cb4d0"} 19:16:38 INFO - Running post-run listener: copy_logs_to_upload_dir 19:16:38 INFO - Copying logs to upload dir... 19:16:38 INFO - mkdir: /builds/slave/test/build/upload/logs 19:16:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.690389 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-02-11 19:16:38.649694) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-11 19:16:38.654203) ========= 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.v9JBSvorp1/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.70ikqYV9k6/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3b57905745922699480af14d2991268bf0320752c160c0019e9d0e258659cdbb449ba989132cf887e840d50a2c5e5138cc5ff113d1d69de400daad9ca4aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/425b742cccc200e5a5f0f042cc0cc6b45c7a118a3a88a45a7983e8f26895b636b1ff08156fcf97e9d0fdf5536d4091144af9eec0bf462b78ee6bf7c4dbbe3179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00baf1031b88e27690f7e32599ac91e68685f240e278a1821789bcd818ba05f9105bc695c53354bcaea91fe607c3428f3273b7fab08a557bc916c858596314d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722b0395ea6a79d749fe8d04817b33ef9e58d8174806ebeea25563a8f0d47d232388517cefbc03551cd79866cea70eac545395c68258836f35863697215cb4d0"} build_url:https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/GzPepZ70ROuRwHqncvDRvg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3b57905745922699480af14d2991268bf0320752c160c0019e9d0e258659cdbb449ba989132cf887e840d50a2c5e5138cc5ff113d1d69de400daad9ca4aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/425b742cccc200e5a5f0f042cc0cc6b45c7a118a3a88a45a7983e8f26895b636b1ff08156fcf97e9d0fdf5536d4091144af9eec0bf462b78ee6bf7c4dbbe3179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00baf1031b88e27690f7e32599ac91e68685f240e278a1821789bcd818ba05f9105bc695c53354bcaea91fe607c3428f3273b7fab08a557bc916c858596314d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/722b0395ea6a79d749fe8d04817b33ef9e58d8174806ebeea25563a8f0d47d232388517cefbc03551cd79866cea70eac545395c68258836f35863697215cb4d0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-11 19:16:38.693884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 19:16:38.694306) ========= 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.v9JBSvorp1/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.70ikqYV9k6/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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.005418 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 19:16:38.743113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-11 19:16:38.743434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-11 19:16:38.743759) ========= ========= Total master_lag: 0.19 =========