builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0370 starttime: 1492654682.86 results: success (0) buildid: 20170419171727 builduid: 936fd57733e04b0295dc5b431687b5c2 revision: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:02.861843) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:02.862269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:02.862543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:02.889050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:02.889362) ========= 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.85XLqaDLGW/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.M0NqHgB8yk/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-04-19 19:18:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2017-04-19 19:18:03 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133021 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:03.049809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:03.050132) ========= 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.85XLqaDLGW/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.M0NqHgB8yk/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.029344 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:03.103804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:18:03.105215) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 --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 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.85XLqaDLGW/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.M0NqHgB8yk/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-04-19 19:18:03,237 truncating revision to first 12 chars 2017-04-19 19:18:03,237 Setting DEBUG logging. 2017-04-19 19:18:03,237 attempt 1/10 2017-04-19 19:18:03,237 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9edc76120a27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 19:18:04,566 unpacking tar archive at: mozilla-beta-9edc76120a27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600205 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:18:04.735011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:04.735740) ========= script_repo_revision: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:04.736669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:04.737362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:18:04.758575) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-19 19:18:04.759262) ========= /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.85XLqaDLGW/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.M0NqHgB8yk/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:18:04 INFO - MultiFileLogger online at 20170419 19:18:04 in /builds/slave/test 19:18:04 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 19:18:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:18:04 INFO - {'append_to_log': False, 19:18:04 INFO - 'base_work_dir': '/builds/slave/test', 19:18:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:18:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:18:04 INFO - 'branch': 'Mozilla-Beta', 19:18:04 INFO - 'buildbot_json_path': 'buildprops.json', 19:18:04 INFO - 'config_files': ('talos/mac_config.py',), 19:18:04 INFO - 'default_actions': ('clobber', 19:18:04 INFO - 'read-buildbot-config', 19:18:04 INFO - 'download-and-extract', 19:18:04 INFO - 'populate-webroot', 19:18:04 INFO - 'create-virtualenv', 19:18:04 INFO - 'install', 19:18:04 INFO - 'run-tests'), 19:18:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:18:04 INFO - 'download_minidump_stackwalk': True, 19:18:04 INFO - 'download_symbols': 'ondemand', 19:18:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:18:04 INFO - 'tooltool.py': '/tools/tooltool.py', 19:18:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:18:04 INFO - '/tools/misc-python/virtualenv.py')}, 19:18:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:18:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:18:04 INFO - 'gecko_profile': False, 19:18:04 INFO - 'gecko_profile_interval': 0, 19:18:04 INFO - 'installer_path': 'installer.exe', 19:18:04 INFO - 'log_level': 'info', 19:18:04 INFO - 'log_name': 'talos', 19:18:04 INFO - 'log_to_console': True, 19:18:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:18:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:18:04 INFO - 'opt_config_files': (), 19:18:04 INFO - 'pip_index': False, 19:18:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:18:04 INFO - 'cmd': ('bash', 19:18:04 INFO - '-c', 19:18:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:18:04 INFO - 'enabled': True, 19:18:04 INFO - 'halt_on_failure': False, 19:18:04 INFO - 'name': 'check_screen_resolution'},), 19:18:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:18:04 INFO - 'cmd': ('bash', 19:18:04 INFO - '-c', 19:18:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:18:04 INFO - 'enabled': True, 19:18:04 INFO - 'halt_on_failure': False, 19:18:04 INFO - 'name': 'check_screen_resolution'},), 19:18:04 INFO - 'run_cmd_checks_enabled': True, 19:18:04 INFO - 'suite': 'dromaeojs', 19:18:04 INFO - 'system_bits': '32', 19:18:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:18:04 INFO - 'title': 't-yosemite-r7-0370', 19:18:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:18:04 INFO - 'use_talos_json': True, 19:18:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:18:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:18:04 INFO - 'work_dir': 'build'} 19:18:04 INFO - [mozharness: 2017-04-20 02:18:04.992824Z] Running clobber step. 19:18:04 INFO - Running pre-action listener: _resource_record_pre_action 19:18:04 INFO - Running main action method: clobber 19:18:04 INFO - rmtree: /builds/slave/test/build 19:18:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:07 INFO - Running post-action listener: _resource_record_post_action 19:18:07 INFO - [mozharness: 2017-04-20 02:18:07.391379Z] Finished clobber step (success) 19:18:07 INFO - [mozharness: 2017-04-20 02:18:07.391590Z] Running read-buildbot-config step. 19:18:07 INFO - Running pre-action listener: _resource_record_pre_action 19:18:07 INFO - Running main action method: read_buildbot_config 19:18:07 INFO - Using buildbot properties: 19:18:07 INFO - { 19:18:07 INFO - "project": "", 19:18:07 INFO - "product": "firefox", 19:18:07 INFO - "script_repo_revision": "production", 19:18:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 19:18:07 INFO - "repository": "", 19:18:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 19:18:07 INFO - "buildid": "20170419171727", 19:18:07 INFO - "pgo_build": "False", 19:18:07 INFO - "basedir": "/builds/slave/test", 19:18:07 INFO - "buildnumber": 3, 19:18:07 INFO - "slavename": "t-yosemite-r7-0370", 19:18:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:18:07 INFO - "platform": "yosemite_r7", 19:18:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:18:07 INFO - "branch": "mozilla-beta", 19:18:07 INFO - "repo_path": "releases/mozilla-beta", 19:18:07 INFO - "revision": "9edc76120a27a6c407e9f45d0b7a9b0877b80f57", 19:18:07 INFO - "stage_platform": "macosx64", 19:18:07 INFO - "builduid": "936fd57733e04b0295dc5b431687b5c2", 19:18:07 INFO - "slavebuilddir": "test" 19:18:07 INFO - } 19:18:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 19:18:07 INFO - Running post-action listener: _resource_record_post_action 19:18:07 INFO - [mozharness: 2017-04-20 02:18:07.397234Z] Finished read-buildbot-config step (success) 19:18:07 INFO - [mozharness: 2017-04-20 02:18:07.397431Z] Running download-and-extract step. 19:18:07 INFO - Running pre-action listener: _resource_record_pre_action 19:18:07 INFO - Running main action method: download_and_extract 19:18:07 INFO - mkdir: /builds/slave/test/build/tests 19:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:07 INFO - trying https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 19:18:07 INFO - Downloading https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 19:18:08 INFO - Downloaded 1165 bytes. 19:18:08 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:18:08 INFO - Using the following test package requirements: 19:18:08 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:18:08 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:08 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 19:18:08 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:08 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 19:18:08 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:18:08 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:08 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 19:18:08 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:18:08 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:08 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 19:18:08 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:08 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 19:18:08 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:08 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 19:18:08 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:08 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 19:18:08 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 19:18:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:18:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:18:08 INFO - Fetch https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:18:10 INFO - Expected file size: 51220783 19:18:10 INFO - Obtained file size: 51220783 19:18:25 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:18:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:18:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:18:25 INFO - Fetch https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:18:27 INFO - Expected file size: 51220783 19:18:27 INFO - Obtained file size: 51220783 19:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 19:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 19:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 19:18:43 INFO - Expected file size: 14404424 19:18:43 INFO - Obtained file size: 14404424 19:18: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')]} 19:18:43 INFO - trying https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:18:43 INFO - Downloading https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 19:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 19:18:45 INFO - Downloaded 59193643 bytes. 19:18:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:18:45 INFO - mkdir: /builds/slave/test/properties 19:18:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:18:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:18:45 INFO - Contents: 19:18:45 INFO - build_url:https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:18:46 INFO - Running post-action listener: _resource_record_post_action 19:18:46 INFO - Running post-action listener: set_extra_try_arguments 19:18:46 INFO - [mozharness: 2017-04-20 02:18:46.492597Z] Finished download-and-extract step (success) 19:18:46 INFO - [mozharness: 2017-04-20 02:18:46.492725Z] Running populate-webroot step. 19:18:46 INFO - Running pre-action listener: _resource_record_pre_action 19:18:46 INFO - Running main action method: populate_webroot 19:18:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:18:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:18:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:18:46 INFO - '--tppagecycles', 19:18:46 INFO - '7'], 19:18:46 INFO - 'tests': ['tsvgm']}}, 19:18:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:18:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:18:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:18:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:18:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:18:46 INFO - 'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:18:46 INFO - 'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['damp', 'tps']}, 19:18:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:18:46 INFO - 'tests': ['damp', 'tps']}, 19:18:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['dromaeo_dom']}, 19:18:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:18:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['basic_compositor_video']}, 19:18:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:18:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['a11yr', 19:18:46 INFO - 'ts_paint', 19:18:46 INFO - 'tpaint', 19:18:46 INFO - 'sessionrestore', 19:18:46 INFO - 'sessionrestore_no_auto_restore', 19:18:46 INFO - 'tabpaint']}, 19:18:46 INFO - 'other-e10s': {'tests': ['a11yr', 19:18:46 INFO - 'ts_paint', 19:18:46 INFO - 'tpaint', 19:18:46 INFO - 'sessionrestore', 19:18:46 INFO - 'sessionrestore_no_auto_restore', 19:18:46 INFO - 'tabpaint']}, 19:18:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:18:46 INFO - 'ts_paint', 19:18:46 INFO - 'tpaint', 19:18:46 INFO - 'sessionrestore', 19:18:46 INFO - 'sessionrestore_no_auto_restore', 19:18:46 INFO - 'tabpaint']}, 19:18:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:18:46 INFO - 'ts_paint', 19:18:46 INFO - 'tpaint', 19:18:46 INFO - 'sessionrestore', 19:18:46 INFO - 'sessionrestore_no_auto_restore', 19:18:46 INFO - 'tabpaint']}, 19:18:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['a11yr', 19:18:46 INFO - 'ts_paint', 19:18:46 INFO - 'tpaint', 19:18:46 INFO - 'sessionrestore', 19:18:46 INFO - 'sessionrestore_no_auto_restore', 19:18:46 INFO - 'tabpaint']}, 19:18:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['a11yr', 19:18:46 INFO - 'ts_paint', 19:18:46 INFO - 'tpaint', 19:18:46 INFO - 'sessionrestore', 19:18:46 INFO - 'sessionrestore_no_auto_restore', 19:18:46 INFO - 'tabpaint']}, 19:18:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['tsvgx', 19:18:46 INFO - 'tsvgr_opacity', 19:18:46 INFO - 'tart', 19:18:46 INFO - 'tscrollx', 19:18:46 INFO - 'cart', 19:18:46 INFO - 'tsvg_static']}, 19:18:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:18:46 INFO - 'tsvgr_opacity', 19:18:46 INFO - 'tart', 19:18:46 INFO - 'tscrollx', 19:18:46 INFO - 'cart', 19:18:46 INFO - 'tsvg_static']}, 19:18:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:18:46 INFO - 'talos_options': ['--disable-e10s'], 19:18:46 INFO - 'tests': ['tp5o']}, 19:18:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:18:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:18:46 INFO - 'talos_options': ['--disable-e10s', 19:18:46 INFO - '--xperf_path', 19:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:46 INFO - 'tests': ['tp5n']}, 19:18:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:18:46 INFO - 'talos_options': ['--xperf_path', 19:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:46 INFO - 'tests': ['tp5n']}}, 19:18:46 INFO - 'talos.zip': {'path': '', 19:18:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:18:46 INFO - Running post-action listener: _resource_record_post_action 19:18:46 INFO - [mozharness: 2017-04-20 02:18:46.510808Z] Finished populate-webroot step (success) 19:18:46 INFO - [mozharness: 2017-04-20 02:18:46.510941Z] Running create-virtualenv step. 19:18:46 INFO - Running pre-action listener: _resource_record_pre_action 19:18:46 INFO - Running main action method: create_virtualenv 19:18:46 INFO - Creating virtualenv /builds/slave/test/build/venv 19:18:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:18:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:18:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:18:46 INFO - Using real prefix '/tools/python27' 19:18:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:18:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:18:50 INFO - Installing pip.................done. 19:18:50 INFO - Return code: 0 19:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:18:50 INFO - Reading from file tmpfile_stdout 19:18:50 INFO - Output received: 19:18:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:50 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:50 INFO - 'HOME': '/Users/cltbld', 19:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:50 INFO - 'LOGNAME': 'cltbld', 19:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:50 INFO - 'MOZ_NO_REMOTE': '1', 19:18:50 INFO - 'NO_EM_RESTART': '1', 19:18:50 INFO - 'PAGER': '/bin/cat', 19:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:50 INFO - 'PWD': '/builds/slave/test', 19:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:50 INFO - 'SHELL': '/bin/bash', 19:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:18:50 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:50 INFO - 'USER': 'cltbld', 19:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:50 INFO - 'XPC_FLAGS': '0x0', 19:18:50 INFO - 'XPC_SERVICE_NAME': '0', 19:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:18:50 INFO - Cleaning up... 19:18:50 INFO - Return code: 0 19:18:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:50 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:50 INFO - 'HOME': '/Users/cltbld', 19:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:50 INFO - 'LOGNAME': 'cltbld', 19:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:50 INFO - 'MOZ_NO_REMOTE': '1', 19:18:50 INFO - 'NO_EM_RESTART': '1', 19:18:50 INFO - 'PAGER': '/bin/cat', 19:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:50 INFO - 'PWD': '/builds/slave/test', 19:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:50 INFO - 'SHELL': '/bin/bash', 19:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:18:50 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:50 INFO - 'USER': 'cltbld', 19:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:50 INFO - 'XPC_FLAGS': '0x0', 19:18:50 INFO - 'XPC_SERVICE_NAME': '0', 19:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:51 INFO - Downloading/unpacking psutil>=3.1.1 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:18:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:54 INFO - Installing collected packages: psutil 19:18:54 INFO - Running setup.py install for psutil 19:18:54 INFO - building 'psutil._psutil_osx' extension 19:18:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:18:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:18:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:18:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:18:55 INFO - building 'psutil._psutil_posix' extension 19:18:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:18:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:18:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:18:55 INFO - ^ 19:18:55 INFO - 1 warning generated. 19:18:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:18:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:55 INFO - Successfully installed psutil 19:18:55 INFO - Cleaning up... 19:18:55 INFO - Return code: 0 19:18:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:18: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 mozsystemmonitor==0.3 19:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:55 INFO - 'HOME': '/Users/cltbld', 19:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:55 INFO - 'LOGNAME': 'cltbld', 19:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:55 INFO - 'MOZ_NO_REMOTE': '1', 19:18:55 INFO - 'NO_EM_RESTART': '1', 19:18:55 INFO - 'PAGER': '/bin/cat', 19:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:55 INFO - 'PWD': '/builds/slave/test', 19:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:55 INFO - 'SHELL': '/bin/bash', 19:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:18:55 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:55 INFO - 'USER': 'cltbld', 19:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:55 INFO - 'XPC_FLAGS': '0x0', 19:18:55 INFO - 'XPC_SERVICE_NAME': '0', 19:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:18:58 INFO - Installing collected packages: mozsystemmonitor 19:18:58 INFO - Running setup.py install for mozsystemmonitor 19:18:58 INFO - Successfully installed mozsystemmonitor 19:18:58 INFO - Cleaning up... 19:18:58 INFO - Return code: 0 19:18:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:00 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:00 INFO - 'HOME': '/Users/cltbld', 19:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:00 INFO - 'LOGNAME': 'cltbld', 19:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:00 INFO - 'MOZ_NO_REMOTE': '1', 19:19:00 INFO - 'NO_EM_RESTART': '1', 19:19:00 INFO - 'PAGER': '/bin/cat', 19:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:00 INFO - 'PWD': '/builds/slave/test', 19:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:00 INFO - 'SHELL': '/bin/bash', 19:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:00 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:00 INFO - 'USER': 'cltbld', 19:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:00 INFO - 'XPC_FLAGS': '0x0', 19:19:00 INFO - 'XPC_SERVICE_NAME': '0', 19:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:00 INFO - Downloading/unpacking jsonschema==2.5.1 19:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:19:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:03 INFO - Downloading functools32-3.2.3-2.tar.gz 19:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:19:03 INFO - warning: no files found matching '*.txt' 19:19:03 INFO - no previously-included directories found matching 'build' 19:19:03 INFO - no previously-included directories found matching 'dist' 19:19:03 INFO - no previously-included directories found matching '.git*' 19:19:03 INFO - Installing collected packages: jsonschema, functools32 19:19:03 INFO - Running setup.py install for functools32 19:19:04 INFO - warning: no files found matching '*.txt' 19:19:04 INFO - no previously-included directories found matching 'build' 19:19:04 INFO - no previously-included directories found matching 'dist' 19:19:04 INFO - no previously-included directories found matching '.git*' 19:19:04 INFO - Successfully installed jsonschema functools32 19:19:04 INFO - Cleaning up... 19:19:04 INFO - Return code: 0 19:19:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:04 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:04 INFO - 'HOME': '/Users/cltbld', 19:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:04 INFO - 'LOGNAME': 'cltbld', 19:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:04 INFO - 'MOZ_NO_REMOTE': '1', 19:19:04 INFO - 'NO_EM_RESTART': '1', 19:19:04 INFO - 'PAGER': '/bin/cat', 19:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:04 INFO - 'PWD': '/builds/slave/test', 19:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:04 INFO - 'SHELL': '/bin/bash', 19:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:04 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:04 INFO - 'USER': 'cltbld', 19:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:04 INFO - 'XPC_FLAGS': '0x0', 19:19:04 INFO - 'XPC_SERVICE_NAME': '0', 19:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:19:04 INFO - Cleaning up... 19:19:04 INFO - Return code: 0 19:19:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:04 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:04 INFO - 'HOME': '/Users/cltbld', 19:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:04 INFO - 'LOGNAME': 'cltbld', 19:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:04 INFO - 'MOZ_NO_REMOTE': '1', 19:19:04 INFO - 'NO_EM_RESTART': '1', 19:19:04 INFO - 'PAGER': '/bin/cat', 19:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:04 INFO - 'PWD': '/builds/slave/test', 19:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:04 INFO - 'SHELL': '/bin/bash', 19:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:04 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:04 INFO - 'USER': 'cltbld', 19:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:04 INFO - 'XPC_FLAGS': '0x0', 19:19:04 INFO - 'XPC_SERVICE_NAME': '0', 19:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:04 INFO - Downloading/unpacking blobuploader==1.2.4 19:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:07 INFO - Downloading blobuploader-1.2.4.tar.gz 19:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:19:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:19:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:08 INFO - Downloading docopt-0.6.1.tar.gz 19:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:19:08 INFO - Installing collected packages: blobuploader, requests, docopt 19:19:08 INFO - Running setup.py install for blobuploader 19:19:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:19:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:19:08 INFO - Running setup.py install for requests 19:19:09 INFO - Running setup.py install for docopt 19:19:09 INFO - Successfully installed blobuploader requests docopt 19:19:09 INFO - Cleaning up... 19:19:09 INFO - Return code: 0 19:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:09 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:09 INFO - 'HOME': '/Users/cltbld', 19:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:09 INFO - 'LOGNAME': 'cltbld', 19:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:09 INFO - 'MOZ_NO_REMOTE': '1', 19:19:09 INFO - 'NO_EM_RESTART': '1', 19:19:09 INFO - 'PAGER': '/bin/cat', 19:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:09 INFO - 'PWD': '/builds/slave/test', 19:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:09 INFO - 'SHELL': '/bin/bash', 19:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:09 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:09 INFO - 'USER': 'cltbld', 19:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:09 INFO - 'XPC_FLAGS': '0x0', 19:19:09 INFO - 'XPC_SERVICE_NAME': '0', 19:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:09 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-mxzpnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:09 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-HIGErr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-GlJd16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-6VuLpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-7JLU2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-0sE8TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-FSvjiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-rbCFdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-GoCChV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-iPT9PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-GKxTx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:10 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-e7WF8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:11 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ycgAqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:11 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-4BePlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:11 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-biXpmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:11 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Z93J_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:11 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-EjVwbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:19:11 INFO - Running setup.py install for manifestparser 19:19:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:19:11 INFO - Running setup.py install for mozcrash 19:19:11 INFO - Running setup.py install for mozdebug 19:19:11 INFO - Running setup.py install for mozdevice 19:19:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Running setup.py install for mozfile 19:19:12 INFO - Running setup.py install for mozhttpd 19:19:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Running setup.py install for mozinfo 19:19:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Running setup.py install for mozInstall 19:19:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:19:12 INFO - Running setup.py install for mozleak 19:19:12 INFO - Running setup.py install for mozlog 19:19:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:19:13 INFO - Running setup.py install for moznetwork 19:19:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:19:13 INFO - Running setup.py install for mozprocess 19:19:13 INFO - Running setup.py install for mozprofile 19:19:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:19:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:19:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:19:13 INFO - Running setup.py install for mozrunner 19:19:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:19:13 INFO - Running setup.py install for mozscreenshot 19:19:13 INFO - Running setup.py install for moztest 19:19:13 INFO - Running setup.py install for mozversion 19:19:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:19:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:19:14 INFO - Cleaning up... 19:19:14 INFO - Return code: 0 19:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:14 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:14 INFO - 'HOME': '/Users/cltbld', 19:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:14 INFO - 'LOGNAME': 'cltbld', 19:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:14 INFO - 'MOZ_NO_REMOTE': '1', 19:19:14 INFO - 'NO_EM_RESTART': '1', 19:19:14 INFO - 'PAGER': '/bin/cat', 19:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:14 INFO - 'PWD': '/builds/slave/test', 19:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:14 INFO - 'SHELL': '/bin/bash', 19:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:14 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:14 INFO - 'USER': 'cltbld', 19:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:14 INFO - 'XPC_FLAGS': '0x0', 19:19:14 INFO - 'XPC_SERVICE_NAME': '0', 19:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:14 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-rRXoh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:14 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-jCOlKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:14 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-2vt8fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:14 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-anruzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:14 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Yn57ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:14 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-4CwZ_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-q7_7if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-n4Tbfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-5ncQRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-mU6q1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-G48SCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-LxJ9Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-_yqEh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-yS0Z7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-RNE23I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-XZ2k9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-8shwiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:19:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:18 INFO - Downloading blessings-1.6.tar.gz 19:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:19:18 INFO - Installing collected packages: blessings 19:19:18 INFO - Running setup.py install for blessings 19:19:19 INFO - Successfully installed blessings 19:19:19 INFO - Cleaning up... 19:19:19 INFO - Return code: 0 19:19:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:19 INFO - Reading from file tmpfile_stdout 19:19:19 INFO - Current package versions: 19:19:19 INFO - blessings == 1.6 19:19:19 INFO - blobuploader == 1.2.4 19:19:19 INFO - docopt == 0.6.1 19:19:19 INFO - functools32 == 3.2.3-2 19:19:19 INFO - jsonschema == 2.5.1 19:19:19 INFO - manifestparser == 1.1 19:19:19 INFO - mozInstall == 1.12 19:19:19 INFO - mozcrash == 1.0 19:19:19 INFO - mozdebug == 0.1 19:19:19 INFO - mozdevice == 0.49 19:19:19 INFO - mozfile == 1.2 19:19:19 INFO - mozhttpd == 0.7 19:19:19 INFO - mozinfo == 0.9 19:19:19 INFO - mozleak == 0.1 19:19:19 INFO - mozlog == 3.4 19:19:19 INFO - moznetwork == 0.27 19:19:19 INFO - mozprocess == 0.25 19:19:19 INFO - mozprofile == 0.28 19:19:19 INFO - mozrunner == 6.13 19:19:19 INFO - mozscreenshot == 0.1 19:19:19 INFO - mozsystemmonitor == 0.3 19:19:19 INFO - moztest == 0.8 19:19:19 INFO - mozversion == 1.4 19:19:19 INFO - psutil == 3.1.1 19:19:19 INFO - requests == 1.2.3 19:19:19 INFO - wsgiref == 0.1.2 19:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:19 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:19 INFO - 'HOME': '/Users/cltbld', 19:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:19 INFO - 'LOGNAME': 'cltbld', 19:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:19 INFO - 'MOZ_NO_REMOTE': '1', 19:19:19 INFO - 'NO_EM_RESTART': '1', 19:19:19 INFO - 'PAGER': '/bin/cat', 19:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:19 INFO - 'PWD': '/builds/slave/test', 19:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:19 INFO - 'SHELL': '/bin/bash', 19:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:19 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:19 INFO - 'USER': 'cltbld', 19:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:19 INFO - 'XPC_FLAGS': '0x0', 19:19:19 INFO - 'XPC_SERVICE_NAME': '0', 19:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:19:19 INFO - Cleaning up... 19:19:19 INFO - Return code: 0 19:19:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:19 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 0x109a49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81fb576930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, '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.85XLqaDLGW/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.M0NqHgB8yk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:19 INFO - 'HOME': '/Users/cltbld', 19:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:19 INFO - 'LOGNAME': 'cltbld', 19:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:19 INFO - 'MOZ_NO_REMOTE': '1', 19:19:19 INFO - 'NO_EM_RESTART': '1', 19:19:19 INFO - 'PAGER': '/bin/cat', 19:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:19 INFO - 'PWD': '/builds/slave/test', 19:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:19 INFO - 'SHELL': '/bin/bash', 19:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:19 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:19 INFO - 'USER': 'cltbld', 19:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:19 INFO - 'XPC_FLAGS': '0x0', 19:19:19 INFO - 'XPC_SERVICE_NAME': '0', 19:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:19:20 INFO - Cleaning up... 19:19:20 INFO - Return code: 0 19:19:20 INFO - Running post-action listener: _resource_record_post_action 19:19:20 INFO - Running post-action listener: _start_resource_monitoring 19:19:20 INFO - Starting resource monitoring. 19:19:20 INFO - [mozharness: 2017-04-20 02:19:20.061027Z] Finished create-virtualenv step (success) 19:19:20 INFO - [mozharness: 2017-04-20 02:19:20.061877Z] Running install step. 19:19:20 INFO - Running pre-action listener: _resource_record_pre_action 19:19:20 INFO - Running main action method: install 19:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:20 INFO - Reading from file tmpfile_stdout 19:19:20 INFO - Detecting whether we're running mozinstall >=1.0... 19:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:19:20 INFO - Reading from file tmpfile_stdout 19:19:20 INFO - Output received: 19:19:20 INFO - Usage: mozinstall [options] installer 19:19:20 INFO - Options: 19:19:20 INFO - -h, --help show this help message and exit 19:19:20 INFO - -d DEST, --destination=DEST 19:19:20 INFO - Directory to install application into. [default: 19:19:20 INFO - "/builds/slave/test"] 19:19:20 INFO - --app=APP Application being installed. [default: firefox] 19:19:20 INFO - mkdir: /builds/slave/test/build/application 19:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:19:35 INFO - Reading from file tmpfile_stdout 19:19:35 INFO - Output received: 19:19:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:19:35 INFO - Running post-action listener: _resource_record_post_action 19:19:35 INFO - [mozharness: 2017-04-20 02:19:35.241966Z] Finished install step (success) 19:19:35 INFO - [mozharness: 2017-04-20 02:19:35.242122Z] Running run-tests step. 19:19:35 INFO - Running pre-action listener: _resource_record_pre_action 19:19:35 INFO - Running main action method: run_tests 19:19:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:35 INFO - 2017-04-19 19:19:35.256 screenresolution[1644:7535] starting screenresolution argv=screenresolution get 19:19:35 INFO - 2017-04-19 19:19:35.259 screenresolution[1644:7535] Display 0: 1600x1200x32@60 19:19:35 INFO - 2017-04-19 19:19:35.264 screenresolution[1645:7537] starting screenresolution argv=screenresolution list 19:19:35 INFO - Available Modes on Display 0 19:19:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:35 INFO - Intel Iris: 19:19:35 INFO - Chipset Model: Intel Iris 19:19:35 INFO - Type: GPU 19:19:35 INFO - Bus: Built-In 19:19:35 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:35 INFO - Vendor: Intel (0x8086) 19:19:35 INFO - Device ID: 0x0a2e 19:19:35 INFO - Revision ID: 0x0009 19:19:35 INFO - Displays: 19:19:35 INFO - Display: 19:19:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:35 INFO - Display Serial Number: 1600x1200 60 19:19:35 INFO - Main Display: Yes 19:19:35 INFO - Mirror: Off 19:19:35 INFO - Online: Yes 19:19:35 INFO - Rotation: Supported 19:19:35 INFO - Return code: 0 19:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:35 INFO - Python 2.7.3 19:19:35 INFO - Return code: 0 19:19:35 INFO - grabbing minidump binary from tooltool 19:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:35 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 0x109827d30>, '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 0x10974edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:19:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:19:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:19:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:35 INFO - Return code: 0 19:19:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:19:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:35 INFO - ENV: RUST_BACKTRACE is now 1 19:19:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:19:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:35 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/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:19:35 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/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:19:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85XLqaDLGW/Render', 19:19:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:35 INFO - 'HOME': '/Users/cltbld', 19:19:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:35 INFO - 'LOGNAME': 'cltbld', 19:19:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:35 INFO - 'MOZ_NO_REMOTE': '1', 19:19:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:35 INFO - 'NO_EM_RESTART': '1', 19:19:35 INFO - 'PAGER': '/bin/cat', 19:19:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:35 INFO - 'PWD': '/builds/slave/test', 19:19:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:35 INFO - 'RUST_BACKTRACE': '1', 19:19:35 INFO - 'SHELL': '/bin/bash', 19:19:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M0NqHgB8yk/Listeners', 19:19:35 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 19:19:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:35 INFO - 'USER': 'cltbld', 19:19:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:35 INFO - 'XPC_FLAGS': '0x0', 19:19:35 INFO - 'XPC_SERVICE_NAME': '0', 19:19:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:35 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/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:19:35 INFO - mozversion application_buildid: 20170419171727 19:19:35 INFO - mozversion application_changeset: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 19:19:35 INFO - mozversion application_display_name: Firefox 19:19:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:35 INFO - mozversion application_name: Firefox 19:19:35 INFO - mozversion application_remotingname: firefox 19:19:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:19:35 INFO - mozversion application_vendor: Mozilla 19:19:35 INFO - mozversion application_version: 54.0 19:19:35 INFO - mozversion platform_buildid: 20170419171727 19:19:35 INFO - mozversion platform_changeset: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 19:19:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:19:35 INFO - mozversion platform_version: 54.0 19:19:35 INFO - using testdate: 1492654775 19:19:35 INFO - actual date: 1492654775 19:19:35 INFO - starting webserver on 'localhost:49247' 19:19:35 INFO - SUITE-START | Running 2 tests 19:19:35 INFO - TEST-START | dromaeo_css 19:19:35 INFO - operating with platform_type : mac_ 19:19:35 INFO - Initialising browser for dromaeo_css test... 19:19:35 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpA4mhx8/profile http://localhost:49247/getInfo.html) 19:19:38 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 19:19:38 INFO - PROCESS | 1655 | colorDepth:24 19:19:38 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 19:19:38 INFO - PROCESS | 1655 | __metrics 19:19:38 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:19:38 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:39 INFO - TEST-INFO | 1655: exit 0 19:19:39 INFO - Browser initialized. 19:19:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:19:39 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpA4mhx8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:51 INFO - PROCESS | 1658 | RSS: Main: 165138432 19:19:51 INFO - PROCESS | 1658 | 19:22:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 19:22:56 INFO - PROCESS | 1658 | RSS: Main: 317014016 19:22:56 INFO - PROCESS | 1658 | 19:25:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 19:26:00 INFO - PROCESS | 1658 | RSS: Main: 299548672 19:26:00 INFO - PROCESS | 1658 | 19:29:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 19:29:02 INFO - PROCESS | 1658 | RSS: Main: 282312704 19:29:02 INFO - PROCESS | 1658 | 19:32:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 19:32:05 INFO - PROCESS | 1658 | RSS: Main: 291405824 19:32:05 INFO - PROCESS | 1658 | 19:35:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 19:35:10 INFO - PROCESS | 1658 | RSS: Main: 269926400 19:35:10 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 19:38:13 INFO - PROCESS | 1658 | RSS: Main: 416428032 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | __start_tp_report 19:38:13 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 19:38:13 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 19:38:13 INFO - PROCESS | 1658 | |i|pagename|runs| 19:38:13 INFO - PROCESS | 1658 | |0;dojo.html;3550.769200002;3582.355176068308;3586.587542432621;3589.479525468807;3637.5998640149596;6209.099680546318;6228.128062071313;6236.970899801533;6237.719302631381;6290;6244.500439964803;6249.843903754798;6300.495960323175;6312.116303717472;6331;5525.751341189656;5566.972165139179;5578.609497335188;5601.29983752031;5665.745041473144;5453.700046497441;5480.945190548104;5486.670799752008;5657.066584013633;5659.5755318351285;5537.889242215153;5575.080111781551;5575.275214222166;5577.832665020056;5581.05122129239;5490.945090549083;5494.148406996882;5499.4225606311165;5500.917486237689;5507.889842203173;5325;5437.211604317391;5447.319085114361;5459.454054594509;5483.7806487740445;6145.201123853871;6146.631202127886;6156.107364432177;6156.292026416974;6156.538259630545;6323.430891219812;6343.175387199681;6442.48460123189;6468.838279043061;6490.545661803676;6659.200895892475;6662.267150613428;6663.200415950068;6673.865442874723;6679.465642748569;6273.87452250957;6318.557700960934;6322.462590679797;6332.52506062038;6349.841253968688;6015.759369625166;6321.399467050623;6447.25856526496;6501.837454063686;6508.674566271668;6361.427471527492;6395.680215989275;6400.7119679614525;6401.231852177769;6462.935370646233;5491.917621235684;6598.73605055802;6615.338466153346;6621.503387245976;6633.800985970429;6371.299157092716;6530.05314229434;6531.118299029666;6539.346065393423;6544.640044797582;6339.302676705559;6364.681765911686;6397.488200944006;6538.476921846336;6556.934430655728;5257.710825904612;5290.550303224269;5296.2055691646565;5309.070912590281;5317.335333083364;4413.8234470621455;4469.888252793641;4575.771211439414;4734.479207287196;4735.668503204743;6022.126791615191;6303.401176888188;6305.558610897285;6310.5898116622275;6311.305756366796;6411.5832470889245;6419.646919419477;6525.0538671893255;6563.606183628997;6631.701573429207;6280.120783090371;6299.307076221612;6315.652639104894;6315.684215789192;6320.27316858558;5818.883622327529;5852.4147585241135;5856.795012174553;5863.091220860773;5889.793857214977;6546.8363290918105;6629.801105966829;6770.492213084137;6808.557443766238;6853;5527.695976721319;6592.967035164794;6605.834854128685;6617.735290588323;6622.768203112868;6749.0888730020815;6863.759768408082;6881.827954301182;6893.7931862044215;6901.861962760616;6357.618542887441;6393.8721225576155;6513.706883190173;6516.055172000129;6533.640649764118;5097.847064588068;6560.278369379269;6622.403983641495;6626.701798419179;6659.866802664016;6430.742770289136;6470.158879345655;6471;6480.222373315232;6482.189726284215;6325.557210995186;6361.809145725636;6426;6440.355964403522;6490.51321150925;6258.624482531062;6341.778037768656;6376.266729326187;6401.039844023434;6403.135576697086;6460.192475940507;6463.838404039937;6479.967600161969;6485.156929599122;6487.091807146909;6195.783147589813;6384.840378990562;6388.329225431448;6435.742570297136;6445.6454894981225 19:38:13 INFO - PROCESS | 1658 | |1;ext.html;776.7825008997479;805.0540614777635;835.1856939484002;900.3787386703174;905.9184673379402;23466;41714;41737.58262417379;41922.16155676885;41955.74132776014;42944.57055429445;43276.567234327646;43303.917402064966;43325.566744332544;43391.349129763075;8022.959885200566;9636.277279204052;9806.11744942955;9813.509324533781;9820.165285950667;8033.839323213532;11880;11982.281063136195;11997.700057498545;12001.579944701938;12075.335856527887;12106.334151621657;12107.697307567294;12110.939445302762;12114.333711645855;11001.734800497965;11043.282186657922;12037.277763334185;12063.879361206364;12089.214201076902;10295.485225738683;10958.068564172056;11706;11706;11715.121365897592;40623;40743.388849167284;40859.591404086175;40895.59104408947;40929.79535102335;4080.285949958775;4123.299039163349;4127.9174416511805;4130.855420060284;4152.314868046768;22659.773402266095;28459.146225613265;30815.69184308173;30970.225744356572;31029.689703102908;3227.451333273349;3282.3271229397915;3314.5359649649067;3317.701406873369;3351.8826841060445;375325.99999999726;375473;375534.22328883444;376125;376489;41316.1736765263;53965.73017134889;54079.45920540823;54149;54182;55648.44351556514;55707.44292557023;55717.72141139268;55754.72122639361;55807;14518.346674399467;15484.612884677974;15564.92217538905;15588.53234402947;15588.92205538965;11828.645140645795;12000.279983201035;12086.153969222245;13221.206727596375;13244.337783110806;10980.231383803057;12353.876461235452;12502.562410315595;12686.175398599062;12716.936415317865;5249.160134378481;5473.616846820764;5474.644148130359;5493.587980901449;5501;917.7017469322496;1068.3856782350024;1075.8219749374423;1161.3032180691519;1167.7839599674087;27251.182464526097;27501.72498275032;28001.73992170357;28029.71970280312;28592.285192870346;945.8013817098487;1122.9831552526718;1143.7598104398003;1143.7941170589208;1171.9531218751154;9143.908560914439;11658.704843484047;12031.4452570734;12086.939565302293;12104.273743575413;324522;325288;325474;326756;327929;44293.55706442959;44427;44503.77748111239;44613.776931115135;44938.10123797506;1415.3913817058763;1457.9708405831825;1461.4300422835104;1465.5456808389433;1469.5077149154938;21552.78447215508;22104.668429973884;22490.100395983976;23386.64920026235;23614.763852361255;38890.80554597209;38894.6386876458;38899.80550097232;38929.41605875857;38976.80511597424;299613;300428;300926;301411.9858801384;301428.4928575343;27494.587581185897;27954.720452796024;28099.297517562223;28184.71815281821;28195.859020705586;28789.85605072045;29850.10449686513;36556.817215914816;36821.895343139746;38303.85088447351;26359;27077.593836092867;27119;27590.3102422433;27806.5829012569;26766.598501022112;26779.196624101307;26856.462870742867;27721.861390692917;27780.027699031245;30645.846770766002;31755.682443176196;31768;31821.5226771594;31931;25977.480450391264;26594.601080984186;27067.187984360502;27631.30921726973;27870.58194127049;20679.896600516902;21877.453063673536;22459.887700562045;22556.98493567826;22759.31722048341 19:38:13 INFO - PROCESS | 1658 | |2;jquery.html;434.446081246411;439.9890002749931;445.17198011698235;448.87880272326476;454.2595569222169;16367.79034830299;17095.829041709578;22448;22723.772762272372;22908.312750617486;22513.887430562867;23663.645045324334;24140.034398624033;24207.15274965372;24537.877310613465;6834.4874134440115;6854.931450685492;7064.976465021288;7138.678759455837;7142.178649455327;5939.287285525743;6934.4452443804375;6970.337817907291;7030.472714546429;7036.929630703678;6740.494462915276;7009.789706308793;7031.1211098612675;7095.467839912028;7106.644667766617;6087.391260873877;6691.762024025571;6967.163940327167;7047.731408346495;7060.505764596481;6739.5619284746335;6792.28680988494;6794.762183323609;6812.250652428229;6815.829604259884;27401.86299068512;27928.441431171465;27966.860165699243;27991.580126298122;28256.293592660142;2955.5418910068975;3012.7891047626676;3057.4038062577806;3093.3040065985197;3101.2401961519345;15560.37758489659;15986;15990.12054337011;16294;16755.413560525445;2109.4093653776968;2155.4247834155294;2168.165256376291;2181.650935850272;2212.0598745533084;104669.95330046755;136152.9577056345;138895.30552347173;141800;143112;20681.208036915126;20735;20833;20866.06102725381;20989.950502474814;34751.30497390038;35572.46641300383;35585.46621800675;35598;35600.82199589037;10990.780184396428;11026.00765931054;11169.218154729091;11221.719457013476;11341.43292835355;9100.99889012208;9121.771955701028;9138.497382644018;9179.449233045905;9244.445333280024;10014.79970400588;10093.444860532742;10185.796284074277;10198.592056317813;10200.928902465283;3242.4812030075077;3604.351216780952;4213.641840443596;4308.4399028126145;4317.201317756225;787.6691789448446;960.6205548808322;973.3673112476947;978.7406337320616;994.1351024608492;20728.689069663968;22972.31083067477;24204.273871783873;24276.271711848673;24356.512869742506;938.1509733691021;978.3396207559869;1018.4907546226887;1021.2851004297022;1031.041131747467;12074.396280185956;12315.076369272341;12742.936285318514;13002.08985371015;13008.414621342063;638492;645199;772954;782149;796579;143312;167360.16319918566;168225;169133;178146;1074.7474343529263;1097.4896673047072;1142.23470274916;1271.4024408527791;1329.2556168545646;15287.541373758804;19135;19388.933608651096;19864.304749334282;19890.30383936555;61605.38394616176;62058;63362.683186583774;63843.36156638374;64916;87672;88451;90633;91166.54416728139;91660.54169729109;11275.32348059119;11595.710107247049;11608.24546404481;11627.418629068681;11981.28112313264;13122.14706044104;13199.34003299812;13588.93205533966;13678;13710.38303276335;6177;9548.952255238679;11455.770884582429;11801.82297265559;11821.76356472883;8589.570521474026;10490.790184196121;10569.682909512727;10718.946405267923;11102.833457497982;6548.017797330439;11087.33475991443;11929.582464613697;11957.880421195676;12017.098717596391;11566.30602163873;11614.303141811519;11915.702107447383;11970.162088653711;11971.760564788481;11223.352410466468;11251.324920504796;11323.603673871376;11437.656870293904;11612.6516204514 19:38:13 INFO - PROCESS | 1658 | |3;mootools.html;1571.6856628674268;1586.2544604036107;1611.9435819746304;1613.5482065021797;1624.8700103991682;10888.61889833856;11565.710857228574;11567.768644627102;11568.768624627503;11573.305601663906;11065.778684426306;11237.269577477458;11350.716232094202;11560.6531804046;11593.6521904343;2452.8405653632544;2501.5497210502194;2502.4119331956977;2504.6368276599883;2508.9874550627223;2147.3450597567735;2378.0725517048363;2451.4361696809747;2486.9751302487016;2488.7635674610883;2422.454947636785;2480.8635525046116;2481.330040888959;2489.4149874779505;2494.625806129077;2397.4725560376687;2430.064425196303;2437.293184976355;2437.7196622388474;2488.253523942828;2044.570640165567;2456.078970386105;2466.90132394704;2472.851628902272;2488.875556222182;11238.325700458;11440.027597654209;11452.141089418245;11457.59898403552;11472.31166130035;5904.114382842565;6107.26712794463;6121;6124.693765311717;6125.877482450326;3217.613886333655;3594.245208506217;3683.797391143486;3744.213715119828;3801.3157631626295;1084.436093231515;1229.877012298763;1259.916471834231;1293.7671219180543;1313.8226339444147;14031.64920876976;14299.857001429957;14716.558503245027;15677.21613919311;15722.663573596257;4700.576948074689;4841.515848415131;4868.172410690191;4891.584215341664;4901.387326584177;10468.581256749645;10635.468226588795;12082.758344833053;12107.576234831738;12132.272063676208;5739.2252045973255;5932.644041357532;5973.253343332083;5989.850253743692;5996.730147143389;4722.315264286659;5073.416557095981;5460.6177567569885;5493.945060549423;5494.752736126884;3981.1042515434374;4001;4047.433359329696;4058.5332686740812;4109.321961876317;960.673371053845;965.4110992294694;965.75856035991;981.8085473332775;985.6944347252374;793.8332950080433;820.1183727492969;845.1210740829591;870.5777697816554;888.8533391990378;6608.8347791305605;6795.592264464148;6888.138982627172;7050.294970502909;7076.858462830714;1037.6886933919945;1045.9895401045892;1046.9478174434644;1062.4900047977014;1081.967540973772;4066.674666026711;4375.956240437555;4395.824167033346;4487.259602165606;4588.701734387254;13693.315334233248;14290.785638215435;14341.713165736626;14371.353289102015;14373.281335933161;13512.054156209168;13758.31208439574;14236.145831250158;14298.356573954197;14477.276136193148;10125.544350504098;10163.55489916276;10288.897111028944;10426.478676066166;10436.530356133992;5783.652980821164;7068.29317068289;7090.184628767758;7231.746888858865;7310.890336645061;10707.625233116803;11005.944970275097;12938;12955.157914735511;12957.093003489665;12626.179298345578;12976.675583110498;13000.284984325575;13175.275359854917;13215.14101583394;9500.667476638284;9575.760605984906;9642.517874106406;9664.98517655636;9793.412395256308;10597.788044239227;10651.254412191072;10678.466076695979;10697.839532407175;10702;8996.91003089987;9228.723138305862;9232.769180770534;9263.722088337361;9280;8980.595873185854;8990.415622984485;9021.413608115452;9066.818663626822;9076.001639819746;8090.231428014329;8148.1037085919315;8261.669533218605;8279.54462504568;8335.041470231;6001.609895356788;6060.333363330118;6107.725152368065;6180.8763824722355;6279.466245369194;5928.288605367211;6077.756889724362;6212.099245609452;6246.531510136849;6266.530010249341 19:38:13 INFO - PROCESS | 1658 | |4;prototype.html;321.9581454410927;362.9800360980146;369.549150036955;386.7698719262038;391.66121305071124;4480.372747815304;4804.567588916997;4818.879528011801;4984.7756850941705;5357.54460870826;4237;4479.776011199443;4839.402997010978;5110.514501122397;5225.608079394051;3758.68051215647;4109.835606575733;4343.6959412841115;4358.8038538265855;4424.889377765549;3854.3447613905705;4036.3541833306676;4380.671449641273;4541.227991241497;4593.379893714339;3780.6786423153926;4267.978660106695;4300.849470268541;4303.5469782224145;4308.310670292738;3414.4464268757906;4098.4876890388705;4274.358846173068;4283.143371325732;4304.332828411601;4017.232417736216;4032.4676622883117;4052.696047796427;4072.429859819628;4076.673866090706;4293.334533147367;4738.407699037621;4935.481774413706;5044.924326135111;5127.897442051138;4496.685232033759;4820.373351464287;4950.47525761864;5011.6241281904;5013.498650134994;4422.5577442255835;4895.014041434722;5487.286652735159;5510.228568000483;5568.638038527523;3798.4302354646748;4143.585641435862;4367.235733746582;4485.708428952108;4510.819567217307;4960.404751429852;5365.678059316453;5456.590755693299;5741.483266506035;5806.477417032445;4099.323611604112;4254.553271906405;4401.657494464219;4561.338605902126;4630.4443466784205;4029.9194016119513;4487.169873573399;4635;4643.767811609406;4713.269443236304;4244.490661120685;4530.22986092365;4994.900101998012;5005.574526165244;5064.569511591556;4720.0559888022535;5148.742562871841;5558.194061861089;5613.943860561342;5629.971850140805;1280.7832559068736;1398.4126666799968;1437.9431118128168;1459.489178787416;1574.826769055403;996.531630133836;1133.7449073958458;1168.1881092640533;1198.937826937666;1227.478321713286;4324.870253892388;4772.444528826047;5015.56744978685;5230.736949386238;5233.947660523346;4613.515580864028;5294.549963253166;5726.988884725865;5782.421757824184;5793.304803423616;4199.70602057853;4496.797644106023;4891.3396691446915;4989.950100499022;5101.8724531886255;2538.6925733247394;2538.8603626800705;3011.5633233181065;3019.1093627379973;3019.8641061152302;5553.194786755897;5583.525400341016;5980.202571367126;6056.545759068087;6057.7879774207695;4859;5082.669626474268;5704.914426283609;5745.695707158742;5935.52515798735;5968.612040217372;6017.669028203491;6023.939760602338;6058.787942421994;6067.939320606737;5051.520105589963;5205.479452054764;5548.0845660465575;5702.258706368146;5785.4214578541805;5510.8071217507195;5593.986464550543;5594.720263986866;5638.364874186604;5657.773689052392;4758.381410416624;5508.724563771715;5877.735501902339;5888.762270337244;6253.154310099165;3997.4603428536775;4206.72656277341;4409.647228221798;4560.954390456186;4597.655175861757;4810.831620893252;4870.975645121752;4875.756212189305;5110.744462776772;5729.684867332337;4542.500324964318;4859.129235244386;5117.769700363418;5424.267723857229;5499.2677306648275;5204.063268611535;5411.621186516906;5437.673739575638;5499.587530935116;5639.6334238274385;4993.700377977333;5176.926611920415;5236.528712415901;5378.62844974529;5514.228008078952;5147.8893653601845;5622.493975542221;5625.8593535161945;5638.689872057076;5668.886622267614;4297.699161058821;5156.922646160386;5193.532582067632;5318.973405133104;5428.592855535771 19:38:13 INFO - PROCESS | 1658 | |5;yui.html;794.3327604811957;811.3428123220192;846.8941382327209;886.8403687336281;894.5929602031076;15754.13352265625;17241.827581724177;17483.825161748395;17516.824831751677;18244.0877956102;18259.90870045651;18590.628187436243;18728.531786705338;18903.24387024521;18905.149268282927;1006.0492834271598;1026.6765968719867;1027.3579013116803;1029.2023681646708;1030.7062487191151;990.2078337330144;1008.6570566007556;1011.9089281964622;1012.4229189362067;1027.4349107990613;1075.6611667324808;1077.1006209814814;1077.7521170130835;1078.4984981983375;1078.946052697366;1076.6285631457135;1076.6554702495205;1078.3691540448847;1078.946052697362;1079.0504356166523;794.8410317936379;795;795.5266616363255;796.0049937578027;797.3222760653456;17335.826641733547;17544.736828947574;17608.735868961976;18042.188101535463;18293.54266143344;13242.337883105805;13391;13478.865211347858;13562.389692463765;13598;12091.45588448522;12148.45331960064;12157.574484892986;12280.877191228152;12499.687507812287;3381.6956473917467;3803.8858834235016;3882.2623701496627;3898.1229223424784;3902.941455878164;121981.39009304896;124334.37832810868;126621;130280;133130.33739325256;11072;11490.310581365145;11497.252678575866;11758.000569951479;11765.411729413496;20088.598228035356;24042.278731638078;24070.91680874365;24121.396965076012;24122.39694007664;8199.71301004462;8261.545614991113;8365.536031194639;8413.579321033923;8458.661653533913;4435.489918659331;4465.575770301816;4529.230030894756;4562.292844609091;4585.727969348635;2967.5103607904884;3708.573514045919;3799.164183879542;3801.8099095045136;3804.296205201991;672.3175976383974;680.0377465885815;681.7239018197638;699.2133849419403;700.6496751624188;572.5391060196582;630.3224034163201;630.8895943210011;737.9003834482277;765.1659690936906;7783.610819459004;10044.799104017879;10224.64213752515;10524.421156836295;11243.887561124448;609.5732986909093;620.1565870416231;630.3716421824519;671.8780922224479;743.6393349225622;4912.606991440676;5284.233786100994;5360.8659783504945;5393.217983392465;5431.646942948775;112496.4375178119;112745.43627281811;113770.43114784373;114572;115753;51360.486395136315;76985.23014769892;87370.56314718512;90095.99999999869;99524.50237748765;82379.5881020591;83026;83055.16944830475;85106;85804;10749.67750967441;11315.603953861575;11458.656240312805;11707.531698731955;11728.589499367481;42518;47719.76140119277;48179.5182048189;48442.5155748438;48966;71219.64390178016;72345.27654723385;72546;73551.63224183845;74649;10298.897011029794;13093.345332733516;13595.660108496972;13710.17738935667;13819.930900345435;15328.846711532742;15344.462943796914;15592.062942253271;15680.529584112495;16199.271032803317;14217;14397.352119154453;14588.781168282272;14755;14860.62848428798;14125.788113178105;14596.489122880648;14655.26723663834;14674.413023479368;14967.7006459868;13573.932130339284;14483.710325793214;14840.257987100818;14947.626309342353;14975.700485990437;10027.949860250652;10121.848172277274;10492.370457772558;10580.83574129764;10723.785524289626;10629.309094908805;11014.95509508536;11429.942850285695;11556.24884382546;11776.175667703521 19:38:13 INFO - PROCESS | 1658 | __end_tp_report 19:38:13 INFO - PROCESS | 1658 | __start_cc_report 19:38:13 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1498 19:38:13 INFO - PROCESS | 1658 | __end_cc_report 19:38:13 INFO - PROCESS | 1658 | __startTimestamp1492655893359__endTimestamp 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | ------- Summary: start ------- 19:38:13 INFO - PROCESS | 1658 | Number of tests: 6 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:6091.90 Median:6332.53 stddev:673.62 (10.6%) stddev-sans-first:645.52 19:38:13 INFO - PROCESS | 1658 | Values: 3550.8 3582.4 3586.6 3589.5 3637.6 6209.1 6228.1 6237.0 6237.7 6290.0 6244.5 6249.8 6300.5 6312.1 6331.0 5525.8 5567.0 5578.6 5601.3 5665.7 5453.7 5480.9 5486.7 5657.1 5659.6 5537.9 5575.1 5575.3 5577.8 5581.1 5490.9 5494.1 5499.4 5500.9 5507.9 5325.0 5437.2 5447.3 5459.5 5483.8 6145.2 6146.6 6156.1 6156.3 6156.5 6323.4 6343.2 6442.5 6468.8 6490.5 6659.2 6662.3 6663.2 6673.9 6679.5 6273.9 6318.6 6322.5 6332.5 6349.8 6015.8 6321.4 6447.3 6501.8 6508.7 6361.4 6395.7 6400.7 6401.2 6462.9 5491.9 6598.7 6615.3 6621.5 6633.8 6371.3 6530.1 6531.1 6539.3 6544.6 6339.3 6364.7 6397.5 6538.5 6556.9 5257.7 5290.6 5296.2 5309.1 5317.3 4413.8 4469.9 4575.8 4734.5 4735.7 6022.1 6303.4 6305.6 6310.6 6311.3 6411.6 6419.6 6525.1 6563.6 6631.7 6280.1 6299.3 6315.7 6315.7 6320.3 5818.9 5852.4 5856.8 5863.1 5889.8 6546.8 6629.8 6770.5 6808.6 6853.0 5527.7 6593.0 6605.8 6617.7 6622.8 6749.1 6863.8 6881.8 6893.8 6901.9 6357.6 6393.9 6513.7 6516.1 6533.6 5097.8 6560.3 6622.4 6626.7 6659.9 6430.7 6470.2 6471.0 6480.2 6482.2 6325.6 6361.8 6426.0 6440.4 6490.5 6258.6 6341.8 6376.3 6401.0 6403.1 6460.2 6463.8 6480.0 6485.2 6487.1 6195.8 6384.8 6388.3 6435.7 6445.6 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:47676.12 Median:164731.55 stddev:88374.58 (53.6%) stddev-sans-first:88552.34 19:38:13 INFO - PROCESS | 1658 | Values: 776.8 805.1 835.2 900.4 905.9 23466.0 41714.0 41737.6 41922.2 41955.7 42944.6 43276.6 43303.9 43325.6 43391.3 8023.0 9636.3 9806.1 9813.5 9820.2 8033.8 11880.0 11982.3 11997.7 12001.6 12075.3 12106.3 12107.7 12110.9 12114.3 11001.7 11043.3 12037.3 12063.9 12089.2 10295.5 10958.1 11706.0 11706.0 11715.1 40623.0 40743.4 40859.6 40895.6 40929.8 4080.3 4123.3 4127.9 4130.9 4152.3 22659.8 28459.1 30815.7 30970.2 31029.7 3227.5 3282.3 3314.5 3317.7 3351.9 375326.0 375473.0 375534.2 376125.0 376489.0 41316.2 53965.7 54079.5 54149.0 54182.0 55648.4 55707.4 55717.7 55754.7 55807.0 14518.3 15484.6 15564.9 15588.5 15588.9 11828.6 12000.3 12086.2 13221.2 13244.3 10980.2 12353.9 12502.6 12686.2 12716.9 5249.2 5473.6 5474.6 5493.6 5501.0 917.7 1068.4 1075.8 1161.3 1167.8 27251.2 27501.7 28001.7 28029.7 28592.3 945.8 1123.0 1143.8 1143.8 1172.0 9143.9 11658.7 12031.4 12086.9 12104.3 324522.0 325288.0 325474.0 326756.0 327929.0 44293.6 44427.0 44503.8 44613.8 44938.1 1415.4 1458.0 1461.4 1465.5 1469.5 21552.8 22104.7 22490.1 23386.6 23614.8 38890.8 38894.6 38899.8 38929.4 38976.8 299613.0 300428.0 300926.0 301412.0 301428.5 27494.6 27954.7 28099.3 28184.7 28195.9 28789.9 29850.1 36556.8 36821.9 38303.9 26359.0 27077.6 27119.0 27590.3 27806.6 26766.6 26779.2 26856.5 27721.9 27780.0 30645.8 31755.7 31768.0 31821.5 31931.0 25977.5 26594.6 27067.2 27631.3 27870.6 20679.9 21877.5 22459.9 22557.0 22759.3 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:42618.65 Median:22940.31 stddev:121881.91 (531.3%) stddev-sans-first:122182.67 19:38:13 INFO - PROCESS | 1658 | Values: 434.4 440.0 445.2 448.9 454.3 16367.8 17095.8 22448.0 22723.8 22908.3 22513.9 23663.6 24140.0 24207.2 24537.9 6834.5 6854.9 7065.0 7138.7 7142.2 5939.3 6934.4 6970.3 7030.5 7036.9 6740.5 7009.8 7031.1 7095.5 7106.6 6087.4 6691.8 6967.2 7047.7 7060.5 6739.6 6792.3 6794.8 6812.3 6815.8 27401.9 27928.4 27966.9 27991.6 28256.3 2955.5 3012.8 3057.4 3093.3 3101.2 15560.4 15986.0 15990.1 16294.0 16755.4 2109.4 2155.4 2168.2 2181.7 2212.1 104670.0 136153.0 138895.3 141800.0 143112.0 20681.2 20735.0 20833.0 20866.1 20990.0 34751.3 35572.5 35585.5 35598.0 35600.8 10990.8 11026.0 11169.2 11221.7 11341.4 9101.0 9121.8 9138.5 9179.4 9244.4 10014.8 10093.4 10185.8 10198.6 10200.9 3242.5 3604.4 4213.6 4308.4 4317.2 787.7 960.6 973.4 978.7 994.1 20728.7 22972.3 24204.3 24276.3 24356.5 938.2 978.3 1018.5 1021.3 1031.0 12074.4 12315.1 12742.9 13002.1 13008.4 638492.0 645199.0 772954.0 782149.0 796579.0 143312.0 167360.2 168225.0 169133.0 178146.0 1074.7 1097.5 1142.2 1271.4 1329.3 15287.5 19135.0 19388.9 19864.3 19890.3 61605.4 62058.0 63362.7 63843.4 64916.0 87672.0 88451.0 90633.0 91166.5 91660.5 11275.3 11595.7 11608.2 11627.4 11981.3 13122.1 13199.3 13588.9 13678.0 13710.4 6177.0 9549.0 11455.8 11801.8 11821.8 8589.6 10490.8 10569.7 10718.9 11102.8 6548.0 11087.3 11929.6 11957.9 12017.1 11566.3 11614.3 11915.7 11970.2 11971.8 11223.4 11251.3 11323.6 11437.7 11612.7 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:6918.62 Median:2498.09 stddev:4304.99 (172.3%) stddev-sans-first:4298.32 19:38:13 INFO - PROCESS | 1658 | Values: 1571.7 1586.3 1611.9 1613.5 1624.9 10888.6 11565.7 11567.8 11568.8 11573.3 11065.8 11237.3 11350.7 11560.7 11593.7 2452.8 2501.5 2502.4 2504.6 2509.0 2147.3 2378.1 2451.4 2487.0 2488.8 2422.5 2480.9 2481.3 2489.4 2494.6 2397.5 2430.1 2437.3 2437.7 2488.3 2044.6 2456.1 2466.9 2472.9 2488.9 11238.3 11440.0 11452.1 11457.6 11472.3 5904.1 6107.3 6121.0 6124.7 6125.9 3217.6 3594.2 3683.8 3744.2 3801.3 1084.4 1229.9 1259.9 1293.8 1313.8 14031.6 14299.9 14716.6 15677.2 15722.7 4700.6 4841.5 4868.2 4891.6 4901.4 10468.6 10635.5 12082.8 12107.6 12132.3 5739.2 5932.6 5973.3 5989.9 5996.7 4722.3 5073.4 5460.6 5493.9 5494.8 3981.1 4001.0 4047.4 4058.5 4109.3 960.7 965.4 965.8 981.8 985.7 793.8 820.1 845.1 870.6 888.9 6608.8 6795.6 6888.1 7050.3 7076.9 1037.7 1046.0 1046.9 1062.5 1082.0 4066.7 4376.0 4395.8 4487.3 4588.7 13693.3 14290.8 14341.7 14371.4 14373.3 13512.1 13758.3 14236.1 14298.4 14477.3 10125.5 10163.6 10288.9 10426.5 10436.5 5783.7 7068.3 7090.2 7231.7 7310.9 10707.6 11005.9 12938.0 12955.2 12957.1 12626.2 12976.7 13000.3 13175.3 13215.1 9500.7 9575.8 9642.5 9665.0 9793.4 10597.8 10651.3 10678.5 10697.8 10702.0 8996.9 9228.7 9232.8 9263.7 9280.0 8980.6 8990.4 9021.4 9066.8 9076.0 8090.2 8148.1 8261.7 8279.5 8335.0 6001.6 6060.3 6107.7 6180.9 6279.5 5928.3 6077.8 6212.1 6246.5 6266.5 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4577.94 Median:4883.55 stddev:1293.10 (26.5%) stddev-sans-first:1256.65 19:38:13 INFO - PROCESS | 1658 | Values: 322.0 363.0 369.5 386.8 391.7 4480.4 4804.6 4818.9 4984.8 5357.5 4237.0 4479.8 4839.4 5110.5 5225.6 3758.7 4109.8 4343.7 4358.8 4424.9 3854.3 4036.4 4380.7 4541.2 4593.4 3780.7 4268.0 4300.8 4303.5 4308.3 3414.4 4098.5 4274.4 4283.1 4304.3 4017.2 4032.5 4052.7 4072.4 4076.7 4293.3 4738.4 4935.5 5044.9 5127.9 4496.7 4820.4 4950.5 5011.6 5013.5 4422.6 4895.0 5487.3 5510.2 5568.6 3798.4 4143.6 4367.2 4485.7 4510.8 4960.4 5365.7 5456.6 5741.5 5806.5 4099.3 4254.6 4401.7 4561.3 4630.4 4029.9 4487.2 4635.0 4643.8 4713.3 4244.5 4530.2 4994.9 5005.6 5064.6 4720.1 5148.7 5558.2 5613.9 5630.0 1280.8 1398.4 1437.9 1459.5 1574.8 996.5 1133.7 1168.2 1198.9 1227.5 4324.9 4772.4 5015.6 5230.7 5233.9 4613.5 5294.5 5727.0 5782.4 5793.3 4199.7 4496.8 4891.3 4990.0 5101.9 2538.7 2538.9 3011.6 3019.1 3019.9 5553.2 5583.5 5980.2 6056.5 6057.8 4859.0 5082.7 5704.9 5745.7 5935.5 5968.6 6017.7 6023.9 6058.8 6067.9 5051.5 5205.5 5548.1 5702.3 5785.4 5510.8 5594.0 5594.7 5638.4 5657.8 4758.4 5508.7 5877.7 5888.8 6253.2 3997.5 4206.7 4409.6 4561.0 4597.7 4810.8 4871.0 4875.8 5110.7 5729.7 4542.5 4859.1 5117.8 5424.3 5499.3 5204.1 5411.6 5437.7 5499.6 5639.6 4993.7 5176.9 5236.5 5378.6 5514.2 5147.9 5622.5 5625.9 5638.7 5668.9 4297.7 5156.9 5193.5 5319.0 5428.6 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:21915.20 Median:17409.83 stddev:32127.61 (184.5%) stddev-sans-first:32178.59 19:38:13 INFO - PROCESS | 1658 | Values: 794.3 811.3 846.9 886.8 894.6 15754.1 17241.8 17483.8 17516.8 18244.1 18259.9 18590.6 18728.5 18903.2 18905.1 1006.0 1026.7 1027.4 1029.2 1030.7 990.2 1008.7 1011.9 1012.4 1027.4 1075.7 1077.1 1077.8 1078.5 1078.9 1076.6 1076.7 1078.4 1078.9 1079.1 794.8 795.0 795.5 796.0 797.3 17335.8 17544.7 17608.7 18042.2 18293.5 13242.3 13391.0 13478.9 13562.4 13598.0 12091.5 12148.5 12157.6 12280.9 12499.7 3381.7 3803.9 3882.3 3898.1 3902.9 121981.4 124334.4 126621.0 130280.0 133130.3 11072.0 11490.3 11497.3 11758.0 11765.4 20088.6 24042.3 24070.9 24121.4 24122.4 8199.7 8261.5 8365.5 8413.6 8458.7 4435.5 4465.6 4529.2 4562.3 4585.7 2967.5 3708.6 3799.2 3801.8 3804.3 672.3 680.0 681.7 699.2 700.6 572.5 630.3 630.9 737.9 765.2 7783.6 10044.8 10224.6 10524.4 11243.9 609.6 620.2 630.4 671.9 743.6 4912.6 5284.2 5360.9 5393.2 5431.6 112496.4 112745.4 113770.4 114572.0 115753.0 51360.5 76985.2 87370.6 90096.0 99524.5 82379.6 83026.0 83055.2 85106.0 85804.0 10749.7 11315.6 11458.7 11707.5 11728.6 42518.0 47719.8 48179.5 48442.5 48966.0 71219.6 72345.3 72546.0 73551.6 74649.0 10298.9 13093.3 13595.7 13710.2 13819.9 15328.8 15344.5 15592.1 15680.5 16199.3 14217.0 14397.4 14588.8 14755.0 14860.6 14125.8 14596.5 14655.3 14674.4 14967.7 13573.9 14483.7 14840.3 14947.6 14975.7 10027.9 10121.8 10492.4 10580.8 10723.8 10629.3 11015.0 11429.9 11556.2 11776.2 19:38:13 INFO - PROCESS | 1658 | -------- Summary: end -------- 19:38:13 INFO - PROCESS | 1658 | 19:38:13 INFO - TEST-INFO | 1658: exit 0 19:38:13 INFO - TEST-OK | dromaeo_css | took 1118094ms 19:38:13 INFO - TEST-START | kraken 19:38:13 INFO - operating with platform_type : mac_ 19:38:13 INFO - Initialising browser for kraken test... 19:38:13 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmp4bYj3S/profile http://localhost:49247/getInfo.html) 19:38:15 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 19:38:15 INFO - PROCESS | 1669 | colorDepth:24 19:38:15 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 19:38:15 INFO - PROCESS | 1669 | __metrics 19:38:16 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:38:16 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:38:16 INFO - TEST-INFO | 1669: exit 0 19:38:16 INFO - Browser initialized. 19:38:16 INFO - Running cycle 1/1 for kraken test... 19:38:16 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmp4bYj3S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:28 INFO - PROCESS | 1671 | RSS: Main: 165019648 19:38:28 INFO - PROCESS | 1671 | 19:38:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 19:38:32 INFO - PROCESS | 1671 | RSS: Main: 215986176 19:38:32 INFO - PROCESS | 1671 | 19:38:35 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 19:38:35 INFO - PROCESS | 1671 | RSS: Main: 231354368 19:38:35 INFO - PROCESS | 1671 | 19:38:38 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 19:38:39 INFO - PROCESS | 1671 | RSS: Main: 328171520 19:38:39 INFO - PROCESS | 1671 | 19:38:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 19:38:42 INFO - PROCESS | 1671 | RSS: Main: 230084608 19:38:42 INFO - PROCESS | 1671 | 19:38:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:38:44 INFO - PROCESS | 1671 | RSS: Main: 232280064 19:38:44 INFO - PROCESS | 1671 | 19:38:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 19:38:48 INFO - PROCESS | 1671 | RSS: Main: 273121280 19:38:48 INFO - PROCESS | 1671 | 19:38:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 19:38:52 INFO - PROCESS | 1671 | RSS: Main: 274198528 19:38:52 INFO - PROCESS | 1671 | 19:38:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 19:38:55 INFO - PROCESS | 1671 | RSS: Main: 270671872 19:38:55 INFO - PROCESS | 1671 | 19:38:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:38:57 INFO - PROCESS | 1671 | RSS: Main: 247664640 19:38:57 INFO - PROCESS | 1671 | 19:38:59 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:39:00 INFO - PROCESS | 1671 | RSS: Main: 251846656 19:39:00 INFO - PROCESS | 1671 | 19:39:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:39:03 INFO - PROCESS | 1671 | RSS: Main: 252682240 19:39:03 INFO - PROCESS | 1671 | 19:39:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:39:06 INFO - PROCESS | 1671 | RSS: Main: 270467072 19:39:06 INFO - PROCESS | 1671 | 19:39:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:39:10 INFO - PROCESS | 1671 | RSS: Main: 264486912 19:39:10 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 19:39:11 INFO - PROCESS | 1671 | RSS: Main: 308838400 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | __start_tp_report 19:39:11 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 19:39:11 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 19:39:11 INFO - PROCESS | 1671 | |i|pagename|runs| 19:39:11 INFO - PROCESS | 1671 | |0;ai-astar;105;116;116;116;116;116;115;119;164;172 19:39:11 INFO - PROCESS | 1671 | |1;audio-beat-detection;138;107;107;150;109;105;105;106;124;107 19:39:11 INFO - PROCESS | 1671 | |2;audio-dft;184;180;183;185;183;184;185;183;186;184 19:39:11 INFO - PROCESS | 1671 | |3;audio-fft;82;62;59;91;62;79;82;65;75;59 19:39:11 INFO - PROCESS | 1671 | |4;audio-oscillator;84;69;87;69;82;97;108;95;68;81 19:39:11 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;87;87;86;90;87;95;86;88;88 19:39:11 INFO - PROCESS | 1671 | |6;imaging-darkroom;94;94;95;94;94;95;95;95;94;105 19:39:11 INFO - PROCESS | 1671 | |7;imaging-desaturate;83;85;128;132;83;85;85;83;85;83 19:39:11 INFO - PROCESS | 1671 | |8;json-parse-financial;64;61;61;62;63;63;63;63;62;63 19:39:11 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;54;59;71;64;60;57;58;58;58;58 19:39:11 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;92;93;86;104;99;98;83;83;80;79 19:39:11 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;131;132;134;132;132;137;137;137;172;143 19:39:11 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;160;160;162;160;159;159;161;163;158;160 19:39:11 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;64;65;64;64;63;62;63;62;61;61 19:39:11 INFO - PROCESS | 1671 | __end_tp_report 19:39:11 INFO - PROCESS | 1671 | __start_cc_report 19:39:11 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2114 19:39:11 INFO - PROCESS | 1671 | __end_cc_report 19:39:11 INFO - PROCESS | 1671 | __startTimestamp1492655951984__endTimestamp 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | ------- Summary: start ------- 19:39:11 INFO - PROCESS | 1671 | Number of tests: 14 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:125.50 Median:116.00 stddev:22.78 (19.6%) stddev-sans-first:22.92 19:39:11 INFO - PROCESS | 1671 | Values: 105.0 116.0 116.0 116.0 116.0 116.0 115.0 119.0 164.0 172.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:108.00 stddev:16.12 (14.9%) stddev-sans-first:14.96 19:39:11 INFO - PROCESS | 1671 | Values: 138.0 107.0 107.0 150.0 109.0 105.0 105.0 106.0 124.0 107.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.64 (0.9%) stddev-sans-first:1.73 19:39:11 INFO - PROCESS | 1671 | Values: 184.0 180.0 183.0 185.0 183.0 184.0 185.0 183.0 186.0 184.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:71.60 Median:77.00 stddev:11.57 (15.0%) stddev-sans-first:11.64 19:39:11 INFO - PROCESS | 1671 | Values: 82.0 62.0 59.0 91.0 62.0 79.0 82.0 65.0 75.0 59.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:83.00 stddev:13.31 (16.0%) stddev-sans-first:14.12 19:39:11 INFO - PROCESS | 1671 | Values: 84.0 69.0 87.0 69.0 82.0 97.0 108.0 95.0 68.0 81.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:2.66 (3.0%) stddev-sans-first:2.82 19:39:11 INFO - PROCESS | 1671 | Values: 88.0 87.0 87.0 86.0 90.0 87.0 95.0 86.0 88.0 88.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:94.50 stddev:3.37 (3.6%) stddev-sans-first:3.54 19:39:11 INFO - PROCESS | 1671 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 105.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:84.00 stddev:19.44 (23.1%) stddev-sans-first:20.27 19:39:11 INFO - PROCESS | 1671 | Values: 83.0 85.0 128.0 132.0 83.0 85.0 85.0 83.0 85.0 83.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:0.87 19:39:11 INFO - PROCESS | 1671 | Values: 64.0 61.0 61.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:58.50 stddev:4.69 (8.0%) stddev-sans-first:4.50 19:39:11 INFO - PROCESS | 1671 | Values: 54.0 59.0 71.0 64.0 60.0 57.0 58.0 58.0 58.0 58.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:89.00 stddev:8.74 (9.8%) stddev-sans-first:9.23 19:39:11 INFO - PROCESS | 1671 | Values: 92.0 93.0 86.0 104.0 99.0 98.0 83.0 83.0 80.0 79.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:137.00 stddev:12.26 (8.9%) stddev-sans-first:12.68 19:39:11 INFO - PROCESS | 1671 | Values: 131.0 132.0 134.0 132.0 132.0 137.0 137.0 137.0 172.0 143.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 19:39:11 INFO - PROCESS | 1671 | Values: 160.0 160.0 162.0 160.0 159.0 159.0 161.0 163.0 158.0 160.0 19:39:11 INFO - PROCESS | 1671 | 19:39:11 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:1.37 (2.2%) stddev-sans-first:1.39 19:39:11 INFO - PROCESS | 1671 | Values: 64.0 65.0 64.0 64.0 63.0 62.0 63.0 62.0 61.0 61.0 19:39:11 INFO - PROCESS | 1671 | -------- Summary: end -------- 19:39:11 INFO - PROCESS | 1671 | 19:39:12 INFO - TEST-INFO | 1671: exit 0 19:39:12 INFO - TEST-OK | kraken | took 58863ms 19:39:12 INFO - SUITE-END | took 1176s 19:39:13 INFO - Completed test suite (00:19:37) 19:39:13 INFO - javascript benchmark 19:39:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7820.679035964417, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3550.769200002, 3582.355176068308, 3586.587542432621, 3589.479525468807, 3637.5998640149596, 6209.099680546318, 6228.128062071313, 6236.970899801533, 6237.719302631381, 6290.0, 6244.500439964803, 6249.843903754798, 6300.495960323175, 6312.116303717472, 6331.0, 5525.751341189656, 5566.972165139179, 5578.609497335188, 5601.29983752031, 5665.745041473144, 5453.700046497441, 5480.945190548104, 5486.670799752008, 5657.066584013633, 5659.5755318351285, 5537.889242215153, 5575.080111781551, 5575.275214222166, 5577.832665020056, 5581.05122129239, 5490.945090549083, 5494.148406996882, 5499.4225606311165, 5500.917486237689, 5507.889842203173, 5325.0, 5437.211604317391, 5447.319085114361, 5459.454054594509, 5483.7806487740445, 6145.201123853871, 6146.631202127886, 6156.107364432177, 6156.292026416974, 6156.538259630545, 6323.430891219812, 6343.175387199681, 6442.48460123189, 6468.838279043061, 6490.545661803676, 6659.200895892475, 6662.267150613428, 6663.200415950068, 6673.865442874723, 6679.465642748569, 6273.87452250957, 6318.557700960934, 6322.462590679797, 6332.52506062038, 6349.841253968688, 6015.759369625166, 6321.399467050623, 6447.25856526496, 6501.837454063686, 6508.674566271668, 6361.427471527492, 6395.680215989275, 6400.7119679614525, 6401.231852177769, 6462.935370646233, 5491.917621235684, 6598.73605055802, 6615.338466153346, 6621.503387245976, 6633.800985970429, 6371.299157092716, 6530.05314229434, 6531.118299029666, 6539.346065393423, 6544.640044797582, 6339.302676705559, 6364.681765911686, 6397.488200944006, 6538.476921846336, 6556.934430655728, 5257.710825904612, 5290.550303224269, 5296.2055691646565, 5309.070912590281, 5317.335333083364, 4413.8234470621455, 4469.888252793641, 4575.771211439414, 4734.479207287196, 4735.668503204743, 6022.126791615191, 6303.401176888188, 6305.558610897285, 6310.5898116622275, 6311.305756366796, 6411.5832470889245, 6419.646919419477, 6525.0538671893255, 6563.606183628997, 6631.701573429207, 6280.120783090371, 6299.307076221612, 6315.652639104894, 6315.684215789192, 6320.27316858558, 5818.883622327529, 5852.4147585241135, 5856.795012174553, 5863.091220860773, 5889.793857214977, 6546.8363290918105, 6629.801105966829, 6770.492213084137, 6808.557443766238, 6853.0, 5527.695976721319, 6592.967035164794, 6605.834854128685, 6617.735290588323, 6622.768203112868, 6749.0888730020815, 6863.759768408082, 6881.827954301182, 6893.7931862044215, 6901.861962760616, 6357.618542887441, 6393.8721225576155, 6513.706883190173, 6516.055172000129, 6533.640649764118, 5097.847064588068, 6560.278369379269, 6622.403983641495, 6626.701798419179, 6659.866802664016, 6430.742770289136, 6470.158879345655, 6471.0, 6480.222373315232, 6482.189726284215, 6325.557210995186, 6361.809145725636, 6426.0, 6440.355964403522, 6490.51321150925, 6258.624482531062, 6341.778037768656, 6376.266729326187, 6401.039844023434, 6403.135576697086, 6460.192475940507, 6463.838404039937, 6479.967600161969, 6485.156929599122, 6487.091807146909, 6195.783147589813, 6384.840378990562, 6388.329225431448, 6435.742570297136, 6445.6454894981225], "value": 6049.852146604289, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.7825008997479, 805.0540614777635, 835.1856939484002, 900.3787386703174, 905.9184673379402, 23466.0, 41714.0, 41737.58262417379, 41922.16155676885, 41955.74132776014, 42944.57055429445, 43276.567234327646, 43303.917402064966, 43325.566744332544, 43391.349129763075, 8022.959885200566, 9636.277279204052, 9806.11744942955, 9813.509324533781, 9820.165285950667, 8033.839323213532, 11880.0, 11982.281063136195, 11997.700057498545, 12001.579944701938, 12075.335856527887, 12106.334151621657, 12107.697307567294, 12110.939445302762, 12114.333711645855, 11001.734800497965, 11043.282186657922, 12037.277763334185, 12063.879361206364, 12089.214201076902, 10295.485225738683, 10958.068564172056, 11706.0, 11706.0, 11715.121365897592, 40623.0, 40743.388849167284, 40859.591404086175, 40895.59104408947, 40929.79535102335, 4080.285949958775, 4123.299039163349, 4127.9174416511805, 4130.855420060284, 4152.314868046768, 22659.773402266095, 28459.146225613265, 30815.69184308173, 30970.225744356572, 31029.689703102908, 3227.451333273349, 3282.3271229397915, 3314.5359649649067, 3317.701406873369, 3351.8826841060445, 375325.99999999726, 375473.0, 375534.22328883444, 376125.0, 376489.0, 41316.1736765263, 53965.73017134889, 54079.45920540823, 54149.0, 54182.0, 55648.44351556514, 55707.44292557023, 55717.72141139268, 55754.72122639361, 55807.0, 14518.346674399467, 15484.612884677974, 15564.92217538905, 15588.53234402947, 15588.92205538965, 11828.645140645795, 12000.279983201035, 12086.153969222245, 13221.206727596375, 13244.337783110806, 10980.231383803057, 12353.876461235452, 12502.562410315595, 12686.175398599062, 12716.936415317865, 5249.160134378481, 5473.616846820764, 5474.644148130359, 5493.587980901449, 5501.0, 917.7017469322496, 1068.3856782350024, 1075.8219749374423, 1161.3032180691519, 1167.7839599674087, 27251.182464526097, 27501.72498275032, 28001.73992170357, 28029.71970280312, 28592.285192870346, 945.8013817098487, 1122.9831552526718, 1143.7598104398003, 1143.7941170589208, 1171.9531218751154, 9143.908560914439, 11658.704843484047, 12031.4452570734, 12086.939565302293, 12104.273743575413, 324522.0, 325288.0, 325474.0, 326756.0, 327929.0, 44293.55706442959, 44427.0, 44503.77748111239, 44613.776931115135, 44938.10123797506, 1415.3913817058763, 1457.9708405831825, 1461.4300422835104, 1465.5456808389433, 1469.5077149154938, 21552.78447215508, 22104.668429973884, 22490.100395983976, 23386.64920026235, 23614.763852361255, 38890.80554597209, 38894.6386876458, 38899.80550097232, 38929.41605875857, 38976.80511597424, 299613.0, 300428.0, 300926.0, 301411.9858801384, 301428.4928575343, 27494.587581185897, 27954.720452796024, 28099.297517562223, 28184.71815281821, 28195.859020705586, 28789.85605072045, 29850.10449686513, 36556.817215914816, 36821.895343139746, 38303.85088447351, 26359.0, 27077.593836092867, 27119.0, 27590.3102422433, 27806.5829012569, 26766.598501022112, 26779.196624101307, 26856.462870742867, 27721.861390692917, 27780.027699031245, 30645.846770766002, 31755.682443176196, 31768.0, 31821.5226771594, 31931.0, 25977.480450391264, 26594.601080984186, 27067.187984360502, 27631.30921726973, 27870.58194127049, 20679.896600516902, 21877.453063673536, 22459.887700562045, 22556.98493567826, 22759.31722048341], "value": 17967.156573101085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.446081246411, 439.9890002749931, 445.17198011698235, 448.87880272326476, 454.2595569222169, 16367.79034830299, 17095.829041709578, 22448.0, 22723.772762272372, 22908.312750617486, 22513.887430562867, 23663.645045324334, 24140.034398624033, 24207.15274965372, 24537.877310613465, 6834.4874134440115, 6854.931450685492, 7064.976465021288, 7138.678759455837, 7142.178649455327, 5939.287285525743, 6934.4452443804375, 6970.337817907291, 7030.472714546429, 7036.929630703678, 6740.494462915276, 7009.789706308793, 7031.1211098612675, 7095.467839912028, 7106.644667766617, 6087.391260873877, 6691.762024025571, 6967.163940327167, 7047.731408346495, 7060.505764596481, 6739.5619284746335, 6792.28680988494, 6794.762183323609, 6812.250652428229, 6815.829604259884, 27401.86299068512, 27928.441431171465, 27966.860165699243, 27991.580126298122, 28256.293592660142, 2955.5418910068975, 3012.7891047626676, 3057.4038062577806, 3093.3040065985197, 3101.2401961519345, 15560.37758489659, 15986.0, 15990.12054337011, 16294.0, 16755.413560525445, 2109.4093653776968, 2155.4247834155294, 2168.165256376291, 2181.650935850272, 2212.0598745533084, 104669.95330046755, 136152.9577056345, 138895.30552347173, 141800.0, 143112.0, 20681.208036915126, 20735.0, 20833.0, 20866.06102725381, 20989.950502474814, 34751.30497390038, 35572.46641300383, 35585.46621800675, 35598.0, 35600.82199589037, 10990.780184396428, 11026.00765931054, 11169.218154729091, 11221.719457013476, 11341.43292835355, 9100.99889012208, 9121.771955701028, 9138.497382644018, 9179.449233045905, 9244.445333280024, 10014.79970400588, 10093.444860532742, 10185.796284074277, 10198.592056317813, 10200.928902465283, 3242.4812030075077, 3604.351216780952, 4213.641840443596, 4308.4399028126145, 4317.201317756225, 787.6691789448446, 960.6205548808322, 973.3673112476947, 978.7406337320616, 994.1351024608492, 20728.689069663968, 22972.31083067477, 24204.273871783873, 24276.271711848673, 24356.512869742506, 938.1509733691021, 978.3396207559869, 1018.4907546226887, 1021.2851004297022, 1031.041131747467, 12074.396280185956, 12315.076369272341, 12742.936285318514, 13002.08985371015, 13008.414621342063, 638492.0, 645199.0, 772954.0, 782149.0, 796579.0, 143312.0, 167360.16319918566, 168225.0, 169133.0, 178146.0, 1074.7474343529263, 1097.4896673047072, 1142.23470274916, 1271.4024408527791, 1329.2556168545646, 15287.541373758804, 19135.0, 19388.933608651096, 19864.304749334282, 19890.30383936555, 61605.38394616176, 62058.0, 63362.683186583774, 63843.36156638374, 64916.0, 87672.0, 88451.0, 90633.0, 91166.54416728139, 91660.54169729109, 11275.32348059119, 11595.710107247049, 11608.24546404481, 11627.418629068681, 11981.28112313264, 13122.14706044104, 13199.34003299812, 13588.93205533966, 13678.0, 13710.38303276335, 6177.0, 9548.952255238679, 11455.770884582429, 11801.82297265559, 11821.76356472883, 8589.570521474026, 10490.790184196121, 10569.682909512727, 10718.946405267923, 11102.833457497982, 6548.017797330439, 11087.33475991443, 11929.582464613697, 11957.880421195676, 12017.098717596391, 11566.30602163873, 11614.303141811519, 11915.702107447383, 11970.162088653711, 11971.760564788481, 11223.352410466468, 11251.324920504796, 11323.603673871376, 11437.656870293904, 11612.6516204514], "value": 11796.748533543796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1571.6856628674268, 1586.2544604036107, 1611.9435819746304, 1613.5482065021797, 1624.8700103991682, 10888.61889833856, 11565.710857228574, 11567.768644627102, 11568.768624627503, 11573.305601663906, 11065.778684426306, 11237.269577477458, 11350.716232094202, 11560.6531804046, 11593.6521904343, 2452.8405653632544, 2501.5497210502194, 2502.4119331956977, 2504.6368276599883, 2508.9874550627223, 2147.3450597567735, 2378.0725517048363, 2451.4361696809747, 2486.9751302487016, 2488.7635674610883, 2422.454947636785, 2480.8635525046116, 2481.330040888959, 2489.4149874779505, 2494.625806129077, 2397.4725560376687, 2430.064425196303, 2437.293184976355, 2437.7196622388474, 2488.253523942828, 2044.570640165567, 2456.078970386105, 2466.90132394704, 2472.851628902272, 2488.875556222182, 11238.325700458, 11440.027597654209, 11452.141089418245, 11457.59898403552, 11472.31166130035, 5904.114382842565, 6107.26712794463, 6121.0, 6124.693765311717, 6125.877482450326, 3217.613886333655, 3594.245208506217, 3683.797391143486, 3744.213715119828, 3801.3157631626295, 1084.436093231515, 1229.877012298763, 1259.916471834231, 1293.7671219180543, 1313.8226339444147, 14031.64920876976, 14299.857001429957, 14716.558503245027, 15677.21613919311, 15722.663573596257, 4700.576948074689, 4841.515848415131, 4868.172410690191, 4891.584215341664, 4901.387326584177, 10468.581256749645, 10635.468226588795, 12082.758344833053, 12107.576234831738, 12132.272063676208, 5739.2252045973255, 5932.644041357532, 5973.253343332083, 5989.850253743692, 5996.730147143389, 4722.315264286659, 5073.416557095981, 5460.6177567569885, 5493.945060549423, 5494.752736126884, 3981.1042515434374, 4001.0, 4047.433359329696, 4058.5332686740812, 4109.321961876317, 960.673371053845, 965.4110992294694, 965.75856035991, 981.8085473332775, 985.6944347252374, 793.8332950080433, 820.1183727492969, 845.1210740829591, 870.5777697816554, 888.8533391990378, 6608.8347791305605, 6795.592264464148, 6888.138982627172, 7050.294970502909, 7076.858462830714, 1037.6886933919945, 1045.9895401045892, 1046.9478174434644, 1062.4900047977014, 1081.967540973772, 4066.674666026711, 4375.956240437555, 4395.824167033346, 4487.259602165606, 4588.701734387254, 13693.315334233248, 14290.785638215435, 14341.713165736626, 14371.353289102015, 14373.281335933161, 13512.054156209168, 13758.31208439574, 14236.145831250158, 14298.356573954197, 14477.276136193148, 10125.544350504098, 10163.55489916276, 10288.897111028944, 10426.478676066166, 10436.530356133992, 5783.652980821164, 7068.29317068289, 7090.184628767758, 7231.746888858865, 7310.890336645061, 10707.625233116803, 11005.944970275097, 12938.0, 12955.157914735511, 12957.093003489665, 12626.179298345578, 12976.675583110498, 13000.284984325575, 13175.275359854917, 13215.14101583394, 9500.667476638284, 9575.760605984906, 9642.517874106406, 9664.98517655636, 9793.412395256308, 10597.788044239227, 10651.254412191072, 10678.466076695979, 10697.839532407175, 10702.0, 8996.91003089987, 9228.723138305862, 9232.769180770534, 9263.722088337361, 9280.0, 8980.595873185854, 8990.415622984485, 9021.413608115452, 9066.818663626822, 9076.001639819746, 8090.231428014329, 8148.1037085919315, 8261.669533218605, 8279.54462504568, 8335.041470231, 6001.609895356788, 6060.333363330118, 6107.725152368065, 6180.8763824722355, 6279.466245369194, 5928.288605367211, 6077.756889724362, 6212.099245609452, 6246.531510136849, 6266.530010249341], "value": 5257.492513224078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.9581454410927, 362.9800360980146, 369.549150036955, 386.7698719262038, 391.66121305071124, 4480.372747815304, 4804.567588916997, 4818.879528011801, 4984.7756850941705, 5357.54460870826, 4237.0, 4479.776011199443, 4839.402997010978, 5110.514501122397, 5225.608079394051, 3758.68051215647, 4109.835606575733, 4343.6959412841115, 4358.8038538265855, 4424.889377765549, 3854.3447613905705, 4036.3541833306676, 4380.671449641273, 4541.227991241497, 4593.379893714339, 3780.6786423153926, 4267.978660106695, 4300.849470268541, 4303.5469782224145, 4308.310670292738, 3414.4464268757906, 4098.4876890388705, 4274.358846173068, 4283.143371325732, 4304.332828411601, 4017.232417736216, 4032.4676622883117, 4052.696047796427, 4072.429859819628, 4076.673866090706, 4293.334533147367, 4738.407699037621, 4935.481774413706, 5044.924326135111, 5127.897442051138, 4496.685232033759, 4820.373351464287, 4950.47525761864, 5011.6241281904, 5013.498650134994, 4422.5577442255835, 4895.014041434722, 5487.286652735159, 5510.228568000483, 5568.638038527523, 3798.4302354646748, 4143.585641435862, 4367.235733746582, 4485.708428952108, 4510.819567217307, 4960.404751429852, 5365.678059316453, 5456.590755693299, 5741.483266506035, 5806.477417032445, 4099.323611604112, 4254.553271906405, 4401.657494464219, 4561.338605902126, 4630.4443466784205, 4029.9194016119513, 4487.169873573399, 4635.0, 4643.767811609406, 4713.269443236304, 4244.490661120685, 4530.22986092365, 4994.900101998012, 5005.574526165244, 5064.569511591556, 4720.0559888022535, 5148.742562871841, 5558.194061861089, 5613.943860561342, 5629.971850140805, 1280.7832559068736, 1398.4126666799968, 1437.9431118128168, 1459.489178787416, 1574.826769055403, 996.531630133836, 1133.7449073958458, 1168.1881092640533, 1198.937826937666, 1227.478321713286, 4324.870253892388, 4772.444528826047, 5015.56744978685, 5230.736949386238, 5233.947660523346, 4613.515580864028, 5294.549963253166, 5726.988884725865, 5782.421757824184, 5793.304803423616, 4199.70602057853, 4496.797644106023, 4891.3396691446915, 4989.950100499022, 5101.8724531886255, 2538.6925733247394, 2538.8603626800705, 3011.5633233181065, 3019.1093627379973, 3019.8641061152302, 5553.194786755897, 5583.525400341016, 5980.202571367126, 6056.545759068087, 6057.7879774207695, 4859.0, 5082.669626474268, 5704.914426283609, 5745.695707158742, 5935.52515798735, 5968.612040217372, 6017.669028203491, 6023.939760602338, 6058.787942421994, 6067.939320606737, 5051.520105589963, 5205.479452054764, 5548.0845660465575, 5702.258706368146, 5785.4214578541805, 5510.8071217507195, 5593.986464550543, 5594.720263986866, 5638.364874186604, 5657.773689052392, 4758.381410416624, 5508.724563771715, 5877.735501902339, 5888.762270337244, 6253.154310099165, 3997.4603428536775, 4206.72656277341, 4409.647228221798, 4560.954390456186, 4597.655175861757, 4810.831620893252, 4870.975645121752, 4875.756212189305, 5110.744462776772, 5729.684867332337, 4542.500324964318, 4859.129235244386, 5117.769700363418, 5424.267723857229, 5499.2677306648275, 5204.063268611535, 5411.621186516906, 5437.673739575638, 5499.587530935116, 5639.6334238274385, 4993.700377977333, 5176.926611920415, 5236.528712415901, 5378.62844974529, 5514.228008078952, 5147.8893653601845, 5622.493975542221, 5625.8593535161945, 5638.689872057076, 5668.886622267614, 4297.699161058821, 5156.922646160386, 5193.532582067632, 5318.973405133104, 5428.592855535771], "value": 4197.878802973236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.3327604811957, 811.3428123220192, 846.8941382327209, 886.8403687336281, 894.5929602031076, 15754.13352265625, 17241.827581724177, 17483.825161748395, 17516.824831751677, 18244.0877956102, 18259.90870045651, 18590.628187436243, 18728.531786705338, 18903.24387024521, 18905.149268282927, 1006.0492834271598, 1026.6765968719867, 1027.3579013116803, 1029.2023681646708, 1030.7062487191151, 990.2078337330144, 1008.6570566007556, 1011.9089281964622, 1012.4229189362067, 1027.4349107990613, 1075.6611667324808, 1077.1006209814814, 1077.7521170130835, 1078.4984981983375, 1078.946052697366, 1076.6285631457135, 1076.6554702495205, 1078.3691540448847, 1078.946052697362, 1079.0504356166523, 794.8410317936379, 795.0, 795.5266616363255, 796.0049937578027, 797.3222760653456, 17335.826641733547, 17544.736828947574, 17608.735868961976, 18042.188101535463, 18293.54266143344, 13242.337883105805, 13391.0, 13478.865211347858, 13562.389692463765, 13598.0, 12091.45588448522, 12148.45331960064, 12157.574484892986, 12280.877191228152, 12499.687507812287, 3381.6956473917467, 3803.8858834235016, 3882.2623701496627, 3898.1229223424784, 3902.941455878164, 121981.39009304896, 124334.37832810868, 126621.0, 130280.0, 133130.33739325256, 11072.0, 11490.310581365145, 11497.252678575866, 11758.000569951479, 11765.411729413496, 20088.598228035356, 24042.278731638078, 24070.91680874365, 24121.396965076012, 24122.39694007664, 8199.71301004462, 8261.545614991113, 8365.536031194639, 8413.579321033923, 8458.661653533913, 4435.489918659331, 4465.575770301816, 4529.230030894756, 4562.292844609091, 4585.727969348635, 2967.5103607904884, 3708.573514045919, 3799.164183879542, 3801.8099095045136, 3804.296205201991, 672.3175976383974, 680.0377465885815, 681.7239018197638, 699.2133849419403, 700.6496751624188, 572.5391060196582, 630.3224034163201, 630.8895943210011, 737.9003834482277, 765.1659690936906, 7783.610819459004, 10044.799104017879, 10224.64213752515, 10524.421156836295, 11243.887561124448, 609.5732986909093, 620.1565870416231, 630.3716421824519, 671.8780922224479, 743.6393349225622, 4912.606991440676, 5284.233786100994, 5360.8659783504945, 5393.217983392465, 5431.646942948775, 112496.4375178119, 112745.43627281811, 113770.43114784373, 114572.0, 115753.0, 51360.486395136315, 76985.23014769892, 87370.56314718512, 90095.99999999869, 99524.50237748765, 82379.5881020591, 83026.0, 83055.16944830475, 85106.0, 85804.0, 10749.67750967441, 11315.603953861575, 11458.656240312805, 11707.531698731955, 11728.589499367481, 42518.0, 47719.76140119277, 48179.5182048189, 48442.5155748438, 48966.0, 71219.64390178016, 72345.27654723385, 72546.0, 73551.63224183845, 74649.0, 10298.897011029794, 13093.345332733516, 13595.660108496972, 13710.17738935667, 13819.930900345435, 15328.846711532742, 15344.462943796914, 15592.062942253271, 15680.529584112495, 16199.271032803317, 14217.0, 14397.352119154453, 14588.781168282272, 14755.0, 14860.62848428798, 14125.788113178105, 14596.489122880648, 14655.26723663834, 14674.413023479368, 14967.7006459868, 13573.932130339284, 14483.710325793214, 14840.257987100818, 14947.626309342353, 14975.700485990437, 10027.949860250652, 10121.848172277274, 10492.370457772558, 10580.83574129764, 10723.785524289626, 10629.309094908805, 11014.95509508536, 11429.942850285695, 11556.24884382546, 11776.175667703521], "value": 8084.113950229686, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 116.0, 116.0, 116.0, 116.0, 115.0, 119.0, 164.0, 172.0], "value": 125.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 107.0, 107.0, 150.0, 109.0, 105.0, 105.0, 106.0, 124.0, 107.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 180.0, 183.0, 185.0, 183.0, 184.0, 185.0, 183.0, 186.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 59.0, 91.0, 62.0, 79.0, 82.0, 65.0, 75.0, 59.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 87.0, 69.0, 82.0, 97.0, 108.0, 95.0, 68.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 86.0, 90.0, 87.0, 95.0, 86.0, 88.0, 88.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 105.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 128.0, 132.0, 83.0, 85.0, 85.0, 83.0, 85.0, 83.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 71.0, 64.0, 60.0, 57.0, 58.0, 58.0, 58.0, 58.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 86.0, 104.0, 99.0, 98.0, 83.0, 83.0, 80.0, 79.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 134.0, 132.0, 132.0, 137.0, 137.0, 137.0, 172.0, 143.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 159.0, 159.0, 161.0, 163.0, 158.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 63.0, 62.0, 63.0, 62.0, 61.0, 61.0], "value": 62.9, "unit": "score"}]}]} 19:39:13 INFO - Return code: 0 19:39:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:39:13 INFO - # TBPL SUCCESS # 19:39:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:39:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:39:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:39:13 INFO - 2017-04-19 19:39:13.323 screenresolution[1675:10200] starting screenresolution argv=screenresolution get 19:39:13 INFO - 2017-04-19 19:39:13.325 screenresolution[1675:10200] Display 0: 1600x1200x32@60 19:39:13 INFO - 2017-04-19 19:39:13.331 screenresolution[1676:10203] starting screenresolution argv=screenresolution list 19:39:13 INFO - Available Modes on Display 0 19:39:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:39:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:39:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:39:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:39:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:39:13 INFO - Intel Iris: 19:39:13 INFO - Chipset Model: Intel Iris 19:39:13 INFO - Type: GPU 19:39:13 INFO - Bus: Built-In 19:39:13 INFO - VRAM (Dynamic, Max): 1536 MB 19:39:13 INFO - Vendor: Intel (0x8086) 19:39:13 INFO - Device ID: 0x0a2e 19:39:13 INFO - Revision ID: 0x0009 19:39:13 INFO - Displays: 19:39:13 INFO - Display: 19:39:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:39:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:39:13 INFO - Display Serial Number: 1600x1200 60 19:39:13 INFO - Main Display: Yes 19:39:13 INFO - Mirror: Off 19:39:13 INFO - Online: Yes 19:39:13 INFO - Rotation: Supported 19:39:13 INFO - Return code: 0 19:39:13 INFO - Running post-action listener: _resource_record_post_action 19:39:13 INFO - [mozharness: 2017-04-20 02:39:13.567736Z] Finished run-tests step (success) 19:39:13 INFO - Running post-run listener: _resource_record_post_run 19:39:13 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38749184; Write bytes: 425688576; Read time: 247; Write time: 1399 19:39:13 INFO - TinderboxPrint: CPU usage
53.7% 19:39:13 INFO - TinderboxPrint: I/O read bytes / time
38,749,184 / 247 19:39:13 INFO - TinderboxPrint: I/O write bytes / time
425,688,576 / 1,399 19:39:13 INFO - TinderboxPrint: CPU idle
2,209.6 (46.3%) 19:39:13 INFO - TinderboxPrint: CPU system
949.2 (19.9%) 19:39:13 INFO - TinderboxPrint: CPU user
1,615.0 (33.8%) 19:39:13 INFO - TinderboxPrint: Swap in / out
159,911,936 / 0 19:39:13 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121252352; Write bytes: 116594688; Read time: 11111; Write time: 260 19:39:13 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34833408; Write bytes: 298886656; Read time: 223; Write time: 1108 19:39:14 INFO - Running post-run listener: _upload_blobber_files 19:39:14 INFO - Blob upload gear active. 19:39:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:39:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:39:14 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'] 19:39:14 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 19:39:14 INFO - (blobuploader) - INFO - Open directory for files ... 19:39:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:39:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:39:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:15 INFO - (blobuploader) - INFO - Done attempting. 19:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:17 INFO - (blobuploader) - INFO - Done attempting. 19:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:18 INFO - (blobuploader) - INFO - Done attempting. 19:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:20 INFO - (blobuploader) - INFO - Done attempting. 19:39:20 INFO - (blobuploader) - INFO - Iteration through files over. 19:39:20 INFO - Return code: 0 19:39:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:39:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:39:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3fcfc2c3ad0a6608c65f2a8b1a8131fd197f0427c994438116b1cb06c4b10ff40fc496839d44edf94f5a55bf0658f083295096570b3949a5b2090f79fa589b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb71f2786959e222ce17b160fba82a9760ed0f15aaf1d1061aab05471b48ea78328f7a770c3725441e53f3baac9d1bb03078f2142433331bafecf8ab72386a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e969f2ee669238ec45f6b499c66d5e5fabcdfe8e2c5ee955d281652111de6b46f56b6011c7058ce63735f11eb95ac41cca42490ae0acb622b49b87c3d96386ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050fd3fdf1f939d796c1155344f49394da596aa71c1052e674ad2f81d476d8ea08244d5f25263009f3ddc2602eeefadaf43e29418c3b2df58d6a2be6e328416d"} 19:39:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:39:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:39:20 INFO - Contents: 19:39:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3fcfc2c3ad0a6608c65f2a8b1a8131fd197f0427c994438116b1cb06c4b10ff40fc496839d44edf94f5a55bf0658f083295096570b3949a5b2090f79fa589b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb71f2786959e222ce17b160fba82a9760ed0f15aaf1d1061aab05471b48ea78328f7a770c3725441e53f3baac9d1bb03078f2142433331bafecf8ab72386a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e969f2ee669238ec45f6b499c66d5e5fabcdfe8e2c5ee955d281652111de6b46f56b6011c7058ce63735f11eb95ac41cca42490ae0acb622b49b87c3d96386ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050fd3fdf1f939d796c1155344f49394da596aa71c1052e674ad2f81d476d8ea08244d5f25263009f3ddc2602eeefadaf43e29418c3b2df58d6a2be6e328416d"} 19:39:20 INFO - Running post-run listener: copy_logs_to_upload_dir 19:39:20 INFO - Copying logs to upload dir... 19:39:20 INFO - mkdir: /builds/slave/test/build/upload/logs 19:39:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.700113 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-19 19:39:20.528993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:39:20.532515) ========= 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.85XLqaDLGW/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.M0NqHgB8yk/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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/e3fcfc2c3ad0a6608c65f2a8b1a8131fd197f0427c994438116b1cb06c4b10ff40fc496839d44edf94f5a55bf0658f083295096570b3949a5b2090f79fa589b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb71f2786959e222ce17b160fba82a9760ed0f15aaf1d1061aab05471b48ea78328f7a770c3725441e53f3baac9d1bb03078f2142433331bafecf8ab72386a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e969f2ee669238ec45f6b499c66d5e5fabcdfe8e2c5ee955d281652111de6b46f56b6011c7058ce63735f11eb95ac41cca42490ae0acb622b49b87c3d96386ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050fd3fdf1f939d796c1155344f49394da596aa71c1052e674ad2f81d476d8ea08244d5f25263009f3ddc2602eeefadaf43e29418c3b2df58d6a2be6e328416d"} build_url:https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010285 build_url: 'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3fcfc2c3ad0a6608c65f2a8b1a8131fd197f0427c994438116b1cb06c4b10ff40fc496839d44edf94f5a55bf0658f083295096570b3949a5b2090f79fa589b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb71f2786959e222ce17b160fba82a9760ed0f15aaf1d1061aab05471b48ea78328f7a770c3725441e53f3baac9d1bb03078f2142433331bafecf8ab72386a13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e969f2ee669238ec45f6b499c66d5e5fabcdfe8e2c5ee955d281652111de6b46f56b6011c7058ce63735f11eb95ac41cca42490ae0acb622b49b87c3d96386ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050fd3fdf1f939d796c1155344f49394da596aa71c1052e674ad2f81d476d8ea08244d5f25263009f3ddc2602eeefadaf43e29418c3b2df58d6a2be6e328416d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:39:20.569034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:39:20.569417) ========= 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.85XLqaDLGW/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.M0NqHgB8yk/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.004572 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:39:20.618193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:39:20.618533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:39:20.618901) ========= ========= Total master_lag: 0.22 =========