builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0134 starttime: 1492823986.22 results: success (0) buildid: 20170421170720 builduid: 27035f1f63c94520b9cf3bf182d70543 revision: bf2654d9c37523800d2f27c7e8c12eac40873f7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.218038) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.218520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.218811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.247537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.248073) ========= 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.j3HwqEjZt7/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.3oeBdLo29R/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-21 18:19:46-- 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% 15.0M=0.001s 2017-04-21 18:19:46 (15.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179471 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.458894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.459273) ========= 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.j3HwqEjZt7/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.3oeBdLo29R/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.029285 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:46.510821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 18:19:46.511213) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf2654d9c37523800d2f27c7e8c12eac40873f7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bf2654d9c37523800d2f27c7e8c12eac40873f7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j3HwqEjZt7/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.3oeBdLo29R/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-21 18:19:46,591 truncating revision to first 12 chars 2017-04-21 18:19:46,591 Setting DEBUG logging. 2017-04-21 18:19:46,591 attempt 1/10 2017-04-21 18:19:46,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf2654d9c375?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 18:19:48,724 unpacking tar archive at: mozilla-central-bf2654d9c375/testing/mozharness/ program finished with exit code 0 elapsedTime=2.413894 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 18:19:48.956435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:48.956851) ========= script_repo_revision: bf2654d9c37523800d2f27c7e8c12eac40873f7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:48.957287) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:48.957584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 18:19:48.976735) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-21 18:19:48.977184) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j3HwqEjZt7/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.3oeBdLo29R/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:19:49 INFO - MultiFileLogger online at 20170421 18:19:49 in /builds/slave/test 18:19:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:19:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:19:49 INFO - {'append_to_log': False, 18:19:49 INFO - 'base_work_dir': '/builds/slave/test', 18:19:49 INFO - 'blob_upload_branch': 'Firefox', 18:19:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:19:49 INFO - 'branch': 'Firefox', 18:19:49 INFO - 'buildbot_json_path': 'buildprops.json', 18:19:49 INFO - 'config_files': ('talos/mac_config.py',), 18:19:49 INFO - 'default_actions': ('clobber', 18:19:49 INFO - 'read-buildbot-config', 18:19:49 INFO - 'download-and-extract', 18:19:49 INFO - 'populate-webroot', 18:19:49 INFO - 'create-virtualenv', 18:19:49 INFO - 'install', 18:19:49 INFO - 'run-tests'), 18:19:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:19:49 INFO - 'download_minidump_stackwalk': True, 18:19:49 INFO - 'download_symbols': 'ondemand', 18:19:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:19:49 INFO - 'tooltool.py': '/tools/tooltool.py', 18:19:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:19:49 INFO - '/tools/misc-python/virtualenv.py')}, 18:19:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:19:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:19:49 INFO - 'gecko_profile': False, 18:19:49 INFO - 'gecko_profile_interval': 0, 18:19:49 INFO - 'installer_path': 'installer.exe', 18:19:49 INFO - 'log_level': 'info', 18:19:49 INFO - 'log_name': 'talos', 18:19:49 INFO - 'log_to_console': True, 18:19:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:19:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:19:49 INFO - 'opt_config_files': (), 18:19:49 INFO - 'pip_index': False, 18:19:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:19:49 INFO - 'cmd': ('bash', 18:19:49 INFO - '-c', 18:19:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:19:49 INFO - 'enabled': True, 18:19:49 INFO - 'halt_on_failure': False, 18:19:49 INFO - 'name': 'check_screen_resolution'},), 18:19:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:19:49 INFO - 'cmd': ('bash', 18:19:49 INFO - '-c', 18:19:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:19:49 INFO - 'enabled': True, 18:19:49 INFO - 'halt_on_failure': False, 18:19:49 INFO - 'name': 'check_screen_resolution'},), 18:19:49 INFO - 'run_cmd_checks_enabled': True, 18:19:49 INFO - 'suite': 'dromaeojs', 18:19:49 INFO - 'system_bits': '32', 18:19:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:19:49 INFO - 'title': 't-yosemite-r7-0134', 18:19:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:19:49 INFO - 'use_talos_json': True, 18:19:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:19:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:19:49 INFO - 'work_dir': 'build'} 18:19:49 INFO - [mozharness: 2017-04-22 01:19:49.166303Z] Running clobber step. 18:19:49 INFO - Running pre-action listener: _resource_record_pre_action 18:19:49 INFO - Running main action method: clobber 18:19:49 INFO - rmtree: /builds/slave/test/build 18:19:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:19:51 INFO - Running post-action listener: _resource_record_post_action 18:19:51 INFO - [mozharness: 2017-04-22 01:19:51.674007Z] Finished clobber step (success) 18:19:51 INFO - [mozharness: 2017-04-22 01:19:51.674138Z] Running read-buildbot-config step. 18:19:51 INFO - Running pre-action listener: _resource_record_pre_action 18:19:51 INFO - Running main action method: read_buildbot_config 18:19:51 INFO - Using buildbot properties: 18:19:51 INFO - { 18:19:51 INFO - "project": "", 18:19:51 INFO - "product": "firefox", 18:19:51 INFO - "script_repo_revision": "production", 18:19:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:19:51 INFO - "repository": "", 18:19:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:19:51 INFO - "buildid": "20170421170720", 18:19:51 INFO - "pgo_build": "False", 18:19:51 INFO - "basedir": "/builds/slave/test", 18:19:51 INFO - "buildnumber": 32, 18:19:51 INFO - "slavename": "t-yosemite-r7-0134", 18:19:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:19:51 INFO - "platform": "yosemite_r7", 18:19:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:19:51 INFO - "branch": "mozilla-central", 18:19:51 INFO - "repo_path": "mozilla-central", 18:19:51 INFO - "revision": "bf2654d9c37523800d2f27c7e8c12eac40873f7f", 18:19:51 INFO - "stage_platform": "macosx64", 18:19:51 INFO - "builduid": "27035f1f63c94520b9cf3bf182d70543", 18:19:51 INFO - "slavebuilddir": "test" 18:19:51 INFO - } 18:19:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:19:51 INFO - Running post-action listener: _resource_record_post_action 18:19:51 INFO - [mozharness: 2017-04-22 01:19:51.677309Z] Finished read-buildbot-config step (success) 18:19:51 INFO - [mozharness: 2017-04-22 01:19:51.677424Z] Running download-and-extract step. 18:19:51 INFO - Running pre-action listener: _resource_record_pre_action 18:19:51 INFO - Running main action method: download_and_extract 18:19:51 INFO - mkdir: /builds/slave/test/build/tests 18:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:51 INFO - trying https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:19:51 INFO - Downloading https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 18:19:53 INFO - Downloaded 1325 bytes. 18:19:53 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:19:53 INFO - Using the following test package requirements: 18:19:53 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 18:19:53 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:19:53 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:19:53 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:19:53 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'jsshell-mac.zip'], 18:19:53 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:19:53 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:19:53 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:19:53 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:19:53 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:19:53 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:19:53 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:19:53 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:19:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:19:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:19:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:19:54 INFO - Expected file size: 52526429 18:19:54 INFO - Obtained file size: 52526429 18:20:11 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:20:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:20:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:20:11 INFO - Fetch https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:20:12 INFO - Expected file size: 52526429 18:20:12 INFO - Obtained file size: 52526429 18:20:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:20:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:20:28 INFO - Fetch https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:20:29 INFO - Expected file size: 14408811 18:20:29 INFO - Obtained file size: 14408811 18:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:30 INFO - trying https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:20:30 INFO - Downloading https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 18:20:32 INFO - Downloaded 71021566 bytes. 18:20:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:20:32 INFO - mkdir: /builds/slave/test/properties 18:20:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:32 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:32 INFO - Contents: 18:20:32 INFO - build_url:https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:20:32 INFO - Running post-action listener: _resource_record_post_action 18:20:32 INFO - Running post-action listener: set_extra_try_arguments 18:20:32 INFO - [mozharness: 2017-04-22 01:20:32.944679Z] Finished download-and-extract step (success) 18:20:32 INFO - [mozharness: 2017-04-22 01:20:32.944811Z] Running populate-webroot step. 18:20:32 INFO - Running pre-action listener: _resource_record_pre_action 18:20:32 INFO - Running main action method: populate_webroot 18:20:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:20:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:20:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:20:32 INFO - '--tppagecycles', 18:20:32 INFO - '7'], 18:20:32 INFO - 'tests': ['tsvgm']}}, 18:20:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:20:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:20:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:20:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:20:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:20:32 INFO - 'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:20:32 INFO - 'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['damp', 'tps']}, 18:20:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:20:32 INFO - 'tests': ['damp', 'tps']}, 18:20:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['dromaeo_dom']}, 18:20:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:20:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:20:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['a11yr', 18:20:32 INFO - 'ts_paint', 18:20:32 INFO - 'tpaint', 18:20:32 INFO - 'sessionrestore', 18:20:32 INFO - 'sessionrestore_no_auto_restore', 18:20:32 INFO - 'tabpaint']}, 18:20:32 INFO - 'other-e10s': {'tests': ['a11yr', 18:20:32 INFO - 'ts_paint', 18:20:32 INFO - 'tpaint', 18:20:32 INFO - 'sessionrestore', 18:20:32 INFO - 'sessionrestore_no_auto_restore', 18:20:32 INFO - 'tabpaint']}, 18:20:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:20:32 INFO - 'ts_paint', 18:20:32 INFO - 'tpaint', 18:20:32 INFO - 'sessionrestore', 18:20:32 INFO - 'sessionrestore_no_auto_restore', 18:20:32 INFO - 'tabpaint']}, 18:20:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:20:32 INFO - 'ts_paint', 18:20:32 INFO - 'tpaint', 18:20:32 INFO - 'sessionrestore', 18:20:32 INFO - 'sessionrestore_no_auto_restore', 18:20:32 INFO - 'tabpaint']}, 18:20:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['a11yr', 18:20:32 INFO - 'ts_paint', 18:20:32 INFO - 'tpaint', 18:20:32 INFO - 'sessionrestore', 18:20:32 INFO - 'sessionrestore_no_auto_restore', 18:20:32 INFO - 'tabpaint']}, 18:20:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['a11yr', 18:20:32 INFO - 'ts_paint', 18:20:32 INFO - 'tpaint', 18:20:32 INFO - 'sessionrestore', 18:20:32 INFO - 'sessionrestore_no_auto_restore', 18:20:32 INFO - 'tabpaint']}, 18:20:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:20:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:20:32 INFO - 'bloom_basic_ref']}, 18:20:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['tsvgx', 18:20:32 INFO - 'tsvgr_opacity', 18:20:32 INFO - 'tart', 18:20:32 INFO - 'tscrollx', 18:20:32 INFO - 'cart', 18:20:32 INFO - 'tsvg_static']}, 18:20:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:20:32 INFO - 'tsvgr_opacity', 18:20:32 INFO - 'tart', 18:20:32 INFO - 'tscrollx', 18:20:32 INFO - 'cart', 18:20:32 INFO - 'tsvg_static']}, 18:20:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:20:32 INFO - 'talos_options': ['--disable-e10s'], 18:20:32 INFO - 'tests': ['tp5o']}, 18:20:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:20:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:20:32 INFO - 'talos_options': ['--disable-e10s', 18:20:32 INFO - '--xperf_path', 18:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:32 INFO - 'tests': ['tp5n']}, 18:20:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:20:32 INFO - 'talos_options': ['--xperf_path', 18:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:32 INFO - 'tests': ['tp5n']}}, 18:20:32 INFO - 'talos.zip': {'path': '', 18:20:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:20:32 INFO - Running post-action listener: _resource_record_post_action 18:20:32 INFO - [mozharness: 2017-04-22 01:20:32.964950Z] Finished populate-webroot step (success) 18:20:32 INFO - [mozharness: 2017-04-22 01:20:32.965083Z] Running create-virtualenv step. 18:20:32 INFO - Running pre-action listener: _resource_record_pre_action 18:20:32 INFO - Running main action method: create_virtualenv 18:20:32 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:20:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:33 INFO - Using real prefix '/tools/python27' 18:20:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:33 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:36 INFO - Installing pip.................done. 18:20:36 INFO - Return code: 0 18:20:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:20:36 INFO - Reading from file tmpfile_stdout 18:20:36 INFO - Output received: 18:20:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:20:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:37 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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:20:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:20:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:37 INFO - 'HOME': '/Users/cltbld', 18:20:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:37 INFO - 'LOGNAME': 'cltbld', 18:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:37 INFO - 'MOZ_NO_REMOTE': '1', 18:20:37 INFO - 'NO_EM_RESTART': '1', 18:20:37 INFO - 'PAGER': '/bin/cat', 18:20:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:37 INFO - 'PWD': '/builds/slave/test', 18:20:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:37 INFO - 'SHELL': '/bin/bash', 18:20:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:20:37 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:20:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:37 INFO - 'USER': 'cltbld', 18:20:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:37 INFO - 'XPC_FLAGS': '0x0', 18:20:37 INFO - 'XPC_SERVICE_NAME': '0', 18:20:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:20:37 INFO - Cleaning up... 18:20:37 INFO - Return code: 0 18:20:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:38 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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:20:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:20:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:38 INFO - 'HOME': '/Users/cltbld', 18:20:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:38 INFO - 'LOGNAME': 'cltbld', 18:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:38 INFO - 'MOZ_NO_REMOTE': '1', 18:20:38 INFO - 'NO_EM_RESTART': '1', 18:20:38 INFO - 'PAGER': '/bin/cat', 18:20:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:38 INFO - 'PWD': '/builds/slave/test', 18:20:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:38 INFO - 'SHELL': '/bin/bash', 18:20:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:20:38 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:20:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:38 INFO - 'USER': 'cltbld', 18:20:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:38 INFO - 'XPC_FLAGS': '0x0', 18:20:38 INFO - 'XPC_SERVICE_NAME': '0', 18:20:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:38 INFO - Downloading/unpacking psutil>=3.1.1 18:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:20:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:42 INFO - Installing collected packages: psutil 18:20:42 INFO - Running setup.py install for psutil 18:20:42 INFO - building 'psutil._psutil_osx' extension 18:20:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:20:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:20:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:20:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:20:43 INFO - building 'psutil._psutil_posix' extension 18:20:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:20:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:20:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:20:43 INFO - ^ 18:20:43 INFO - 1 warning generated. 18:20:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:20:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:43 INFO - Successfully installed psutil 18:20:43 INFO - Cleaning up... 18:20:43 INFO - Return code: 0 18:20:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:43 INFO - 'HOME': '/Users/cltbld', 18:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:43 INFO - 'LOGNAME': 'cltbld', 18:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:43 INFO - 'MOZ_NO_REMOTE': '1', 18:20:43 INFO - 'NO_EM_RESTART': '1', 18:20:43 INFO - 'PAGER': '/bin/cat', 18:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:43 INFO - 'PWD': '/builds/slave/test', 18:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:43 INFO - 'SHELL': '/bin/bash', 18:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:20:43 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:43 INFO - 'USER': 'cltbld', 18:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:43 INFO - 'XPC_FLAGS': '0x0', 18:20:43 INFO - 'XPC_SERVICE_NAME': '0', 18:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:20:46 INFO - Installing collected packages: mozsystemmonitor 18:20:46 INFO - Running setup.py install for mozsystemmonitor 18:20:46 INFO - Successfully installed mozsystemmonitor 18:20:46 INFO - Cleaning up... 18:20:46 INFO - Return code: 0 18:20:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:46 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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:46 INFO - 'HOME': '/Users/cltbld', 18:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:46 INFO - 'LOGNAME': 'cltbld', 18:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:46 INFO - 'MOZ_NO_REMOTE': '1', 18:20:46 INFO - 'NO_EM_RESTART': '1', 18:20:46 INFO - 'PAGER': '/bin/cat', 18:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:46 INFO - 'PWD': '/builds/slave/test', 18:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:46 INFO - 'SHELL': '/bin/bash', 18:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:20:46 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:46 INFO - 'USER': 'cltbld', 18:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:46 INFO - 'XPC_FLAGS': '0x0', 18:20:46 INFO - 'XPC_SERVICE_NAME': '0', 18:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:47 INFO - Downloading/unpacking jsonschema==2.5.1 18:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:20:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:50 INFO - Downloading functools32-3.2.3-2.tar.gz 18:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:20:50 INFO - warning: no files found matching '*.txt' 18:20:50 INFO - no previously-included directories found matching 'build' 18:20:50 INFO - no previously-included directories found matching 'dist' 18:20:50 INFO - no previously-included directories found matching '.git*' 18:20:50 INFO - Installing collected packages: jsonschema, functools32 18:20:50 INFO - Running setup.py install for functools32 18:20:50 INFO - warning: no files found matching '*.txt' 18:20:50 INFO - no previously-included directories found matching 'build' 18:20:50 INFO - no previously-included directories found matching 'dist' 18:20:50 INFO - no previously-included directories found matching '.git*' 18:20:50 INFO - Successfully installed jsonschema functools32 18:20:50 INFO - Cleaning up... 18:20:50 INFO - Return code: 0 18:20:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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', '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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:20: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:20: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 functools32==3.2.3-2 18:20:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:20:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:50 INFO - 'HOME': '/Users/cltbld', 18:20:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:50 INFO - 'LOGNAME': 'cltbld', 18:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:50 INFO - 'MOZ_NO_REMOTE': '1', 18:20:50 INFO - 'NO_EM_RESTART': '1', 18:20:50 INFO - 'PAGER': '/bin/cat', 18:20:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:50 INFO - 'PWD': '/builds/slave/test', 18:20:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:50 INFO - 'SHELL': '/bin/bash', 18:20:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:20:50 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:20:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:50 INFO - 'USER': 'cltbld', 18:20:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:50 INFO - 'XPC_FLAGS': '0x0', 18:20:50 INFO - 'XPC_SERVICE_NAME': '0', 18:20:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:20:50 INFO - Cleaning up... 18:20:50 INFO - Return code: 0 18:20:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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', '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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:20: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 blobuploader==1.2.4 18:20:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:20:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:50 INFO - 'HOME': '/Users/cltbld', 18:20:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:50 INFO - 'LOGNAME': 'cltbld', 18:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:50 INFO - 'MOZ_NO_REMOTE': '1', 18:20:50 INFO - 'NO_EM_RESTART': '1', 18:20:50 INFO - 'PAGER': '/bin/cat', 18:20:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:50 INFO - 'PWD': '/builds/slave/test', 18:20:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:50 INFO - 'SHELL': '/bin/bash', 18:20:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:20:50 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:20:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:50 INFO - 'USER': 'cltbld', 18:20:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:50 INFO - 'XPC_FLAGS': '0x0', 18:20:50 INFO - 'XPC_SERVICE_NAME': '0', 18:20:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:51 INFO - Downloading/unpacking blobuploader==1.2.4 18:20: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 18:20: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 18:20: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 18:20: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 18:20: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 18:20: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 18:20:53 INFO - Downloading blobuploader-1.2.4.tar.gz 18:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:20:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:20:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:55 INFO - Downloading docopt-0.6.1.tar.gz 18:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:20:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:20:55 INFO - Running setup.py install for blobuploader 18:20:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:20:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:20:55 INFO - Running setup.py install for requests 18:20:55 INFO - Running setup.py install for docopt 18:20:55 INFO - Successfully installed blobuploader requests docopt 18:20:55 INFO - Cleaning up... 18:20:55 INFO - Return code: 0 18:20:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:56 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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:20:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:20:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:56 INFO - 'HOME': '/Users/cltbld', 18:20:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:56 INFO - 'LOGNAME': 'cltbld', 18:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:56 INFO - 'MOZ_NO_REMOTE': '1', 18:20:56 INFO - 'NO_EM_RESTART': '1', 18:20:56 INFO - 'PAGER': '/bin/cat', 18:20:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:56 INFO - 'PWD': '/builds/slave/test', 18:20:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:56 INFO - 'SHELL': '/bin/bash', 18:20:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:20:56 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:20:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:56 INFO - 'USER': 'cltbld', 18:20:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:56 INFO - 'XPC_FLAGS': '0x0', 18:20:56 INFO - 'XPC_SERVICE_NAME': '0', 18:20:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-WbC7ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-9o4sxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-pjoV4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-vNkUKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Xd7WLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-4UHCf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Fs3yyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-_9xouU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-vs8O_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-TSPbC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hZ6GKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Xbqa7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ns9GKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-KlvsZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-iDmDj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-yhwB_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:57 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-z1w7fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:20:57 INFO - Running setup.py install for manifestparser 18:20:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:20:58 INFO - Running setup.py install for mozcrash 18:20:58 INFO - Running setup.py install for mozdebug 18:20:58 INFO - Running setup.py install for mozdevice 18:20:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:20:58 INFO - Running setup.py install for mozfile 18:20:58 INFO - Running setup.py install for mozhttpd 18:20:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:20:58 INFO - Running setup.py install for mozinfo 18:20:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:20:58 INFO - Running setup.py install for mozInstall 18:20:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Running setup.py install for mozleak 18:20:59 INFO - Running setup.py install for mozlog 18:20:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Running setup.py install for moznetwork 18:20:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Running setup.py install for mozprocess 18:20:59 INFO - Running setup.py install for mozprofile 18:20:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:20:59 INFO - Running setup.py install for mozrunner 18:21:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:00 INFO - Running setup.py install for mozscreenshot 18:21:00 INFO - Running setup.py install for moztest 18:21:00 INFO - Running setup.py install for mozversion 18:21:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:00 INFO - Cleaning up... 18:21:00 INFO - Return code: 0 18:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:00 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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:00 INFO - 'HOME': '/Users/cltbld', 18:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:00 INFO - 'LOGNAME': 'cltbld', 18:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:00 INFO - 'MOZ_NO_REMOTE': '1', 18:21:00 INFO - 'NO_EM_RESTART': '1', 18:21:00 INFO - 'PAGER': '/bin/cat', 18:21:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:00 INFO - 'PWD': '/builds/slave/test', 18:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:00 INFO - 'SHELL': '/bin/bash', 18:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:21:00 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:00 INFO - 'USER': 'cltbld', 18:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:00 INFO - 'XPC_FLAGS': '0x0', 18:21:00 INFO - 'XPC_SERVICE_NAME': '0', 18:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-t1a1WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-BG4aBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-NC03yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Ywo7Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-XLnfs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-iloMOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hvbVS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-gxqzO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-kf1P68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-5_wny6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-tCNNvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:02 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-JPlGxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:02 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)) 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:02 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-EddgBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:02 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-W42Yxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:02 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-v6vu3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:02 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-cq94Tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:02 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ZWzHYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:21:02 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:21:02 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:21:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:05 INFO - Downloading blessings-1.6.tar.gz 18:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:21:05 INFO - Installing collected packages: blessings 18:21:05 INFO - Running setup.py install for blessings 18:21:05 INFO - Successfully installed blessings 18:21:05 INFO - Cleaning up... 18:21:05 INFO - Return code: 0 18:21:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:05 INFO - Reading from file tmpfile_stdout 18:21:05 INFO - Current package versions: 18:21:05 INFO - blessings == 1.6 18:21:05 INFO - blobuploader == 1.2.4 18:21:05 INFO - docopt == 0.6.1 18:21:05 INFO - functools32 == 3.2.3-2 18:21:05 INFO - jsonschema == 2.5.1 18:21:05 INFO - manifestparser == 1.1 18:21:05 INFO - mozInstall == 1.12 18:21:05 INFO - mozcrash == 1.0 18:21:05 INFO - mozdebug == 0.1 18:21:05 INFO - mozdevice == 0.50 18:21:05 INFO - mozfile == 1.2 18:21:05 INFO - mozhttpd == 0.7 18:21:05 INFO - mozinfo == 0.9 18:21:05 INFO - mozleak == 0.1 18:21:05 INFO - mozlog == 3.4 18:21:05 INFO - moznetwork == 0.27 18:21:05 INFO - mozprocess == 0.25 18:21:05 INFO - mozprofile == 0.28 18:21:05 INFO - mozrunner == 6.13 18:21:05 INFO - mozscreenshot == 0.1 18:21:05 INFO - mozsystemmonitor == 0.3 18:21:05 INFO - moztest == 0.8 18:21:05 INFO - mozversion == 1.4 18:21:05 INFO - psutil == 3.1.1 18:21:05 INFO - requests == 1.2.3 18:21:05 INFO - wsgiref == 0.1.2 18:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:05 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 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:21:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:21:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:05 INFO - 'HOME': '/Users/cltbld', 18:21:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:05 INFO - 'LOGNAME': 'cltbld', 18:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:05 INFO - 'MOZ_NO_REMOTE': '1', 18:21:05 INFO - 'NO_EM_RESTART': '1', 18:21:05 INFO - 'PAGER': '/bin/cat', 18:21:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:05 INFO - 'PWD': '/builds/slave/test', 18:21:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:05 INFO - 'SHELL': '/bin/bash', 18:21:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:21:05 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:21:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:05 INFO - 'USER': 'cltbld', 18:21:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:05 INFO - 'XPC_FLAGS': '0x0', 18:21:05 INFO - 'XPC_SERVICE_NAME': '0', 18:21:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:21:06 INFO - Cleaning up... 18:21:06 INFO - Return code: 0 18:21:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f88b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc281588ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, '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.j3HwqEjZt7/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.3oeBdLo29R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:21:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:21:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:06 INFO - 'HOME': '/Users/cltbld', 18:21:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:06 INFO - 'LOGNAME': 'cltbld', 18:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:06 INFO - 'MOZ_NO_REMOTE': '1', 18:21:06 INFO - 'NO_EM_RESTART': '1', 18:21:06 INFO - 'PAGER': '/bin/cat', 18:21:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:06 INFO - 'PWD': '/builds/slave/test', 18:21:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:06 INFO - 'SHELL': '/bin/bash', 18:21:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:21:06 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:21:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:06 INFO - 'USER': 'cltbld', 18:21:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:06 INFO - 'XPC_FLAGS': '0x0', 18:21:06 INFO - 'XPC_SERVICE_NAME': '0', 18:21:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:21:06 INFO - Cleaning up... 18:21:06 INFO - Return code: 0 18:21:06 INFO - Running post-action listener: _resource_record_post_action 18:21:06 INFO - Running post-action listener: _start_resource_monitoring 18:21:06 INFO - Starting resource monitoring. 18:21:06 INFO - [mozharness: 2017-04-22 01:21:06.527921Z] Finished create-virtualenv step (success) 18:21:06 INFO - [mozharness: 2017-04-22 01:21:06.528837Z] Running install step. 18:21:06 INFO - Running pre-action listener: _resource_record_pre_action 18:21:06 INFO - Running main action method: install 18:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:06 INFO - Reading from file tmpfile_stdout 18:21:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:21:06 INFO - Reading from file tmpfile_stdout 18:21:06 INFO - Output received: 18:21:06 INFO - Usage: mozinstall [options] installer 18:21:06 INFO - Options: 18:21:06 INFO - -h, --help show this help message and exit 18:21:06 INFO - -d DEST, --destination=DEST 18:21:06 INFO - Directory to install application into. [default: 18:21:06 INFO - "/builds/slave/test"] 18:21:06 INFO - --app=APP Application being installed. [default: firefox] 18:21:06 INFO - mkdir: /builds/slave/test/build/application 18:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:21:26 INFO - Reading from file tmpfile_stdout 18:21:26 INFO - Output received: 18:21:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:21:26 INFO - Running post-action listener: _resource_record_post_action 18:21:26 INFO - [mozharness: 2017-04-22 01:21:26.916131Z] Finished install step (success) 18:21:26 INFO - [mozharness: 2017-04-22 01:21:26.916244Z] Running run-tests step. 18:21:26 INFO - Running pre-action listener: _resource_record_pre_action 18:21:26 INFO - Running main action method: run_tests 18:21:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:21:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:21:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:21:26 INFO - 2017-04-21 18:21:26.929 screenresolution[1625:7433] starting screenresolution argv=screenresolution get 18:21:26 INFO - 2017-04-21 18:21:26.931 screenresolution[1625:7433] Display 0: 1600x1200x32@60 18:21:26 INFO - 2017-04-21 18:21:26.936 screenresolution[1626:7435] starting screenresolution argv=screenresolution list 18:21:26 INFO - Available Modes on Display 0 18:21:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:21:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:21:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:21:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:21:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:21:27 INFO - Intel Iris: 18:21:27 INFO - Chipset Model: Intel Iris 18:21:27 INFO - Type: GPU 18:21:27 INFO - Bus: Built-In 18:21:27 INFO - VRAM (Dynamic, Max): 1536 MB 18:21:27 INFO - Vendor: Intel (0x8086) 18:21:27 INFO - Device ID: 0x0a2e 18:21:27 INFO - Revision ID: 0x0009 18:21:27 INFO - Displays: 18:21:27 INFO - Display: 18:21:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:21:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:21:27 INFO - Display Serial Number: 1600x1200 60 18:21:27 INFO - Main Display: Yes 18:21:27 INFO - Mirror: Off 18:21:27 INFO - Online: Yes 18:21:27 INFO - Rotation: Supported 18:21:27 INFO - Return code: 0 18:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:27 INFO - Python 2.7.3 18:21:27 INFO - Return code: 0 18:21:27 INFO - grabbing minidump binary from tooltool 18:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:27 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 0x109d66d30>, '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 0x109c8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d5bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:21:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:21:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:21:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:27 INFO - Return code: 0 18:21:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:21:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:27 INFO - ENV: RUST_BACKTRACE is now 1 18:21:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:21:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:21:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j3HwqEjZt7/Render', 18:21:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:27 INFO - 'HOME': '/Users/cltbld', 18:21:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:27 INFO - 'LOGNAME': 'cltbld', 18:21:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:27 INFO - 'MOZ_NO_REMOTE': '1', 18:21:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:27 INFO - 'NO_EM_RESTART': '1', 18:21:27 INFO - 'PAGER': '/bin/cat', 18:21:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:27 INFO - 'PWD': '/builds/slave/test', 18:21:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:27 INFO - 'RUST_BACKTRACE': '1', 18:21:27 INFO - 'SHELL': '/bin/bash', 18:21:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3oeBdLo29R/Listeners', 18:21:27 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 18:21:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:27 INFO - 'USER': 'cltbld', 18:21:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:27 INFO - 'XPC_FLAGS': '0x0', 18:21:27 INFO - 'XPC_SERVICE_NAME': '0', 18:21:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:21:27 INFO - mozversion application_buildid: 20170421170720 18:21:27 INFO - mozversion application_changeset: bf2654d9c37523800d2f27c7e8c12eac40873f7f 18:21:27 INFO - mozversion application_display_name: Nightly 18:21:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:27 INFO - mozversion application_name: Firefox 18:21:27 INFO - mozversion application_remotingname: firefox 18:21:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:21:27 INFO - mozversion application_vendor: Mozilla 18:21:27 INFO - mozversion application_version: 55.0a1 18:21:27 INFO - mozversion platform_buildid: 20170421170720 18:21:27 INFO - mozversion platform_changeset: bf2654d9c37523800d2f27c7e8c12eac40873f7f 18:21:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:21:27 INFO - mozversion platform_version: 55.0a1 18:21:27 INFO - using testdate: 1492824087 18:21:27 INFO - actual date: 1492824087 18:21:27 INFO - starting webserver on 'localhost:49236' 18:21:27 INFO - SUITE-START | Running 2 tests 18:21:27 INFO - TEST-START | dromaeo_css 18:21:27 INFO - operating with platform_type : mac_ 18:21:27 INFO - Initialising browser for dromaeo_css test... 18:21:27 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpKzaI0X/profile http://localhost:49236/getInfo.html) 18:21:30 INFO - PID 1636 | __metrics Screen width/height:1600/1200 18:21:30 INFO - PID 1636 | colorDepth:24 18:21:30 INFO - PID 1636 | Browser inner width/height: 1024/689 18:21:30 INFO - PID 1636 | __metrics 18:21:30 INFO - PID 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:21:30 INFO - PID 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:21:31 INFO - TEST-INFO | 1636: exit 0 18:21:31 INFO - Browser initialized. 18:21:31 INFO - Running cycle 1/1 for dromaeo_css test... 18:21:31 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpKzaI0X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:21:43 INFO - PID 1638 | RSS: Main: 242561024 18:21:43 INFO - PID 1638 | 18:24:48 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 18:24:50 INFO - PID 1638 | RSS: Main: 402956288 18:24:50 INFO - PID 1638 | 18:26:33 INFO - PID 1638 | ************************* 18:26:33 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:26:33 INFO - PID 1638 | 18:26:33 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:26:33 INFO - PID 1638 | Full stack: 18:26:33 INFO - PID 1638 | ************************* 18:26:33 INFO - PID 1638 | ************************* 18:26:33 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:26:33 INFO - PID 1638 | 18:26:33 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:26:33 INFO - PID 1638 | Full stack: 18:26:33 INFO - PID 1638 | ************************* 18:26:33 INFO - PID 1638 | ************************* 18:26:33 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:26:33 INFO - PID 1638 | 18:26:33 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:26:33 INFO - PID 1638 | Full stack: 18:26:33 INFO - PID 1638 | ************************* 18:26:33 INFO - PID 1638 | ************************* 18:26:33 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:26:33 INFO - PID 1638 | 18:26:33 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:26:33 INFO - PID 1638 | Full stack: 18:26:33 INFO - PID 1638 | ************************* 18:27:53 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 18:27:54 INFO - PID 1638 | RSS: Main: 366366720 18:27:54 INFO - PID 1638 | 18:30:56 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 18:30:56 INFO - PID 1638 | RSS: Main: 327438336 18:30:56 INFO - PID 1638 | 18:33:59 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 18:33:59 INFO - PID 1638 | RSS: Main: 330780672 18:33:59 INFO - PID 1638 | 18:37:03 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 18:37:04 INFO - PID 1638 | RSS: Main: 338485248 18:37:04 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 18:40:06 INFO - PID 1638 | RSS: Main: 376721408 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | __start_tp_report 18:40:06 INFO - PID 1638 | _x_x_mozilla_page_load 18:40:06 INFO - PID 1638 | _x_x_mozilla_page_load_details 18:40:06 INFO - PID 1638 | |i|pagename|runs| 18:40:06 INFO - PID 1638 | |0;dojo.html;3530.0821786335546;3537.0803591066315;3568.107973006748;3584.9283014339712;3586.3903136466797;4992.475790042044;5998.1602575639445;6099.824329823229;6178.382161783819;6205.038219076045;6117.44942955134;6129.4199191187845;6157.107219453176;6187.319394866561;6188.040853667678;4349.847755328564;5155.226715992593;5319.335083114611;5320.281761962144;5405.216243644669;5384.976854397652;5424.186372044205;5446.183072539131;5446.2919820423285;5452.127659574468;5272.209168624699;5313.256144139824;5326.946730532683;5332.840014799563;5446.183072539131;5326.227696983916;5366.973165134188;5383.919241211385;5415.9458405415835;5450.5367043801325;5331.067063263913;5334.706591137486;5340.54605358545;5340.973295133499;5418.187271909206;6021.698915054273;6117.204763380777;6166.07508873668;6202.3797620238065;6214.471769899564;6287.7170527325925;6342.5243106767175;6350.174477317919;6359.841003974938;6364.840878978016;6409.903851442232;6413.230412350501;6416.903746443807;6427.132337134473;6520.739170433224;5283.2075188722;6243.188385509855;6246.562740608159;6263.498920086382;6280.089387038854;6627.37039981201;6718.899216511756;6719.832004199934;6756.223034351015;6766.221884483348;6268.216472940882;6297.1813664223355;6322.399372059647;6356.98288273874;6431.0031945048595;6578.703958321791;6612.305707900601;6613.6362500062;6614.140161778938;6620.536562440583;6495.220573531112;6501.902471462932;6507.349265073455;6521.347865213441;6541.084248205255;6342.302346741854;6543.672816359163;6550.508711846631;6552.475801935833;6569.146011018633;5165.1219292720325;5177.611679124081;5179.067767801832;5185.637005409585;5200.193969934666;4666.066786642617;4691.272852707836;4711;4714.457837348748;4731.7634118293945;6217.036359364306;6249.437550620466;6268.843278918063;6269.216347956505;6283.214598175228;6545.919923212712;6553.475721942234;6558.081868538408;6563.982582699689;6573.835654108686;6100.399513635627;6171.382861713882;6183.690815459299;6237.781677641261;6246.6876656167005;5755.510781583613;5774.82675519735;5797.826065218051;5798.623089499169;5799.043157878903;6764.661766911537;6766.120404347502;6828.07820944186;6832.077669514552;6847.21257055445;6357.427831495188;6426.293107758236;6533.771318003847;6543.051257567531;6560.983047627626;6670.499712521483;6687.230968438692;6695.09616201826;6699.095622090956;6708.362705542965;6323.177986861679;6443.2590252119735;6489.448396886318;6494.480441564758;6520.706568204348;6517.4134327910715;6566.868662626625;6588.6046837188005;6592.373724496165;6598.109255250672;6341.4292713656;6366.745330186926;6377.7130029147875;6400.103985442135;6402.167718196604;6241.656708881055;6314.778982735582;6318.115463834974;6320.462760665395;6323.525735569759;4977.676451030671;6092.634441933498;6243.656598887105;6267.310595834546;6306.527010474325;6353.841153971188;6383.7765678202895;6387.744490220339;6420.7431702731365;6427.035944608159;6272.8431789203805;6278.46633036197;6282.994720844643;6294.968525157345;6311.400416960381 18:40:06 INFO - PID 1638 | |1;ext.html;696.6133795743362;738.2285511640335;787.5156778581172;1121.4897221764093;1123.9325640461568;22877.74172420518;27072.864635676844;27522.862385688095;27526.449471010594;27639.723602763966;36472.81763591185;37116.62883371166;37117.50443672353;37140.62859371406;37199.44200836989;8327.292180164679;8488.66045358185;8498.447600905953;8505.277051450634;8511.74464766058;5835.35811060783;8298.751037468886;8429.578521073952;8433.451825631346;8453.788655283606;6000.639961602318;8294.70968516102;8419.621117049748;8420.578971051453;8427.662893484285;8391.95804020979;8414.11651776567;8444.451110677848;8448.535330556817;8461.703840365557;5818.1272809078555;7577;7786;8333.791655208608;8335.66657333706;26064.34839129018;35722;36289;36335.4549681755;36402;3585.7848529088337;3620.981895090508;3625.256822351438;3626.7279954003557;3634.0914771307175;30314.54528182079;30378;30397.392052158833;30452;30471.542926856117;3070.6775788542104;3091.7835751497405;3114.9688503114903;3128;3128.0146753772488;274276.62861685565;280735;281488;282422.5878870613;282717;46800.29799553009;46807.531924680996;46878.296825547644;46909;46959.765201173774;50513;50514;50552;50552.494475055515;50665.493345066076;13984.160950343012;14141.71716565663;14155.858441415454;14166.362513686909;14177.716445671029;11472.139589530818;11477;11477.483513241925;11491.597794077166;11521.48153333102;10787.514561844735;10842;12565.685857853445;12806.42371093303;12879.291638959947;4026.8993275168355;4896.3389942358035;5080.695158290514;5149.922751158736;5182.896342073137;1012.5696578953915;1022.5960745505483;1032.2206733915846;1064.4518073192312;1073.8013467508379;23037.848107594553;24284.63573046406;24303.513929721306;24346.878265608913;24353;1118.0999295566985;1119.1047162270152;1146.48408216303;1158.820382840661;1159.5709587452698;12361.505539778309;12440.253584784941;12446.315452650191;12467.251964882136;12481.875181248253;291654;291881;292094;292261;292909;53634;53653.463465364846;53772.92454150973;53810.192847107326;53832.73083634557;1319.8350206224222;1466.5820241231197;1469.1421728505368;1518.1953564610774;1543.6218126559065;23661.408464788517;23663;23702;23747.287581372588;23797.881010594836;37927.620723793516;38022.429663555624;38051.61948380481;38099.80950095232;38104.18958104278;275125;275311;275677;276406.6179669089;276526;33707.3258534823;33741;33873.32253354968;34056.48915266323;34340.31319373648;35489.645103549665;35552.822235888656;44754.77622611996;44775.77612111918;44927.550724492336;28154;28231.15306540807;29720.405591888473;30667.386652267276;30969.380612388075;27773.444531109668;30368.240793980327;30418.695813041588;30937.381252375275;30991.69008309888;29552;32059.198520037186;35814;36194.63805361913;36779;30006;30173.547396789505;30759.923402680797;30783.53824692676;30978.845105774326;21769.78230217741;22605.43486412853;23308.883455582614;23910.402239944142;24047 18:40:06 INFO - PID 1638 | |2;jquery.html;370.5460810507129;384.40801166204045;433.75926360869744;443.2907348242812;459.17577947584084;20864.582708345843;21043;21335.786642133575;21588;21886;21974.340769776893;22680.54638907221;23046.65430018547;23607.881960590217;23682.88158559209;6135.447809697126;6362;6363.522735794811;6365.267994180659;6370.331115232903;5971.387725314163;6210.130581718563;6260.029695397221;6264.185655864731;6268.467180289658;5982.910256346158;6225.035119556476;6236.282827474831;6240.968795156018;6247.375262473762;6047.213862197908;6166.445019948226;6174.876502469948;6182.258129024523;6183.041628547582;5440.700761458118;5495.862603434946;5498.615096943216;5515.34539638111;5626.746796394131;27362.726372736215;28054.158375248775;28063.438731225466;28195.85902070497;28461.857690711622;1944.5235917200378;2300.9884950575306;2301.2866011536476;2301.620232661609;2302.1482051641;17485.12574371289;17518.38685645996;17545.56136096595;18116.184771685304;18316.816831831646;2135.2206444647745;2143.496278374581;2184.912603495858;2189.518305972699;2190.44143743346;143656;157989;158585;160201;162104.9999999988;11768.117391195694;12372.566960156531;12392;12400.937995309965;12411.441485133191;16857.662846743;16876.746848797276;16915.069671168203;16922.069286189377;16922.153892305334;8644.418458217155;8832.205101540892;8892.64429422816;8923.643054277885;8985.955070224607;6884.621345825927;8277.8344433111;8287.50274983503;8470.644696848474;8478.660853565912;7638.656260468292;7701.26837950405;7810.453268271166;7828.238646304536;7830.451868369273;1940.7094282302394;1956.217512994785;2121.9045142968603;2127.106615221611;2257.3792207143165;907.3784457646533;915.702396721055;958.5399008475971;971.8920430708997;1001.2640709078821;18931.24275029011;19216.71174932377;21190.04644790988;21195.940202990096;21200.893995529925;966.4771906401129;997.8602995580625;1006.9899301006897;1013.1742629756725;1013.4122209118693;9655.951720241354;9889.653862114936;10277;10958.780824383468;10966.56133754657;535869;539041;550477;554799;557676.4232357624;129339.82640694454;131618;133620;135439;138350;949.349695458613;1123.5168877382641;1163.1915818506056;1163.6218229075414;1165.3648761424874;17835.73246401279;17966.5508362292;17982.640347192722;18127.81872181261;18451.90774046121;56042.719786400805;56510.43489565052;56799.71600142138;57105.14342284952;57498.13752793628;78053;78145;80060.59969700115;80099;80916.78624820514;8490.957545212234;8752.737417877473;8851;8868.15752503511;8974.596143173443;13230.603081907559;14268.357923893658;14295.785563216768;14540.709185816013;14858.85141148618;9641;11557.537698492302;11638.88361116378;12036;12717.872821271669;10408;10446.843297350393;10450.216233782345;10775.784484310114;11921.34432606215;12094.213876098378;12103.515859365527;12306.138570299992;12477.251364918135;12530.185537940004;8760.605772740115;8812.779680507781;8960.32797540174;9011.729648110568;9110.134537218953;11362.602308919148;11912.821307680219;11978.820317695066;12103.939480302543;12173.452194651085 18:40:06 INFO - PID 1638 | |3;mootools.html;1194.2058531076823;1349.2309383651318;1439.9424023039078;1461.8391976882542;1469.7281003014443;9835.213182945365;10340.32787868789;11652.708682282937;11966.940165299162;11981.40092995349;11601.867495776136;11694.181407301492;11719.882801171985;11724.472398742057;11759.941200294008;2495.1267056530205;2533.8859751311234;2535.936601584966;2536.315194897386;2537.429078457351;2102.2536999365234;2184.759676435591;2470.8750474591925;2551.6427700122;2562.692476902765;2498.439099922585;2498.800095992325;2517.9748202518017;2529.304441278654;2531.936701582466;2515.6981162260463;2520.962185567218;2522.6216067589826;2523.9242822715164;2526.608375701769;2167.580234946113;2454.8895299711558;2455.3861534616344;2494.588392915167;2498.462830491435;8533.829323413496;11855.822162667568;11881.405929703567;11884.940575297069;11891.524339026428;6508.8698226035685;6752.054712340277;6773.966130169367;6779.28817474163;6787.796366108975;3580.5882323532605;3954.644082032602;4104.179164167179;4297.312430011183;4307.806148723315;1196.2045239915446;1230.9322987235698;1253.5800506830224;1254.4982007197102;1258.779713550125;16742.66514669712;16748.24632891523;16755.413560525445;16769.329226831032;16779.83220167807;5793.2179155814265;5821;5935.139404786281;6048.153258543807;6095.512359011357;13750.793738093937;13758.31208439574;13787.586372408843;13791.793123103162;13796.861486469614;6719.462443004646;6845.657717114124;6865.27914568963;6866.107406037183;6870.5534140281725;5235.424103348629;6201.348858369896;6219.813405597839;6256.624602523863;6278.937210627927;4146.274401979642;4591.747453890068;4737.360456338351;4739.431268247763;4752.239641657318;1426.771716525351;1472.263868065967;1478.186997151584;1490.936126260545;1495.4915328788263;788.3693045563641;794.3287921706149;811.2212276214782;816.1389733830865;844.2612713875359;6144.38556144382;6308.968455157695;6761.8647627047185;6994.545354551938;6998.4751143664425;881.8324518341623;941.2893265584577;950.9904900951041;951.1012093571646;957.8419560772395;3549.467579863041;4295.076558539929;4304.612584867377;4351.5430879757805;4421.756803375781;14660.486882959045;15154.772678409832;15205.923970380078;15208.847911520965;15226.46707365237;12137.422135122553;14505.347259373353;15032.624184395478;15032.774508382383;15077.698446031018;8345.707900223584;8539.573021348908;8562;8563.871541926876;8566.871496927552;5906.970465147647;6619.470442364503;6670.899936501053;7150.856982860418;7162.570245785269;10471.947640262055;13269.668258293234;13768.862311376757;13768.862311376757;13771.311434428038;13393.129446585941;13841.515546955809;13902.582922512342;14231.501897433955;14321.427142914583;9383.249340052917;9657.22742180638;9662.468564229035;9667.371620844904;9668.371555848847;9680.322377433513;9863.309568330147;9984.700458986243;10623.628173013907;10764.03123718869;9082.45505269686;9255.02822203659;9316.20812230968;9343.672971445967;9407.670731524364;8895.199432051146;9011.864822027545;9018.954905225432;9075.092490751136;9092.909070909207;8041;8064.798380040546;8113.71601993951;8140.796480088045;8210.917890821254;6044.395560443921;6076.149339092619;6106.419890110433;6166.660833654013;6170.259568851767;5917.881642367042;6022.307434644897;6180.81457556274;6182.474489668429;6352.714127864349 18:40:06 INFO - PID 1638 | |4;prototype.html;389.92006638639083;399.1000294336271;405.6754596322942;406.47361666641694;410.2574340443797;5898.587098903073;5923.644581325124;5937.317208521022;5945.256842894638;6010.8797824043495;4740.2889566564945;5687.829365119053;5762.250907382045;5869.70651467426;5881.029854998581;4488.147252022121;4493.415855938723;4493.865184044484;4499.75251361175;4514.435695538058;4526.4794548627;4531;4531.592156705896;4557.635389168859;4562.270036794113;4219.535851056381;4288.571142885718;4495.08958692556;4508.729476231437;4526.728396296233;4437.892001299389;4455.621272191867;4474.373587697709;4474.77626118696;4475.820967161309;3259.7555183361105;3978.1446988897237;3984.641382275609;3995.3219647747724;4007.298722723541;5503.889922201533;5675.772969081232;5774.624649397818;5784.739686714066;5797.405713428799;4418.403515525395;5357;5378.897326048151;5413.590952026349;5424.484673956007;5743.712814359265;6306.968465157691;6321.040477452005;6324.177856878577;6336.46140078094;3835.61643835617;4307.8492252771;4474.440694913136;4514.909701805978;4534.750588717619;5424.67095561586;6388.297287298394;6503.739850405978;6505.284418713938;6563.947764289628;4618.49196588375;4685.4143232095985;4704.835330763475;4721.763911804464;4724.456687480983;4525.751083690363;4630.791614377361;4782.234842425265;4811.109944660249;4815.95184048155;5099.4390617032095;5265.288781146143;5311.893762124813;5394.487523685244;5456.781728730885;5283.260343551829;5526;6327.841803954938;6373.808785736435;6381.1704478417505;1454.287399174397;1535.1249787621173;1560.4772401245482;1613.9273732682057;1644.3669187362952;962.9037096290455;1117.9049780768562;1139.5669645534645;1142.2061667141422;1151.0043812102472;5945.702714864326;5956.6723830188885;5962.493188079062;5974.880502389928;6005.429484198994;4821;5889.528837692974;5992.041273396236;6235.657038862815;6466.159399278064;5659.179418984224;5848.415158484203;5924.970375148183;5942.82171534846;5983.491403230687;3352.798832070084;3383.543221665093;3384.4754063120254;3400.489926511043;3402;5557.5831812614215;5655.4344565543115;6557.78029222213;6688.531802773759;6800.65996700163;5266.473352664703;5584.9841085813205;6322.304546499881;6596;6611.933880661132;5295.523402893681;6123;6492.253390860112;6716.887632254625;6717;4988.5260900214425;5400.216968539618;6122.602030867979;6298.937010629835;6414.871702566016;5698.344690360662;6032.396760324108;6038.758449661965;6341.955861186564;6386.840328991627;6218.22272215973;6328.14570033058;6557.737690492327;6622.536422450382;6761.898571521529;3575.570931488238;4643.907121857612;4668.136394766979;4678.251479763221;4678.432725037151;5726;6271.466925311217;6329.841753956188;6461.215723490411;6494.447971922439;5083.669561478492;6255.37446255389;6274;6282.623042617458;6286.322501336586;5129.358830146231;5190.40310364313;6039.822234664199;6255.343188965093;6268.749250029948;5733.799317023884;6079.996800528041;6096.634201947897;6145.385461453819;6150.384961503813;5427.6200665953;6157.96921015392;6281.277653069773;6307.211598550181;6341.904871427025;5927.911081333697;6043.305019922589;6056.303525094494;6091.634501929899;6138.570300078952 18:40:06 INFO - PID 1638 | |5;yui.html;703.6938931564769;711.7366574367485;856.0540602634093;860.8235311761085;870.647387807938;12892.677683057906;12982.09125361224;13230.470781168753;13261.93369033156;13281.933590332035;12848.229106253631;14162.433502659882;16933.57666058346;16943.83056169438;16969.066701331423;957.7414098193501;964.2189826240732;968.5012218707371;989.8218320702271;999.4303247149128;1001.7645853224486;1006.9144122749575;1007.1741172238767;1009;1009.4851625670924;697.6476879176034;713.6431784107946;1003.8544411060392;1051.8685164354456;1065.248999455382;1002.3634991780199;1005.1154983614446;1007.8790545134631;1008.4151192308481;1035.6064695415732;742.8440027594212;746.0599644447981;751.3163021650327;752.9834723123794;768.6848392159188;15986.960847544873;16052.919735401365;16153.4346297879;16225.83774162255;16428.83571164297;16866.241019154168;16979.23593438298;17263.56841078983;17390.391336303295;17475.5631109222;13771.380287887068;13870.167789932637;13923;14098.365573549216;14111.012229143964;3523.5067090607336;3547.450145227494;3550.414181660023;3550.431930891045;3552.769070010441;115653.68692626184;117398;119215.4039229807;119421.40289298585;120829;12624.431900564497;12645.304508252135;12942.417591208417;12948.482060717466;12948.676283092998;25239.62140567893;25541.3614659635;25780.355491112874;25781.22656320276;25800.61299080515;7606.923930760621;7657;7672.578008209491;7684.577348245788;7689.115751688516;3855.7879316637855;3870.2646497165447;3885.7279990400966;3937.8031098444962;3943.684505239574;4226.788660566959;4327.588879056485;4333.544977777351;4336.609705126491;4339.804708788112;889.1419779912416;942.9245660347156;961.4567769210374;979.0405402705388;980.2843923935567;647.7538535356534;667.9499037572201;676.942459890905;676.9796906092826;688.9758858439931;10900.945495272474;11623.59317423903;11728.706782330339;11848.526058957717;11972.521099155936;657.6974591687781;658.7562601837351;665.4277321503503;667.3793372163934;692.069166970424;5428.75570599324;5635.3237611486065;5674.319081710139;5776.33572139201;5777;95842.56236156463;96940.51529742447;98017.50991244998;100040;100227;76083.61958190173;78634;78696.21303787004;82702;85151;67601;71298;73020.63489682623;74302.62848685723;76855;11951.282923024646;12382.133250672367;12394.132410731163;12488.559945883686;12539.373031348214;29945.251368715955;35212.47181292334;36058.63941360553;37270.83727083805;38413.615863841005;46365.53634463612;49383.50616493789;49845.75077124591;50178;50191;15495.14776687293;15689.529314120595;15710.9214453927;15992.92003539975;16047.358105675643;17767.20047597887;17878.91060544689;17967.640647187243;18032.90983545074;18154.27382904669;15999.760003600188;16026;16098.11460369644;16107.75838362449;16125.919370403073;16116.952398094087;16156.67686646284;16354;16477.505674829776;16500.257488413292;13287;15856.44502442409;15913.840861591236;15990;16190.757138643165;9891.208703303862;9958.352707074017;10039.498025098861;10081;10306.742331441474;10738.047037064558;10947.616833410792;11095.5561777528;11256.549738010715;11374.488148033524 18:40:06 INFO - PID 1638 | __end_tp_report 18:40:06 INFO - PID 1638 | __start_cc_report 18:40:06 INFO - PID 1638 | _x_x_mozilla_cycle_collect,1782 18:40:06 INFO - PID 1638 | __end_cc_report 18:40:06 INFO - PID 1638 | __startTimestamp1492825206854__endTimestamp 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | ------- Summary: start ------- 18:40:06 INFO - PID 1638 | Number of tests: 6 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6028.23 Median:6282.99 stddev:701.92 (11.2%) stddev-sans-first:676.17 18:40:06 INFO - PID 1638 | Values: 3530.1 3537.1 3568.1 3584.9 3586.4 4992.5 5998.2 6099.8 6178.4 6205.0 6117.4 6129.4 6157.1 6187.3 6188.0 4349.8 5155.2 5319.3 5320.3 5405.2 5385.0 5424.2 5446.2 5446.3 5452.1 5272.2 5313.3 5326.9 5332.8 5446.2 5326.2 5367.0 5383.9 5415.9 5450.5 5331.1 5334.7 5340.5 5341.0 5418.2 6021.7 6117.2 6166.1 6202.4 6214.5 6287.7 6342.5 6350.2 6359.8 6364.8 6409.9 6413.2 6416.9 6427.1 6520.7 5283.2 6243.2 6246.6 6263.5 6280.1 6627.4 6718.9 6719.8 6756.2 6766.2 6268.2 6297.2 6322.4 6357.0 6431.0 6578.7 6612.3 6613.6 6614.1 6620.5 6495.2 6501.9 6507.3 6521.3 6541.1 6342.3 6543.7 6550.5 6552.5 6569.1 5165.1 5177.6 5179.1 5185.6 5200.2 4666.1 4691.3 4711.0 4714.5 4731.8 6217.0 6249.4 6268.8 6269.2 6283.2 6545.9 6553.5 6558.1 6564.0 6573.8 6100.4 6171.4 6183.7 6237.8 6246.7 5755.5 5774.8 5797.8 5798.6 5799.0 6764.7 6766.1 6828.1 6832.1 6847.2 6357.4 6426.3 6533.8 6543.1 6561.0 6670.5 6687.2 6695.1 6699.1 6708.4 6323.2 6443.3 6489.4 6494.5 6520.7 6517.4 6566.9 6588.6 6592.4 6598.1 6341.4 6366.7 6377.7 6400.1 6402.2 6241.7 6314.8 6318.1 6320.5 6323.5 4977.7 6092.6 6243.7 6267.3 6306.5 6353.8 6383.8 6387.7 6420.7 6427.0 6272.8 6278.5 6283.0 6295.0 6311.4 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:42840.58 Median:16937.66 stddev:74116.31 (437.6%) stddev-sans-first:74256.68 18:40:06 INFO - PID 1638 | Values: 696.6 738.2 787.5 1121.5 1123.9 22877.7 27072.9 27522.9 27526.4 27639.7 36472.8 37116.6 37117.5 37140.6 37199.4 8327.3 8488.7 8498.4 8505.3 8511.7 5835.4 8298.8 8429.6 8433.5 8453.8 6000.6 8294.7 8419.6 8420.6 8427.7 8392.0 8414.1 8444.5 8448.5 8461.7 5818.1 7577.0 7786.0 8333.8 8335.7 26064.3 35722.0 36289.0 36335.5 36402.0 3585.8 3621.0 3625.3 3626.7 3634.1 30314.5 30378.0 30397.4 30452.0 30471.5 3070.7 3091.8 3115.0 3128.0 3128.0 274276.6 280735.0 281488.0 282422.6 282717.0 46800.3 46807.5 46878.3 46909.0 46959.8 50513.0 50514.0 50552.0 50552.5 50665.5 13984.2 14141.7 14155.9 14166.4 14177.7 11472.1 11477.0 11477.5 11491.6 11521.5 10787.5 10842.0 12565.7 12806.4 12879.3 4026.9 4896.3 5080.7 5149.9 5182.9 1012.6 1022.6 1032.2 1064.5 1073.8 23037.8 24284.6 24303.5 24346.9 24353.0 1118.1 1119.1 1146.5 1158.8 1159.6 12361.5 12440.3 12446.3 12467.3 12481.9 291654.0 291881.0 292094.0 292261.0 292909.0 53634.0 53653.5 53772.9 53810.2 53832.7 1319.8 1466.6 1469.1 1518.2 1543.6 23661.4 23663.0 23702.0 23747.3 23797.9 37927.6 38022.4 38051.6 38099.8 38104.2 275125.0 275311.0 275677.0 276406.6 276526.0 33707.3 33741.0 33873.3 34056.5 34340.3 35489.6 35552.8 44754.8 44775.8 44927.6 28154.0 28231.2 29720.4 30667.4 30969.4 27773.4 30368.2 30418.7 30937.4 30991.7 29552.0 32059.2 35814.0 36194.6 36779.0 30006.0 30173.5 30759.9 30783.5 30978.8 21769.8 22605.4 23308.9 23910.4 24047.0 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:35711.46 Median:2301.88 stddev:93150.67 (4046.7%) stddev-sans-first:93374.19 18:40:06 INFO - PID 1638 | Values: 370.5 384.4 433.8 443.3 459.2 20864.6 21043.0 21335.8 21588.0 21886.0 21974.3 22680.5 23046.7 23607.9 23682.9 6135.4 6362.0 6363.5 6365.3 6370.3 5971.4 6210.1 6260.0 6264.2 6268.5 5982.9 6225.0 6236.3 6241.0 6247.4 6047.2 6166.4 6174.9 6182.3 6183.0 5440.7 5495.9 5498.6 5515.3 5626.7 27362.7 28054.2 28063.4 28195.9 28461.9 1944.5 2301.0 2301.3 2301.6 2302.1 17485.1 17518.4 17545.6 18116.2 18316.8 2135.2 2143.5 2184.9 2189.5 2190.4 143656.0 157989.0 158585.0 160201.0 162105.0 11768.1 12372.6 12392.0 12400.9 12411.4 16857.7 16876.7 16915.1 16922.1 16922.2 8644.4 8832.2 8892.6 8923.6 8986.0 6884.6 8277.8 8287.5 8470.6 8478.7 7638.7 7701.3 7810.5 7828.2 7830.5 1940.7 1956.2 2121.9 2127.1 2257.4 907.4 915.7 958.5 971.9 1001.3 18931.2 19216.7 21190.0 21195.9 21200.9 966.5 997.9 1007.0 1013.2 1013.4 9656.0 9889.7 10277.0 10958.8 10966.6 535869.0 539041.0 550477.0 554799.0 557676.4 129339.8 131618.0 133620.0 135439.0 138350.0 949.3 1123.5 1163.2 1163.6 1165.4 17835.7 17966.6 17982.6 18127.8 18451.9 56042.7 56510.4 56799.7 57105.1 57498.1 78053.0 78145.0 80060.6 80099.0 80916.8 8491.0 8752.7 8851.0 8868.2 8974.6 13230.6 14268.4 14295.8 14540.7 14858.9 9641.0 11557.5 11638.9 12036.0 12717.9 10408.0 10446.8 10450.2 10775.8 11921.3 12094.2 12103.5 12306.1 12477.3 12530.2 8760.6 8812.8 8960.3 9011.7 9110.1 11362.6 11912.8 11978.8 12103.9 12173.5 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:7162.76 Median:4296.19 stddev:4537.06 (105.6%) stddev-sans-first:4527.62 18:40:06 INFO - PID 1638 | Values: 1194.2 1349.2 1439.9 1461.8 1469.7 9835.2 10340.3 11652.7 11966.9 11981.4 11601.9 11694.2 11719.9 11724.5 11759.9 2495.1 2533.9 2535.9 2536.3 2537.4 2102.3 2184.8 2470.9 2551.6 2562.7 2498.4 2498.8 2518.0 2529.3 2531.9 2515.7 2521.0 2522.6 2523.9 2526.6 2167.6 2454.9 2455.4 2494.6 2498.5 8533.8 11855.8 11881.4 11884.9 11891.5 6508.9 6752.1 6774.0 6779.3 6787.8 3580.6 3954.6 4104.2 4297.3 4307.8 1196.2 1230.9 1253.6 1254.5 1258.8 16742.7 16748.2 16755.4 16769.3 16779.8 5793.2 5821.0 5935.1 6048.2 6095.5 13750.8 13758.3 13787.6 13791.8 13796.9 6719.5 6845.7 6865.3 6866.1 6870.6 5235.4 6201.3 6219.8 6256.6 6278.9 4146.3 4591.7 4737.4 4739.4 4752.2 1426.8 1472.3 1478.2 1490.9 1495.5 788.4 794.3 811.2 816.1 844.3 6144.4 6309.0 6761.9 6994.5 6998.5 881.8 941.3 951.0 951.1 957.8 3549.5 4295.1 4304.6 4351.5 4421.8 14660.5 15154.8 15205.9 15208.8 15226.5 12137.4 14505.3 15032.6 15032.8 15077.7 8345.7 8539.6 8562.0 8563.9 8566.9 5907.0 6619.5 6670.9 7150.9 7162.6 10471.9 13269.7 13768.9 13768.9 13771.3 13393.1 13841.5 13902.6 14231.5 14321.4 9383.2 9657.2 9662.5 9667.4 9668.4 9680.3 9863.3 9984.7 10623.6 10764.0 9082.5 9255.0 9316.2 9343.7 9407.7 8895.2 9011.9 9019.0 9075.1 9092.9 8041.0 8064.8 8113.7 8140.8 8210.9 6044.4 6076.1 6106.4 6166.7 6170.3 5917.9 6022.3 6180.8 6182.5 6352.7 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:5100.72 Median:5657.31 stddev:1502.81 (26.6%) stddev-sans-first:1464.84 18:40:06 INFO - PID 1638 | Values: 389.9 399.1 405.7 406.5 410.3 5898.6 5923.6 5937.3 5945.3 6010.9 4740.3 5687.8 5762.3 5869.7 5881.0 4488.1 4493.4 4493.9 4499.8 4514.4 4526.5 4531.0 4531.6 4557.6 4562.3 4219.5 4288.6 4495.1 4508.7 4526.7 4437.9 4455.6 4474.4 4474.8 4475.8 3259.8 3978.1 3984.6 3995.3 4007.3 5503.9 5675.8 5774.6 5784.7 5797.4 4418.4 5357.0 5378.9 5413.6 5424.5 5743.7 6307.0 6321.0 6324.2 6336.5 3835.6 4307.8 4474.4 4514.9 4534.8 5424.7 6388.3 6503.7 6505.3 6563.9 4618.5 4685.4 4704.8 4721.8 4724.5 4525.8 4630.8 4782.2 4811.1 4816.0 5099.4 5265.3 5311.9 5394.5 5456.8 5283.3 5526.0 6327.8 6373.8 6381.2 1454.3 1535.1 1560.5 1613.9 1644.4 962.9 1117.9 1139.6 1142.2 1151.0 5945.7 5956.7 5962.5 5974.9 6005.4 4821.0 5889.5 5992.0 6235.7 6466.2 5659.2 5848.4 5925.0 5942.8 5983.5 3352.8 3383.5 3384.5 3400.5 3402.0 5557.6 5655.4 6557.8 6688.5 6800.7 5266.5 5585.0 6322.3 6596.0 6611.9 5295.5 6123.0 6492.3 6716.9 6717.0 4988.5 5400.2 6122.6 6298.9 6414.9 5698.3 6032.4 6038.8 6342.0 6386.8 6218.2 6328.1 6557.7 6622.5 6761.9 3575.6 4643.9 4668.1 4678.3 4678.4 5726.0 6271.5 6329.8 6461.2 6494.4 5083.7 6255.4 6274.0 6282.6 6286.3 5129.4 5190.4 6039.8 6255.3 6268.7 5733.8 6080.0 6096.6 6145.4 6150.4 5427.6 6158.0 6281.3 6307.2 6341.9 5927.9 6043.3 6056.3 6091.6 6138.6 18:40:06 INFO - PID 1638 | 18:40:06 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:20226.19 Median:18000.28 stddev:28149.00 (156.4%) stddev-sans-first:28189.79 18:40:06 INFO - PID 1638 | Values: 703.7 711.7 856.1 860.8 870.6 12892.7 12982.1 13230.5 13261.9 13281.9 12848.2 14162.4 16933.6 16943.8 16969.1 957.7 964.2 968.5 989.8 999.4 1001.8 1006.9 1007.2 1009.0 1009.5 697.6 713.6 1003.9 1051.9 1065.2 1002.4 1005.1 1007.9 1008.4 1035.6 742.8 746.1 751.3 753.0 768.7 15987.0 16052.9 16153.4 16225.8 16428.8 16866.2 16979.2 17263.6 17390.4 17475.6 13771.4 13870.2 13923.0 14098.4 14111.0 3523.5 3547.5 3550.4 3550.4 3552.8 115653.7 117398.0 119215.4 119421.4 120829.0 12624.4 12645.3 12942.4 12948.5 12948.7 25239.6 25541.4 25780.4 25781.2 25800.6 7606.9 7657.0 7672.6 7684.6 7689.1 3855.8 3870.3 3885.7 3937.8 3943.7 4226.8 4327.6 4333.5 4336.6 4339.8 889.1 942.9 961.5 979.0 980.3 647.8 667.9 676.9 677.0 689.0 10900.9 11623.6 11728.7 11848.5 11972.5 657.7 658.8 665.4 667.4 692.1 5428.8 5635.3 5674.3 5776.3 5777.0 95842.6 96940.5 98017.5 100040.0 100227.0 76083.6 78634.0 78696.2 82702.0 85151.0 67601.0 71298.0 73020.6 74302.6 76855.0 11951.3 12382.1 12394.1 12488.6 12539.4 29945.3 35212.5 36058.6 37270.8 38413.6 46365.5 49383.5 49845.8 50178.0 50191.0 15495.1 15689.5 15710.9 15992.9 16047.4 17767.2 17878.9 17967.6 18032.9 18154.3 15999.8 16026.0 16098.1 16107.8 16125.9 16117.0 16156.7 16354.0 16477.5 16500.3 13287.0 15856.4 15913.8 15990.0 16190.8 9891.2 9958.4 10039.5 10081.0 10306.7 10738.0 10947.6 11095.6 11256.5 11374.5 18:40:06 INFO - PID 1638 | -------- Summary: end -------- 18:40:06 INFO - PID 1638 | 18:40:07 INFO - TEST-INFO | 1638: exit 0 18:40:07 INFO - TEST-OK | dromaeo_css | took 1120021ms 18:40:07 INFO - TEST-START | kraken 18:40:07 INFO - operating with platform_type : mac_ 18:40:07 INFO - Initialising browser for kraken test... 18:40:07 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpmQYbvd/profile http://localhost:49236/getInfo.html) 18:40:09 INFO - PID 1648 | __metrics Screen width/height:1600/1200 18:40:09 INFO - PID 1648 | colorDepth:24 18:40:09 INFO - PID 1648 | Browser inner width/height: 1024/689 18:40:09 INFO - PID 1648 | __metrics 18:40:10 INFO - PID 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:40:10 INFO - PID 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:40:11 INFO - TEST-INFO | 1648: exit 0 18:40:11 INFO - Browser initialized. 18:40:11 INFO - Running cycle 1/1 for kraken test... 18:40:11 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpmQYbvd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:40:23 INFO - PID 1649 | RSS: Main: 241569792 18:40:23 INFO - PID 1649 | 18:40:26 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:27 INFO - PID 1649 | RSS: Main: 312602624 18:40:27 INFO - PID 1649 | 18:40:29 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 18:40:30 INFO - PID 1649 | RSS: Main: 294391808 18:40:30 INFO - PID 1649 | 18:40:33 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 18:40:34 INFO - PID 1649 | RSS: Main: 386539520 18:40:34 INFO - PID 1649 | 18:40:36 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 18:40:36 INFO - PID 1649 | RSS: Main: 289099776 18:40:36 INFO - PID 1649 | 18:40:38 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:39 INFO - PID 1649 | RSS: Main: 291471360 18:40:39 INFO - PID 1649 | 18:40:42 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:42 INFO - PID 1649 | RSS: Main: 354779136 18:40:42 INFO - PID 1649 | 18:40:45 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:46 INFO - PID 1649 | RSS: Main: 379879424 18:40:46 INFO - PID 1649 | 18:40:49 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 18:40:49 INFO - PID 1649 | RSS: Main: 393183232 18:40:49 INFO - PID 1649 | 18:40:51 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:52 INFO - PID 1649 | RSS: Main: 332800000 18:40:52 INFO - PID 1649 | 18:40:53 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:54 INFO - PID 1649 | RSS: Main: 331919360 18:40:54 INFO - PID 1649 | 18:40:56 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:57 INFO - PID 1649 | RSS: Main: 334106624 18:40:57 INFO - PID 1649 | 18:41:00 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:41:01 INFO - PID 1649 | RSS: Main: 352501760 18:41:01 INFO - PID 1649 | 18:41:04 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:41:04 INFO - PID 1649 | RSS: Main: 344932352 18:41:04 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 18:41:06 INFO - PID 1649 | RSS: Main: 387604480 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | __start_tp_report 18:41:06 INFO - PID 1649 | _x_x_mozilla_page_load 18:41:06 INFO - PID 1649 | _x_x_mozilla_page_load_details 18:41:06 INFO - PID 1649 | |i|pagename|runs| 18:41:06 INFO - PID 1649 | |0;ai-astar;112;112;112;112;111;115;113;110;112;112 18:41:06 INFO - PID 1649 | |1;audio-beat-detection;139;109;110;149;136;91;124;137;158;121 18:41:06 INFO - PID 1649 | |2;audio-dft;186;184;184;186;187;184;184;187;217;185 18:41:06 INFO - PID 1649 | |3;audio-fft;85;60;61;87;61;59;57;60;80;57 18:41:06 INFO - PID 1649 | |4;audio-oscillator;95;68;86;67;67;69;88;68;69;91 18:41:06 INFO - PID 1649 | |5;imaging-gaussian-blur;88;88;88;87;88;87;88;88;88;88 18:41:06 INFO - PID 1649 | |6;imaging-darkroom;96;96;95;95;96;96;96;96;96;100 18:41:06 INFO - PID 1649 | |7;imaging-desaturate;88;84;84;87;83;85;85;83;86;85 18:41:06 INFO - PID 1649 | |8;json-parse-financial;50;49;50;49;51;49;48;48;49;49 18:41:06 INFO - PID 1649 | |9;json-stringify-tinderbox;55;53;60;56;66;59;57;58;58;57 18:41:06 INFO - PID 1649 | |10;stanford-crypto-aes;83;89;82;97;102;104;105;83;83;83 18:41:06 INFO - PID 1649 | |11;stanford-crypto-ccm;151;148;139;149;124;154;149;147;187;138 18:41:06 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;182;182;186;188;239;204;182;182;192;228 18:41:06 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;68;66;67;67;66;66;67;68;66;67 18:41:06 INFO - PID 1649 | __end_tp_report 18:41:06 INFO - PID 1649 | __start_cc_report 18:41:06 INFO - PID 1649 | _x_x_mozilla_cycle_collect,2215 18:41:06 INFO - PID 1649 | __end_cc_report 18:41:06 INFO - PID 1649 | __startTimestamp1492825266879__endTimestamp 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | ------- Summary: start ------- 18:41:06 INFO - PID 1649 | Number of tests: 14 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:1.29 (1.1%) stddev-sans-first:1.36 18:41:06 INFO - PID 1649 | Values: 112.0 112.0 112.0 112.0 111.0 115.0 113.0 110.0 112.0 112.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:138.00 stddev:20.34 (14.7%) stddev-sans-first:21.13 18:41:06 INFO - PID 1649 | Values: 139.0 109.0 110.0 149.0 136.0 91.0 124.0 137.0 158.0 121.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:188.40 Median:186.00 stddev:10.12 (5.4%) stddev-sans-first:10.70 18:41:06 INFO - PID 1649 | Values: 186.0 184.0 184.0 186.0 187.0 184.0 184.0 187.0 217.0 185.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:66.70 Median:61.00 stddev:12.14 (19.9%) stddev-sans-first:10.92 18:41:06 INFO - PID 1649 | Values: 85.0 60.0 61.0 87.0 61.0 59.0 57.0 60.0 80.0 57.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:77.50 stddev:11.60 (15.0%) stddev-sans-first:10.27 18:41:06 INFO - PID 1649 | Values: 95.0 68.0 86.0 67.0 67.0 69.0 88.0 68.0 69.0 91.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 18:41:06 INFO - PID 1649 | Values: 88.0 88.0 88.0 87.0 88.0 87.0 88.0 88.0 88.0 88.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 18:41:06 INFO - PID 1649 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 100.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.63 (1.9%) stddev-sans-first:1.32 18:41:06 INFO - PID 1649 | Values: 88.0 84.0 84.0 87.0 83.0 85.0 85.0 83.0 86.0 85.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:0.92 (1.9%) stddev-sans-first:0.93 18:41:06 INFO - PID 1649 | Values: 50.0 49.0 50.0 49.0 51.0 49.0 48.0 48.0 49.0 49.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:3.48 (6.0%) stddev-sans-first:3.53 18:41:06 INFO - PID 1649 | Values: 55.0 53.0 60.0 56.0 66.0 59.0 57.0 58.0 58.0 57.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:83.00 stddev:9.79 (11.8%) stddev-sans-first:9.94 18:41:06 INFO - PID 1649 | Values: 83.0 89.0 82.0 97.0 102.0 104.0 105.0 83.0 83.0 83.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:149.00 stddev:16.06 (10.8%) stddev-sans-first:17.01 18:41:06 INFO - PID 1649 | Values: 151.0 148.0 139.0 149.0 124.0 154.0 149.0 147.0 187.0 138.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.50 Median:190.00 stddev:20.81 (11.0%) stddev-sans-first:21.40 18:41:06 INFO - PID 1649 | Values: 182.0 182.0 186.0 188.0 239.0 204.0 182.0 182.0 192.0 228.0 18:41:06 INFO - PID 1649 | 18:41:06 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 18:41:06 INFO - PID 1649 | Values: 68.0 66.0 67.0 67.0 66.0 66.0 67.0 68.0 66.0 67.0 18:41:06 INFO - PID 1649 | -------- Summary: end -------- 18:41:06 INFO - PID 1649 | 18:41:07 INFO - TEST-INFO | 1649: exit 0 18:41:07 INFO - TEST-OK | kraken | took 60434ms 18:41:07 INFO - SUITE-END | took 1180s 18:41:08 INFO - Completed test suite (00:19:40) 18:41:08 INFO - javascript benchmark 18:41:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7719.093329221075, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3530.0821786335546, 3537.0803591066315, 3568.107973006748, 3584.9283014339712, 3586.3903136466797, 4992.475790042044, 5998.1602575639445, 6099.824329823229, 6178.382161783819, 6205.038219076045, 6117.44942955134, 6129.4199191187845, 6157.107219453176, 6187.319394866561, 6188.040853667678, 4349.847755328564, 5155.226715992593, 5319.335083114611, 5320.281761962144, 5405.216243644669, 5384.976854397652, 5424.186372044205, 5446.183072539131, 5446.2919820423285, 5452.127659574468, 5272.209168624699, 5313.256144139824, 5326.946730532683, 5332.840014799563, 5446.183072539131, 5326.227696983916, 5366.973165134188, 5383.919241211385, 5415.9458405415835, 5450.5367043801325, 5331.067063263913, 5334.706591137486, 5340.54605358545, 5340.973295133499, 5418.187271909206, 6021.698915054273, 6117.204763380777, 6166.07508873668, 6202.3797620238065, 6214.471769899564, 6287.7170527325925, 6342.5243106767175, 6350.174477317919, 6359.841003974938, 6364.840878978016, 6409.903851442232, 6413.230412350501, 6416.903746443807, 6427.132337134473, 6520.739170433224, 5283.2075188722, 6243.188385509855, 6246.562740608159, 6263.498920086382, 6280.089387038854, 6627.37039981201, 6718.899216511756, 6719.832004199934, 6756.223034351015, 6766.221884483348, 6268.216472940882, 6297.1813664223355, 6322.399372059647, 6356.98288273874, 6431.0031945048595, 6578.703958321791, 6612.305707900601, 6613.6362500062, 6614.140161778938, 6620.536562440583, 6495.220573531112, 6501.902471462932, 6507.349265073455, 6521.347865213441, 6541.084248205255, 6342.302346741854, 6543.672816359163, 6550.508711846631, 6552.475801935833, 6569.146011018633, 5165.1219292720325, 5177.611679124081, 5179.067767801832, 5185.637005409585, 5200.193969934666, 4666.066786642617, 4691.272852707836, 4711.0, 4714.457837348748, 4731.7634118293945, 6217.036359364306, 6249.437550620466, 6268.843278918063, 6269.216347956505, 6283.214598175228, 6545.919923212712, 6553.475721942234, 6558.081868538408, 6563.982582699689, 6573.835654108686, 6100.399513635627, 6171.382861713882, 6183.690815459299, 6237.781677641261, 6246.6876656167005, 5755.510781583613, 5774.82675519735, 5797.826065218051, 5798.623089499169, 5799.043157878903, 6764.661766911537, 6766.120404347502, 6828.07820944186, 6832.077669514552, 6847.21257055445, 6357.427831495188, 6426.293107758236, 6533.771318003847, 6543.051257567531, 6560.983047627626, 6670.499712521483, 6687.230968438692, 6695.09616201826, 6699.095622090956, 6708.362705542965, 6323.177986861679, 6443.2590252119735, 6489.448396886318, 6494.480441564758, 6520.706568204348, 6517.4134327910715, 6566.868662626625, 6588.6046837188005, 6592.373724496165, 6598.109255250672, 6341.4292713656, 6366.745330186926, 6377.7130029147875, 6400.103985442135, 6402.167718196604, 6241.656708881055, 6314.778982735582, 6318.115463834974, 6320.462760665395, 6323.525735569759, 4977.676451030671, 6092.634441933498, 6243.656598887105, 6267.310595834546, 6306.527010474325, 6353.841153971188, 6383.7765678202895, 6387.744490220339, 6420.7431702731365, 6427.035944608159, 6272.8431789203805, 6278.46633036197, 6282.994720844643, 6294.968525157345, 6311.400416960381], "value": 5982.7892321013705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.6133795743362, 738.2285511640335, 787.5156778581172, 1121.4897221764093, 1123.9325640461568, 22877.74172420518, 27072.864635676844, 27522.862385688095, 27526.449471010594, 27639.723602763966, 36472.81763591185, 37116.62883371166, 37117.50443672353, 37140.62859371406, 37199.44200836989, 8327.292180164679, 8488.66045358185, 8498.447600905953, 8505.277051450634, 8511.74464766058, 5835.35811060783, 8298.751037468886, 8429.578521073952, 8433.451825631346, 8453.788655283606, 6000.639961602318, 8294.70968516102, 8419.621117049748, 8420.578971051453, 8427.662893484285, 8391.95804020979, 8414.11651776567, 8444.451110677848, 8448.535330556817, 8461.703840365557, 5818.1272809078555, 7577.0, 7786.0, 8333.791655208608, 8335.66657333706, 26064.34839129018, 35722.0, 36289.0, 36335.4549681755, 36402.0, 3585.7848529088337, 3620.981895090508, 3625.256822351438, 3626.7279954003557, 3634.0914771307175, 30314.54528182079, 30378.0, 30397.392052158833, 30452.0, 30471.542926856117, 3070.6775788542104, 3091.7835751497405, 3114.9688503114903, 3128.0, 3128.0146753772488, 274276.62861685565, 280735.0, 281488.0, 282422.5878870613, 282717.0, 46800.29799553009, 46807.531924680996, 46878.296825547644, 46909.0, 46959.765201173774, 50513.0, 50514.0, 50552.0, 50552.494475055515, 50665.493345066076, 13984.160950343012, 14141.71716565663, 14155.858441415454, 14166.362513686909, 14177.716445671029, 11472.139589530818, 11477.0, 11477.483513241925, 11491.597794077166, 11521.48153333102, 10787.514561844735, 10842.0, 12565.685857853445, 12806.42371093303, 12879.291638959947, 4026.8993275168355, 4896.3389942358035, 5080.695158290514, 5149.922751158736, 5182.896342073137, 1012.5696578953915, 1022.5960745505483, 1032.2206733915846, 1064.4518073192312, 1073.8013467508379, 23037.848107594553, 24284.63573046406, 24303.513929721306, 24346.878265608913, 24353.0, 1118.0999295566985, 1119.1047162270152, 1146.48408216303, 1158.820382840661, 1159.5709587452698, 12361.505539778309, 12440.253584784941, 12446.315452650191, 12467.251964882136, 12481.875181248253, 291654.0, 291881.0, 292094.0, 292261.0, 292909.0, 53634.0, 53653.463465364846, 53772.92454150973, 53810.192847107326, 53832.73083634557, 1319.8350206224222, 1466.5820241231197, 1469.1421728505368, 1518.1953564610774, 1543.6218126559065, 23661.408464788517, 23663.0, 23702.0, 23747.287581372588, 23797.881010594836, 37927.620723793516, 38022.429663555624, 38051.61948380481, 38099.80950095232, 38104.18958104278, 275125.0, 275311.0, 275677.0, 276406.6179669089, 276526.0, 33707.3258534823, 33741.0, 33873.32253354968, 34056.48915266323, 34340.31319373648, 35489.645103549665, 35552.822235888656, 44754.77622611996, 44775.77612111918, 44927.550724492336, 28154.0, 28231.15306540807, 29720.405591888473, 30667.386652267276, 30969.380612388075, 27773.444531109668, 30368.240793980327, 30418.695813041588, 30937.381252375275, 30991.69008309888, 29552.0, 32059.198520037186, 35814.0, 36194.63805361913, 36779.0, 30006.0, 30173.547396789505, 30759.923402680797, 30783.53824692676, 30978.845105774326, 21769.78230217741, 22605.43486412853, 23308.883455582614, 23910.402239944142, 24047.0], "value": 16811.209763895462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.5460810507129, 384.40801166204045, 433.75926360869744, 443.2907348242812, 459.17577947584084, 20864.582708345843, 21043.0, 21335.786642133575, 21588.0, 21886.0, 21974.340769776893, 22680.54638907221, 23046.65430018547, 23607.881960590217, 23682.88158559209, 6135.447809697126, 6362.0, 6363.522735794811, 6365.267994180659, 6370.331115232903, 5971.387725314163, 6210.130581718563, 6260.029695397221, 6264.185655864731, 6268.467180289658, 5982.910256346158, 6225.035119556476, 6236.282827474831, 6240.968795156018, 6247.375262473762, 6047.213862197908, 6166.445019948226, 6174.876502469948, 6182.258129024523, 6183.041628547582, 5440.700761458118, 5495.862603434946, 5498.615096943216, 5515.34539638111, 5626.746796394131, 27362.726372736215, 28054.158375248775, 28063.438731225466, 28195.85902070497, 28461.857690711622, 1944.5235917200378, 2300.9884950575306, 2301.2866011536476, 2301.620232661609, 2302.1482051641, 17485.12574371289, 17518.38685645996, 17545.56136096595, 18116.184771685304, 18316.816831831646, 2135.2206444647745, 2143.496278374581, 2184.912603495858, 2189.518305972699, 2190.44143743346, 143656.0, 157989.0, 158585.0, 160201.0, 162104.9999999988, 11768.117391195694, 12372.566960156531, 12392.0, 12400.937995309965, 12411.441485133191, 16857.662846743, 16876.746848797276, 16915.069671168203, 16922.069286189377, 16922.153892305334, 8644.418458217155, 8832.205101540892, 8892.64429422816, 8923.643054277885, 8985.955070224607, 6884.621345825927, 8277.8344433111, 8287.50274983503, 8470.644696848474, 8478.660853565912, 7638.656260468292, 7701.26837950405, 7810.453268271166, 7828.238646304536, 7830.451868369273, 1940.7094282302394, 1956.217512994785, 2121.9045142968603, 2127.106615221611, 2257.3792207143165, 907.3784457646533, 915.702396721055, 958.5399008475971, 971.8920430708997, 1001.2640709078821, 18931.24275029011, 19216.71174932377, 21190.04644790988, 21195.940202990096, 21200.893995529925, 966.4771906401129, 997.8602995580625, 1006.9899301006897, 1013.1742629756725, 1013.4122209118693, 9655.951720241354, 9889.653862114936, 10277.0, 10958.780824383468, 10966.56133754657, 535869.0, 539041.0, 550477.0, 554799.0, 557676.4232357624, 129339.82640694454, 131618.0, 133620.0, 135439.0, 138350.0, 949.349695458613, 1123.5168877382641, 1163.1915818506056, 1163.6218229075414, 1165.3648761424874, 17835.73246401279, 17966.5508362292, 17982.640347192722, 18127.81872181261, 18451.90774046121, 56042.719786400805, 56510.43489565052, 56799.71600142138, 57105.14342284952, 57498.13752793628, 78053.0, 78145.0, 80060.59969700115, 80099.0, 80916.78624820514, 8490.957545212234, 8752.737417877473, 8851.0, 8868.15752503511, 8974.596143173443, 13230.603081907559, 14268.357923893658, 14295.785563216768, 14540.709185816013, 14858.85141148618, 9641.0, 11557.537698492302, 11638.88361116378, 12036.0, 12717.872821271669, 10408.0, 10446.843297350393, 10450.216233782345, 10775.784484310114, 11921.34432606215, 12094.213876098378, 12103.515859365527, 12306.138570299992, 12477.251364918135, 12530.185537940004, 8760.605772740115, 8812.779680507781, 8960.32797540174, 9011.729648110568, 9110.134537218953, 11362.602308919148, 11912.821307680219, 11978.820317695066, 12103.939480302543, 12173.452194651085], "value": 10403.59203433259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1194.2058531076823, 1349.2309383651318, 1439.9424023039078, 1461.8391976882542, 1469.7281003014443, 9835.213182945365, 10340.32787868789, 11652.708682282937, 11966.940165299162, 11981.40092995349, 11601.867495776136, 11694.181407301492, 11719.882801171985, 11724.472398742057, 11759.941200294008, 2495.1267056530205, 2533.8859751311234, 2535.936601584966, 2536.315194897386, 2537.429078457351, 2102.2536999365234, 2184.759676435591, 2470.8750474591925, 2551.6427700122, 2562.692476902765, 2498.439099922585, 2498.800095992325, 2517.9748202518017, 2529.304441278654, 2531.936701582466, 2515.6981162260463, 2520.962185567218, 2522.6216067589826, 2523.9242822715164, 2526.608375701769, 2167.580234946113, 2454.8895299711558, 2455.3861534616344, 2494.588392915167, 2498.462830491435, 8533.829323413496, 11855.822162667568, 11881.405929703567, 11884.940575297069, 11891.524339026428, 6508.8698226035685, 6752.054712340277, 6773.966130169367, 6779.28817474163, 6787.796366108975, 3580.5882323532605, 3954.644082032602, 4104.179164167179, 4297.312430011183, 4307.806148723315, 1196.2045239915446, 1230.9322987235698, 1253.5800506830224, 1254.4982007197102, 1258.779713550125, 16742.66514669712, 16748.24632891523, 16755.413560525445, 16769.329226831032, 16779.83220167807, 5793.2179155814265, 5821.0, 5935.139404786281, 6048.153258543807, 6095.512359011357, 13750.793738093937, 13758.31208439574, 13787.586372408843, 13791.793123103162, 13796.861486469614, 6719.462443004646, 6845.657717114124, 6865.27914568963, 6866.107406037183, 6870.5534140281725, 5235.424103348629, 6201.348858369896, 6219.813405597839, 6256.624602523863, 6278.937210627927, 4146.274401979642, 4591.747453890068, 4737.360456338351, 4739.431268247763, 4752.239641657318, 1426.771716525351, 1472.263868065967, 1478.186997151584, 1490.936126260545, 1495.4915328788263, 788.3693045563641, 794.3287921706149, 811.2212276214782, 816.1389733830865, 844.2612713875359, 6144.38556144382, 6308.968455157695, 6761.8647627047185, 6994.545354551938, 6998.4751143664425, 881.8324518341623, 941.2893265584577, 950.9904900951041, 951.1012093571646, 957.8419560772395, 3549.467579863041, 4295.076558539929, 4304.612584867377, 4351.5430879757805, 4421.756803375781, 14660.486882959045, 15154.772678409832, 15205.923970380078, 15208.847911520965, 15226.46707365237, 12137.422135122553, 14505.347259373353, 15032.624184395478, 15032.774508382383, 15077.698446031018, 8345.707900223584, 8539.573021348908, 8562.0, 8563.871541926876, 8566.871496927552, 5906.970465147647, 6619.470442364503, 6670.899936501053, 7150.856982860418, 7162.570245785269, 10471.947640262055, 13269.668258293234, 13768.862311376757, 13768.862311376757, 13771.311434428038, 13393.129446585941, 13841.515546955809, 13902.582922512342, 14231.501897433955, 14321.427142914583, 9383.249340052917, 9657.22742180638, 9662.468564229035, 9667.371620844904, 9668.371555848847, 9680.322377433513, 9863.309568330147, 9984.700458986243, 10623.628173013907, 10764.03123718869, 9082.45505269686, 9255.02822203659, 9316.20812230968, 9343.672971445967, 9407.670731524364, 8895.199432051146, 9011.864822027545, 9018.954905225432, 9075.092490751136, 9092.909070909207, 8041.0, 8064.798380040546, 8113.71601993951, 8140.796480088045, 8210.917890821254, 6044.395560443921, 6076.149339092619, 6106.419890110433, 6166.660833654013, 6170.259568851767, 5917.881642367042, 6022.307434644897, 6180.81457556274, 6182.474489668429, 6352.714127864349], "value": 5430.044724880257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.92006638639083, 399.1000294336271, 405.6754596322942, 406.47361666641694, 410.2574340443797, 5898.587098903073, 5923.644581325124, 5937.317208521022, 5945.256842894638, 6010.8797824043495, 4740.2889566564945, 5687.829365119053, 5762.250907382045, 5869.70651467426, 5881.029854998581, 4488.147252022121, 4493.415855938723, 4493.865184044484, 4499.75251361175, 4514.435695538058, 4526.4794548627, 4531.0, 4531.592156705896, 4557.635389168859, 4562.270036794113, 4219.535851056381, 4288.571142885718, 4495.08958692556, 4508.729476231437, 4526.728396296233, 4437.892001299389, 4455.621272191867, 4474.373587697709, 4474.77626118696, 4475.820967161309, 3259.7555183361105, 3978.1446988897237, 3984.641382275609, 3995.3219647747724, 4007.298722723541, 5503.889922201533, 5675.772969081232, 5774.624649397818, 5784.739686714066, 5797.405713428799, 4418.403515525395, 5357.0, 5378.897326048151, 5413.590952026349, 5424.484673956007, 5743.712814359265, 6306.968465157691, 6321.040477452005, 6324.177856878577, 6336.46140078094, 3835.61643835617, 4307.8492252771, 4474.440694913136, 4514.909701805978, 4534.750588717619, 5424.67095561586, 6388.297287298394, 6503.739850405978, 6505.284418713938, 6563.947764289628, 4618.49196588375, 4685.4143232095985, 4704.835330763475, 4721.763911804464, 4724.456687480983, 4525.751083690363, 4630.791614377361, 4782.234842425265, 4811.109944660249, 4815.95184048155, 5099.4390617032095, 5265.288781146143, 5311.893762124813, 5394.487523685244, 5456.781728730885, 5283.260343551829, 5526.0, 6327.841803954938, 6373.808785736435, 6381.1704478417505, 1454.287399174397, 1535.1249787621173, 1560.4772401245482, 1613.9273732682057, 1644.3669187362952, 962.9037096290455, 1117.9049780768562, 1139.5669645534645, 1142.2061667141422, 1151.0043812102472, 5945.702714864326, 5956.6723830188885, 5962.493188079062, 5974.880502389928, 6005.429484198994, 4821.0, 5889.528837692974, 5992.041273396236, 6235.657038862815, 6466.159399278064, 5659.179418984224, 5848.415158484203, 5924.970375148183, 5942.82171534846, 5983.491403230687, 3352.798832070084, 3383.543221665093, 3384.4754063120254, 3400.489926511043, 3402.0, 5557.5831812614215, 5655.4344565543115, 6557.78029222213, 6688.531802773759, 6800.65996700163, 5266.473352664703, 5584.9841085813205, 6322.304546499881, 6596.0, 6611.933880661132, 5295.523402893681, 6123.0, 6492.253390860112, 6716.887632254625, 6717.0, 4988.5260900214425, 5400.216968539618, 6122.602030867979, 6298.937010629835, 6414.871702566016, 5698.344690360662, 6032.396760324108, 6038.758449661965, 6341.955861186564, 6386.840328991627, 6218.22272215973, 6328.14570033058, 6557.737690492327, 6622.536422450382, 6761.898571521529, 3575.570931488238, 4643.907121857612, 4668.136394766979, 4678.251479763221, 4678.432725037151, 5726.0, 6271.466925311217, 6329.841753956188, 6461.215723490411, 6494.447971922439, 5083.669561478492, 6255.37446255389, 6274.0, 6282.623042617458, 6286.322501336586, 5129.358830146231, 5190.40310364313, 6039.822234664199, 6255.343188965093, 6268.749250029948, 5733.799317023884, 6079.996800528041, 6096.634201947897, 6145.385461453819, 6150.384961503813, 5427.6200665953, 6157.96921015392, 6281.277653069773, 6307.211598550181, 6341.904871427025, 5927.911081333697, 6043.305019922589, 6056.303525094494, 6091.634501929899, 6138.570300078952], "value": 4647.10818084337, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.6938931564769, 711.7366574367485, 856.0540602634093, 860.8235311761085, 870.647387807938, 12892.677683057906, 12982.09125361224, 13230.470781168753, 13261.93369033156, 13281.933590332035, 12848.229106253631, 14162.433502659882, 16933.57666058346, 16943.83056169438, 16969.066701331423, 957.7414098193501, 964.2189826240732, 968.5012218707371, 989.8218320702271, 999.4303247149128, 1001.7645853224486, 1006.9144122749575, 1007.1741172238767, 1009.0, 1009.4851625670924, 697.6476879176034, 713.6431784107946, 1003.8544411060392, 1051.8685164354456, 1065.248999455382, 1002.3634991780199, 1005.1154983614446, 1007.8790545134631, 1008.4151192308481, 1035.6064695415732, 742.8440027594212, 746.0599644447981, 751.3163021650327, 752.9834723123794, 768.6848392159188, 15986.960847544873, 16052.919735401365, 16153.4346297879, 16225.83774162255, 16428.83571164297, 16866.241019154168, 16979.23593438298, 17263.56841078983, 17390.391336303295, 17475.5631109222, 13771.380287887068, 13870.167789932637, 13923.0, 14098.365573549216, 14111.012229143964, 3523.5067090607336, 3547.450145227494, 3550.414181660023, 3550.431930891045, 3552.769070010441, 115653.68692626184, 117398.0, 119215.4039229807, 119421.40289298585, 120829.0, 12624.431900564497, 12645.304508252135, 12942.417591208417, 12948.482060717466, 12948.676283092998, 25239.62140567893, 25541.3614659635, 25780.355491112874, 25781.22656320276, 25800.61299080515, 7606.923930760621, 7657.0, 7672.578008209491, 7684.577348245788, 7689.115751688516, 3855.7879316637855, 3870.2646497165447, 3885.7279990400966, 3937.8031098444962, 3943.684505239574, 4226.788660566959, 4327.588879056485, 4333.544977777351, 4336.609705126491, 4339.804708788112, 889.1419779912416, 942.9245660347156, 961.4567769210374, 979.0405402705388, 980.2843923935567, 647.7538535356534, 667.9499037572201, 676.942459890905, 676.9796906092826, 688.9758858439931, 10900.945495272474, 11623.59317423903, 11728.706782330339, 11848.526058957717, 11972.521099155936, 657.6974591687781, 658.7562601837351, 665.4277321503503, 667.3793372163934, 692.069166970424, 5428.75570599324, 5635.3237611486065, 5674.319081710139, 5776.33572139201, 5777.0, 95842.56236156463, 96940.51529742447, 98017.50991244998, 100040.0, 100227.0, 76083.61958190173, 78634.0, 78696.21303787004, 82702.0, 85151.0, 67601.0, 71298.0, 73020.63489682623, 74302.62848685723, 76855.0, 11951.282923024646, 12382.133250672367, 12394.132410731163, 12488.559945883686, 12539.373031348214, 29945.251368715955, 35212.47181292334, 36058.63941360553, 37270.83727083805, 38413.615863841005, 46365.53634463612, 49383.50616493789, 49845.75077124591, 50178.0, 50191.0, 15495.14776687293, 15689.529314120595, 15710.9214453927, 15992.92003539975, 16047.358105675643, 17767.20047597887, 17878.91060544689, 17967.640647187243, 18032.90983545074, 18154.27382904669, 15999.760003600188, 16026.0, 16098.11460369644, 16107.75838362449, 16125.919370403073, 16116.952398094087, 16156.67686646284, 16354.0, 16477.505674829776, 16500.257488413292, 13287.0, 15856.44502442409, 15913.840861591236, 15990.0, 16190.757138643165, 9891.208703303862, 9958.352707074017, 10039.498025098861, 10081.0, 10306.742331441474, 10738.047037064558, 10947.616833410792, 11095.5561777528, 11256.549738010715, 11374.488148033524], "value": 8011.158886144968, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 112.0, 111.0, 115.0, 113.0, 110.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 110.0, 149.0, 136.0, 91.0, 124.0, 137.0, 158.0, 121.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 184.0, 186.0, 187.0, 184.0, 184.0, 187.0, 217.0, 185.0], "value": 188.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 61.0, 87.0, 61.0, 59.0, 57.0, 60.0, 80.0, 57.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 68.0, 86.0, 67.0, 67.0, 69.0, 88.0, 68.0, 69.0, 91.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 87.0, 88.0, 87.0, 88.0, 88.0, 88.0, 88.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 100.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 84.0, 87.0, 83.0, 85.0, 85.0, 83.0, 86.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 49.0, 51.0, 49.0, 48.0, 48.0, 49.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 60.0, 56.0, 66.0, 59.0, 57.0, 58.0, 58.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 82.0, 97.0, 102.0, 104.0, 105.0, 83.0, 83.0, 83.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 139.0, 149.0, 124.0, 154.0, 149.0, 147.0, 187.0, 138.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 186.0, 188.0, 239.0, 204.0, 182.0, 182.0, 192.0, 228.0], "value": 196.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 68.0, 66.0, 67.0], "value": 66.8, "unit": "score"}]}]} 18:41:08 INFO - Return code: 0 18:41:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:41:08 ERROR - # TBPL SUCCESS # 18:41:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:41:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:41:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:41:08 INFO - 2017-04-21 18:41:08.207 screenresolution[1653:9767] starting screenresolution argv=screenresolution get 18:41:08 INFO - 2017-04-21 18:41:08.212 screenresolution[1653:9767] Display 0: 1600x1200x32@60 18:41:08 INFO - 2017-04-21 18:41:08.218 screenresolution[1654:9770] starting screenresolution argv=screenresolution list 18:41:08 INFO - Available Modes on Display 0 18:41:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:41:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:41:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:41:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:41:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:41:08 INFO - Intel Iris: 18:41:08 INFO - Chipset Model: Intel Iris 18:41:08 INFO - Type: GPU 18:41:08 INFO - Bus: Built-In 18:41:08 INFO - VRAM (Dynamic, Max): 1536 MB 18:41:08 INFO - Vendor: Intel (0x8086) 18:41:08 INFO - Device ID: 0x0a2e 18:41:08 INFO - Revision ID: 0x0009 18:41:08 INFO - Displays: 18:41:08 INFO - Display: 18:41:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:41:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:41:08 INFO - Display Serial Number: 1600x1200 60 18:41:08 INFO - Main Display: Yes 18:41:08 INFO - Mirror: Off 18:41:08 INFO - Online: Yes 18:41:08 INFO - Rotation: Supported 18:41:08 INFO - Return code: 0 18:41:08 INFO - Running post-action listener: _resource_record_post_action 18:41:08 INFO - [mozharness: 2017-04-22 01:41:08.468109Z] Finished run-tests step (success) 18:41:08 INFO - Running post-run listener: _resource_record_post_run 18:41:08 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 11902976; Write bytes: 517648896; Read time: 131; Write time: 1798 18:41:08 INFO - TinderboxPrint: CPU usage
53.4% 18:41:08 INFO - TinderboxPrint: I/O read bytes / time
11,902,976 / 131 18:41:08 INFO - TinderboxPrint: I/O write bytes / time
517,648,896 / 1,798 18:41:08 INFO - TinderboxPrint: CPU idle
2,241.6 (46.6%) 18:41:08 INFO - TinderboxPrint: CPU system
959.9 (20.0%) 18:41:08 INFO - TinderboxPrint: CPU user
1,604.1 (33.4%) 18:41:08 INFO - TinderboxPrint: Swap in / out
246,743,040 / 0 18:41:08 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 210533888; Write bytes: 206596096; Read time: 16373; Write time: 498 18:41:08 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 4762624; Write bytes: 303999488; Read time: 40; Write time: 1271 18:41:08 INFO - Running post-run listener: _upload_blobber_files 18:41:08 INFO - Blob upload gear active. 18:41:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:41:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:41:09 INFO - (blobuploader) - INFO - Open directory for files ... 18:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:41:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:10 INFO - (blobuploader) - INFO - Done attempting. 18:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:11 INFO - (blobuploader) - INFO - Done attempting. 18:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:12 INFO - (blobuploader) - INFO - Done attempting. 18:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:14 INFO - (blobuploader) - INFO - Done attempting. 18:41:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:41:14 INFO - Return code: 0 18:41:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:41:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:41:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b323f32d66f1917af81b61e0e5332099d00ba1bfa84871b4e29c1e18298348ea69139bcf2dd8bbc12f8c6313a6ecb5b67b022ec5cf4732631d05612482da867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e22a6b35926f7f287039e04ca17b3775d940e3d79b20f985cf00ee9ccd0fec698e382a42845614e32f7761b8535181f60bdba430e55a3cda4399dd94481c4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9f9d1512d3dd3b00d22a887b938d40fa350745d195e2cf2cd8d9c588271141de2a8347ce7c07e10bb8f91759dc4a636d69e5bb9e0fef1ccc0312fd6db55aba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/639a17e9749950986b876abf0a38e09dfe3fb6f85794a70ce8ba8adb5f21c10181ab2027991e5607285158ef5649d5e6cb433d57eaca9c02606c92528d7267f9"} 18:41:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:41:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:41:14 INFO - Contents: 18:41:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b323f32d66f1917af81b61e0e5332099d00ba1bfa84871b4e29c1e18298348ea69139bcf2dd8bbc12f8c6313a6ecb5b67b022ec5cf4732631d05612482da867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e22a6b35926f7f287039e04ca17b3775d940e3d79b20f985cf00ee9ccd0fec698e382a42845614e32f7761b8535181f60bdba430e55a3cda4399dd94481c4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9f9d1512d3dd3b00d22a887b938d40fa350745d195e2cf2cd8d9c588271141de2a8347ce7c07e10bb8f91759dc4a636d69e5bb9e0fef1ccc0312fd6db55aba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/639a17e9749950986b876abf0a38e09dfe3fb6f85794a70ce8ba8adb5f21c10181ab2027991e5607285158ef5649d5e6cb433d57eaca9c02606c92528d7267f9"} 18:41:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:41:14 INFO - Copying logs to upload dir... 18:41:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:41:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.556098 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-21 18:41:14.554961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 18:41:14.558795) ========= 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.j3HwqEjZt7/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.3oeBdLo29R/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b323f32d66f1917af81b61e0e5332099d00ba1bfa84871b4e29c1e18298348ea69139bcf2dd8bbc12f8c6313a6ecb5b67b022ec5cf4732631d05612482da867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e22a6b35926f7f287039e04ca17b3775d940e3d79b20f985cf00ee9ccd0fec698e382a42845614e32f7761b8535181f60bdba430e55a3cda4399dd94481c4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9f9d1512d3dd3b00d22a887b938d40fa350745d195e2cf2cd8d9c588271141de2a8347ce7c07e10bb8f91759dc4a636d69e5bb9e0fef1ccc0312fd6db55aba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/639a17e9749950986b876abf0a38e09dfe3fb6f85794a70ce8ba8adb5f21c10181ab2027991e5607285158ef5649d5e6cb433d57eaca9c02606c92528d7267f9"} build_url:https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010916 build_url: 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b323f32d66f1917af81b61e0e5332099d00ba1bfa84871b4e29c1e18298348ea69139bcf2dd8bbc12f8c6313a6ecb5b67b022ec5cf4732631d05612482da867", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e22a6b35926f7f287039e04ca17b3775d940e3d79b20f985cf00ee9ccd0fec698e382a42845614e32f7761b8535181f60bdba430e55a3cda4399dd94481c4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9f9d1512d3dd3b00d22a887b938d40fa350745d195e2cf2cd8d9c588271141de2a8347ce7c07e10bb8f91759dc4a636d69e5bb9e0fef1ccc0312fd6db55aba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/639a17e9749950986b876abf0a38e09dfe3fb6f85794a70ce8ba8adb5f21c10181ab2027991e5607285158ef5649d5e6cb433d57eaca9c02606c92528d7267f9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 18:41:14.595561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:41:14.595919) ========= 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.j3HwqEjZt7/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.3oeBdLo29R/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005127 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:41:14.644335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 18:41:14.644653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 18:41:14.645003) ========= ========= Total master_lag: 0.18 =========