builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0206 starttime: 1489798094.9 results: success (0) buildid: 20170317161920 builduid: b3d2e518d0df4c798087b4809bdf6170 revision: de2b6ddee3456ff8493ea5fbd8255efb7682862b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:14.901130) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:14.901653) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:14.901986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:14.928399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:14.928973) ========= 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.h59RtgtNLK/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.6eqfSz8JUL/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-17 17:48:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.67M=0.002s 2017-03-17 17:48:15 (7.67 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121895 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:15.076400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:15.076840) ========= 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.h59RtgtNLK/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.6eqfSz8JUL/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.021595 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:15.126363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-17 17:48:15.126867) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev de2b6ddee3456ff8493ea5fbd8255efb7682862b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev de2b6ddee3456ff8493ea5fbd8255efb7682862b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h59RtgtNLK/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.6eqfSz8JUL/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-17 17:48:15,220 truncating revision to first 12 chars 2017-03-17 17:48:15,220 Setting DEBUG logging. 2017-03-17 17:48:15,220 attempt 1/10 2017-03-17 17:48:15,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/de2b6ddee345?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 17:48:17,397 unpacking tar archive at: mozilla-beta-de2b6ddee345/testing/mozharness/ program finished with exit code 0 elapsedTime=2.431081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-17 17:48:17.582796) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:17.583195) ========= script_repo_revision: de2b6ddee3456ff8493ea5fbd8255efb7682862b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:17.583645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:17.584088) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 17:48:17.604163) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-17 17:48:17.604540) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h59RtgtNLK/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.6eqfSz8JUL/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:48:17 INFO - MultiFileLogger online at 20170317 17:48:17 in /builds/slave/test 17:48:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:48:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:48:17 INFO - {'append_to_log': False, 17:48:17 INFO - 'base_work_dir': '/builds/slave/test', 17:48:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:48:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:48:17 INFO - 'branch': 'Mozilla-Beta', 17:48:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:48:17 INFO - 'config_files': ('talos/mac_config.py',), 17:48:17 INFO - 'default_actions': ('clobber', 17:48:17 INFO - 'read-buildbot-config', 17:48:17 INFO - 'download-and-extract', 17:48:17 INFO - 'populate-webroot', 17:48:17 INFO - 'create-virtualenv', 17:48:17 INFO - 'install', 17:48:17 INFO - 'run-tests'), 17:48:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:48:17 INFO - 'download_minidump_stackwalk': True, 17:48:17 INFO - 'download_symbols': 'ondemand', 17:48:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:48:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:48:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:48:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:48:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:48:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:48:17 INFO - 'installer_path': 'installer.exe', 17:48:17 INFO - 'log_level': 'info', 17:48:17 INFO - 'log_name': 'talos', 17:48:17 INFO - 'log_to_console': True, 17:48:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:48:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:48:17 INFO - 'opt_config_files': (), 17:48:17 INFO - 'pip_index': False, 17:48:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:48:17 INFO - 'cmd': ('bash', 17:48:17 INFO - '-c', 17:48:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:48:17 INFO - 'enabled': True, 17:48:17 INFO - 'halt_on_failure': False, 17:48:17 INFO - 'name': 'check_screen_resolution'},), 17:48:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:48:17 INFO - 'cmd': ('bash', 17:48:17 INFO - '-c', 17:48:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:48:17 INFO - 'enabled': True, 17:48:17 INFO - 'halt_on_failure': False, 17:48:17 INFO - 'name': 'check_screen_resolution'},), 17:48:17 INFO - 'run_cmd_checks_enabled': True, 17:48:17 INFO - 'sps_profile': False, 17:48:17 INFO - 'sps_profile_interval': 0, 17:48:17 INFO - 'suite': 'dromaeojs', 17:48:17 INFO - 'system_bits': '32', 17:48:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:48:17 INFO - 'title': 't-yosemite-r7-0206', 17:48:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:48:17 INFO - 'use_talos_json': True, 17:48:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:48:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:48:17 INFO - 'work_dir': 'build'} 17:48:17 INFO - [mozharness: 2017-03-18 00:48:17.815499Z] Running clobber step. 17:48:17 INFO - Running pre-action listener: _resource_record_pre_action 17:48:17 INFO - Running main action method: clobber 17:48:17 INFO - rmtree: /builds/slave/test/build 17:48:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:48:19 INFO - Running post-action listener: _resource_record_post_action 17:48:19 INFO - [mozharness: 2017-03-18 00:48:19.520050Z] Finished clobber step (success) 17:48:19 INFO - [mozharness: 2017-03-18 00:48:19.520167Z] Running read-buildbot-config step. 17:48:19 INFO - Running pre-action listener: _resource_record_pre_action 17:48:19 INFO - Running main action method: read_buildbot_config 17:48:19 INFO - Using buildbot properties: 17:48:19 INFO - { 17:48:19 INFO - "project": "", 17:48:19 INFO - "product": "firefox", 17:48:19 INFO - "script_repo_revision": "production", 17:48:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:48:19 INFO - "repository": "", 17:48:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:48:19 INFO - "buildid": "20170317161920", 17:48:19 INFO - "pgo_build": "False", 17:48:19 INFO - "basedir": "/builds/slave/test", 17:48:19 INFO - "buildnumber": 57, 17:48:19 INFO - "slavename": "t-yosemite-r7-0206", 17:48:19 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:48:19 INFO - "platform": "yosemite_r7", 17:48:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:48:19 INFO - "branch": "mozilla-beta", 17:48:19 INFO - "repo_path": "releases/mozilla-beta", 17:48:19 INFO - "revision": "de2b6ddee3456ff8493ea5fbd8255efb7682862b", 17:48:19 INFO - "stage_platform": "macosx64", 17:48:19 INFO - "builduid": "b3d2e518d0df4c798087b4809bdf6170", 17:48:19 INFO - "slavebuilddir": "test" 17:48:19 INFO - } 17:48:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 17:48:19 INFO - Running post-action listener: _resource_record_post_action 17:48:19 INFO - [mozharness: 2017-03-18 00:48:19.523500Z] Finished read-buildbot-config step (success) 17:48:19 INFO - [mozharness: 2017-03-18 00:48:19.523637Z] Running download-and-extract step. 17:48:19 INFO - Running pre-action listener: _resource_record_pre_action 17:48:19 INFO - Running main action method: download_and_extract 17:48:19 INFO - mkdir: /builds/slave/test/build/tests 17:48:19 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')]} 17:48:19 INFO - trying https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 17:48:19 INFO - Downloading https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 17:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 17:48:20 INFO - Downloaded 1165 bytes. 17:48:20 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 17:48:20 INFO - Using the following test package requirements: 17:48:20 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 17:48:20 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:48:20 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 17:48:20 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:48:20 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 17:48:20 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:48:20 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:48:20 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 17:48:20 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 17:48:20 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:48:20 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 17:48:20 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:48:20 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 17:48:20 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:48:20 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 17:48:20 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 17:48:20 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 17:48:20 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 17:48:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 17:48:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 17:48:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 17:48:21 INFO - Expected file size: 16108187 17:48:21 INFO - Obtained file size: 16108187 17:48:28 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:48:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 17:48:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 17:48:28 INFO - Fetch https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 17:48:29 INFO - Expected file size: 16108187 17:48:29 INFO - Obtained file size: 16108187 17:48:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 17:48:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 17:48:35 INFO - Fetch https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 17:48:36 INFO - Expected file size: 14403650 17:48:36 INFO - Obtained file size: 14403650 17:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:48:36 INFO - trying https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:48:36 INFO - Downloading https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 17:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 17:48:38 INFO - Downloaded 58718286 bytes. 17:48:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:48:38 INFO - mkdir: /builds/slave/test/properties 17:48:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:48:38 INFO - Writing to file /builds/slave/test/properties/build_url 17:48:38 INFO - Contents: 17:48:38 INFO - build_url:https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 17:48:39 INFO - Running post-action listener: _resource_record_post_action 17:48:39 INFO - Running post-action listener: set_extra_try_arguments 17:48:39 INFO - [mozharness: 2017-03-18 00:48:39.449726Z] Finished download-and-extract step (success) 17:48:39 INFO - [mozharness: 2017-03-18 00:48:39.449863Z] Running populate-webroot step. 17:48:39 INFO - Running pre-action listener: _resource_record_pre_action 17:48:39 INFO - Running main action method: populate_webroot 17:48:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:48:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:48:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:48:39 INFO - '--tppagecycles', 17:48:39 INFO - '7'], 17:48:39 INFO - 'tests': ['tsvgm']}}, 17:48:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:48:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:48:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:48:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:48:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:48:39 INFO - 'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:48:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:48:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:48:39 INFO - 'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['damp', 'tps']}, 17:48:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:48:39 INFO - 'tests': ['damp', 'tps']}, 17:48:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['dromaeo_dom']}, 17:48:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:48:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['basic_compositor_video']}, 17:48:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:48:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['a11yr', 17:48:39 INFO - 'ts_paint', 17:48:39 INFO - 'tpaint', 17:48:39 INFO - 'sessionrestore', 17:48:39 INFO - 'sessionrestore_no_auto_restore', 17:48:39 INFO - 'tabpaint']}, 17:48:39 INFO - 'other-e10s': {'tests': ['a11yr', 17:48:39 INFO - 'ts_paint', 17:48:39 INFO - 'tpaint', 17:48:39 INFO - 'sessionrestore', 17:48:39 INFO - 'sessionrestore_no_auto_restore', 17:48:39 INFO - 'tabpaint']}, 17:48:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:48:39 INFO - 'ts_paint', 17:48:39 INFO - 'tpaint', 17:48:39 INFO - 'sessionrestore', 17:48:39 INFO - 'sessionrestore_no_auto_restore', 17:48:39 INFO - 'tabpaint']}, 17:48:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:48:39 INFO - 'ts_paint', 17:48:39 INFO - 'tpaint', 17:48:39 INFO - 'sessionrestore', 17:48:39 INFO - 'sessionrestore_no_auto_restore', 17:48:39 INFO - 'tabpaint']}, 17:48:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['a11yr', 17:48:39 INFO - 'ts_paint', 17:48:39 INFO - 'tpaint', 17:48:39 INFO - 'sessionrestore', 17:48:39 INFO - 'sessionrestore_no_auto_restore', 17:48:39 INFO - 'tabpaint']}, 17:48:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['a11yr', 17:48:39 INFO - 'ts_paint', 17:48:39 INFO - 'tpaint', 17:48:39 INFO - 'sessionrestore', 17:48:39 INFO - 'sessionrestore_no_auto_restore', 17:48:39 INFO - 'tabpaint']}, 17:48:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['tsvgx', 17:48:39 INFO - 'tsvgr_opacity', 17:48:39 INFO - 'tart', 17:48:39 INFO - 'tscrollx', 17:48:39 INFO - 'cart', 17:48:39 INFO - 'tsvg_static']}, 17:48:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:48:39 INFO - 'tsvgr_opacity', 17:48:39 INFO - 'tart', 17:48:39 INFO - 'tscrollx', 17:48:39 INFO - 'cart', 17:48:39 INFO - 'tsvg_static']}, 17:48:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:48:39 INFO - 'talos_options': ['--disable-e10s'], 17:48:39 INFO - 'tests': ['tp5o']}, 17:48:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:48:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:48:39 INFO - 'talos_options': ['--disable-e10s', 17:48:39 INFO - '--xperf_path', 17:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:48:39 INFO - 'tests': ['tp5n']}, 17:48:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:48:39 INFO - 'talos_options': ['--xperf_path', 17:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:48:39 INFO - 'tests': ['tp5n']}}, 17:48:39 INFO - 'talos.zip': {'path': '', 17:48:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:48:39 INFO - Running post-action listener: _resource_record_post_action 17:48:39 INFO - [mozharness: 2017-03-18 00:48:39.468623Z] Finished populate-webroot step (success) 17:48:39 INFO - [mozharness: 2017-03-18 00:48:39.468755Z] Running create-virtualenv step. 17:48:39 INFO - Running pre-action listener: _resource_record_pre_action 17:48:39 INFO - Running main action method: create_virtualenv 17:48:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:48:39 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 17:48:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:48:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:48:39 INFO - Using real prefix '/tools/python27' 17:48:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:48:40 INFO - Installing distribute.............................................................................................................................................................................................done. 17:48:43 INFO - Installing pip.................done. 17:48:43 INFO - Return code: 0 17:48:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:48:43 INFO - Reading from file tmpfile_stdout 17:48:43 INFO - Output received: 17:48:43 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) 17:48:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:43 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:48:43 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 17:48:43 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 17:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:43 INFO - 'HOME': '/Users/cltbld', 17:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:43 INFO - 'LOGNAME': 'cltbld', 17:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:43 INFO - 'MOZ_NO_REMOTE': '1', 17:48:43 INFO - 'NO_EM_RESTART': '1', 17:48:43 INFO - 'PAGER': '/bin/cat', 17:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:43 INFO - 'PWD': '/builds/slave/test', 17:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:43 INFO - 'SHELL': '/bin/bash', 17:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:48:43 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:43 INFO - 'USER': 'cltbld', 17:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:43 INFO - 'XPC_FLAGS': '0x0', 17:48:43 INFO - 'XPC_SERVICE_NAME': '0', 17:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:43 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 17:48:43 INFO - Cleaning up... 17:48:43 INFO - Return code: 0 17:48:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:43 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:48:43 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 17:48:43 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 17:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:43 INFO - 'HOME': '/Users/cltbld', 17:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:43 INFO - 'LOGNAME': 'cltbld', 17:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:43 INFO - 'MOZ_NO_REMOTE': '1', 17:48:43 INFO - 'NO_EM_RESTART': '1', 17:48:43 INFO - 'PAGER': '/bin/cat', 17:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:43 INFO - 'PWD': '/builds/slave/test', 17:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:43 INFO - 'SHELL': '/bin/bash', 17:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:48:43 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:43 INFO - 'USER': 'cltbld', 17:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:43 INFO - 'XPC_FLAGS': '0x0', 17:48:43 INFO - 'XPC_SERVICE_NAME': '0', 17:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:43 INFO - Downloading/unpacking psutil>=3.1.1 17:48:43 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 17:48:43 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 17:48:43 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 17:48:43 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 17:48:43 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 17:48:43 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 17:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:48:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:48:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:48:47 INFO - Installing collected packages: psutil 17:48:47 INFO - Running setup.py install for psutil 17:48:47 INFO - building 'psutil._psutil_osx' extension 17:48:47 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 17:48:47 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 17:48:47 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 17:48:48 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 17:48:48 INFO - building 'psutil._psutil_posix' extension 17:48:48 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 17:48:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:48:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:48:48 INFO - ^ 17:48:48 INFO - 1 warning generated. 17:48:48 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 17:48:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:48:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:48:48 INFO - Successfully installed psutil 17:48:48 INFO - Cleaning up... 17:48:48 INFO - Return code: 0 17:48:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:48:48 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')]} 17:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:48 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')]} 17:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:48 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:48:48 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 17:48:48 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 17:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:48 INFO - 'HOME': '/Users/cltbld', 17:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:48 INFO - 'LOGNAME': 'cltbld', 17:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:48 INFO - 'MOZ_NO_REMOTE': '1', 17:48:48 INFO - 'NO_EM_RESTART': '1', 17:48:48 INFO - 'PAGER': '/bin/cat', 17:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:48 INFO - 'PWD': '/builds/slave/test', 17:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:48 INFO - 'SHELL': '/bin/bash', 17:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:48:48 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:48 INFO - 'USER': 'cltbld', 17:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:48 INFO - 'XPC_FLAGS': '0x0', 17:48:48 INFO - 'XPC_SERVICE_NAME': '0', 17:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:48:48 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 17:48:48 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 17:48:48 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 17:48:48 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 17:48:48 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 17:48:48 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 17:48:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:48:51 INFO - Installing collected packages: mozsystemmonitor 17:48:51 INFO - Running setup.py install for mozsystemmonitor 17:48:51 INFO - Successfully installed mozsystemmonitor 17:48:51 INFO - Cleaning up... 17:48:51 INFO - Return code: 0 17:48:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:48:51 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 17:48:51 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 17:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:51 INFO - 'HOME': '/Users/cltbld', 17:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:51 INFO - 'LOGNAME': 'cltbld', 17:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:51 INFO - 'MOZ_NO_REMOTE': '1', 17:48:51 INFO - 'NO_EM_RESTART': '1', 17:48:51 INFO - 'PAGER': '/bin/cat', 17:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:51 INFO - 'PWD': '/builds/slave/test', 17:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:51 INFO - 'SHELL': '/bin/bash', 17:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:48:51 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:51 INFO - 'USER': 'cltbld', 17:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:51 INFO - 'XPC_FLAGS': '0x0', 17:48:51 INFO - 'XPC_SERVICE_NAME': '0', 17:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:51 INFO - Downloading/unpacking jsonschema==2.5.1 17:48:51 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 17:48:51 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 17:48:51 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 17:48:51 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 17:48:51 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 17:48:51 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 17:48:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:48:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:48:54 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 17:48:54 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 17:48:54 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 17:48:54 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 17:48:54 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 17:48:54 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 17:48:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:48:54 INFO - warning: no files found matching '*.txt' 17:48:54 INFO - no previously-included directories found matching 'build' 17:48:54 INFO - no previously-included directories found matching 'dist' 17:48:54 INFO - no previously-included directories found matching '.git*' 17:48:54 INFO - Installing collected packages: jsonschema, functools32 17:48:54 INFO - Running setup.py install for functools32 17:48:55 INFO - warning: no files found matching '*.txt' 17:48:55 INFO - no previously-included directories found matching 'build' 17:48:55 INFO - no previously-included directories found matching 'dist' 17:48:55 INFO - no previously-included directories found matching '.git*' 17:48:55 INFO - Successfully installed jsonschema functools32 17:48:55 INFO - Cleaning up... 17:48:55 INFO - Return code: 0 17:48:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:48: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')]} 17:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48: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')]} 17:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:55 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:48:55 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 17:48:55 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 17:48:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:48:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:55 INFO - 'HOME': '/Users/cltbld', 17:48:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:55 INFO - 'LOGNAME': 'cltbld', 17:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:55 INFO - 'MOZ_NO_REMOTE': '1', 17:48:55 INFO - 'NO_EM_RESTART': '1', 17:48:55 INFO - 'PAGER': '/bin/cat', 17:48:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:55 INFO - 'PWD': '/builds/slave/test', 17:48:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:55 INFO - 'SHELL': '/bin/bash', 17:48:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:48:55 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:48:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:55 INFO - 'USER': 'cltbld', 17:48:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:55 INFO - 'XPC_FLAGS': '0x0', 17:48:55 INFO - 'XPC_SERVICE_NAME': '0', 17:48:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:48:55 INFO - Cleaning up... 17:48:55 INFO - Return code: 0 17:48:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:48: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')]} 17:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48: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')]} 17:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:55 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:48:55 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 17:48:55 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 17:48:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:48:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:55 INFO - 'HOME': '/Users/cltbld', 17:48:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:55 INFO - 'LOGNAME': 'cltbld', 17:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:55 INFO - 'MOZ_NO_REMOTE': '1', 17:48:55 INFO - 'NO_EM_RESTART': '1', 17:48:55 INFO - 'PAGER': '/bin/cat', 17:48:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:55 INFO - 'PWD': '/builds/slave/test', 17:48:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:55 INFO - 'SHELL': '/bin/bash', 17:48:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:48:55 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:48:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:55 INFO - 'USER': 'cltbld', 17:48:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:55 INFO - 'XPC_FLAGS': '0x0', 17:48:55 INFO - 'XPC_SERVICE_NAME': '0', 17:48:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:48:55 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 17:48:55 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 17:48:55 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 17:48:55 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 17:48:55 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 17:48:55 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 17:48:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:48:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:48:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:48:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:48:59 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 17:48:59 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 17:48:59 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 17:48:59 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 17:48:59 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 17:48:59 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 17:48:59 INFO - Downloading docopt-0.6.1.tar.gz 17:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:48:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:48:59 INFO - Running setup.py install for blobuploader 17:48:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:48:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:48:59 INFO - Running setup.py install for requests 17:49:00 INFO - Running setup.py install for docopt 17:49:00 INFO - Successfully installed blobuploader requests docopt 17:49:00 INFO - Cleaning up... 17:49:00 INFO - Return code: 0 17:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:00 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:49:00 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 17:49:00 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 17:49:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:49:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:00 INFO - 'HOME': '/Users/cltbld', 17:49:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:00 INFO - 'LOGNAME': 'cltbld', 17:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:00 INFO - 'MOZ_NO_REMOTE': '1', 17:49:00 INFO - 'NO_EM_RESTART': '1', 17:49:00 INFO - 'PAGER': '/bin/cat', 17:49:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:00 INFO - 'PWD': '/builds/slave/test', 17:49:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:00 INFO - 'SHELL': '/bin/bash', 17:49:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:49:00 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:49:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:00 INFO - 'USER': 'cltbld', 17:49:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:00 INFO - 'XPC_FLAGS': '0x0', 17:49:00 INFO - 'XPC_SERVICE_NAME': '0', 17:49:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:00 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-40dr2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:00 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-sDi6xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-rVW8IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-orm_TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-6BKoAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-NwpHos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-vPC398-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-SgIZqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-mNYfc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-fDZEZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-dJokVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:01 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-NwyPFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:02 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-xY3iC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:02 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ge67DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:02 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-fX76O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:02 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-daDaQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:02 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-iBeQOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:49:02 INFO - Running setup.py install for manifestparser 17:49:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:49:02 INFO - Running setup.py install for mozcrash 17:49:02 INFO - Running setup.py install for mozdebug 17:49:02 INFO - Running setup.py install for mozdevice 17:49:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Running setup.py install for mozfile 17:49:03 INFO - Running setup.py install for mozhttpd 17:49:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Running setup.py install for mozinfo 17:49:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Running setup.py install for mozInstall 17:49:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:49:03 INFO - Running setup.py install for mozleak 17:49:03 INFO - Running setup.py install for mozlog 17:49:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:49:04 INFO - Running setup.py install for moznetwork 17:49:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:49:04 INFO - Running setup.py install for mozprocess 17:49:04 INFO - Running setup.py install for mozprofile 17:49:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:49:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:49:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:49:04 INFO - Running setup.py install for mozrunner 17:49:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:49:04 INFO - Running setup.py install for mozscreenshot 17:49:04 INFO - Running setup.py install for moztest 17:49:05 INFO - Running setup.py install for mozversion 17:49:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:49:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:49:05 INFO - Cleaning up... 17:49:05 INFO - Return code: 0 17:49:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:05 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')]} 17:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:05 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')]} 17:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:05 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:49:05 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 17:49:05 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 17:49:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:49:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:05 INFO - 'HOME': '/Users/cltbld', 17:49:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:05 INFO - 'LOGNAME': 'cltbld', 17:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:05 INFO - 'MOZ_NO_REMOTE': '1', 17:49:05 INFO - 'NO_EM_RESTART': '1', 17:49:05 INFO - 'PAGER': '/bin/cat', 17:49:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:05 INFO - 'PWD': '/builds/slave/test', 17:49:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:05 INFO - 'SHELL': '/bin/bash', 17:49:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:49:05 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:49:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:05 INFO - 'USER': 'cltbld', 17:49:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:05 INFO - 'XPC_FLAGS': '0x0', 17:49:05 INFO - 'XPC_SERVICE_NAME': '0', 17:49:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:05 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-j3GVBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:05 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)) 17:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:05 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-KI2WgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:05 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)) 17:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:05 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-M_CUiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:05 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)) 17:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:05 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-BxWV8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:05 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)) 17:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:05 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-oTah9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-5_DXK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-kKf0tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-bddUDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-D3lNYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ar2hKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-B0fIu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-WjM7YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-9oQpRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:06 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)) 17:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:06 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-0j5fDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:07 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)) 17:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:07 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-GlSS44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:07 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)) 17:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:07 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-uyrE1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:07 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)) 17:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:07 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-lv9HZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:07 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)) 17:49:07 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)) 17:49:07 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)) 17:49:07 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)) 17:49:07 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)) 17:49:07 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)) 17:49:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:09 INFO - Downloading blessings-1.6.tar.gz 17:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:49:10 INFO - Installing collected packages: blessings 17:49:10 INFO - Running setup.py install for blessings 17:49:10 INFO - Successfully installed blessings 17:49:10 INFO - Cleaning up... 17:49:10 INFO - Return code: 0 17:49:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:49:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:49:10 INFO - Reading from file tmpfile_stdout 17:49:10 INFO - Current package versions: 17:49:10 INFO - blessings == 1.6 17:49:10 INFO - blobuploader == 1.2.4 17:49:10 INFO - docopt == 0.6.1 17:49:10 INFO - functools32 == 3.2.3-2 17:49:10 INFO - jsonschema == 2.5.1 17:49:10 INFO - manifestparser == 1.1 17:49:10 INFO - mozInstall == 1.12 17:49:10 INFO - mozcrash == 1.0 17:49:10 INFO - mozdebug == 0.1 17:49:10 INFO - mozdevice == 0.49 17:49:10 INFO - mozfile == 1.2 17:49:10 INFO - mozhttpd == 0.7 17:49:10 INFO - mozinfo == 0.9 17:49:10 INFO - mozleak == 0.1 17:49:10 INFO - mozlog == 3.4 17:49:10 INFO - moznetwork == 0.27 17:49:10 INFO - mozprocess == 0.24 17:49:10 INFO - mozprofile == 0.28 17:49:10 INFO - mozrunner == 6.13 17:49:10 INFO - mozscreenshot == 0.1 17:49:10 INFO - mozsystemmonitor == 0.3 17:49:10 INFO - moztest == 0.8 17:49:10 INFO - mozversion == 1.4 17:49:10 INFO - psutil == 3.1.1 17:49:10 INFO - requests == 1.2.3 17:49:10 INFO - wsgiref == 0.1.2 17:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:11 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:49:11 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 17:49:11 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 17:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:11 INFO - 'HOME': '/Users/cltbld', 17:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:11 INFO - 'LOGNAME': 'cltbld', 17:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:11 INFO - 'MOZ_NO_REMOTE': '1', 17:49:11 INFO - 'NO_EM_RESTART': '1', 17:49:11 INFO - 'PAGER': '/bin/cat', 17:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:11 INFO - 'PWD': '/builds/slave/test', 17:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:11 INFO - 'SHELL': '/bin/bash', 17:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:49:11 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:11 INFO - 'USER': 'cltbld', 17:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:11 INFO - 'XPC_FLAGS': '0x0', 17:49:11 INFO - 'XPC_SERVICE_NAME': '0', 17:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 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)) 17:49:11 INFO - Cleaning up... 17:49:11 INFO - Return code: 0 17:49:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:49: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')]} 17:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:12 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')]} 17:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:12 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 0x10a20bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a20e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff588cb4750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, '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.h59RtgtNLK/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.6eqfSz8JUL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 17:49:12 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 17:49:12 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 17:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:12 INFO - 'HOME': '/Users/cltbld', 17:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:12 INFO - 'LOGNAME': 'cltbld', 17:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:12 INFO - 'MOZ_NO_REMOTE': '1', 17:49:12 INFO - 'NO_EM_RESTART': '1', 17:49:12 INFO - 'PAGER': '/bin/cat', 17:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:12 INFO - 'PWD': '/builds/slave/test', 17:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:12 INFO - 'SHELL': '/bin/bash', 17:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:49:12 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:12 INFO - 'USER': 'cltbld', 17:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:12 INFO - 'XPC_FLAGS': '0x0', 17:49:12 INFO - 'XPC_SERVICE_NAME': '0', 17:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:49:13 INFO - Cleaning up... 17:49:13 INFO - Return code: 0 17:49:13 INFO - Running post-action listener: _resource_record_post_action 17:49:13 INFO - Running post-action listener: _start_resource_monitoring 17:49:13 INFO - Starting resource monitoring. 17:49:13 INFO - [mozharness: 2017-03-18 00:49:13.075822Z] Finished create-virtualenv step (success) 17:49:13 INFO - [mozharness: 2017-03-18 00:49:13.076808Z] Running install step. 17:49:13 INFO - Running pre-action listener: _resource_record_pre_action 17:49:13 INFO - Running main action method: install 17:49:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:49:13 INFO - Reading from file tmpfile_stdout 17:49:13 INFO - Detecting whether we're running mozinstall >=1.0... 17:49:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:49:13 INFO - Reading from file tmpfile_stdout 17:49:13 INFO - Output received: 17:49:13 INFO - Usage: mozinstall [options] installer 17:49:13 INFO - Options: 17:49:13 INFO - -h, --help show this help message and exit 17:49:13 INFO - -d DEST, --destination=DEST 17:49:13 INFO - Directory to install application into. [default: 17:49:13 INFO - "/builds/slave/test"] 17:49:13 INFO - --app=APP Application being installed. [default: firefox] 17:49:13 INFO - mkdir: /builds/slave/test/build/application 17:49:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:49:28 INFO - Reading from file tmpfile_stdout 17:49:28 INFO - Output received: 17:49:28 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:49:28 INFO - Running post-action listener: _resource_record_post_action 17:49:28 INFO - [mozharness: 2017-03-18 00:49:28.078003Z] Finished install step (success) 17:49:28 INFO - [mozharness: 2017-03-18 00:49:28.078149Z] Running run-tests step. 17:49:28 INFO - Running pre-action listener: _resource_record_pre_action 17:49:28 INFO - Running main action method: run_tests 17:49:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:49:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:49:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:49:28 INFO - 2017-03-17 17:49:28.091 screenresolution[2178:31486] starting screenresolution argv=screenresolution get 17:49:28 INFO - 2017-03-17 17:49:28.094 screenresolution[2178:31486] Display 0: 1600x1200x32@60 17:49:28 INFO - 2017-03-17 17:49:28.099 screenresolution[2179:31488] starting screenresolution argv=screenresolution list 17:49:28 INFO - Available Modes on Display 0 17:49:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:49:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:49:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:49:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:49:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:49:28 INFO - Intel Iris: 17:49:28 INFO - Chipset Model: Intel Iris 17:49:28 INFO - Type: GPU 17:49:28 INFO - Bus: Built-In 17:49:28 INFO - VRAM (Dynamic, Max): 1536 MB 17:49:28 INFO - Vendor: Intel (0x8086) 17:49:28 INFO - Device ID: 0x0a2e 17:49:28 INFO - Revision ID: 0x0009 17:49:28 INFO - Displays: 17:49:28 INFO - Display: 17:49:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:49:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:49:28 INFO - Display Serial Number: 1600x1200 60 17:49:28 INFO - Main Display: Yes 17:49:28 INFO - Mirror: Off 17:49:28 INFO - Online: Yes 17:49:28 INFO - Rotation: Supported 17:49:28 INFO - Return code: 0 17:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:49:28 INFO - Python 2.7.3 17:49:28 INFO - Return code: 0 17:49:28 INFO - grabbing minidump binary from tooltool 17:49:28 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')]} 17:49:28 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 0x109fe9d30>, '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 0x109f10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fdebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:49:28 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 17:49:28 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 17:49:28 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 17:49:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:49:28 INFO - Return code: 0 17:49:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:49:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:49:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:49:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:49:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 17:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0206 --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 17:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h59RtgtNLK/Render', 17:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:28 INFO - 'HOME': '/Users/cltbld', 17:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:28 INFO - 'LOGNAME': 'cltbld', 17:49:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:49:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:28 INFO - 'MOZ_NO_REMOTE': '1', 17:49:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:49:28 INFO - 'NO_EM_RESTART': '1', 17:49:28 INFO - 'PAGER': '/bin/cat', 17:49:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:28 INFO - 'PWD': '/builds/slave/test', 17:49:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:28 INFO - 'SHELL': '/bin/bash', 17:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6eqfSz8JUL/Listeners', 17:49:28 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 17:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:28 INFO - 'USER': 'cltbld', 17:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:28 INFO - 'XPC_FLAGS': '0x0', 17:49:28 INFO - 'XPC_SERVICE_NAME': '0', 17:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:49:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 17:49:28 INFO - mozversion application_buildid: 20170317161920 17:49:28 INFO - mozversion application_changeset: de2b6ddee3456ff8493ea5fbd8255efb7682862b 17:49:28 INFO - mozversion application_display_name: Firefox 17:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:49:28 INFO - mozversion application_name: Firefox 17:49:28 INFO - mozversion application_remotingname: firefox 17:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:49:28 INFO - mozversion application_vendor: Mozilla 17:49:28 INFO - mozversion application_version: 53.0 17:49:28 INFO - mozversion platform_buildid: 20170317161920 17:49:28 INFO - mozversion platform_changeset: de2b6ddee3456ff8493ea5fbd8255efb7682862b 17:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:49:28 INFO - mozversion platform_version: 53.0 17:49:28 INFO - using testdate: 1489798168 17:49:28 INFO - actual date: 1489798168 17:49:28 INFO - starting webserver on 'localhost:61409' 17:49:28 INFO - SUITE-START | Running 2 tests 17:49:28 INFO - TEST-START | dromaeo_css 17:49:28 INFO - operating with platform_type : mac_ 17:49:28 INFO - Initialising browser for dromaeo_css test... 17:49:28 INFO - TEST-INFO | started process 2189 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpjzMClw/profile http://localhost:61409/getInfo.html) 17:49:31 INFO - PROCESS | 2189 | __metrics Screen width/height:1600/1200 17:49:31 INFO - PROCESS | 2189 | colorDepth:24 17:49:31 INFO - PROCESS | 2189 | Browser inner width/height: 1024/689 17:49:31 INFO - PROCESS | 2189 | __metrics 17:49:31 INFO - PROCESS | 2189 | 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" 17:49:31 INFO - PROCESS | 2189 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:49:31 INFO - TEST-INFO | 2189: exit 0 17:49:31 INFO - Browser initialized. 17:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 17:49:31 INFO - TEST-INFO | started process 2192 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpjzMClw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:49:43 INFO - PROCESS | 2192 | RSS: Main: 167067648 17:49:43 INFO - PROCESS | 2192 | 17:52:46 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:61409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61409/tests/dromaeo/cssquery-ext.html) 17:52:48 INFO - PROCESS | 2192 | RSS: Main: 321159168 17:52:48 INFO - PROCESS | 2192 | 17:55:51 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:61409/tests/dromaeo/cssquery-ext.html (next: http://localhost:61409/tests/dromaeo/cssquery-jquery.html) 17:55:51 INFO - PROCESS | 2192 | RSS: Main: 307142656 17:55:51 INFO - PROCESS | 2192 | 17:58:54 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:61409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61409/tests/dromaeo/cssquery-mootools.html) 17:58:54 INFO - PROCESS | 2192 | RSS: Main: 280301568 17:58:54 INFO - PROCESS | 2192 | 18:01:56 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:61409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61409/tests/dromaeo/cssquery-prototype.html) 18:01:57 INFO - PROCESS | 2192 | RSS: Main: 280203264 18:01:57 INFO - PROCESS | 2192 | 18:05:00 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:61409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61409/tests/dromaeo/cssquery-yui.html) 18:05:01 INFO - PROCESS | 2192 | RSS: Main: 262307840 18:05:01 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:61409/tests/dromaeo/cssquery-yui.html (next: http://localhost:61409/tests/dromaeo/cssquery-dojo.html) 18:08:04 INFO - PROCESS | 2192 | RSS: Main: 460296192 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | __start_tp_report 18:08:04 INFO - PROCESS | 2192 | _x_x_mozilla_page_load 18:08:04 INFO - PROCESS | 2192 | _x_x_mozilla_page_load_details 18:08:04 INFO - PROCESS | 2192 | |i|pagename|runs| 18:08:04 INFO - PROCESS | 2192 | |0;dojo.html;3426.3489936911983;3435.467502537106;3438.3295257424807;3443.311337732454;3478.565179352581;5803.825885223439;5855.560832937525;5858.004139296319;5860.5311575074;5932.1694962705205;5809.244798176232;5833.737481813318;5898.852528686785;5948.7323070461825;5979.970100149504;5248.291480650101;5291.841244762663;5295.391030031538;5348.786048558053;5410.1073322901675;5270.235815806705;5283.260343551906;5287.735613219324;5370.919436208441;5406.567474602022;5318.30861987941;5371.5165635092835;5392.487713667196;5399.892002159974;5425.647332923367;5361.571074314045;5408;5414.972925135388;5416.8104116356135;5423.728813559306;5283.392409872837;5346.6524675896335;5349.946500534984;5354.678719276817;5358.2498450217;5749.137629355589;5757.596968212227;5758.078707406795;5781.103928891029;5813.767449302023;6245.843853903643;6266.248050234001;6267.843303917393;6273.153124328249;6279.37206279373;4982.526659967298;6305.117283580303;6305.243370795488;6306.432421082079;6313.337099604521;5928.851778705567;5978.790742324085;5983;6111.847203819895;6125.938740612582;6258.217722784652;6295.811125666238;6381.361863813581;6405.423511883952;6416.165898433173;6295.653739044396;6298.02380631003;6303.464205542488;6312.400321969406;6334.3032266450655;6193.473554747807;6240.781572644935;6256.092866534418;6293.937060629427;6307.117003619497;6187.071939209065;6192.287886893065;6217.844553886099;6247.9062814057825;6278;6238.906416403757;6252.249730032334;6259.0924315973925;6262.029385445263;6262.185915830913;5083.74581270935;5102.081625307406;5105.2086926526445;5106.846794596168;5121.923171152435;4482.529334419904;4520.683552151384;4531.501534831166;4541.613962813198;4589.128065667513;5916.408359164049;5966.105084237312;5984.371640977722;6001.909971350433;6008.128821320972;6319;6338.873222535523;6348.396902294275;6412.583182093149;6413.711382987777;5534.723263836792;5677.17680936262;5965.850853728604;5981.671008094597;5996.16053752475;5165.819196328111;5478.45215478457;5492.642978206404;5551.056320425457;5575.470330318613;6385.757149835127;6422.710978006001;6441.227052753606;6476.060971159155;6506.512011599054;6210.503159747119;6244.406781355764;6264.154339164337;6269.780557680459;6275.937240627535;6261.405166509175;6318.178636777373;6329.208848893888;6354.936450635434;6371.74513019474;6274.403931626488;6278.46633036197;6293.622382656872;6301.149344838388;6301.936980630135;6267.4986001120715;6269.31037585856;6280.27776805655;6293.213348331458;6307.747690092345;4737.360456338351;6143.450468055886;6208.689565521616;6211.099390588249;6325.335839736946;6150.04674275488;6250.281217660027;6293.276273228637;6298.590591611531;6317.4630156437215;6210.5652604317265;6217.378262173746;6225.719842607003;6229.53278504123;6236.282827474898;6128.503123582287;6174.845628859314;6291.716872740829;6309.873802524015;6322.49420046386;6030.125631783455;6131.509479241561;6134.049222370361;6148.1159724198105;6166.105914642441 18:08:04 INFO - PROCESS | 2192 | |1;ext.html;471.45546893338195;474.44489946762286;475.91909375406175;483.35713501043614;524.4991033562948;32167.839160804193;33991.83004084979;42073.57926420739;42815;42987.785061074654;44480.77759611198;44610.33084503727;44678.32982505257;44733.32900006502;44890.55109448905;9392.577334019952;9573.425594464354;9590.664326748565;9593.088656577649;9608.615655373811;9107.590158442852;9284.16442520173;9461.053894610553;11702.12234082443;11958.64124076279;11076.94768996944;11819;11884.821727674092;11897.16719829608;11912.166148369617;10784;11790.823137652986;11799.351035693033;11830;11832.467538960767;11632.476538555786;11736.413179341083;11743.530258789639;11745.882541174564;11747.236429632047;41143.794281028706;41392.58607413917;41414.792926035174;41430.585694142974;41450.58549414497;3385.238321377695;3399.0312760863035;3421.349943510725;3464.5842498900292;3464.9480257796154;26908.73091269082;27388.863055684793;27561.724382756318;28798.712012880023;29072.854635726897;3242.9460425361617;3289.5723555937575;3353.7820041697455;3445.9655403445895;3519.63043880394;404633;426012;427249;427828;428536.85731571453;59082.11376829351;59503;59610.70194648999;59972.80054398887;60009.09986350208;62858.37141628525;62993.68503157455;63054.68472657607;63083;63176.36823631797;16501;17055.91472042657;17083.572910677085;17104.572385690208;17113.572160696083;13193.868061319456;13279.40242689062;13280.468781248643;13292.73414531704;13297.401616927262;14275.214863182624;14655.34050967709;22345.55308893813;22750.976206070765;22897.96959136843;7376.7786966391095;7425.62871856405;8788.824223515494;8957.193852553302;8971.237444817263;877.9771566125393;888.2804928008205;890.6971629645951;917.0920788419417;921.1433366968784;28303.858480707466;28820;28970.27574310659;29401.11796646104;29539.113826585235;1046.5133712823422;1049.4070849969742;1054.667779649408;1089.2647462962468;1094.63876920616;14688.485902993343;14998.250087495582;15135.702504123688;15229.314680839389;15307.01338615286;696880;697660;702864;703584;704886;54282.5717428254;54875;54882.45117548773;54920;55127;1313.4943046927;1355.8440779310308;1429.221074514392;1432.957011289663;1443.5669299210406;23525.52948941046;26394;27537;27825.747841347595;28329.866805327558;45227.32159017552;45827;45903.77048114738;45954.93202805815;46023;565758;573334;573382;575474;576550;21579.2447264345;22110.557788844453;23816.88091559531;24330;24700.25899223026;38283;38779;38793.61206388013;38988.80505597454;39329.41005884857;31681.84159079282;32306.19234519062;32460.83769581137;32908.341833162725;33439.49840752342;32708.018759437255;32921.83539082289;32999.835000824845;33227.50158747572;33694.66305336915;32226.516602251453;32845.50731739074;32880.83559582187;33801;33824.49263261102;28197.15408537747;30338.393232134793;30451;30459.847700761355;30861.537076944314;22746.924841680964;22998.19506317271;23549.175778848345;23587.764122358556;23908.64137037911 18:08:04 INFO - PROCESS | 2192 | |2;jquery.html;404.1049076296002;405.5761728993202;412.31555617674667;417.99582004179956;434.3202887481092;20695.275665351717;21468.89265553674;22192.223272185478;22500;22789;17937.372191973285;21701;21880.01795242608;22634;23017.4245643859;5236.319278493809;5759.10733836255;6079.908801367983;6084.269887613493;6092.29938557065;5049.444561098277;5772.797952071678;6037.818865434044;6079.78720744774;6081.78713745019;6015.939840601582;6018.729157187915;6021.879562408749;6028.246469191351;6030.819075427744;7798.922010779905;7961.686321756903;8133;8187.79530511736;8230.341572674202;6823.454123670094;7907.48601340911;8021.398395120389;8042.477238979506;8054.758357249292;29921.850390748124;29935.952241671435;30456.54315185274;30642.54036189459;30776;2708.214617760847;2832.985835070832;2890.132960111958;2927.45842019225;2948.82307061577;16257.674846503121;16501.504954851374;16781.489665930003;16839.74740378883;17535.5616109597;1701.2939630053513;1957.7357056797293;2078.5842831433774;2208.447888027993;2223.6886835842993;123284.76715232822;149706;159083.40916590803;159428;161209;23993.760062399502;24643;24669.259922202364;24676.629850552257;24966.875165624057;42732;42988.355174672404;43851.342229866576;44076.77961610172;44233.778831105636;11650;11861.822072668916;11884.702882428008;11913.987311078656;11924.523019079314;9486.478243696663;9500.334976551576;9504.334696571312;9689.224862011022;9698.854517182248;9020.81958360829;9303.953480232556;11252;11311.717207069725;11405.942970285096;3646.927061458809;4111.362738775495;4215.831366745296;4231.809568569422;4390.8902277442685;1030.340582027503;1038;1049.6116436918237;1056.40482870864;1079.5034284229343;21288;21447.78552214489;21752;21808.9728629245;21885.781142188374;1044.796264728386;1053.6522947427331;1056.5509658395151;1090.0516550601028;1093.5680406239492;10993.230473866752;11056.834147487794;11106.389148596743;11109.55561777536;11352.14858885587;770488;776883;780644;780798;782855;147728.2613586925;152429.8991024703;154476.8209271639;154792.90414191879;160977;823.5717426937958;1029.4543891737542;1059.247933966892;1060.5545670818274;1070.0904231403244;19374.709379359603;19770.50573735668;20123.496912576717;20199.293024744064;20323.288684895957;54870.17694734662;59524.70237648784;61905;62304.68847655733;64056.67971660112;66643.33461659655;73052.26947730668;84707.30585388381;89952.55023724839;92116.61825072495;5761.827145185651;7933.206679332021;8323;8513.40406171562;8648.481091134552;9856.655017074369;11051.502682379472;12375.566855160387;13069.5821273061;13180.143290686075;10693.465326733787;10807.13542916549;11071.83392249133;11292.9435352826;11415.315081095161;8757.737267881974;10697.358158510515;10928.672139835817;10966.396848173426;11344;11102.88897111051;11341.376224307742;11610.535578576762;11746.17776755619;11776.52893884235;8401.873971890549;8412.957935210285;8632.913670863461;8644.438111522732;8645.351598630003;10347;10841.512131953923;11081.83377249358;11085.44572771342;11322.490487927898 18:08:04 INFO - PROCESS | 2192 | |3;mootools.html;1238.7212877102647;1472.1755816742625;1485.9405623775049;1495.7158139953415;1499.4751836857101;7652.158262591118;8025.197480251972;8249.670013199473;8516.190961858629;8522.531260780655;8407.411481196319;8486.15138486151;8486.44838085524;8487;8497.980242370908;2371.5256948610263;2413.6620873077695;2419.709634843812;2419.9879000604974;2423.866687332196;2184.071769497965;2267.455810605459;2364.5507353602848;2439.6706444630013;2443.1204766284122;2417.7340492545895;2417.830751847371;2417.8549287042833;2419.250032489925;2422.0190822716827;2363.1728894886824;2396.496735685508;2398.5922393193023;2401.399650087478;2401.435662619283;1996.341207401554;2365.8107351411845;2436.658867758515;2438.3538362333998;2441.511697660475;8384.8742268866;8450.366222533334;8460.196281353261;8486.448380855287;8492;5138.306328645623;5302.09864323066;5310.522053015208;5312.415634280226;5322.574194064466;3407.4718418645148;3569.3218288525095;3605.6574625410544;3621.3662609043313;3632.346177688015;1230.366361323919;1269.9174553653984;1273.3251376770233;1314.1129737427198;1322.1802482460935;10858.131349492021;10958.890411095947;10982;10987.505562249718;11003.394813285346;4142.937855932163;4541.704789188692;4771;4832.516748325139;4852.927206091911;9547.665831695997;9550.522473876279;9554.04459554039;9567.808643827084;9575.09036641518;5331.840044798662;5333.093374126408;5339.919901201485;5341.172118321666;5350.9732451337495;3797.9240415191543;4731.858044258678;4819.108464933998;4832.565069143794;4912.1158191525155;3712.4988126603103;3932.623581746423;4012.2376748417705;4026.134381108076;4027.375756757707;1216.841810564621;1235.7281398092405;1238.2013601227159;1247.3451437995125;1247.3513772838073;768.3814529303852;847.4618617178013;895.0735988252128;900.9279257659372;904.3985749476656;3915.941260881089;4351.73889566627;5067.175816706057;5292.655977361459;5353.9196912046355;954.9331546791797;983.9176905403998;997.3816233934862;1027.8920713325142;1039.0856046679025;3085.9845700771352;3264.2002709336366;3488.4941683456263;3568.536090308295;3578.7673801202836;9764.658236961814;10059.597616095274;10243.180545556486;10269.691909242734;10311.381317120997;10193.490325483695;10195.439250841127;10201.13290370312;10209.030142136486;10215.387076775269;7933.9603301983125;8013.919860801434;8073.19268073188;8079.959600201962;8082.878756818653;5214;5275.498827611371;5347.090994530861;5380.677159370451;5468.0977638690765;9067.501287429255;9130;9193.080691930754;9274.25805935537;9389.953050234979;9215.539223038955;9349.626014959325;9431.858522122311;9520.428774273565;9522.143007129114;6696.799096027127;6699.564528305645;6750.32496750321;6753.628550429774;6839.384455399038;6621.10477145904;7158;7662.501937374052;7858.960705196438;7900.6049697513745;7009.684564194726;7029.683664235019;7090.6100164491445;7122.216556178712;7162.785116446515;6910.170779506491;6914.51598388108;6927.861442771015;6964.303569642995;6973.6164510952385;6408.487321014401;6416.615003099829;6417.037444383193;6478.384553467413;6487.935120648733;4082.0611259409907;4584.243599805995;4904.485029071896;4904.7302398367;5016.623753218596;4856.1987272099705;4868.829590964299;4931.457539670705;5016.598672106295;5120.206368012964 18:08:04 INFO - PROCESS | 2192 | |4;prototype.html;329.9935197647177;358.7668015789737;377.7771115042125;386.7930657098453;389.62401282762147;5062.797488100471;5357.973210133949;5401.756920938557;5431.674099554025;5433.293671822667;5071.670341427814;5166.741662916858;5233.136532472137;5241.266222728811;5278.683279003253;3970.3250447423934;4090.8568200113;4230.7250028748185;4246.57534246576;4252.704768184125;4206.621404073633;4234.809433575497;4255.4467919170465;4260.42484264625;4261;4071.796410179494;4128.559972843604;4203.579642035787;4204.747715137101;4216.114615930658;4176.791160441966;4180.853670121562;4190.20386126635;4190.491423087686;4215.620594146541;3731.552213734369;3756.849726010956;3757.9624203757885;3759.2293579816073;3788.3749181385037;4999.500049995007;5218.295530103425;5220.407775628431;5268.631195816294;5279.234510995884;4303.892402689927;4830.6135509159185;4905;4948.455669876311;4956.529129732669;5703.800366987136;5716.514096301819;5743.2246646703;5759.88965958382;5820.883582328372;3699.7965111918834;4015.357542793139;4140.68944829139;4200.663946884272;4201.621854033121;5191.844244672666;5587.552995760329;5830.4169583041785;5929.37741537141;5930.738094048343;3426.9828650856584;4258.701890867672;4297.355396690521;4307.3754305626135;4319.6976211665515;3113.2372568720357;4066.9389959150635;4292.926768307923;4336.284513055373;4358.259095953696;4765.833195838129;4830.468648448667;4830.855074347775;4837.685550439211;4866.6106711463;4339.023719663113;4881.243407271879;5042.747862606929;5426.403095659474;5725.764942807301;1271.7202215512573;1328.860469650692;1346.340293256317;1374.2647683489286;1383.557261676254;912.5938957164132;996.8554559588819;998.7553049502773;1010.4947526236881;1013.381837079381;4485.349624304457;4519.07358991406;4748.976255118771;4996.475370086088;5010.498950105033;4945.159322915113;5004.623728474626;5534.363483545636;5645.802396916089;5668.853786148645;4522.479914809839;4783.569478746929;4977.751112444364;4994.550490455804;5010.348654674869;2701.7163197863943;2717.2391730315544;2872.4111557130736;2905.8376649340435;2906.4913640112895;5203.487645839044;5212;5683.147527870852;5720.167487783112;5749.310082790092;4849.684770489906;5615.241942337814;5644.407337229532;5687.720262940888;5755.014519990596;4819.421669399694;4901.828436004723;5652.095664693629;5662.377138514842;5722.37053924068;4933.555979961677;5456.571825537598;5504.4495550444635;5890.1740460457395;5961.523078153824;5350.946490535201;5385.649932754515;5709.771609135588;5790.1893734877995;5804.82585522435;5527.474889885454;5608.775648974159;6128.203333566607;6134.809898852483;6214.477453024038;3359.328134373184;3752.1614408939968;3993.381025940984;3995.62041606047;4066.694997875112;5205.843824685266;5839.474447299764;5892.467958330779;5903.347062822417;5931.406859314034;4441.578050085237;4651.3023046543285;5499.807506737245;5817.680027598353;5866.823995280149;4960.330355402119;5468.835934921959;5643.548516118783;5648.689322087324;5712.571557133315;4879.414470263591;5305.469453054664;5538.363088244903;5551.278333816578;5600.487868275624;5285.418603953485;5596.804111856066;5641.576881733804;5718.199452076629;5777.83331250781;5027.2580226450855;5172;5610.747516361692;5647.887042259214;5654.886902262014 18:08:04 INFO - PROCESS | 2192 | |5;yui.html;738.2764890407398;739.3863093632285;753.4161025205468;788.4677842456344;884.9778755531113;15214.77177842332;15758.527244182693;15785.763213551805;15798.763018554717;15806.13066281354;14134.151950882928;14464.493742719007;14500.854991450082;14524.927375363108;14552.636184095403;906.1074841281333;906.9138431848996;923.0630909626734;927.6104036304769;929.159111004542;730.4193166432672;757.5681861339039;904.416651259937;907.0113576201938;909.195362104539;934.4907025670992;963.2005435488562;965.6716716316452;966.4008314844771;968.728755948332;950.5864948747283;952.1383148250844;953.2564599612314;954.1412728544296;955.6082006377387;715.965429953717;716.8387112899608;716.8494616130619;719.0400814912099;719.9496035277533;15097.54707358781;15531.767023494656;15551;15592.688146237011;15605.531834044998;13954.09298395601;14376.209308488029;14737.484188053366;14797.630059248497;14834.184119873402;11866.288022718665;11909.761804763857;11941.641750747405;12049.638510844688;12071.215371000857;3790.128270497801;3870.845166193349;3944.881653550398;4036.1322315702264;4071.5928407159345;108879.91120088777;113433.73132537385;114061.85938140596;116121.25818112736;120961;9788.265880058882;10732.30240034411;10987.450627468595;11369.033632141196;11808.239045566095;23230.76769232286;23336.64995025076;23347.299581012598;23354.53290934206;23364.299071027897;7617.352525035434;7892.171322011106;7895.368370530344;8029.839403211903;8097.716579919675;4092.8850602217176;4195.958040419618;4428.7279609522475;4496.348029535699;4586.610138138229;3273.263515708946;3719.590845007047;3798.2783271178387;3918.1380096378753;4123.237201117803;737.1265050914683;741.5661837824933;750.3322043381395;754.5359603843597;761.7866997240782;679.8402375441767;689.1385767790263;704.1866644026157;720.4560556779597;753.5892938348613;10207.591696332063;10273.691789246335;10282.588696452207;10735.409552474688;10739.140868730483;648.2447948140364;679.894616334469;691.8720036793109;706.6290197646276;733.3509843788286;5040.901173382007;5147.124988751922;5159.329287192641;5159.922601160985;5169.224616307509;104225.47887260666;105908.47045764721;106889;107208.4639576797;108539.91460085298;92271;94274.58588121184;94613.05386946042;97300;98846.50576747215;84598;85121.57439212888;85319.14680853236;86826;87833;9520.761980950532;9861.457619830979;9909.851352229867;9952;9980.700578982642;55054.17418738642;55991.16013259886;56436;56546.717266413405;57170.14244786248;42913.99204111365;67945;69319;70738;72553.63723181562;11360.602378916697;11594;11667.066634669376;11768.117391195865;11799.705007374885;12383.876161238633;12965.351732413154;12967.805482917953;12973.805392918925;13009.21944683322;11852.229605075643;11961.222520536137;12016.75966480683;12056.336901470153;12081.75836483283;11409.432767978444;11742.00192983606;11880.82178767302;12128.332941688292;12147.574834880737;11396.697902722197;11840.940795295968;11948.581799636971;11958.820617690568;12060.457279422271;9857.457839818879;10056.64801731936;10179.694609161737;10192.847107293544;10821.188410869374;8285.871488691051;8827.617818654744;9962.512042569559;10095.646652367132;10099.427778913974 18:08:04 INFO - PROCESS | 2192 | __end_tp_report 18:08:04 INFO - PROCESS | 2192 | __start_cc_report 18:08:04 INFO - PROCESS | 2192 | _x_x_mozilla_cycle_collect,1619 18:08:04 INFO - PROCESS | 2192 | __end_cc_report 18:08:04 INFO - PROCESS | 2192 | __startTimestamp1489799284630__endTimestamp 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | ------- Summary: start ------- 18:08:04 INFO - PROCESS | 2192 | Number of tests: 6 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | [#0] dojo.html Cycles:165 Average:5851.95 Median:6148.12 stddev:638.10 (10.4%) stddev-sans-first:611.03 18:08:04 INFO - PROCESS | 2192 | Values: 3426.3 3435.5 3438.3 3443.3 3478.6 5803.8 5855.6 5858.0 5860.5 5932.2 5809.2 5833.7 5898.9 5948.7 5980.0 5248.3 5291.8 5295.4 5348.8 5410.1 5270.2 5283.3 5287.7 5370.9 5406.6 5318.3 5371.5 5392.5 5399.9 5425.6 5361.6 5408.0 5415.0 5416.8 5423.7 5283.4 5346.7 5349.9 5354.7 5358.2 5749.1 5757.6 5758.1 5781.1 5813.8 6245.8 6266.2 6267.8 6273.2 6279.4 4982.5 6305.1 6305.2 6306.4 6313.3 5928.9 5978.8 5983.0 6111.8 6125.9 6258.2 6295.8 6381.4 6405.4 6416.2 6295.7 6298.0 6303.5 6312.4 6334.3 6193.5 6240.8 6256.1 6293.9 6307.1 6187.1 6192.3 6217.8 6247.9 6278.0 6238.9 6252.2 6259.1 6262.0 6262.2 5083.7 5102.1 5105.2 5106.8 5121.9 4482.5 4520.7 4531.5 4541.6 4589.1 5916.4 5966.1 5984.4 6001.9 6008.1 6319.0 6338.9 6348.4 6412.6 6413.7 5534.7 5677.2 5965.9 5981.7 5996.2 5165.8 5478.5 5492.6 5551.1 5575.5 6385.8 6422.7 6441.2 6476.1 6506.5 6210.5 6244.4 6264.2 6269.8 6275.9 6261.4 6318.2 6329.2 6354.9 6371.7 6274.4 6278.5 6293.6 6301.1 6301.9 6267.5 6269.3 6280.3 6293.2 6307.7 4737.4 6143.5 6208.7 6211.1 6325.3 6150.0 6250.3 6293.3 6298.6 6317.5 6210.6 6217.4 6225.7 6229.5 6236.3 6128.5 6174.8 6291.7 6309.9 6322.5 6030.1 6131.5 6134.0 6148.1 6166.1 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | [#1] ext.html Cycles:180 Average:68933.92 Median:33333.50 stddev:154671.91 (464.0%) stddev-sans-first:155020.40 18:08:04 INFO - PROCESS | 2192 | Values: 471.5 474.4 475.9 483.4 524.5 32167.8 33991.8 42073.6 42815.0 42987.8 44480.8 44610.3 44678.3 44733.3 44890.6 9392.6 9573.4 9590.7 9593.1 9608.6 9107.6 9284.2 9461.1 11702.1 11958.6 11076.9 11819.0 11884.8 11897.2 11912.2 10784.0 11790.8 11799.4 11830.0 11832.5 11632.5 11736.4 11743.5 11745.9 11747.2 41143.8 41392.6 41414.8 41430.6 41450.6 3385.2 3399.0 3421.3 3464.6 3464.9 26908.7 27388.9 27561.7 28798.7 29072.9 3242.9 3289.6 3353.8 3446.0 3519.6 404633.0 426012.0 427249.0 427828.0 428536.9 59082.1 59503.0 59610.7 59972.8 60009.1 62858.4 62993.7 63054.7 63083.0 63176.4 16501.0 17055.9 17083.6 17104.6 17113.6 13193.9 13279.4 13280.5 13292.7 13297.4 14275.2 14655.3 22345.6 22751.0 22898.0 7376.8 7425.6 8788.8 8957.2 8971.2 878.0 888.3 890.7 917.1 921.1 28303.9 28820.0 28970.3 29401.1 29539.1 1046.5 1049.4 1054.7 1089.3 1094.6 14688.5 14998.3 15135.7 15229.3 15307.0 696880.0 697660.0 702864.0 703584.0 704886.0 54282.6 54875.0 54882.5 54920.0 55127.0 1313.5 1355.8 1429.2 1433.0 1443.6 23525.5 26394.0 27537.0 27825.7 28329.9 45227.3 45827.0 45903.8 45954.9 46023.0 565758.0 573334.0 573382.0 575474.0 576550.0 21579.2 22110.6 23816.9 24330.0 24700.3 38283.0 38779.0 38793.6 38988.8 39329.4 31681.8 32306.2 32460.8 32908.3 33439.5 32708.0 32921.8 32999.8 33227.5 33694.7 32226.5 32845.5 32880.8 33801.0 33824.5 28197.2 30338.4 30451.0 30459.8 30861.5 22746.9 22998.2 23549.2 23587.8 23908.6 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | [#2] jquery.html Cycles:180 Average:44067.94 Median:24318.38 stddev:129451.77 (532.3%) stddev-sans-first:129773.40 18:08:04 INFO - PROCESS | 2192 | Values: 404.1 405.6 412.3 418.0 434.3 20695.3 21468.9 22192.2 22500.0 22789.0 17937.4 21701.0 21880.0 22634.0 23017.4 5236.3 5759.1 6079.9 6084.3 6092.3 5049.4 5772.8 6037.8 6079.8 6081.8 6015.9 6018.7 6021.9 6028.2 6030.8 7798.9 7961.7 8133.0 8187.8 8230.3 6823.5 7907.5 8021.4 8042.5 8054.8 29921.9 29936.0 30456.5 30642.5 30776.0 2708.2 2833.0 2890.1 2927.5 2948.8 16257.7 16501.5 16781.5 16839.7 17535.6 1701.3 1957.7 2078.6 2208.4 2223.7 123284.8 149706.0 159083.4 159428.0 161209.0 23993.8 24643.0 24669.3 24676.6 24966.9 42732.0 42988.4 43851.3 44076.8 44233.8 11650.0 11861.8 11884.7 11914.0 11924.5 9486.5 9500.3 9504.3 9689.2 9698.9 9020.8 9304.0 11252.0 11311.7 11405.9 3646.9 4111.4 4215.8 4231.8 4390.9 1030.3 1038.0 1049.6 1056.4 1079.5 21288.0 21447.8 21752.0 21809.0 21885.8 1044.8 1053.7 1056.6 1090.1 1093.6 10993.2 11056.8 11106.4 11109.6 11352.1 770488.0 776883.0 780644.0 780798.0 782855.0 147728.3 152429.9 154476.8 154792.9 160977.0 823.6 1029.5 1059.2 1060.6 1070.1 19374.7 19770.5 20123.5 20199.3 20323.3 54870.2 59524.7 61905.0 62304.7 64056.7 66643.3 73052.3 84707.3 89952.6 92116.6 5761.8 7933.2 8323.0 8513.4 8648.5 9856.7 11051.5 12375.6 13069.6 13180.1 10693.5 10807.1 11071.8 11292.9 11415.3 8757.7 10697.4 10928.7 10966.4 11344.0 11102.9 11341.4 11610.5 11746.2 11776.5 8401.9 8413.0 8632.9 8644.4 8645.4 10347.0 10841.5 11081.8 11085.4 11322.5 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | [#3] mootools.html Cycles:180 Average:5432.10 Median:5016.61 stddev:2982.89 (59.5%) stddev-sans-first:2974.61 18:08:04 INFO - PROCESS | 2192 | Values: 1238.7 1472.2 1485.9 1495.7 1499.5 7652.2 8025.2 8249.7 8516.2 8522.5 8407.4 8486.2 8486.4 8487.0 8498.0 2371.5 2413.7 2419.7 2420.0 2423.9 2184.1 2267.5 2364.6 2439.7 2443.1 2417.7 2417.8 2417.9 2419.3 2422.0 2363.2 2396.5 2398.6 2401.4 2401.4 1996.3 2365.8 2436.7 2438.4 2441.5 8384.9 8450.4 8460.2 8486.4 8492.0 5138.3 5302.1 5310.5 5312.4 5322.6 3407.5 3569.3 3605.7 3621.4 3632.3 1230.4 1269.9 1273.3 1314.1 1322.2 10858.1 10958.9 10982.0 10987.5 11003.4 4142.9 4541.7 4771.0 4832.5 4852.9 9547.7 9550.5 9554.0 9567.8 9575.1 5331.8 5333.1 5339.9 5341.2 5351.0 3797.9 4731.9 4819.1 4832.6 4912.1 3712.5 3932.6 4012.2 4026.1 4027.4 1216.8 1235.7 1238.2 1247.3 1247.4 768.4 847.5 895.1 900.9 904.4 3915.9 4351.7 5067.2 5292.7 5353.9 954.9 983.9 997.4 1027.9 1039.1 3086.0 3264.2 3488.5 3568.5 3578.8 9764.7 10059.6 10243.2 10269.7 10311.4 10193.5 10195.4 10201.1 10209.0 10215.4 7934.0 8013.9 8073.2 8080.0 8082.9 5214.0 5275.5 5347.1 5380.7 5468.1 9067.5 9130.0 9193.1 9274.3 9390.0 9215.5 9349.6 9431.9 9520.4 9522.1 6696.8 6699.6 6750.3 6753.6 6839.4 6621.1 7158.0 7662.5 7859.0 7900.6 7009.7 7029.7 7090.6 7122.2 7162.8 6910.2 6914.5 6927.9 6964.3 6973.6 6408.5 6416.6 6417.0 6478.4 6487.9 4082.1 4584.2 4904.5 4904.7 5016.6 4856.2 4868.8 4931.5 5016.6 5120.2 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | [#4] prototype.html Cycles:180 Average:4590.88 Median:4997.99 stddev:1351.64 (27.0%) stddev-sans-first:1317.06 18:08:04 INFO - PROCESS | 2192 | Values: 330.0 358.8 377.8 386.8 389.6 5062.8 5358.0 5401.8 5431.7 5433.3 5071.7 5166.7 5233.1 5241.3 5278.7 3970.3 4090.9 4230.7 4246.6 4252.7 4206.6 4234.8 4255.4 4260.4 4261.0 4071.8 4128.6 4203.6 4204.7 4216.1 4176.8 4180.9 4190.2 4190.5 4215.6 3731.6 3756.8 3758.0 3759.2 3788.4 4999.5 5218.3 5220.4 5268.6 5279.2 4303.9 4830.6 4905.0 4948.5 4956.5 5703.8 5716.5 5743.2 5759.9 5820.9 3699.8 4015.4 4140.7 4200.7 4201.6 5191.8 5587.6 5830.4 5929.4 5930.7 3427.0 4258.7 4297.4 4307.4 4319.7 3113.2 4066.9 4292.9 4336.3 4358.3 4765.8 4830.5 4830.9 4837.7 4866.6 4339.0 4881.2 5042.7 5426.4 5725.8 1271.7 1328.9 1346.3 1374.3 1383.6 912.6 996.9 998.8 1010.5 1013.4 4485.3 4519.1 4749.0 4996.5 5010.5 4945.2 5004.6 5534.4 5645.8 5668.9 4522.5 4783.6 4977.8 4994.6 5010.3 2701.7 2717.2 2872.4 2905.8 2906.5 5203.5 5212.0 5683.1 5720.2 5749.3 4849.7 5615.2 5644.4 5687.7 5755.0 4819.4 4901.8 5652.1 5662.4 5722.4 4933.6 5456.6 5504.4 5890.2 5961.5 5350.9 5385.6 5709.8 5790.2 5804.8 5527.5 5608.8 6128.2 6134.8 6214.5 3359.3 3752.2 3993.4 3995.6 4066.7 5205.8 5839.5 5892.5 5903.3 5931.4 4441.6 4651.3 5499.8 5817.7 5866.8 4960.3 5468.8 5643.5 5648.7 5712.6 4879.4 5305.5 5538.4 5551.3 5600.5 5285.4 5596.8 5641.6 5718.2 5777.8 5027.3 5172.0 5610.7 5647.9 5654.9 18:08:04 INFO - PROCESS | 2192 | 18:08:04 INFO - PROCESS | 2192 | [#5] yui.html Cycles:180 Average:21181.43 Median:4159.60 stddev:31415.31 (755.2%) stddev-sans-first:31465.93 18:08:04 INFO - PROCESS | 2192 | Values: 738.3 739.4 753.4 788.5 885.0 15214.8 15758.5 15785.8 15798.8 15806.1 14134.2 14464.5 14500.9 14524.9 14552.6 906.1 906.9 923.1 927.6 929.2 730.4 757.6 904.4 907.0 909.2 934.5 963.2 965.7 966.4 968.7 950.6 952.1 953.3 954.1 955.6 716.0 716.8 716.8 719.0 719.9 15097.5 15531.8 15551.0 15592.7 15605.5 13954.1 14376.2 14737.5 14797.6 14834.2 11866.3 11909.8 11941.6 12049.6 12071.2 3790.1 3870.8 3944.9 4036.1 4071.6 108879.9 113433.7 114061.9 116121.3 120961.0 9788.3 10732.3 10987.5 11369.0 11808.2 23230.8 23336.6 23347.3 23354.5 23364.3 7617.4 7892.2 7895.4 8029.8 8097.7 4092.9 4196.0 4428.7 4496.3 4586.6 3273.3 3719.6 3798.3 3918.1 4123.2 737.1 741.6 750.3 754.5 761.8 679.8 689.1 704.2 720.5 753.6 10207.6 10273.7 10282.6 10735.4 10739.1 648.2 679.9 691.9 706.6 733.4 5040.9 5147.1 5159.3 5159.9 5169.2 104225.5 105908.5 106889.0 107208.5 108539.9 92271.0 94274.6 94613.1 97300.0 98846.5 84598.0 85121.6 85319.1 86826.0 87833.0 9520.8 9861.5 9909.9 9952.0 9980.7 55054.2 55991.2 56436.0 56546.7 57170.1 42914.0 67945.0 69319.0 70738.0 72553.6 11360.6 11594.0 11667.1 11768.1 11799.7 12383.9 12965.4 12967.8 12973.8 13009.2 11852.2 11961.2 12016.8 12056.3 12081.8 11409.4 11742.0 11880.8 12128.3 12147.6 11396.7 11840.9 11948.6 11958.8 12060.5 9857.5 10056.6 10179.7 10192.8 10821.2 8285.9 8827.6 9962.5 10095.6 10099.4 18:08:04 INFO - PROCESS | 2192 | -------- Summary: end -------- 18:08:04 INFO - PROCESS | 2192 | 18:08:05 INFO - TEST-INFO | 2192: exit 0 18:08:05 INFO - TEST-OK | dromaeo_css | took 1116527ms 18:08:05 INFO - TEST-START | kraken 18:08:05 INFO - operating with platform_type : mac_ 18:08:05 INFO - Initialising browser for kraken test... 18:08:05 INFO - TEST-INFO | started process 2195 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpUbErR5/profile http://localhost:61409/getInfo.html) 18:08:07 INFO - PROCESS | 2195 | __metrics Screen width/height:1600/1200 18:08:07 INFO - PROCESS | 2195 | colorDepth:24 18:08:07 INFO - PROCESS | 2195 | Browser inner width/height: 1024/689 18:08:07 INFO - PROCESS | 2195 | __metrics 18:08:07 INFO - PROCESS | 2195 | 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:08:07 INFO - PROCESS | 2195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:08:08 INFO - TEST-INFO | 2195: exit 0 18:08:08 INFO - Browser initialized. 18:08:08 INFO - Running cycle 1/1 for kraken test... 18:08:08 INFO - TEST-INFO | started process 2197 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpUbErR5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:08:20 INFO - PROCESS | 2197 | RSS: Main: 163282944 18:08:20 INFO - PROCESS | 2197 | 18:08:22 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61409/tests/kraken/driver.html?testName=audio-beat-detection) 18:08:23 INFO - PROCESS | 2197 | RSS: Main: 213913600 18:08:23 INFO - PROCESS | 2197 | 18:08:26 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61409/tests/kraken/driver.html?testName=audio-dft) 18:08:27 INFO - PROCESS | 2197 | RSS: Main: 226721792 18:08:27 INFO - PROCESS | 2197 | 18:08:30 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61409/tests/kraken/driver.html?testName=audio-fft) 18:08:30 INFO - PROCESS | 2197 | RSS: Main: 324046848 18:08:30 INFO - PROCESS | 2197 | 18:08:32 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61409/tests/kraken/driver.html?testName=audio-oscillator) 18:08:33 INFO - PROCESS | 2197 | RSS: Main: 226590720 18:08:33 INFO - PROCESS | 2197 | 18:08:35 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:08:36 INFO - PROCESS | 2197 | RSS: Main: 229421056 18:08:36 INFO - PROCESS | 2197 | 18:08:38 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61409/tests/kraken/driver.html?testName=imaging-darkroom) 18:08:39 INFO - PROCESS | 2197 | RSS: Main: 269201408 18:08:39 INFO - PROCESS | 2197 | 18:08:42 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61409/tests/kraken/driver.html?testName=imaging-desaturate) 18:08:43 INFO - PROCESS | 2197 | RSS: Main: 270643200 18:08:43 INFO - PROCESS | 2197 | 18:08:46 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61409/tests/kraken/driver.html?testName=json-parse-financial) 18:08:46 INFO - PROCESS | 2197 | RSS: Main: 266510336 18:08:46 INFO - PROCESS | 2197 | 18:08:48 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:08:48 INFO - PROCESS | 2197 | RSS: Main: 242905088 18:08:48 INFO - PROCESS | 2197 | 18:08:50 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:08:51 INFO - PROCESS | 2197 | RSS: Main: 245399552 18:08:51 INFO - PROCESS | 2197 | 18:08:53 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:08:54 INFO - PROCESS | 2197 | RSS: Main: 251711488 18:08:54 INFO - PROCESS | 2197 | 18:08:56 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:08:57 INFO - PROCESS | 2197 | RSS: Main: 268906496 18:08:57 INFO - PROCESS | 2197 | 18:09:00 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:09:01 INFO - PROCESS | 2197 | RSS: Main: 262725632 18:09:01 INFO - PROCESS | 2197 | 18:09:02 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:61409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61409/tests/kraken/driver.html?testName=ai-astar) 18:09:03 INFO - PROCESS | 2197 | RSS: Main: 307359744 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | __start_tp_report 18:09:03 INFO - PROCESS | 2197 | _x_x_mozilla_page_load 18:09:03 INFO - PROCESS | 2197 | _x_x_mozilla_page_load_details 18:09:03 INFO - PROCESS | 2197 | |i|pagename|runs| 18:09:03 INFO - PROCESS | 2197 | |0;ai-astar;103;113;116;113;113;115;114;113;114;113 18:09:03 INFO - PROCESS | 2197 | |1;audio-beat-detection;143;114;97;167;140;138;110;108;124;110 18:09:03 INFO - PROCESS | 2197 | |2;audio-dft;183;181;183;195;261;206;184;183;185;183 18:09:03 INFO - PROCESS | 2197 | |3;audio-fft;81;57;58;88;62;58;57;60;67;61 18:09:03 INFO - PROCESS | 2197 | |4;audio-oscillator;84;70;86;69;67;68;80;78;100;109 18:09:03 INFO - PROCESS | 2197 | |5;imaging-gaussian-blur;89;85;89;88;89;85;90;86;88;84 18:09:03 INFO - PROCESS | 2197 | |6;imaging-darkroom;105;96;95;96;96;96;96;96;96;96 18:09:03 INFO - PROCESS | 2197 | |7;imaging-desaturate;75;124;140;126;86;88;85;86;85;85 18:09:03 INFO - PROCESS | 2197 | |8;json-parse-financial;54;53;57;52;55;56;56;56;54;55 18:09:03 INFO - PROCESS | 2197 | |9;json-stringify-tinderbox;63;71;74;72;72;68;68;75;68;69 18:09:03 INFO - PROCESS | 2197 | |10;stanford-crypto-aes;82;81;81;80;81;80;80;82;82;86 18:09:03 INFO - PROCESS | 2197 | |11;stanford-crypto-ccm;152;133;119;144;144;146;129;155;196;167 18:09:03 INFO - PROCESS | 2197 | |12;stanford-crypto-pbkdf2;164;163;163;162;158;161;161;163;160;160 18:09:03 INFO - PROCESS | 2197 | |13;stanford-crypto-sha256-iterative;67;64;64;63;64;63;62;64;63;63 18:09:03 INFO - PROCESS | 2197 | __end_tp_report 18:09:03 INFO - PROCESS | 2197 | __start_cc_report 18:09:03 INFO - PROCESS | 2197 | _x_x_mozilla_cycle_collect,1980 18:09:03 INFO - PROCESS | 2197 | __end_cc_report 18:09:03 INFO - PROCESS | 2197 | __startTimestamp1489799343068__endTimestamp 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | ------- Summary: start ------- 18:09:03 INFO - PROCESS | 2197 | Number of tests: 14 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:3.56 (3.1%) stddev-sans-first:1.09 18:09:03 INFO - PROCESS | 2197 | Values: 103.0 113.0 116.0 113.0 113.0 115.0 114.0 113.0 114.0 113.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:139.00 stddev:21.41 (15.4%) stddev-sans-first:21.71 18:09:03 INFO - PROCESS | 2197 | Values: 143.0 114.0 97.0 167.0 140.0 138.0 110.0 108.0 124.0 110.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#2] audio-dft Cycles:10 Average:194.40 Median:184.50 stddev:24.65 (13.4%) stddev-sans-first:25.79 18:09:03 INFO - PROCESS | 2197 | Values: 183.0 181.0 183.0 195.0 261.0 206.0 184.0 183.0 185.0 183.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#3] audio-fft Cycles:10 Average:64.90 Median:61.50 stddev:10.88 (17.7%) stddev-sans-first:9.85 18:09:03 INFO - PROCESS | 2197 | Values: 81.0 57.0 58.0 88.0 62.0 58.0 57.0 60.0 67.0 61.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#4] audio-oscillator Cycles:10 Average:81.10 Median:74.00 stddev:14.22 (19.2%) stddev-sans-first:15.04 18:09:03 INFO - PROCESS | 2197 | Values: 84.0 70.0 86.0 69.0 67.0 68.0 80.0 78.0 100.0 109.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.50 stddev:2.11 (2.4%) stddev-sans-first:2.15 18:09:03 INFO - PROCESS | 2197 | Values: 89.0 85.0 89.0 88.0 89.0 85.0 90.0 86.0 88.0 84.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.00 stddev:2.90 (3.0%) stddev-sans-first:0.33 18:09:03 INFO - PROCESS | 2197 | Values: 105.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:85.00 stddev:22.73 (26.7%) stddev-sans-first:22.53 18:09:03 INFO - PROCESS | 2197 | Values: 75.0 124.0 140.0 126.0 86.0 88.0 85.0 86.0 85.0 85.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.50 stddev:1.55 (2.8%) stddev-sans-first:1.62 18:09:03 INFO - PROCESS | 2197 | Values: 54.0 53.0 57.0 52.0 55.0 56.0 56.0 56.0 54.0 55.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:71.50 stddev:3.53 (4.9%) stddev-sans-first:2.68 18:09:03 INFO - PROCESS | 2197 | Values: 63.0 71.0 74.0 72.0 72.0 68.0 68.0 75.0 68.0 69.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:1.78 (2.2%) stddev-sans-first:1.88 18:09:03 INFO - PROCESS | 2197 | Values: 82.0 81.0 81.0 80.0 81.0 80.0 80.0 82.0 82.0 86.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:149.00 stddev:21.58 (14.5%) stddev-sans-first:22.85 18:09:03 INFO - PROCESS | 2197 | Values: 152.0 133.0 119.0 144.0 144.0 146.0 129.0 155.0 196.0 167.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.50 stddev:1.84 (1.1%) stddev-sans-first:1.72 18:09:03 INFO - PROCESS | 2197 | Values: 164.0 163.0 163.0 162.0 158.0 161.0 161.0 163.0 160.0 160.0 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - PROCESS | 2197 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.34 (2.1%) stddev-sans-first:0.71 18:09:03 INFO - PROCESS | 2197 | Values: 67.0 64.0 64.0 63.0 64.0 63.0 62.0 64.0 63.0 63.0 18:09:03 INFO - PROCESS | 2197 | -------- Summary: end -------- 18:09:03 INFO - PROCESS | 2197 | 18:09:03 INFO - TEST-INFO | 2197: exit 0 18:09:03 INFO - TEST-OK | kraken | took 58716ms 18:09:03 INFO - SUITE-END | took 1175s 18:09:04 INFO - Completed test suite (00:19:35) 18:09:04 INFO - javascript benchmark 18:09:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3426.3489936911983, 3435.467502537106, 3438.3295257424807, 3443.311337732454, 3478.565179352581, 5803.825885223439, 5855.560832937525, 5858.004139296319, 5860.5311575074, 5932.1694962705205, 5809.244798176232, 5833.737481813318, 5898.852528686785, 5948.7323070461825, 5979.970100149504, 5248.291480650101, 5291.841244762663, 5295.391030031538, 5348.786048558053, 5410.1073322901675, 5270.235815806705, 5283.260343551906, 5287.735613219324, 5370.919436208441, 5406.567474602022, 5318.30861987941, 5371.5165635092835, 5392.487713667196, 5399.892002159974, 5425.647332923367, 5361.571074314045, 5408.0, 5414.972925135388, 5416.8104116356135, 5423.728813559306, 5283.392409872837, 5346.6524675896335, 5349.946500534984, 5354.678719276817, 5358.2498450217, 5749.137629355589, 5757.596968212227, 5758.078707406795, 5781.103928891029, 5813.767449302023, 6245.843853903643, 6266.248050234001, 6267.843303917393, 6273.153124328249, 6279.37206279373, 4982.526659967298, 6305.117283580303, 6305.243370795488, 6306.432421082079, 6313.337099604521, 5928.851778705567, 5978.790742324085, 5983.0, 6111.847203819895, 6125.938740612582, 6258.217722784652, 6295.811125666238, 6381.361863813581, 6405.423511883952, 6416.165898433173, 6295.653739044396, 6298.02380631003, 6303.464205542488, 6312.400321969406, 6334.3032266450655, 6193.473554747807, 6240.781572644935, 6256.092866534418, 6293.937060629427, 6307.117003619497, 6187.071939209065, 6192.287886893065, 6217.844553886099, 6247.9062814057825, 6278.0, 6238.906416403757, 6252.249730032334, 6259.0924315973925, 6262.029385445263, 6262.185915830913, 5083.74581270935, 5102.081625307406, 5105.2086926526445, 5106.846794596168, 5121.923171152435, 4482.529334419904, 4520.683552151384, 4531.501534831166, 4541.613962813198, 4589.128065667513, 5916.408359164049, 5966.105084237312, 5984.371640977722, 6001.909971350433, 6008.128821320972, 6319.0, 6338.873222535523, 6348.396902294275, 6412.583182093149, 6413.711382987777, 5534.723263836792, 5677.17680936262, 5965.850853728604, 5981.671008094597, 5996.16053752475, 5165.819196328111, 5478.45215478457, 5492.642978206404, 5551.056320425457, 5575.470330318613, 6385.757149835127, 6422.710978006001, 6441.227052753606, 6476.060971159155, 6506.512011599054, 6210.503159747119, 6244.406781355764, 6264.154339164337, 6269.780557680459, 6275.937240627535, 6261.405166509175, 6318.178636777373, 6329.208848893888, 6354.936450635434, 6371.74513019474, 6274.403931626488, 6278.46633036197, 6293.622382656872, 6301.149344838388, 6301.936980630135, 6267.4986001120715, 6269.31037585856, 6280.27776805655, 6293.213348331458, 6307.747690092345, 4737.360456338351, 6143.450468055886, 6208.689565521616, 6211.099390588249, 6325.335839736946, 6150.04674275488, 6250.281217660027, 6293.276273228637, 6298.590591611531, 6317.4630156437215, 6210.5652604317265, 6217.378262173746, 6225.719842607003, 6229.53278504123, 6236.282827474898, 6128.503123582287, 6174.845628859314, 6291.716872740829, 6309.873802524015, 6322.49420046386, 6030.125631783455, 6131.509479241561, 6134.049222370361, 6148.1159724198105, 6166.105914642441], "value": 5812.618575250591, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.45546893338195, 474.44489946762286, 475.91909375406175, 483.35713501043614, 524.4991033562948, 32167.839160804193, 33991.83004084979, 42073.57926420739, 42815.0, 42987.785061074654, 44480.77759611198, 44610.33084503727, 44678.32982505257, 44733.32900006502, 44890.55109448905, 9392.577334019952, 9573.425594464354, 9590.664326748565, 9593.088656577649, 9608.615655373811, 9107.590158442852, 9284.16442520173, 9461.053894610553, 11702.12234082443, 11958.64124076279, 11076.94768996944, 11819.0, 11884.821727674092, 11897.16719829608, 11912.166148369617, 10784.0, 11790.823137652986, 11799.351035693033, 11830.0, 11832.467538960767, 11632.476538555786, 11736.413179341083, 11743.530258789639, 11745.882541174564, 11747.236429632047, 41143.794281028706, 41392.58607413917, 41414.792926035174, 41430.585694142974, 41450.58549414497, 3385.238321377695, 3399.0312760863035, 3421.349943510725, 3464.5842498900292, 3464.9480257796154, 26908.73091269082, 27388.863055684793, 27561.724382756318, 28798.712012880023, 29072.854635726897, 3242.9460425361617, 3289.5723555937575, 3353.7820041697455, 3445.9655403445895, 3519.63043880394, 404633.0, 426012.0, 427249.0, 427828.0, 428536.85731571453, 59082.11376829351, 59503.0, 59610.70194648999, 59972.80054398887, 60009.09986350208, 62858.37141628525, 62993.68503157455, 63054.68472657607, 63083.0, 63176.36823631797, 16501.0, 17055.91472042657, 17083.572910677085, 17104.572385690208, 17113.572160696083, 13193.868061319456, 13279.40242689062, 13280.468781248643, 13292.73414531704, 13297.401616927262, 14275.214863182624, 14655.34050967709, 22345.55308893813, 22750.976206070765, 22897.96959136843, 7376.7786966391095, 7425.62871856405, 8788.824223515494, 8957.193852553302, 8971.237444817263, 877.9771566125393, 888.2804928008205, 890.6971629645951, 917.0920788419417, 921.1433366968784, 28303.858480707466, 28820.0, 28970.27574310659, 29401.11796646104, 29539.113826585235, 1046.5133712823422, 1049.4070849969742, 1054.667779649408, 1089.2647462962468, 1094.63876920616, 14688.485902993343, 14998.250087495582, 15135.702504123688, 15229.314680839389, 15307.01338615286, 696880.0, 697660.0, 702864.0, 703584.0, 704886.0, 54282.5717428254, 54875.0, 54882.45117548773, 54920.0, 55127.0, 1313.4943046927, 1355.8440779310308, 1429.221074514392, 1432.957011289663, 1443.5669299210406, 23525.52948941046, 26394.0, 27537.0, 27825.747841347595, 28329.866805327558, 45227.32159017552, 45827.0, 45903.77048114738, 45954.93202805815, 46023.0, 565758.0, 573334.0, 573382.0, 575474.0, 576550.0, 21579.2447264345, 22110.557788844453, 23816.88091559531, 24330.0, 24700.25899223026, 38283.0, 38779.0, 38793.61206388013, 38988.80505597454, 39329.41005884857, 31681.84159079282, 32306.19234519062, 32460.83769581137, 32908.341833162725, 33439.49840752342, 32708.018759437255, 32921.83539082289, 32999.835000824845, 33227.50158747572, 33694.66305336915, 32226.516602251453, 32845.50731739074, 32880.83559582187, 33801.0, 33824.49263261102, 28197.15408537747, 30338.393232134793, 30451.0, 30459.847700761355, 30861.537076944314, 22746.924841680964, 22998.19506317271, 23549.175778848345, 23587.764122358556, 23908.64137037911], "value": 19652.284881447114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.1049076296002, 405.5761728993202, 412.31555617674667, 417.99582004179956, 434.3202887481092, 20695.275665351717, 21468.89265553674, 22192.223272185478, 22500.0, 22789.0, 17937.372191973285, 21701.0, 21880.01795242608, 22634.0, 23017.4245643859, 5236.319278493809, 5759.10733836255, 6079.908801367983, 6084.269887613493, 6092.29938557065, 5049.444561098277, 5772.797952071678, 6037.818865434044, 6079.78720744774, 6081.78713745019, 6015.939840601582, 6018.729157187915, 6021.879562408749, 6028.246469191351, 6030.819075427744, 7798.922010779905, 7961.686321756903, 8133.0, 8187.79530511736, 8230.341572674202, 6823.454123670094, 7907.48601340911, 8021.398395120389, 8042.477238979506, 8054.758357249292, 29921.850390748124, 29935.952241671435, 30456.54315185274, 30642.54036189459, 30776.0, 2708.214617760847, 2832.985835070832, 2890.132960111958, 2927.45842019225, 2948.82307061577, 16257.674846503121, 16501.504954851374, 16781.489665930003, 16839.74740378883, 17535.5616109597, 1701.2939630053513, 1957.7357056797293, 2078.5842831433774, 2208.447888027993, 2223.6886835842993, 123284.76715232822, 149706.0, 159083.40916590803, 159428.0, 161209.0, 23993.760062399502, 24643.0, 24669.259922202364, 24676.629850552257, 24966.875165624057, 42732.0, 42988.355174672404, 43851.342229866576, 44076.77961610172, 44233.778831105636, 11650.0, 11861.822072668916, 11884.702882428008, 11913.987311078656, 11924.523019079314, 9486.478243696663, 9500.334976551576, 9504.334696571312, 9689.224862011022, 9698.854517182248, 9020.81958360829, 9303.953480232556, 11252.0, 11311.717207069725, 11405.942970285096, 3646.927061458809, 4111.362738775495, 4215.831366745296, 4231.809568569422, 4390.8902277442685, 1030.340582027503, 1038.0, 1049.6116436918237, 1056.40482870864, 1079.5034284229343, 21288.0, 21447.78552214489, 21752.0, 21808.9728629245, 21885.781142188374, 1044.796264728386, 1053.6522947427331, 1056.5509658395151, 1090.0516550601028, 1093.5680406239492, 10993.230473866752, 11056.834147487794, 11106.389148596743, 11109.55561777536, 11352.14858885587, 770488.0, 776883.0, 780644.0, 780798.0, 782855.0, 147728.2613586925, 152429.8991024703, 154476.8209271639, 154792.90414191879, 160977.0, 823.5717426937958, 1029.4543891737542, 1059.247933966892, 1060.5545670818274, 1070.0904231403244, 19374.709379359603, 19770.50573735668, 20123.496912576717, 20199.293024744064, 20323.288684895957, 54870.17694734662, 59524.70237648784, 61905.0, 62304.68847655733, 64056.67971660112, 66643.33461659655, 73052.26947730668, 84707.30585388381, 89952.55023724839, 92116.61825072495, 5761.827145185651, 7933.206679332021, 8323.0, 8513.40406171562, 8648.481091134552, 9856.655017074369, 11051.502682379472, 12375.566855160387, 13069.5821273061, 13180.143290686075, 10693.465326733787, 10807.13542916549, 11071.83392249133, 11292.9435352826, 11415.315081095161, 8757.737267881974, 10697.358158510515, 10928.672139835817, 10966.396848173426, 11344.0, 11102.88897111051, 11341.376224307742, 11610.535578576762, 11746.17776755619, 11776.52893884235, 8401.873971890549, 8412.957935210285, 8632.913670863461, 8644.438111522732, 8645.351598630003, 10347.0, 10841.512131953923, 11081.83377249358, 11085.44572771342, 11322.490487927898], "value": 11616.850250988047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.7212877102647, 1472.1755816742625, 1485.9405623775049, 1495.7158139953415, 1499.4751836857101, 7652.158262591118, 8025.197480251972, 8249.670013199473, 8516.190961858629, 8522.531260780655, 8407.411481196319, 8486.15138486151, 8486.44838085524, 8487.0, 8497.980242370908, 2371.5256948610263, 2413.6620873077695, 2419.709634843812, 2419.9879000604974, 2423.866687332196, 2184.071769497965, 2267.455810605459, 2364.5507353602848, 2439.6706444630013, 2443.1204766284122, 2417.7340492545895, 2417.830751847371, 2417.8549287042833, 2419.250032489925, 2422.0190822716827, 2363.1728894886824, 2396.496735685508, 2398.5922393193023, 2401.399650087478, 2401.435662619283, 1996.341207401554, 2365.8107351411845, 2436.658867758515, 2438.3538362333998, 2441.511697660475, 8384.8742268866, 8450.366222533334, 8460.196281353261, 8486.448380855287, 8492.0, 5138.306328645623, 5302.09864323066, 5310.522053015208, 5312.415634280226, 5322.574194064466, 3407.4718418645148, 3569.3218288525095, 3605.6574625410544, 3621.3662609043313, 3632.346177688015, 1230.366361323919, 1269.9174553653984, 1273.3251376770233, 1314.1129737427198, 1322.1802482460935, 10858.131349492021, 10958.890411095947, 10982.0, 10987.505562249718, 11003.394813285346, 4142.937855932163, 4541.704789188692, 4771.0, 4832.516748325139, 4852.927206091911, 9547.665831695997, 9550.522473876279, 9554.04459554039, 9567.808643827084, 9575.09036641518, 5331.840044798662, 5333.093374126408, 5339.919901201485, 5341.172118321666, 5350.9732451337495, 3797.9240415191543, 4731.858044258678, 4819.108464933998, 4832.565069143794, 4912.1158191525155, 3712.4988126603103, 3932.623581746423, 4012.2376748417705, 4026.134381108076, 4027.375756757707, 1216.841810564621, 1235.7281398092405, 1238.2013601227159, 1247.3451437995125, 1247.3513772838073, 768.3814529303852, 847.4618617178013, 895.0735988252128, 900.9279257659372, 904.3985749476656, 3915.941260881089, 4351.73889566627, 5067.175816706057, 5292.655977361459, 5353.9196912046355, 954.9331546791797, 983.9176905403998, 997.3816233934862, 1027.8920713325142, 1039.0856046679025, 3085.9845700771352, 3264.2002709336366, 3488.4941683456263, 3568.536090308295, 3578.7673801202836, 9764.658236961814, 10059.597616095274, 10243.180545556486, 10269.691909242734, 10311.381317120997, 10193.490325483695, 10195.439250841127, 10201.13290370312, 10209.030142136486, 10215.387076775269, 7933.9603301983125, 8013.919860801434, 8073.19268073188, 8079.959600201962, 8082.878756818653, 5214.0, 5275.498827611371, 5347.090994530861, 5380.677159370451, 5468.0977638690765, 9067.501287429255, 9130.0, 9193.080691930754, 9274.25805935537, 9389.953050234979, 9215.539223038955, 9349.626014959325, 9431.858522122311, 9520.428774273565, 9522.143007129114, 6696.799096027127, 6699.564528305645, 6750.32496750321, 6753.628550429774, 6839.384455399038, 6621.10477145904, 7158.0, 7662.501937374052, 7858.960705196438, 7900.6049697513745, 7009.684564194726, 7029.683664235019, 7090.6100164491445, 7122.216556178712, 7162.785116446515, 6910.170779506491, 6914.51598388108, 6927.861442771015, 6964.303569642995, 6973.6164510952385, 6408.487321014401, 6416.615003099829, 6417.037444383193, 6478.384553467413, 6487.935120648733, 4082.0611259409907, 4584.243599805995, 4904.485029071896, 4904.7302398367, 5016.623753218596, 4856.1987272099705, 4868.829590964299, 4931.457539670705, 5016.598672106295, 5120.206368012964], "value": 4426.854162449479, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.9935197647177, 358.7668015789737, 377.7771115042125, 386.7930657098453, 389.62401282762147, 5062.797488100471, 5357.973210133949, 5401.756920938557, 5431.674099554025, 5433.293671822667, 5071.670341427814, 5166.741662916858, 5233.136532472137, 5241.266222728811, 5278.683279003253, 3970.3250447423934, 4090.8568200113, 4230.7250028748185, 4246.57534246576, 4252.704768184125, 4206.621404073633, 4234.809433575497, 4255.4467919170465, 4260.42484264625, 4261.0, 4071.796410179494, 4128.559972843604, 4203.579642035787, 4204.747715137101, 4216.114615930658, 4176.791160441966, 4180.853670121562, 4190.20386126635, 4190.491423087686, 4215.620594146541, 3731.552213734369, 3756.849726010956, 3757.9624203757885, 3759.2293579816073, 3788.3749181385037, 4999.500049995007, 5218.295530103425, 5220.407775628431, 5268.631195816294, 5279.234510995884, 4303.892402689927, 4830.6135509159185, 4905.0, 4948.455669876311, 4956.529129732669, 5703.800366987136, 5716.514096301819, 5743.2246646703, 5759.88965958382, 5820.883582328372, 3699.7965111918834, 4015.357542793139, 4140.68944829139, 4200.663946884272, 4201.621854033121, 5191.844244672666, 5587.552995760329, 5830.4169583041785, 5929.37741537141, 5930.738094048343, 3426.9828650856584, 4258.701890867672, 4297.355396690521, 4307.3754305626135, 4319.6976211665515, 3113.2372568720357, 4066.9389959150635, 4292.926768307923, 4336.284513055373, 4358.259095953696, 4765.833195838129, 4830.468648448667, 4830.855074347775, 4837.685550439211, 4866.6106711463, 4339.023719663113, 4881.243407271879, 5042.747862606929, 5426.403095659474, 5725.764942807301, 1271.7202215512573, 1328.860469650692, 1346.340293256317, 1374.2647683489286, 1383.557261676254, 912.5938957164132, 996.8554559588819, 998.7553049502773, 1010.4947526236881, 1013.381837079381, 4485.349624304457, 4519.07358991406, 4748.976255118771, 4996.475370086088, 5010.498950105033, 4945.159322915113, 5004.623728474626, 5534.363483545636, 5645.802396916089, 5668.853786148645, 4522.479914809839, 4783.569478746929, 4977.751112444364, 4994.550490455804, 5010.348654674869, 2701.7163197863943, 2717.2391730315544, 2872.4111557130736, 2905.8376649340435, 2906.4913640112895, 5203.487645839044, 5212.0, 5683.147527870852, 5720.167487783112, 5749.310082790092, 4849.684770489906, 5615.241942337814, 5644.407337229532, 5687.720262940888, 5755.014519990596, 4819.421669399694, 4901.828436004723, 5652.095664693629, 5662.377138514842, 5722.37053924068, 4933.555979961677, 5456.571825537598, 5504.4495550444635, 5890.1740460457395, 5961.523078153824, 5350.946490535201, 5385.649932754515, 5709.771609135588, 5790.1893734877995, 5804.82585522435, 5527.474889885454, 5608.775648974159, 6128.203333566607, 6134.809898852483, 6214.477453024038, 3359.328134373184, 3752.1614408939968, 3993.381025940984, 3995.62041606047, 4066.694997875112, 5205.843824685266, 5839.474447299764, 5892.467958330779, 5903.347062822417, 5931.406859314034, 4441.578050085237, 4651.3023046543285, 5499.807506737245, 5817.680027598353, 5866.823995280149, 4960.330355402119, 5468.835934921959, 5643.548516118783, 5648.689322087324, 5712.571557133315, 4879.414470263591, 5305.469453054664, 5538.363088244903, 5551.278333816578, 5600.487868275624, 5285.418603953485, 5596.804111856066, 5641.576881733804, 5718.199452076629, 5777.83331250781, 5027.2580226450855, 5172.0, 5610.747516361692, 5647.887042259214, 5654.886902262014], "value": 4179.7200455909815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.2764890407398, 739.3863093632285, 753.4161025205468, 788.4677842456344, 884.9778755531113, 15214.77177842332, 15758.527244182693, 15785.763213551805, 15798.763018554717, 15806.13066281354, 14134.151950882928, 14464.493742719007, 14500.854991450082, 14524.927375363108, 14552.636184095403, 906.1074841281333, 906.9138431848996, 923.0630909626734, 927.6104036304769, 929.159111004542, 730.4193166432672, 757.5681861339039, 904.416651259937, 907.0113576201938, 909.195362104539, 934.4907025670992, 963.2005435488562, 965.6716716316452, 966.4008314844771, 968.728755948332, 950.5864948747283, 952.1383148250844, 953.2564599612314, 954.1412728544296, 955.6082006377387, 715.965429953717, 716.8387112899608, 716.8494616130619, 719.0400814912099, 719.9496035277533, 15097.54707358781, 15531.767023494656, 15551.0, 15592.688146237011, 15605.531834044998, 13954.09298395601, 14376.209308488029, 14737.484188053366, 14797.630059248497, 14834.184119873402, 11866.288022718665, 11909.761804763857, 11941.641750747405, 12049.638510844688, 12071.215371000857, 3790.128270497801, 3870.845166193349, 3944.881653550398, 4036.1322315702264, 4071.5928407159345, 108879.91120088777, 113433.73132537385, 114061.85938140596, 116121.25818112736, 120961.0, 9788.265880058882, 10732.30240034411, 10987.450627468595, 11369.033632141196, 11808.239045566095, 23230.76769232286, 23336.64995025076, 23347.299581012598, 23354.53290934206, 23364.299071027897, 7617.352525035434, 7892.171322011106, 7895.368370530344, 8029.839403211903, 8097.716579919675, 4092.8850602217176, 4195.958040419618, 4428.7279609522475, 4496.348029535699, 4586.610138138229, 3273.263515708946, 3719.590845007047, 3798.2783271178387, 3918.1380096378753, 4123.237201117803, 737.1265050914683, 741.5661837824933, 750.3322043381395, 754.5359603843597, 761.7866997240782, 679.8402375441767, 689.1385767790263, 704.1866644026157, 720.4560556779597, 753.5892938348613, 10207.591696332063, 10273.691789246335, 10282.588696452207, 10735.409552474688, 10739.140868730483, 648.2447948140364, 679.894616334469, 691.8720036793109, 706.6290197646276, 733.3509843788286, 5040.901173382007, 5147.124988751922, 5159.329287192641, 5159.922601160985, 5169.224616307509, 104225.47887260666, 105908.47045764721, 106889.0, 107208.4639576797, 108539.91460085298, 92271.0, 94274.58588121184, 94613.05386946042, 97300.0, 98846.50576747215, 84598.0, 85121.57439212888, 85319.14680853236, 86826.0, 87833.0, 9520.761980950532, 9861.457619830979, 9909.851352229867, 9952.0, 9980.700578982642, 55054.17418738642, 55991.16013259886, 56436.0, 56546.717266413405, 57170.14244786248, 42913.99204111365, 67945.0, 69319.0, 70738.0, 72553.63723181562, 11360.602378916697, 11594.0, 11667.066634669376, 11768.117391195865, 11799.705007374885, 12383.876161238633, 12965.351732413154, 12967.805482917953, 12973.805392918925, 13009.21944683322, 11852.229605075643, 11961.222520536137, 12016.75966480683, 12056.336901470153, 12081.75836483283, 11409.432767978444, 11742.00192983606, 11880.82178767302, 12128.332941688292, 12147.574834880737, 11396.697902722197, 11840.940795295968, 11948.581799636971, 11958.820617690568, 12060.457279422271, 9857.457839818879, 10056.64801731936, 10179.694609161737, 10192.847107293544, 10821.188410869374, 8285.871488691051, 8827.617818654744, 9962.512042569559, 10095.646652367132, 10099.427778913974], "value": 7614.895961465733, "unit": "score"}], "name": "dromaeo_css", "value": 7562.023956425083, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 116.0, 113.0, 113.0, 115.0, 114.0, 113.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 97.0, 167.0, 140.0, 138.0, 110.0, 108.0, 124.0, 110.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 183.0, 195.0, 261.0, 206.0, 184.0, 183.0, 185.0, 183.0], "value": 194.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 88.0, 62.0, 58.0, 57.0, 60.0, 67.0, 61.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 86.0, 69.0, 67.0, 68.0, 80.0, 78.0, 100.0, 109.0], "value": 81.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 88.0, 89.0, 85.0, 90.0, 86.0, 88.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 124.0, 140.0, 126.0, 86.0, 88.0, 85.0, 86.0, 85.0, 85.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 57.0, 52.0, 55.0, 56.0, 56.0, 56.0, 54.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 74.0, 72.0, 72.0, 68.0, 68.0, 75.0, 68.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 80.0, 81.0, 80.0, 80.0, 82.0, 82.0, 86.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 119.0, 144.0, 144.0, 146.0, 129.0, 155.0, 196.0, 167.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 158.0, 161.0, 161.0, 163.0, 160.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 63.0, 64.0, 63.0, 62.0, 64.0, 63.0, 63.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1440.3, "alertThreshold": 2.0}]} 18:09:04 INFO - Return code: 0 18:09:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:09:04 INFO - # TBPL SUCCESS # 18:09:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:09:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:09:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:09:04 INFO - 2017-03-17 18:09:04.372 screenresolution[2203:33673] starting screenresolution argv=screenresolution get 18:09:04 INFO - 2017-03-17 18:09:04.375 screenresolution[2203:33673] Display 0: 1600x1200x32@60 18:09:04 INFO - 2017-03-17 18:09:04.381 screenresolution[2204:33676] starting screenresolution argv=screenresolution list 18:09:04 INFO - Available Modes on Display 0 18:09:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:09:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:09:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:09:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:09:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:09:04 INFO - Intel Iris: 18:09:04 INFO - Chipset Model: Intel Iris 18:09:04 INFO - Type: GPU 18:09:04 INFO - Bus: Built-In 18:09:04 INFO - VRAM (Dynamic, Max): 1536 MB 18:09:04 INFO - Vendor: Intel (0x8086) 18:09:04 INFO - Device ID: 0x0a2e 18:09:04 INFO - Revision ID: 0x0009 18:09:04 INFO - Displays: 18:09:04 INFO - Display: 18:09:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:09:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:09:04 INFO - Display Serial Number: 1600x1200 60 18:09:04 INFO - Main Display: Yes 18:09:04 INFO - Mirror: Off 18:09:04 INFO - Online: Yes 18:09:04 INFO - Rotation: Supported 18:09:04 INFO - Return code: 0 18:09:04 INFO - Running post-action listener: _resource_record_post_action 18:09:04 INFO - [mozharness: 2017-03-18 01:09:04.619720Z] Finished run-tests step (success) 18:09:04 INFO - Running post-run listener: _resource_record_post_run 18:09:04 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 389120; Write bytes: 421989376; Read time: 5; Write time: 1398 18:09:04 INFO - TinderboxPrint: CPU usage
53.7% 18:09:04 INFO - TinderboxPrint: I/O read bytes / time
389,120 / 5 18:09:04 INFO - TinderboxPrint: I/O write bytes / time
421,989,376 / 1,398 18:09:04 INFO - TinderboxPrint: CPU idle
2,206.0 (46.3%) 18:09:04 INFO - TinderboxPrint: CPU system
954.9 (20.0%) 18:09:04 INFO - TinderboxPrint: CPU user
1,604.8 (33.7%) 18:09:04 INFO - TinderboxPrint: Swap in / out
121,745,408 / 0 18:09:04 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 107610624; Write bytes: 104077312; Read time: 9802; Write time: 233 18:09:04 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 389120; Write bytes: 296334336; Read time: 5; Write time: 1100 18:09:05 INFO - Running post-run listener: _upload_blobber_files 18:09:05 INFO - Blob upload gear active. 18:09:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:09:05 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 18:09:05 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:09:05 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:09:05 INFO - (blobuploader) - INFO - Open directory for files ... 18:09:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:09:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:07 INFO - (blobuploader) - INFO - Done attempting. 18:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:09 INFO - (blobuploader) - INFO - Done attempting. 18:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:11 INFO - (blobuploader) - INFO - Done attempting. 18:09:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:09:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:09:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:14 INFO - (blobuploader) - INFO - Done attempting. 18:09:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:09:14 INFO - Return code: 0 18:09:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:09:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:09:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c037540c44911ae192e85fb6d4fe07613e92de43c5f68135ccb81f2815d9793e15529a0748e0c8e40f88d1a50e1ed77f24b9e84b141282b5410bd3a77f01a6e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99b1d27a21edb6a9041b1b587b7abd21d1e97dc8c74bc7604ed60dac30b6e19358194d0edea0fc46189c4d2a3b11129ea1817bec93888d26287f952174203c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4af27b267917206817b5bf802236dad19ff75afe9ccfc8638a206e35104ce3f6a72c6dc90febcd058a9df52b7977a6672a52e7634b4ece3dc3c8d44016194d4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84e90940bc19670d4f685372f0cf47dcbda8692e6c4bab5dd1ea9eedae8221b92b2c85e4af385cceafa00e176cab242993d9318de436856e5b6ddd113484ec02"} 18:09:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:09:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:09:14 INFO - Contents: 18:09:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c037540c44911ae192e85fb6d4fe07613e92de43c5f68135ccb81f2815d9793e15529a0748e0c8e40f88d1a50e1ed77f24b9e84b141282b5410bd3a77f01a6e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99b1d27a21edb6a9041b1b587b7abd21d1e97dc8c74bc7604ed60dac30b6e19358194d0edea0fc46189c4d2a3b11129ea1817bec93888d26287f952174203c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4af27b267917206817b5bf802236dad19ff75afe9ccfc8638a206e35104ce3f6a72c6dc90febcd058a9df52b7977a6672a52e7634b4ece3dc3c8d44016194d4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84e90940bc19670d4f685372f0cf47dcbda8692e6c4bab5dd1ea9eedae8221b92b2c85e4af385cceafa00e176cab242993d9318de436856e5b6ddd113484ec02"} 18:09:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:09:14 INFO - Copying logs to upload dir... 18:09:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:09:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.832345 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-17 18:09:14.474834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 18:09:14.478472) ========= 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.h59RtgtNLK/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.6eqfSz8JUL/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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/Mozilla-Beta/sha512/c037540c44911ae192e85fb6d4fe07613e92de43c5f68135ccb81f2815d9793e15529a0748e0c8e40f88d1a50e1ed77f24b9e84b141282b5410bd3a77f01a6e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99b1d27a21edb6a9041b1b587b7abd21d1e97dc8c74bc7604ed60dac30b6e19358194d0edea0fc46189c4d2a3b11129ea1817bec93888d26287f952174203c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4af27b267917206817b5bf802236dad19ff75afe9ccfc8638a206e35104ce3f6a72c6dc90febcd058a9df52b7977a6672a52e7634b4ece3dc3c8d44016194d4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84e90940bc19670d4f685372f0cf47dcbda8692e6c4bab5dd1ea9eedae8221b92b2c85e4af385cceafa00e176cab242993d9318de436856e5b6ddd113484ec02"} build_url:https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011102 build_url: 'https://queue.taskcluster.net/v1/task/FurZ3UGyTQafo8OUrEhPhQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c037540c44911ae192e85fb6d4fe07613e92de43c5f68135ccb81f2815d9793e15529a0748e0c8e40f88d1a50e1ed77f24b9e84b141282b5410bd3a77f01a6e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99b1d27a21edb6a9041b1b587b7abd21d1e97dc8c74bc7604ed60dac30b6e19358194d0edea0fc46189c4d2a3b11129ea1817bec93888d26287f952174203c0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4af27b267917206817b5bf802236dad19ff75afe9ccfc8638a206e35104ce3f6a72c6dc90febcd058a9df52b7977a6672a52e7634b4ece3dc3c8d44016194d4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84e90940bc19670d4f685372f0cf47dcbda8692e6c4bab5dd1ea9eedae8221b92b2c85e4af385cceafa00e176cab242993d9318de436856e5b6ddd113484ec02"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 18:09:14.512301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 18:09:14.512712) ========= 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.h59RtgtNLK/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.6eqfSz8JUL/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.005328 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 18:09:14.560765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 18:09:14.561084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 18:09:14.561401) ========= ========= Total master_lag: 0.18 =========