builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0389 starttime: 1490160633.02 results: success (0) buildid: 20170321205435 builduid: af339c5cc49f4134aa8a9a913df4bede revision: 9ac2fe545f73719d862d85d87764f7728bb34cfc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.021608) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.022038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.022311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.050225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.050591) ========= 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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-21 22:30:33-- 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% 12.3M=0.001s 2017-03-21 22:30:33 (12.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162027 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.537570) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.538360) ========= 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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.026423 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:33.591208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 22:30:33.592039) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ac2fe545f73719d862d85d87764f7728bb34cfc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ac2fe545f73719d862d85d87764f7728bb34cfc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hGQ1UzYKQH/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.7FZerCnRPB/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-21 22:30:33,728 truncating revision to first 12 chars 2017-03-21 22:30:33,728 Setting DEBUG logging. 2017-03-21 22:30:33,728 attempt 1/10 2017-03-21 22:30:33,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9ac2fe545f73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 22:30:34,652 unpacking tar archive at: mozilla-aurora-9ac2fe545f73/testing/mozharness/ program finished with exit code 0 elapsedTime=1.186067 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 22:30:34.803938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:34.804305) ========= script_repo_revision: 9ac2fe545f73719d862d85d87764f7728bb34cfc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:34.804838) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:34.805161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 22:30:34.825211) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-21 22:30:34.825551) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hGQ1UzYKQH/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.7FZerCnRPB/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:30:35 INFO - MultiFileLogger online at 20170321 22:30:35 in /builds/slave/test 22:30:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:30:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:30:35 INFO - {'append_to_log': False, 22:30:35 INFO - 'base_work_dir': '/builds/slave/test', 22:30:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:30:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:30:35 INFO - 'branch': 'Mozilla-Aurora', 22:30:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:30:35 INFO - 'config_files': ('talos/mac_config.py',), 22:30:35 INFO - 'default_actions': ('clobber', 22:30:35 INFO - 'read-buildbot-config', 22:30:35 INFO - 'download-and-extract', 22:30:35 INFO - 'populate-webroot', 22:30:35 INFO - 'create-virtualenv', 22:30:35 INFO - 'install', 22:30:35 INFO - 'run-tests'), 22:30:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:30:35 INFO - 'download_minidump_stackwalk': True, 22:30:35 INFO - 'download_symbols': 'ondemand', 22:30:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:30:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:30:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:30:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:30:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:30:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:30:35 INFO - 'gecko_profile': False, 22:30:35 INFO - 'gecko_profile_interval': 0, 22:30:35 INFO - 'installer_path': 'installer.exe', 22:30:35 INFO - 'log_level': 'info', 22:30:35 INFO - 'log_name': 'talos', 22:30:35 INFO - 'log_to_console': True, 22:30:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:30:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:30:35 INFO - 'opt_config_files': (), 22:30:35 INFO - 'pip_index': False, 22:30:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:30:35 INFO - 'cmd': ('bash', 22:30:35 INFO - '-c', 22:30:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:30:35 INFO - 'enabled': True, 22:30:35 INFO - 'halt_on_failure': False, 22:30:35 INFO - 'name': 'check_screen_resolution'},), 22:30:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:30:35 INFO - 'cmd': ('bash', 22:30:35 INFO - '-c', 22:30:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:30:35 INFO - 'enabled': True, 22:30:35 INFO - 'halt_on_failure': False, 22:30:35 INFO - 'name': 'check_screen_resolution'},), 22:30:35 INFO - 'run_cmd_checks_enabled': True, 22:30:35 INFO - 'suite': 'dromaeojs', 22:30:35 INFO - 'system_bits': '32', 22:30:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:30:35 INFO - 'title': 't-yosemite-r7-0389', 22:30:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:30:35 INFO - 'use_talos_json': True, 22:30:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:30:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:30:35 INFO - 'work_dir': 'build'} 22:30:35 INFO - [mozharness: 2017-03-22 05:30:35.080847Z] Running clobber step. 22:30:35 INFO - Running pre-action listener: _resource_record_pre_action 22:30:35 INFO - Running main action method: clobber 22:30:35 INFO - rmtree: /builds/slave/test/build 22:30:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:30:37 INFO - Running post-action listener: _resource_record_post_action 22:30:37 INFO - [mozharness: 2017-03-22 05:30:37.478917Z] Finished clobber step (success) 22:30:37 INFO - [mozharness: 2017-03-22 05:30:37.479142Z] Running read-buildbot-config step. 22:30:37 INFO - Running pre-action listener: _resource_record_pre_action 22:30:37 INFO - Running main action method: read_buildbot_config 22:30:37 INFO - Using buildbot properties: 22:30:37 INFO - { 22:30:37 INFO - "project": "", 22:30:37 INFO - "product": "firefox", 22:30:37 INFO - "script_repo_revision": "production", 22:30:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 22:30:37 INFO - "repository": "", 22:30:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 22:30:37 INFO - "buildid": "20170321205435", 22:30:37 INFO - "pgo_build": "False", 22:30:37 INFO - "basedir": "/builds/slave/test", 22:30:37 INFO - "buildnumber": 1, 22:30:37 INFO - "slavename": "t-yosemite-r7-0389", 22:30:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:30:37 INFO - "platform": "yosemite_r7", 22:30:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 22:30:37 INFO - "branch": "mozilla-aurora", 22:30:37 INFO - "repo_path": "releases/mozilla-aurora", 22:30:37 INFO - "revision": "9ac2fe545f73719d862d85d87764f7728bb34cfc", 22:30:37 INFO - "stage_platform": "macosx64", 22:30:37 INFO - "builduid": "af339c5cc49f4134aa8a9a913df4bede", 22:30:37 INFO - "slavebuilddir": "test" 22:30:37 INFO - } 22:30:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 22:30:37 INFO - Running post-action listener: _resource_record_post_action 22:30:37 INFO - [mozharness: 2017-03-22 05:30:37.485279Z] Finished read-buildbot-config step (success) 22:30:37 INFO - [mozharness: 2017-03-22 05:30:37.485434Z] Running download-and-extract step. 22:30:37 INFO - Running pre-action listener: _resource_record_pre_action 22:30:37 INFO - Running main action method: download_and_extract 22:30:37 INFO - mkdir: /builds/slave/test/build/tests 22:30: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')]} 22:30:37 INFO - trying https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 22:30:37 INFO - Downloading https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 22:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 22:30:38 INFO - Downloaded 1199 bytes. 22:30:38 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 22:30:38 INFO - Using the following test package requirements: 22:30:38 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 22:30:38 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 22:30:38 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 22:30:38 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'jsshell-mac.zip'], 22:30:38 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 22:30:38 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 22:30:38 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 22:30:38 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 22:30:38 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 22:30:38 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 22:30:38 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 22:30:38 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 22:30:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 22:30:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:30:38 INFO - Fetch https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 22:30:40 INFO - Expected file size: 51785221 22:30:40 INFO - Obtained file size: 51785221 22:30:56 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 22:30:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 22:30:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:30:56 INFO - Fetch https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 22:30:58 INFO - Expected file size: 51785221 22:30:58 INFO - Obtained file size: 51785221 22:31:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 22:31:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 22:31:14 INFO - Fetch https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 22:31:15 INFO - Expected file size: 14404438 22:31:15 INFO - Obtained file size: 14404438 22:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:31:15 INFO - trying https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 22:31:15 INFO - Downloading https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 22:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 22:31:17 INFO - Downloaded 74693305 bytes. 22:31:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 22:31:17 INFO - mkdir: /builds/slave/test/properties 22:31:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:31:17 INFO - Writing to file /builds/slave/test/properties/build_url 22:31:17 INFO - Contents: 22:31:17 INFO - build_url:https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 22:31:18 INFO - Running post-action listener: _resource_record_post_action 22:31:18 INFO - Running post-action listener: set_extra_try_arguments 22:31:18 INFO - [mozharness: 2017-03-22 05:31:18.387761Z] Finished download-and-extract step (success) 22:31:18 INFO - [mozharness: 2017-03-22 05:31:18.387893Z] Running populate-webroot step. 22:31:18 INFO - Running pre-action listener: _resource_record_pre_action 22:31:18 INFO - Running main action method: populate_webroot 22:31:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:31:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:31:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:31:18 INFO - '--tppagecycles', 22:31:18 INFO - '7'], 22:31:18 INFO - 'tests': ['tsvgm']}}, 22:31:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:31:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:31:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:31:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:31:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:31:18 INFO - 'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:31:18 INFO - 'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['damp', 'tps']}, 22:31:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:31:18 INFO - 'tests': ['damp', 'tps']}, 22:31:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['dromaeo_dom']}, 22:31:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:31:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['basic_compositor_video']}, 22:31:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:31:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['a11yr', 22:31:18 INFO - 'ts_paint', 22:31:18 INFO - 'tpaint', 22:31:18 INFO - 'sessionrestore', 22:31:18 INFO - 'sessionrestore_no_auto_restore', 22:31:18 INFO - 'tabpaint']}, 22:31:18 INFO - 'other-e10s': {'tests': ['a11yr', 22:31:18 INFO - 'ts_paint', 22:31:18 INFO - 'tpaint', 22:31:18 INFO - 'sessionrestore', 22:31:18 INFO - 'sessionrestore_no_auto_restore', 22:31:18 INFO - 'tabpaint']}, 22:31:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:31:18 INFO - 'ts_paint', 22:31:18 INFO - 'tpaint', 22:31:18 INFO - 'sessionrestore', 22:31:18 INFO - 'sessionrestore_no_auto_restore', 22:31:18 INFO - 'tabpaint']}, 22:31:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:31:18 INFO - 'ts_paint', 22:31:18 INFO - 'tpaint', 22:31:18 INFO - 'sessionrestore', 22:31:18 INFO - 'sessionrestore_no_auto_restore', 22:31:18 INFO - 'tabpaint']}, 22:31:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['a11yr', 22:31:18 INFO - 'ts_paint', 22:31:18 INFO - 'tpaint', 22:31:18 INFO - 'sessionrestore', 22:31:18 INFO - 'sessionrestore_no_auto_restore', 22:31:18 INFO - 'tabpaint']}, 22:31:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['a11yr', 22:31:18 INFO - 'ts_paint', 22:31:18 INFO - 'tpaint', 22:31:18 INFO - 'sessionrestore', 22:31:18 INFO - 'sessionrestore_no_auto_restore', 22:31:18 INFO - 'tabpaint']}, 22:31:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['tsvgx', 22:31:18 INFO - 'tsvgr_opacity', 22:31:18 INFO - 'tart', 22:31:18 INFO - 'tscrollx', 22:31:18 INFO - 'cart', 22:31:18 INFO - 'tsvg_static']}, 22:31:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:31:18 INFO - 'tsvgr_opacity', 22:31:18 INFO - 'tart', 22:31:18 INFO - 'tscrollx', 22:31:18 INFO - 'cart', 22:31:18 INFO - 'tsvg_static']}, 22:31:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:31:18 INFO - 'talos_options': ['--disable-e10s'], 22:31:18 INFO - 'tests': ['tp5o']}, 22:31:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:31:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:31:18 INFO - 'talos_options': ['--disable-e10s', 22:31:18 INFO - '--xperf_path', 22:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:18 INFO - 'tests': ['tp5n']}, 22:31:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:31:18 INFO - 'talos_options': ['--xperf_path', 22:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:18 INFO - 'tests': ['tp5n']}}, 22:31:18 INFO - 'talos.zip': {'path': '', 22:31:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:31:18 INFO - Running post-action listener: _resource_record_post_action 22:31:18 INFO - [mozharness: 2017-03-22 05:31:18.406724Z] Finished populate-webroot step (success) 22:31:18 INFO - [mozharness: 2017-03-22 05:31:18.406836Z] Running create-virtualenv step. 22:31:18 INFO - Running pre-action listener: _resource_record_pre_action 22:31:18 INFO - Running main action method: create_virtualenv 22:31:18 INFO - Creating virtualenv /builds/slave/test/build/venv 22:31:18 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 22:31:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:31:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:31:18 INFO - Using real prefix '/tools/python27' 22:31:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:31:19 INFO - Installing distribute.............................................................................................................................................................................................done. 22:31:22 INFO - Installing pip.................done. 22:31:22 INFO - Return code: 0 22:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:31:22 INFO - Reading from file tmpfile_stdout 22:31:22 INFO - Output received: 22:31:22 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) 22:31:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:31:22 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')]} 22:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:22 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')]} 22:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:22 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:22 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 22:31:22 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 22:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:22 INFO - 'HOME': '/Users/cltbld', 22:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:22 INFO - 'LOGNAME': 'cltbld', 22:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:22 INFO - 'MOZ_NO_REMOTE': '1', 22:31:22 INFO - 'NO_EM_RESTART': '1', 22:31:22 INFO - 'PAGER': '/bin/cat', 22:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:22 INFO - 'PWD': '/builds/slave/test', 22:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:22 INFO - 'SHELL': '/bin/bash', 22:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:22 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:22 INFO - 'USER': 'cltbld', 22:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:22 INFO - 'XPC_FLAGS': '0x0', 22:31:22 INFO - 'XPC_SERVICE_NAME': '0', 22:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:22 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 22:31:22 INFO - Cleaning up... 22:31:22 INFO - Return code: 0 22:31:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:31:22 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')]} 22:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:22 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')]} 22:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:22 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:22 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 22:31:22 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 22:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:22 INFO - 'HOME': '/Users/cltbld', 22:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:22 INFO - 'LOGNAME': 'cltbld', 22:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:22 INFO - 'MOZ_NO_REMOTE': '1', 22:31:22 INFO - 'NO_EM_RESTART': '1', 22:31:22 INFO - 'PAGER': '/bin/cat', 22:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:22 INFO - 'PWD': '/builds/slave/test', 22:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:22 INFO - 'SHELL': '/bin/bash', 22:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:22 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:22 INFO - 'USER': 'cltbld', 22:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:22 INFO - 'XPC_FLAGS': '0x0', 22:31:22 INFO - 'XPC_SERVICE_NAME': '0', 22:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:22 INFO - Downloading/unpacking psutil>=3.1.1 22:31:22 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 22:31:22 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 22:31:22 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 22:31:22 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 22:31:22 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 22:31:22 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 22:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:31:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:31:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:31:26 INFO - Installing collected packages: psutil 22:31:26 INFO - Running setup.py install for psutil 22:31:26 INFO - building 'psutil._psutil_osx' extension 22:31:26 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 22:31:27 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 22:31:27 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 22:31:27 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 22:31:27 INFO - building 'psutil._psutil_posix' extension 22:31:27 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 22:31:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:31:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:31:27 INFO - ^ 22:31:27 INFO - 1 warning generated. 22:31:27 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 22:31:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:31:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:31:27 INFO - Successfully installed psutil 22:31:27 INFO - Cleaning up... 22:31:27 INFO - Return code: 0 22:31:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:28 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:28 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 22:31:28 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 22:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:28 INFO - 'HOME': '/Users/cltbld', 22:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:28 INFO - 'LOGNAME': 'cltbld', 22:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:28 INFO - 'MOZ_NO_REMOTE': '1', 22:31:28 INFO - 'NO_EM_RESTART': '1', 22:31:28 INFO - 'PAGER': '/bin/cat', 22:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:28 INFO - 'PWD': '/builds/slave/test', 22:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:28 INFO - 'SHELL': '/bin/bash', 22:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:28 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:28 INFO - 'USER': 'cltbld', 22:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:28 INFO - 'XPC_FLAGS': '0x0', 22:31:28 INFO - 'XPC_SERVICE_NAME': '0', 22:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:31:28 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 22:31:28 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 22:31:28 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 22:31:28 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 22:31:28 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 22:31:28 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 22:31:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:31:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:31:31 INFO - Installing collected packages: mozsystemmonitor 22:31:31 INFO - Running setup.py install for mozsystemmonitor 22:31:31 INFO - Successfully installed mozsystemmonitor 22:31:31 INFO - Cleaning up... 22:31:32 INFO - Return code: 0 22:31:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:31:32 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')]} 22:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:32 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')]} 22:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:32 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:32 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 22:31:32 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 22:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:32 INFO - 'HOME': '/Users/cltbld', 22:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:32 INFO - 'LOGNAME': 'cltbld', 22:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:32 INFO - 'MOZ_NO_REMOTE': '1', 22:31:32 INFO - 'NO_EM_RESTART': '1', 22:31:32 INFO - 'PAGER': '/bin/cat', 22:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:32 INFO - 'PWD': '/builds/slave/test', 22:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:32 INFO - 'SHELL': '/bin/bash', 22:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:32 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:32 INFO - 'USER': 'cltbld', 22:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:32 INFO - 'XPC_FLAGS': '0x0', 22:31:32 INFO - 'XPC_SERVICE_NAME': '0', 22:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:32 INFO - Downloading/unpacking jsonschema==2.5.1 22:31:32 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 22:31:32 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 22:31:32 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 22:31:32 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 22:31:32 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 22:31:32 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 22:31:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:31:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:31:35 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 22:31:35 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 22:31:35 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 22:31:35 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 22:31:35 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 22:31:35 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 22:31:35 INFO - Downloading functools32-3.2.3-2.tar.gz 22:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:31:35 INFO - warning: no files found matching '*.txt' 22:31:35 INFO - no previously-included directories found matching 'build' 22:31:35 INFO - no previously-included directories found matching 'dist' 22:31:35 INFO - no previously-included directories found matching '.git*' 22:31:35 INFO - Installing collected packages: jsonschema, functools32 22:31:35 INFO - Running setup.py install for functools32 22:31:35 INFO - warning: no files found matching '*.txt' 22:31:35 INFO - no previously-included directories found matching 'build' 22:31:35 INFO - no previously-included directories found matching 'dist' 22:31:35 INFO - no previously-included directories found matching '.git*' 22:31:36 INFO - Successfully installed jsonschema functools32 22:31:36 INFO - Cleaning up... 22:31:36 INFO - Return code: 0 22:31:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:36 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:36 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 22:31:36 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 22:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:36 INFO - 'HOME': '/Users/cltbld', 22:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:36 INFO - 'LOGNAME': 'cltbld', 22:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:36 INFO - 'MOZ_NO_REMOTE': '1', 22:31:36 INFO - 'NO_EM_RESTART': '1', 22:31:36 INFO - 'PAGER': '/bin/cat', 22:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:36 INFO - 'PWD': '/builds/slave/test', 22:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:36 INFO - 'SHELL': '/bin/bash', 22:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:36 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:36 INFO - 'USER': 'cltbld', 22:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:36 INFO - 'XPC_FLAGS': '0x0', 22:31:36 INFO - 'XPC_SERVICE_NAME': '0', 22:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:31:36 INFO - Cleaning up... 22:31:36 INFO - Return code: 0 22:31:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:36 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:36 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 22:31:36 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 22:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:36 INFO - 'HOME': '/Users/cltbld', 22:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:36 INFO - 'LOGNAME': 'cltbld', 22:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:36 INFO - 'MOZ_NO_REMOTE': '1', 22:31:36 INFO - 'NO_EM_RESTART': '1', 22:31:36 INFO - 'PAGER': '/bin/cat', 22:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:36 INFO - 'PWD': '/builds/slave/test', 22:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:36 INFO - 'SHELL': '/bin/bash', 22:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:36 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:36 INFO - 'USER': 'cltbld', 22:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:36 INFO - 'XPC_FLAGS': '0x0', 22:31:36 INFO - 'XPC_SERVICE_NAME': '0', 22:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:36 INFO - Downloading/unpacking blobuploader==1.2.4 22:31:36 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 22:31:36 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 22:31:36 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 22:31:36 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 22:31:36 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 22:31:36 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 22:31:39 INFO - Downloading blobuploader-1.2.4.tar.gz 22:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:31:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:31:39 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 22:31:39 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 22:31:39 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 22:31:39 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 22:31:39 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 22:31:39 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 22:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:31:39 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 22:31:39 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 22:31:39 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 22:31:39 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 22:31:39 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 22:31:39 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 22:31:40 INFO - Downloading docopt-0.6.1.tar.gz 22:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:31:40 INFO - Installing collected packages: blobuploader, requests, docopt 22:31:40 INFO - Running setup.py install for blobuploader 22:31:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:31:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:31:40 INFO - Running setup.py install for requests 22:31:41 INFO - Running setup.py install for docopt 22:31:41 INFO - Successfully installed blobuploader requests docopt 22:31:41 INFO - Cleaning up... 22:31:41 INFO - Return code: 0 22:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:41 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')]} 22:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:41 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')]} 22:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:41 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:41 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 22:31:41 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 22:31:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:41 INFO - 'HOME': '/Users/cltbld', 22:31:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:41 INFO - 'LOGNAME': 'cltbld', 22:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:41 INFO - 'MOZ_NO_REMOTE': '1', 22:31:41 INFO - 'NO_EM_RESTART': '1', 22:31:41 INFO - 'PAGER': '/bin/cat', 22:31:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:41 INFO - 'PWD': '/builds/slave/test', 22:31:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:41 INFO - 'SHELL': '/bin/bash', 22:31:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:41 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:41 INFO - 'USER': 'cltbld', 22:31:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:41 INFO - 'XPC_FLAGS': '0x0', 22:31:41 INFO - 'XPC_SERVICE_NAME': '0', 22:31:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:41 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Oy22g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:41 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-n3iGm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:41 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-44tuLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-t34yCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-nx1EDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-UpQkMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-W7SHwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-LOnzN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-dgCRKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-FIMfKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-jUYfOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-kjX1ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:42 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Vd5ao3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:43 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Sgc4k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:43 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-r8_oKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:43 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-QgTa24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:43 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ze6hSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:31:43 INFO - Running setup.py install for manifestparser 22:31:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:31:43 INFO - Running setup.py install for mozcrash 22:31:43 INFO - Running setup.py install for mozdebug 22:31:43 INFO - Running setup.py install for mozdevice 22:31:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Running setup.py install for mozfile 22:31:44 INFO - Running setup.py install for mozhttpd 22:31:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Running setup.py install for mozinfo 22:31:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Running setup.py install for mozInstall 22:31:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Running setup.py install for mozleak 22:31:44 INFO - Running setup.py install for mozlog 22:31:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:31:44 INFO - Running setup.py install for moznetwork 22:31:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:31:45 INFO - Running setup.py install for mozprocess 22:31:45 INFO - Running setup.py install for mozprofile 22:31:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:31:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:31:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:31:45 INFO - Running setup.py install for mozrunner 22:31:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:31:45 INFO - Running setup.py install for mozscreenshot 22:31:45 INFO - Running setup.py install for moztest 22:31:45 INFO - Running setup.py install for mozversion 22:31:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:31:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:31:46 INFO - Cleaning up... 22:31:46 INFO - Return code: 0 22:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:46 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:46 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 22:31:46 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 22:31:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:46 INFO - 'HOME': '/Users/cltbld', 22:31:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:46 INFO - 'LOGNAME': 'cltbld', 22:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:46 INFO - 'MOZ_NO_REMOTE': '1', 22:31:46 INFO - 'NO_EM_RESTART': '1', 22:31:46 INFO - 'PAGER': '/bin/cat', 22:31:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:46 INFO - 'PWD': '/builds/slave/test', 22:31:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:46 INFO - 'SHELL': '/bin/bash', 22:31:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:46 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:46 INFO - 'USER': 'cltbld', 22:31:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:46 INFO - 'XPC_FLAGS': '0x0', 22:31:46 INFO - 'XPC_SERVICE_NAME': '0', 22:31:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:46 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-wZuvwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:46 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)) 22:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:46 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ijIL_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:46 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)) 22:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:46 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-QQ4kV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:46 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)) 22:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:46 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-TWJ768-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:46 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-4NOzYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:46 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)) 22:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:46 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-vSvLKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:46 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)) 22:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:46 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-WPKOIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Ii4_YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-i3NYzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-T7bPCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-g_9bNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ITkMPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-yvMrN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-OGxBJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-q2mFMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:47 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)) 22:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:47 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-kfN9m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:48 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)) 22:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:48 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-jTmPV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 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)) 22:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:31:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:31:50 INFO - Downloading blessings-1.6.tar.gz 22:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:31:50 INFO - Installing collected packages: blessings 22:31:50 INFO - Running setup.py install for blessings 22:31:51 INFO - Successfully installed blessings 22:31:51 INFO - Cleaning up... 22:31:51 INFO - Return code: 0 22:31:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:51 INFO - Reading from file tmpfile_stdout 22:31:51 INFO - Current package versions: 22:31:51 INFO - blessings == 1.6 22:31:51 INFO - blobuploader == 1.2.4 22:31:51 INFO - docopt == 0.6.1 22:31:51 INFO - functools32 == 3.2.3-2 22:31:51 INFO - jsonschema == 2.5.1 22:31:51 INFO - manifestparser == 1.1 22:31:51 INFO - mozInstall == 1.12 22:31:51 INFO - mozcrash == 1.0 22:31:51 INFO - mozdebug == 0.1 22:31:51 INFO - mozdevice == 0.49 22:31:51 INFO - mozfile == 1.2 22:31:51 INFO - mozhttpd == 0.7 22:31:51 INFO - mozinfo == 0.9 22:31:51 INFO - mozleak == 0.1 22:31:51 INFO - mozlog == 3.4 22:31:51 INFO - moznetwork == 0.27 22:31:51 INFO - mozprocess == 0.25 22:31:51 INFO - mozprofile == 0.28 22:31:51 INFO - mozrunner == 6.13 22:31:51 INFO - mozscreenshot == 0.1 22:31:51 INFO - mozsystemmonitor == 0.3 22:31:51 INFO - moztest == 0.8 22:31:51 INFO - mozversion == 1.4 22:31:51 INFO - psutil == 3.1.1 22:31:51 INFO - requests == 1.2.3 22:31:51 INFO - wsgiref == 0.1.2 22:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:51 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 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:51 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 22:31:51 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 22:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:51 INFO - 'HOME': '/Users/cltbld', 22:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:51 INFO - 'LOGNAME': 'cltbld', 22:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:51 INFO - 'MOZ_NO_REMOTE': '1', 22:31:51 INFO - 'NO_EM_RESTART': '1', 22:31:51 INFO - 'PAGER': '/bin/cat', 22:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:51 INFO - 'PWD': '/builds/slave/test', 22:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:51 INFO - 'SHELL': '/bin/bash', 22:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:51 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:51 INFO - 'USER': 'cltbld', 22:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:51 INFO - 'XPC_FLAGS': '0x0', 22:31:51 INFO - 'XPC_SERVICE_NAME': '0', 22:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 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)) 22:31:51 INFO - Cleaning up... 22:31:51 INFO - Return code: 0 22:31:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ad8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101adb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcc35a4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, '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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 22:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:31:51 INFO - 'HOME': '/Users/cltbld', 22:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:31:51 INFO - 'LOGNAME': 'cltbld', 22:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:51 INFO - 'MOZ_NO_REMOTE': '1', 22:31:51 INFO - 'NO_EM_RESTART': '1', 22:31:51 INFO - 'PAGER': '/bin/cat', 22:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:51 INFO - 'PWD': '/builds/slave/test', 22:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:31:51 INFO - 'SHELL': '/bin/bash', 22:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:31:51 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:31:51 INFO - 'USER': 'cltbld', 22:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:51 INFO - 'XPC_FLAGS': '0x0', 22:31:51 INFO - 'XPC_SERVICE_NAME': '0', 22:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:31:51 INFO - Cleaning up... 22:31:51 INFO - Return code: 0 22:31:51 INFO - Running post-action listener: _resource_record_post_action 22:31:51 INFO - Running post-action listener: _start_resource_monitoring 22:31:51 INFO - Starting resource monitoring. 22:31:51 INFO - [mozharness: 2017-03-22 05:31:51.955099Z] Finished create-virtualenv step (success) 22:31:51 INFO - [mozharness: 2017-03-22 05:31:51.956119Z] Running install step. 22:31:51 INFO - Running pre-action listener: _resource_record_pre_action 22:31:51 INFO - Running main action method: install 22:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:52 INFO - Reading from file tmpfile_stdout 22:31:52 INFO - Detecting whether we're running mozinstall >=1.0... 22:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:31:52 INFO - Reading from file tmpfile_stdout 22:31:52 INFO - Output received: 22:31:52 INFO - Usage: mozinstall [options] installer 22:31:52 INFO - Options: 22:31:52 INFO - -h, --help show this help message and exit 22:31:52 INFO - -d DEST, --destination=DEST 22:31:52 INFO - Directory to install application into. [default: 22:31:52 INFO - "/builds/slave/test"] 22:31:52 INFO - --app=APP Application being installed. [default: firefox] 22:31:52 INFO - mkdir: /builds/slave/test/build/application 22:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 22:32:12 INFO - Reading from file tmpfile_stdout 22:32:12 INFO - Output received: 22:32:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 22:32:12 INFO - Running post-action listener: _resource_record_post_action 22:32:12 INFO - [mozharness: 2017-03-22 05:32:12.776305Z] Finished install step (success) 22:32:12 INFO - [mozharness: 2017-03-22 05:32:12.776459Z] Running run-tests step. 22:32:12 INFO - Running pre-action listener: _resource_record_pre_action 22:32:12 INFO - Running main action method: run_tests 22:32:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:32:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:32:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:32:12 INFO - 2017-03-21 22:32:12.790 screenresolution[82554:792186] starting screenresolution argv=screenresolution get 22:32:12 INFO - 2017-03-21 22:32:12.792 screenresolution[82554:792186] Display 0: 1600x1200x32@60 22:32:12 INFO - 2017-03-21 22:32:12.798 screenresolution[82555:792188] starting screenresolution argv=screenresolution list 22:32:12 INFO - Available Modes on Display 0 22:32:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:32:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:32:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:32:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:32:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:32:13 INFO - Intel Iris: 22:32:13 INFO - Chipset Model: Intel Iris 22:32:13 INFO - Type: GPU 22:32:13 INFO - Bus: Built-In 22:32:13 INFO - VRAM (Dynamic, Max): 1536 MB 22:32:13 INFO - Vendor: Intel (0x8086) 22:32:13 INFO - Device ID: 0x0a2e 22:32:13 INFO - Revision ID: 0x0009 22:32:13 INFO - Displays: 22:32:13 INFO - Display: 22:32:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:32:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:32:13 INFO - Display Serial Number: 1600x1200 60 22:32:13 INFO - Main Display: Yes 22:32:13 INFO - Mirror: Off 22:32:13 INFO - Online: Yes 22:32:13 INFO - Rotation: Supported 22:32:13 INFO - Return code: 0 22:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:32:13 INFO - Python 2.7.3 22:32:13 INFO - Return code: 0 22:32:13 INFO - grabbing minidump binary from tooltool 22:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:13 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 0x1018b6d30>, '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 0x1017dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018abbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:32:13 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 22:32:13 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 22:32:13 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 22:32:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:32:13 INFO - Return code: 0 22:32:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:32:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:32:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:32:13 INFO - ENV: RUST_BACKTRACE is now 1 22:32:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:32:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--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 22:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0389 --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 22:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hGQ1UzYKQH/Render', 22:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:32:13 INFO - 'HOME': '/Users/cltbld', 22:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:32:13 INFO - 'LOGNAME': 'cltbld', 22:32:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:32:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:13 INFO - 'MOZ_NO_REMOTE': '1', 22:32:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:32:13 INFO - 'NO_EM_RESTART': '1', 22:32:13 INFO - 'PAGER': '/bin/cat', 22:32:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:13 INFO - 'PWD': '/builds/slave/test', 22:32:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:32:13 INFO - 'RUST_BACKTRACE': '1', 22:32:13 INFO - 'SHELL': '/bin/bash', 22:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7FZerCnRPB/Listeners', 22:32:13 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 22:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:32:13 INFO - 'USER': 'cltbld', 22:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:13 INFO - 'XPC_FLAGS': '0x0', 22:32:13 INFO - 'XPC_SERVICE_NAME': '0', 22:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:32:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--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 22:32:13 INFO - mozversion application_buildid: 20170321205435 22:32:13 INFO - mozversion application_changeset: 9ac2fe545f73719d862d85d87764f7728bb34cfc 22:32:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:32:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:32:13 INFO - mozversion application_name: Firefox 22:32:13 INFO - mozversion application_remotingname: firefox-dev 22:32:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:32:13 INFO - mozversion application_vendor: Mozilla 22:32:13 INFO - mozversion application_version: 54.0a2 22:32:13 INFO - mozversion platform_buildid: 20170321205435 22:32:13 INFO - mozversion platform_changeset: 9ac2fe545f73719d862d85d87764f7728bb34cfc 22:32:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:32:13 INFO - mozversion platform_version: 54.0a2 22:32:13 INFO - using testdate: 1490160733 22:32:13 INFO - actual date: 1490160733 22:32:13 INFO - starting webserver on 'localhost:59814' 22:32:13 INFO - SUITE-START | Running 2 tests 22:32:13 INFO - TEST-START | dromaeo_css 22:32:13 INFO - operating with platform_type : mac_ 22:32:13 INFO - Initialising browser for dromaeo_css test... 22:32:13 INFO - TEST-INFO | started process 82565 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmp7DS0jd/profile http://localhost:59814/getInfo.html) 22:32:16 INFO - PROCESS | 82565 | __metrics Screen width/height:1600/1200 22:32:16 INFO - PROCESS | 82565 | colorDepth:24 22:32:16 INFO - PROCESS | 82565 | Browser inner width/height: 1024/689 22:32:16 INFO - PROCESS | 82565 | __metrics 22:32:16 INFO - PROCESS | 82565 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:32:16 INFO - PROCESS | 82565 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:32:16 INFO - TEST-INFO | 82565: exit 0 22:32:16 INFO - Browser initialized. 22:32:16 INFO - Running cycle 1/1 for dromaeo_css test... 22:32:16 INFO - TEST-INFO | started process 82567 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmp7DS0jd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:29 INFO - PROCESS | 82567 | RSS: Main: 214839296 22:32:29 INFO - PROCESS | 82567 | 22:35:33 INFO - PROCESS | 82567 | Cycle 1(1): loaded http://localhost:59814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59814/tests/dromaeo/cssquery-ext.html) 22:35:35 INFO - PROCESS | 82567 | RSS: Main: 375361536 22:35:35 INFO - PROCESS | 82567 | 22:37:18 INFO - PROCESS | 82567 | ************************* 22:37:18 INFO - PROCESS | 82567 | A coding exception was thrown and uncaught in a Task. 22:37:18 INFO - PROCESS | 82567 | 22:37:18 ERROR - PROCESS | 82567 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:37:18 INFO - PROCESS | 82567 | Full stack: 22:37:18 INFO - PROCESS | 82567 | ************************* 22:38:38 INFO - PROCESS | 82567 | Cycle 1(1): loaded http://localhost:59814/tests/dromaeo/cssquery-ext.html (next: http://localhost:59814/tests/dromaeo/cssquery-jquery.html) 22:38:39 INFO - PROCESS | 82567 | RSS: Main: 352468992 22:38:39 INFO - PROCESS | 82567 | 22:41:41 INFO - PROCESS | 82567 | Cycle 1(1): loaded http://localhost:59814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59814/tests/dromaeo/cssquery-mootools.html) 22:41:42 INFO - PROCESS | 82567 | RSS: Main: 321298432 22:41:42 INFO - PROCESS | 82567 | 22:44:44 INFO - PROCESS | 82567 | Cycle 1(1): loaded http://localhost:59814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59814/tests/dromaeo/cssquery-prototype.html) 22:44:45 INFO - PROCESS | 82567 | RSS: Main: 314814464 22:44:45 INFO - PROCESS | 82567 | 22:47:48 INFO - PROCESS | 82567 | Cycle 1(1): loaded http://localhost:59814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59814/tests/dromaeo/cssquery-yui.html) 22:47:49 INFO - PROCESS | 82567 | RSS: Main: 323403776 22:47:49 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | Cycle 1(1): loaded http://localhost:59814/tests/dromaeo/cssquery-yui.html (next: http://localhost:59814/tests/dromaeo/cssquery-dojo.html) 22:50:53 INFO - PROCESS | 82567 | RSS: Main: 476950528 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | __start_tp_report 22:50:53 INFO - PROCESS | 82567 | _x_x_mozilla_page_load 22:50:53 INFO - PROCESS | 82567 | _x_x_mozilla_page_load_details 22:50:53 INFO - PROCESS | 82567 | |i|pagename|runs| 22:50:53 INFO - PROCESS | 82567 | |0;dojo.html;3317.452620317648;3317.651646577108;3354.09439451348;3364.2262279675674;3389.084947064292;6051.546134039942;6055.848603784908;6059.969700151499;6063.757449702007;6079.9392006079925;4838.975805120978;6096.573239873211;6115.938840611592;6116.816495505131;6139.570230083896;5403.243545903567;5431;5462.0441422751055;5495.780168793243;5535.612507124503;4389;5334.413214546396;5334.91997620036;5389.029974604569;5550.583706222029;5464.4262352453015;5477.0415177344;5490.56075513958;5491.423400542945;5507;5494.890102197974;5505.394406615269;5507.228987941691;5521.116621340566;5525.143602741581;5264.631475796696;5289.788408463695;5362.865928351823;5447.700376479332;5462.617616766828;5864.6187997780435;5894.793682221145;5911.704414779287;5929.495992840613;5936.109583562457;5928.318243402021;6145.446909778141;6366.236051673829;6392.041193820917;6428.164338635994;6485.448736857373;6523.315051919575;6531;6538.0519824625635;6545.443637290836;5901;5905.173275741399;6077.270727512727;6188.350223226586;6192.256929168483;6451.677416129175;6454.709538070798;6454.903176452357;6456.709448074848;6472.805815825533;6208.689565521796;6229.657368844757;6252.624842509464;6254.530910181664;6261.592996455307;6456.967715161488;6464.644444555594;6483.157189565326;6502.804915852532;6503.7073331700185;6211.192544969125;6381.585196962183;6393.584417012879;6419.679016049272;6441;6275.748970041147;6292.339304373067;6327.209098862642;6354.110424540568;6395.97664373698;5174.43081261061;5176.689398636094;5180.352455943007;5180.585553155738;5202.739863006835;4556.997460558672;4559.202139625552;4566.771661416916;4571.885702857388;4589.58693717567;5728.684922329312;5785.074388097884;5836.416358364215;5847.181394604759;6119.357467465941;6252.781152659635;6259.3427690091885;6278.089676996809;6279.623222606659;6298.464630506367;5844.503217226584;5861.824145275648;5862.8534286642325;5866.120081987736;5867.765289388462;5514.724263786875;5526.972365138148;5583.944160558342;5651.689157096317;5726.885462290731;6701.966490167518;6730.596164230162;6731.562448440934;6733.091032710521;6734.629595372302;6467.029945508023;6467.514936379696;6484.902726459201;6505.186851643544;6509.902351464826;6422.133012043501;6467.902981455376;6484.254310754135;6727.461803055646;6728.125343705287;6246.6876656166105;6348.650824204713;6357.554971151975;6385.840353991188;6388.4569811566535;6259.311475737574;6454.805860915746;6457;6488.70800813974;6507.934920650733;6130.489860652556;6232.376762323732;6250.093736408105;6252.124702541557;6256.937430625636;6111;6195.4424101831055;6239.064140378798;6246.437820596168;6258.906116408349;6233.158523599437;6240.157578726814;6242.875142497034;6246.063090536456;6253.468455181179;6161.969190154021;6186.041163619646;6247.375262473898;6268.592541484789;6287.654179020198;6006.81979540597;6041.486473649789;6108.755649774137;6155.9842625968;6186.536009799193 22:50:53 INFO - PROCESS | 82567 | |1;ext.html;746.4625469661845;787.4212453846424;808.6805711743862;876.1370050500257;888.0719647967873;28370;28740.568891466617;29338;29408.41183176335;40577.797111014406;41511.792441037825;41757.37363939543;41782;41791.37312940308;41801.58198418015;9230.030846761094;9316.114969077928;9415.764605884873;9416.058394160564;9427.764305892339;7357.632118394085;7533.28433798791;7817.648205830751;9394.577244024002;9399.389039712396;7517;7541.472096953215;7555.3955683545455;7567.167611562723;10991.395473248967;11127.777444451107;11142.387168705718;11173.776524469506;11173.888261117367;11183.04944079746;10845;10897.509612067475;10909.127269818395;10912.345259284468;10921.672349829518;27984.580231296546;28350.007749728662;38759.8372048839;39042.60957390447;39057.023574410865;3780.9810950945343;3852.9614703852885;3879.35990561557;3896.5518965319066;3899.0642245861072;23524.411889702722;26011.349716257057;26355;27057.917683292842;28614.427711445656;3085.537169424582;3097.4269760094453;3197.488401855692;3229.1119942016135;3272.754543409254;364377;364636;364959;365362;366483.9999999973;53064.14275500339;53068.20397694038;53084.40746777603;53175;53219.46780532145;55242.44757552373;55264;55270.44729552734;55317.170242446395;55354;12074.27554346742;14661.900357473232;14797.63005924839;14802.555923322318;14833.184174870486;12657.177283476729;12668.556600519121;12682.746345073047;12685.556005539946;12701;9553.808923821485;12347.38263086842;12375;12417.875821241852;12476.313802740755;4794.328793968847;4898.828541001048;5398.811041613525;5443.891122177534;5485.725713714378;1085.61583980424;1106.3472551194673;1151.3552410650063;1202.320688810819;1217.7747116783423;26763.464730705666;26902.880601030265;26983.325416864736;27318.5902211467;27416.725832741817;1087.2986923434341;1214.6963259185204;1221.945012474423;1260.0927332320714;1307.0654482045384;11528.423578821026;13931.303434828218;14172.362243699059;14200.218987955555;14235.359408826627;440442;446510;446786;447213;447737;57406;57409.42590574124;57620.71189644025;57680.423195768344;57806.421935780105;1428.7071150414347;1468.8898332624883;1471.1099784630144;1472.374240947593;1476.6898951220364;24860;25692;26318.21045368642;26369.4726105473;26469;33258.50112248366;43027.12755851988;43312.70061898148;43359.34960975651;43364.69905902828;429272;429665;429679.85160074;430421;430864;34248.97253082412;34361.82819085989;34786.478202826474;34917.47623785696;34944.82527587448;43173.56826431696;44051.33922991222;44143.77928110339;44216.55783442253;44238.557614423444;34002.65997339995;35852.64147358493;36459.90620281396;36749.42754007194;38042.80978595089;35498.11254718652;35530.467042993856;36427.81786091052;36433.453498198076;36729;35124.12189695278;35607.82196089003;36504;36576.63423365732;36715.81642091773;29384.55923161197;30075.849620751756;30406.391872161992;31931;32255.032349029567;23665;23738.643920340863;23968.76031239665;24223.878880605484;24236.030558778155 22:50:53 INFO - PROCESS | 82567 | |2;jquery.html;363.02708740575247;400.9358502639578;403.43720509888703;422.3200646958396;447.76939875963865;11413.216522099898;20115.698264526025;20877.47806304843;21072.473188170305;21327.93360331985;21121.57756844866;21999.450013749665;22556.8872155639;22722.31833045007;23053;5876.44173803488;6603.405693487585;6609.471242300604;6766.15423072116;6880.2431732509385;6667.166604174478;6803.625800580966;6804.591724496546;6805.387515123638;6812.931870681304;6506.349365063503;6702.36327548882;6793.864122717543;6794.728210871559;6804.761833335834;6754;6808.183018037817;6826.795196144124;6832.829179270509;7092.397146242575;7228.132624085091;7317.853642927112;7318.414526837893;7333.266673332678;7333.523320984173;25781;26305.07932222382;26470.676466176807;26489;26777.46445071107;2933.7506311963507;2959.319356548006;2963.111066680009;2963.28881068542;3007.5413424489107;15658.608534786608;16049.35802567896;16193.595160120973;16299.51101466946;17054.062026588534;1822.1618055694396;1905.83743916211;1965.3809050149157;1979.9307024254083;2000.0199902048037;151505.24247378693;153642;162893;163678.726425472;166099;15023.924880375529;17994.460166194775;18910.432687019413;19539.413817585497;19734.30929917446;30931.69068309333;31535.684643153734;31570.526442103386;31779.364412711617;32088.83955580207;7062.364387205176;9313.556398758203;10344.482775861177;10351.430671312999;10371.599834022461;8534.658613655385;8729.127087291221;8730.384878797317;8841.955790221136;8853.955730221307;9224.907750922404;9301.302402319852;9428.198603118812;9443.291753118543;9457.19613832832;3209.245827230599;3529.1177205698577;3564.4355644355646;3772.75477093988;3856.8650097246464;887.6759982606302;910.517425764346;911.129870973219;941.764558860285;948.9098535639104;21670.91645417723;22186.667199992015;22353.776462235495;22364.329070127922;22375.881205939637;931.8928323242778;933.3419938943028;937.8499440089553;941.289326558444;953.9570719317647;11046.502907369188;11304.692532580117;11473.024792892531;11613.941930290464;11638.243514171552;737599.3120034365;754775;755202;768583;770296;150893;151987.24006379896;156639;157574;160763.19618402066;1161.815263614715;1177.5466445418404;1208.7642909632536;1218.342095268545;1220.4934951994824;18838;19530.511737206685;19619.803801962367;19674.90162549235;19710.802891970896;50061;63524.68237658782;63643;64709.67645161744;65292.67353663201;82371;84092.57953710192;84177.57911210405;86277;86286;11327.603533876274;11660.766784664429;11675.065994720571;11755.941220293844;12314.568990085305;13368.331583420595;13369.732605348034;13507.459701611826;13774.760271575606;13888.791668125188;11390.487428065922;11478.139139564399;11575.073994080622;11603.825942610698;11693.649190524298;11335.489902954552;11454.969052784956;11530.365829879438;11768.70578235551;11780;11556.479958401724;11591.6522504325;11730.589429369931;11926.880731192578;11950.880491195325;11712.590059347882;11910.225835320676;12001;12162.20945638566;12186;11299.548018079513;11388.804175561447;11732.354720490455;11765.588204412805;12713.36433178356 22:50:53 INFO - PROCESS | 82567 | |3;mootools.html;1404.7708255276632;1539.676667899741;1541.7147827651893;1559.1892216047656;1573.229117732311;10581.047705706485;11184.888151118475;11199.720006999829;11216.607418740346;11233.550657973692;10721.463926803668;10938.671839844797;10945.616903408381;11169.994700476955;11184.32894026359;1997.2310660395779;2419.1532963462823;2423.2851308863837;2425.9029638814427;2426.733059363469;2365.95268094638;2389.880505974703;2400.5798985177526;2402.9639555406684;2405.807535397164;2366.8934897929635;2375.406148462884;2384.344305316043;2392.2823153054014;2398.1126983016306;2328.953420931589;2348.4598542335275;2355.9411014724596;2357.0689577616918;2369.336585755974;2321.8258630602772;2348.459854233519;2376.7979721723673;2383.7616238376195;2387.3554140382175;10849.837252441219;11015.339079655167;11086.722831929186;11104.500297486633;11112.722181945435;5658.292713410824;5842.444967728059;5858.589898707092;5859.29688437386;5867.530597552186;3493.545839040934;3532.4104153131193;3631.364511210528;3655.232401195752;3667.3215455140885;1119.4738472917716;1132.994335028328;1157.6469176901041;1167.8890505402057;1182.0484509969472;13330.400131994083;13607.591772246848;13921.164730116225;15544.76682849758;15785.21073946298;4568.748718820497;4705.106029854317;4751.263554149113;4753.619710423158;4767.69010014348;10354.585816567404;11552.133589980785;11655.941720291345;11658.242214256046;11664.591739289084;4952.529509696573;5593.580481463907;5763.740631671585;5831.154482599999;5852.092925596539;4738.981119059419;4794.9280760788615;5121;5202.739863006835;5216.295800066942;3730.1607138393642;3750.7374483785875;3779.4519794629623;3813.675837553839;3819.8090095495113;1030.9845352319721;1031.3966329697062;1034.5861655337774;1044.368157264859;1046.1212581431635;760.372692528655;915.6285221276925;923.0999775219108;927.1192367251003;953.8521529162991;6383.680815959184;6487.740490380426;6625.271220165778;6655.535782127924;6675.39921407066;946.1437399153639;953.9713808585753;954.3319676226669;985.2216748768393;998.4458625462938;4000.5199376075057;4069.348904175318;4141.7722025288895;4191.392248124005;4210.305299625588;13332.93333533326;13819.170849749047;13852.376643051088;13899.444022238997;13962;12959.352032398343;13430.664233394244;13755.79366309506;13766.449342026408;13803.447862085404;9923.305368624127;10211.438370889673;10212.131968782736;10228.335158214544;10236.232282578836;6436.742530298736;6766.594004359754;6838.2136054352395;6971.721131154697;6988.685509152202;11933.641990740292;12134.75730485403;12354.444050017592;12492.06309526771;12493.312867791996;12818.743625127632;12840.293783841606;12848.421821018264;12927.612171634866;13004.804927926278;8978.506182160045;9328.067193280618;9398.107179817905;9531.094546018117;9601.663941762004;10605.41670208146;10611.840822387516;10681.198910081619;10690.679279621623;10761.677149685522;9237.491937943478;9240.537973101453;9256.72229833106;9291.21024712907;9306;7660.846783064196;9062.864057039282;9133.086691330815;9148.085191480799;9176.587053582738;7739.690412383442;7803.375729941477;7805.843883122419;7938.166492518433;7940.84118317642;5753.165790960371;5788.392218816964;5890.410958904075;5974.462298393166;6013.278406591062;4901.485344038967;5858.238429004202;5874.853128671817;5903.380145084704;6088.178095956989 22:50:53 INFO - PROCESS | 82567 | |4;prototype.html;375.7125798763945;376.745696654758;377.29257641921396;385.1507426125394;386.33164625198407;4509.008018235991;5103.40210151843;5157.4842515748405;5193.818216362428;5196.700095439395;3862.918382852799;4002.5997400259957;4013.3177359848823;4749.715017098976;5025.472325405834;3538.275527843559;4285.700000999931;4319.768865873227;4337.240982828008;4387.758673272985;4087.3664581989838;4345.9348109778375;4381;4402.339649052636;4430.980874398891;3677.963220367802;3915.6867450604027;4026.2350153470748;4339.500957389893;4448.243798554254;3561.626029266916;3660.924823148568;4227.8308867645255;4244.172386384656;4334.978325108385;3386.475096360068;3773.3773927301963;3791.7345785795005;3912.8870409978576;3991.2217117662067;4756.738379389167;4778.737169455679;4786.253017648568;5093.898122037575;5160.56135228506;3533.7349698772437;4159.355299928516;4488.955110448886;4941.481144479814;5010.398752149729;4486.8878278042985;5447.400785913546;5481.917771233435;5483.698396588186;5493.670379777226;4249.787510624487;4356.019895523482;4416.050549131952;4458.929856834369;4476.7090139140855;5460.849754186807;5498.367687715924;5516.889662206733;5864.6187997780435;5936.584439089265;3733.1227161617;3781.9243615128094;3952.3676211805973;4296.131182935433;4453.242948698664;4389.473263208435;4416.757078360657;4707.552782485658;4729.834455794031;4747.359106520576;3981.7212795104065;4530.88672783183;4807.399075115611;4948.356713627278;5083.288339632454;4570.7943142558;5084.51697088776;5457.481539253765;5499.6351568825785;5537.307836520435;1362.4073528015344;1473.6610579566545;1484.6956373943315;1565.4520917678722;1588.7775711400413;1005.6329439754584;1011.3527342500805;1149.9482523286472;1175.9823602645968;1189.3518032672214;4602.355670206174;4829.8178331735435;4890.0903962142465;5017.84946451607;5117.744112794346;5692.345380281238;5710.65736055838;5718.828435146952;5747.183879898819;5766.798162064391;4094.795260237036;4282.066784252735;4800.375951126401;5120.334356533701;5147.794088236428;2406.374342670918;2522.356799016239;2538.669972903511;2609.386794103384;2636;4691.695039822401;5122.769475373542;5185.936882938989;5532.114861622202;5688.914666280009;5000.849974500771;5127.3847138343635;5531.197976293495;5536.560494271438;5598.5723640471415;5774.422557744192;5775.015239484742;5819.912701309569;5820.563457740686;5862.208601838697;4902.779374928065;5085.923711144262;5498.917516237179;5534.972325138348;5689.402612725604;4579.610733087725;4599.4710608280475;5595.804146854841;5623.662580245198;5669.3480249770155;5278.287431196893;5445.809396671098;5623.625824505264;5624.85937851557;5837.970810145922;4004.7196696230985;4196.748195108304;4326.524082350876;4627.583517483443;4661.578218643346;5651.6043876928225;5680.403557626555;5708;5708.914366284426;5757.092668202531;5123.770295129217;5149.098907691214;5364.865878353073;5510.972445137749;5587.424048608812;4776.23580227162;5182.53357197854;5202.505761952609;5441.972790136024;5514.36584792754;4595.540445955377;5377.343406483628;5382.434844341287;5401;5432.429594892479;4682.344471773887;5526.3420973706925;5542.7782888684005;5562.3881373048125;5627;4777.402824646919;4905.288733133747;5082.33929589151;5131.25596788471;5426.72471969079 22:50:53 INFO - PROCESS | 82567 | |5;yui.html;731.235858527838;733.3509843788247;768.646422645583;830.1656834880944;830.944700230707;15682.76475852863;17878.731819022723;17886.910565447186;17992.640147197064;18444.90777546114;13172.407241674124;16444.917775411137;16468.67062658746;16501.33994640213;16510.926789758658;915.0803442540255;935.7286386947811;937.0722984245582;939.7697564096806;940.351157701184;919.5034681272105;947.4457442396207;967.511406739599;967.5936106835146;968.7723385004518;994.0109590957007;996.9401835889834;997.7156510394539;998.4907697074472;998.9051040151174;980.6175591519313;992.4987881120024;993.2699465892563;993.562832353762;994.8905620381752;739.0429393934867;739.3973911262358;739.4454159380465;739.5451797144771;739.8113481062348;11475.483603237873;15044.340636007073;15197.316120774592;15371.615709607237;15408.998415102982;14125.576232713034;14222;14266.859971004329;14273.429062837475;14345.569632911029;11613.593524226611;11715.297082175097;11755.35345555994;11822.940885295604;11913.583024594183;3617.7467577269604;3630.5280313559333;3648.1426864686778;3747.009434951795;3863.2466668999555;107476.46261768797;114916;115973.84026159799;116474;121502;10409.791804164026;10546.525406356732;10601.257911946244;10904.236703430843;11210.383428911326;20700.896495517427;22521.88739056327;22550.661740073912;22567.98444070021;22628.208012719475;7574.280443357982;7674.347680447113;7735.651895664709;7896.802579935433;7975.561344126013;4275.358696195595;4319.611234988866;4483.686141970031;4575.176468235683;4592.7014744041535;3406.148462884279;3475.4439289713523;3479.3215323012278;3502.562179727534;3504.667056629667;605.8303674971015;611.4924612571643;619.8275391854963;635.0537698828804;640.6604499615212;659.7987613777748;684.934931181537;697.7627606613776;710.8887101738586;719.9992011104569;9165;9982.35114717541;10122.392656440637;10190.337628054152;10517.474126293808;544.3250369541739;577.206341280739;585.6134950932365;597.3220394851787;600.8618017855918;4591.4260717410325;4736.653243491064;4940.975295123573;4954.826581069645;4956.90086198274;99472;100303.49848250712;101888;105127;106481;48841;74371.51256974938;74624;86012.5699371499;90724.54637726769;57758;69438.65280673564;69609;71019.64490177516;71531.28468715247;8143.959280203561;10658.573657053632;10660.360378377321;10771.676849694522;11085.833712494481;39412.408813867245;41071;45316.54683453255;46762;46877.76561117172;47980.04039919112;53361.73319133535;62933.68533157305;63101;66248.00627990681;12330.260184388966;12351.567695130627;12557.43491542901;12861.228326300452;13041.478340866259;14097.577072687836;15275;15427;15484.612884677974;15672;13860.528124470524;14173.929130354281;14204.289785510477;14236.928815355857;14722.779158312847;13107.475700972236;13615.455381784617;13743.862561374259;13842.377093030636;13855;12817.102802803714;13733.381997809922;13753.656158596115;13762.449502020208;14208.50270240578;10729.03023391344;11185.496652650812;11283.717907052389;11316.94341528287;12020.519179232733;9983.650572229937;10015;11043.447827608426;11435.485403157045;11441 22:50:53 INFO - PROCESS | 82567 | __end_tp_report 22:50:53 INFO - PROCESS | 82567 | __start_cc_report 22:50:53 INFO - PROCESS | 82567 | _x_x_mozilla_cycle_collect,1671 22:50:53 INFO - PROCESS | 82567 | __end_cc_report 22:50:53 INFO - PROCESS | 82567 | __startTimestamp1490161853399__endTimestamp 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | ------- Summary: start ------- 22:50:53 INFO - PROCESS | 82567 | Number of tests: 6 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | [#0] dojo.html Cycles:165 Average:5934.35 Median:6186.04 stddev:676.42 (10.9%) stddev-sans-first:646.59 22:50:53 INFO - PROCESS | 82567 | Values: 3317.5 3317.7 3354.1 3364.2 3389.1 6051.5 6055.8 6060.0 6063.8 6079.9 4839.0 6096.6 6115.9 6116.8 6139.6 5403.2 5431.0 5462.0 5495.8 5535.6 4389.0 5334.4 5334.9 5389.0 5550.6 5464.4 5477.0 5490.6 5491.4 5507.0 5494.9 5505.4 5507.2 5521.1 5525.1 5264.6 5289.8 5362.9 5447.7 5462.6 5864.6 5894.8 5911.7 5929.5 5936.1 5928.3 6145.4 6366.2 6392.0 6428.2 6485.4 6523.3 6531.0 6538.1 6545.4 5901.0 5905.2 6077.3 6188.4 6192.3 6451.7 6454.7 6454.9 6456.7 6472.8 6208.7 6229.7 6252.6 6254.5 6261.6 6457.0 6464.6 6483.2 6502.8 6503.7 6211.2 6381.6 6393.6 6419.7 6441.0 6275.7 6292.3 6327.2 6354.1 6396.0 5174.4 5176.7 5180.4 5180.6 5202.7 4557.0 4559.2 4566.8 4571.9 4589.6 5728.7 5785.1 5836.4 5847.2 6119.4 6252.8 6259.3 6278.1 6279.6 6298.5 5844.5 5861.8 5862.9 5866.1 5867.8 5514.7 5527.0 5583.9 5651.7 5726.9 6702.0 6730.6 6731.6 6733.1 6734.6 6467.0 6467.5 6484.9 6505.2 6509.9 6422.1 6467.9 6484.3 6727.5 6728.1 6246.7 6348.7 6357.6 6385.8 6388.5 6259.3 6454.8 6457.0 6488.7 6507.9 6130.5 6232.4 6250.1 6252.1 6256.9 6111.0 6195.4 6239.1 6246.4 6258.9 6233.2 6240.2 6242.9 6246.1 6253.5 6162.0 6186.0 6247.4 6268.6 6287.7 6006.8 6041.5 6108.8 6156.0 6186.5 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | [#1] ext.html Cycles:180 Average:55394.04 Median:35569.14 stddev:110007.49 (309.3%) stddev-sans-first:110239.58 22:50:53 INFO - PROCESS | 82567 | Values: 746.5 787.4 808.7 876.1 888.1 28370.0 28740.6 29338.0 29408.4 40577.8 41511.8 41757.4 41782.0 41791.4 41801.6 9230.0 9316.1 9415.8 9416.1 9427.8 7357.6 7533.3 7817.6 9394.6 9399.4 7517.0 7541.5 7555.4 7567.2 10991.4 11127.8 11142.4 11173.8 11173.9 11183.0 10845.0 10897.5 10909.1 10912.3 10921.7 27984.6 28350.0 38759.8 39042.6 39057.0 3781.0 3853.0 3879.4 3896.6 3899.1 23524.4 26011.3 26355.0 27057.9 28614.4 3085.5 3097.4 3197.5 3229.1 3272.8 364377.0 364636.0 364959.0 365362.0 366484.0 53064.1 53068.2 53084.4 53175.0 53219.5 55242.4 55264.0 55270.4 55317.2 55354.0 12074.3 14661.9 14797.6 14802.6 14833.2 12657.2 12668.6 12682.7 12685.6 12701.0 9553.8 12347.4 12375.0 12417.9 12476.3 4794.3 4898.8 5398.8 5443.9 5485.7 1085.6 1106.3 1151.4 1202.3 1217.8 26763.5 26902.9 26983.3 27318.6 27416.7 1087.3 1214.7 1221.9 1260.1 1307.1 11528.4 13931.3 14172.4 14200.2 14235.4 440442.0 446510.0 446786.0 447213.0 447737.0 57406.0 57409.4 57620.7 57680.4 57806.4 1428.7 1468.9 1471.1 1472.4 1476.7 24860.0 25692.0 26318.2 26369.5 26469.0 33258.5 43027.1 43312.7 43359.3 43364.7 429272.0 429665.0 429679.9 430421.0 430864.0 34249.0 34361.8 34786.5 34917.5 34944.8 43173.6 44051.3 44143.8 44216.6 44238.6 34002.7 35852.6 36459.9 36749.4 38042.8 35498.1 35530.5 36427.8 36433.5 36729.0 35124.1 35607.8 36504.0 36576.6 36715.8 29384.6 30075.8 30406.4 31931.0 32255.0 23665.0 23738.6 23968.8 24223.9 24236.0 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | [#2] jquery.html Cycles:180 Average:43417.31 Median:22639.60 stddev:126419.11 (558.4%) stddev-sans-first:126732.42 22:50:53 INFO - PROCESS | 82567 | Values: 363.0 400.9 403.4 422.3 447.8 11413.2 20115.7 20877.5 21072.5 21327.9 21121.6 21999.5 22556.9 22722.3 23053.0 5876.4 6603.4 6609.5 6766.2 6880.2 6667.2 6803.6 6804.6 6805.4 6812.9 6506.3 6702.4 6793.9 6794.7 6804.8 6754.0 6808.2 6826.8 6832.8 7092.4 7228.1 7317.9 7318.4 7333.3 7333.5 25781.0 26305.1 26470.7 26489.0 26777.5 2933.8 2959.3 2963.1 2963.3 3007.5 15658.6 16049.4 16193.6 16299.5 17054.1 1822.2 1905.8 1965.4 1979.9 2000.0 151505.2 153642.0 162893.0 163678.7 166099.0 15023.9 17994.5 18910.4 19539.4 19734.3 30931.7 31535.7 31570.5 31779.4 32088.8 7062.4 9313.6 10344.5 10351.4 10371.6 8534.7 8729.1 8730.4 8842.0 8854.0 9224.9 9301.3 9428.2 9443.3 9457.2 3209.2 3529.1 3564.4 3772.8 3856.9 887.7 910.5 911.1 941.8 948.9 21670.9 22186.7 22353.8 22364.3 22375.9 931.9 933.3 937.8 941.3 954.0 11046.5 11304.7 11473.0 11613.9 11638.2 737599.3 754775.0 755202.0 768583.0 770296.0 150893.0 151987.2 156639.0 157574.0 160763.2 1161.8 1177.5 1208.8 1218.3 1220.5 18838.0 19530.5 19619.8 19674.9 19710.8 50061.0 63524.7 63643.0 64709.7 65292.7 82371.0 84092.6 84177.6 86277.0 86286.0 11327.6 11660.8 11675.1 11755.9 12314.6 13368.3 13369.7 13507.5 13774.8 13888.8 11390.5 11478.1 11575.1 11603.8 11693.6 11335.5 11455.0 11530.4 11768.7 11780.0 11556.5 11591.7 11730.6 11926.9 11950.9 11712.6 11910.2 12001.0 12162.2 12186.0 11299.5 11388.8 11732.4 11765.6 12713.4 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | [#3] mootools.html Cycles:180 Average:6738.27 Median:2421.22 stddev:4226.77 (174.6%) stddev-sans-first:4219.63 22:50:53 INFO - PROCESS | 82567 | Values: 1404.8 1539.7 1541.7 1559.2 1573.2 10581.0 11184.9 11199.7 11216.6 11233.6 10721.5 10938.7 10945.6 11170.0 11184.3 1997.2 2419.2 2423.3 2425.9 2426.7 2366.0 2389.9 2400.6 2403.0 2405.8 2366.9 2375.4 2384.3 2392.3 2398.1 2329.0 2348.5 2355.9 2357.1 2369.3 2321.8 2348.5 2376.8 2383.8 2387.4 10849.8 11015.3 11086.7 11104.5 11112.7 5658.3 5842.4 5858.6 5859.3 5867.5 3493.5 3532.4 3631.4 3655.2 3667.3 1119.5 1133.0 1157.6 1167.9 1182.0 13330.4 13607.6 13921.2 15544.8 15785.2 4568.7 4705.1 4751.3 4753.6 4767.7 10354.6 11552.1 11655.9 11658.2 11664.6 4952.5 5593.6 5763.7 5831.2 5852.1 4739.0 4794.9 5121.0 5202.7 5216.3 3730.2 3750.7 3779.5 3813.7 3819.8 1031.0 1031.4 1034.6 1044.4 1046.1 760.4 915.6 923.1 927.1 953.9 6383.7 6487.7 6625.3 6655.5 6675.4 946.1 954.0 954.3 985.2 998.4 4000.5 4069.3 4141.8 4191.4 4210.3 13332.9 13819.2 13852.4 13899.4 13962.0 12959.4 13430.7 13755.8 13766.4 13803.4 9923.3 10211.4 10212.1 10228.3 10236.2 6436.7 6766.6 6838.2 6971.7 6988.7 11933.6 12134.8 12354.4 12492.1 12493.3 12818.7 12840.3 12848.4 12927.6 13004.8 8978.5 9328.1 9398.1 9531.1 9601.7 10605.4 10611.8 10681.2 10690.7 10761.7 9237.5 9240.5 9256.7 9291.2 9306.0 7660.8 9062.9 9133.1 9148.1 9176.6 7739.7 7803.4 7805.8 7938.2 7940.8 5753.2 5788.4 5890.4 5974.5 6013.3 4901.5 5858.2 5874.9 5903.4 6088.2 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | [#4] prototype.html Cycles:180 Average:4517.33 Median:4803.89 stddev:1293.05 (26.9%) stddev-sans-first:1258.76 22:50:53 INFO - PROCESS | 82567 | Values: 375.7 376.7 377.3 385.2 386.3 4509.0 5103.4 5157.5 5193.8 5196.7 3862.9 4002.6 4013.3 4749.7 5025.5 3538.3 4285.7 4319.8 4337.2 4387.8 4087.4 4345.9 4381.0 4402.3 4431.0 3678.0 3915.7 4026.2 4339.5 4448.2 3561.6 3660.9 4227.8 4244.2 4335.0 3386.5 3773.4 3791.7 3912.9 3991.2 4756.7 4778.7 4786.3 5093.9 5160.6 3533.7 4159.4 4489.0 4941.5 5010.4 4486.9 5447.4 5481.9 5483.7 5493.7 4249.8 4356.0 4416.1 4458.9 4476.7 5460.8 5498.4 5516.9 5864.6 5936.6 3733.1 3781.9 3952.4 4296.1 4453.2 4389.5 4416.8 4707.6 4729.8 4747.4 3981.7 4530.9 4807.4 4948.4 5083.3 4570.8 5084.5 5457.5 5499.6 5537.3 1362.4 1473.7 1484.7 1565.5 1588.8 1005.6 1011.4 1149.9 1176.0 1189.4 4602.4 4829.8 4890.1 5017.8 5117.7 5692.3 5710.7 5718.8 5747.2 5766.8 4094.8 4282.1 4800.4 5120.3 5147.8 2406.4 2522.4 2538.7 2609.4 2636.0 4691.7 5122.8 5185.9 5532.1 5688.9 5000.8 5127.4 5531.2 5536.6 5598.6 5774.4 5775.0 5819.9 5820.6 5862.2 4902.8 5085.9 5498.9 5535.0 5689.4 4579.6 4599.5 5595.8 5623.7 5669.3 5278.3 5445.8 5623.6 5624.9 5838.0 4004.7 4196.7 4326.5 4627.6 4661.6 5651.6 5680.4 5708.0 5708.9 5757.1 5123.8 5149.1 5364.9 5511.0 5587.4 4776.2 5182.5 5202.5 5442.0 5514.4 4595.5 5377.3 5382.4 5401.0 5432.4 4682.3 5526.3 5542.8 5562.4 5627.0 4777.4 4905.3 5082.3 5131.3 5426.7 22:50:53 INFO - PROCESS | 82567 | 22:50:53 INFO - PROCESS | 82567 | [#5] yui.html Cycles:180 Average:19816.09 Median:3624.14 stddev:28402.86 (783.7%) stddev-sans-first:28446.39 22:50:53 INFO - PROCESS | 82567 | Values: 731.2 733.4 768.6 830.2 830.9 15682.8 17878.7 17886.9 17992.6 18444.9 13172.4 16444.9 16468.7 16501.3 16510.9 915.1 935.7 937.1 939.8 940.4 919.5 947.4 967.5 967.6 968.8 994.0 996.9 997.7 998.5 998.9 980.6 992.5 993.3 993.6 994.9 739.0 739.4 739.4 739.5 739.8 11475.5 15044.3 15197.3 15371.6 15409.0 14125.6 14222.0 14266.9 14273.4 14345.6 11613.6 11715.3 11755.4 11822.9 11913.6 3617.7 3630.5 3648.1 3747.0 3863.2 107476.5 114916.0 115973.8 116474.0 121502.0 10409.8 10546.5 10601.3 10904.2 11210.4 20700.9 22521.9 22550.7 22568.0 22628.2 7574.3 7674.3 7735.7 7896.8 7975.6 4275.4 4319.6 4483.7 4575.2 4592.7 3406.1 3475.4 3479.3 3502.6 3504.7 605.8 611.5 619.8 635.1 640.7 659.8 684.9 697.8 710.9 720.0 9165.0 9982.4 10122.4 10190.3 10517.5 544.3 577.2 585.6 597.3 600.9 4591.4 4736.7 4941.0 4954.8 4956.9 99472.0 100303.5 101888.0 105127.0 106481.0 48841.0 74371.5 74624.0 86012.6 90724.5 57758.0 69438.7 69609.0 71019.6 71531.3 8144.0 10658.6 10660.4 10771.7 11085.8 39412.4 41071.0 45316.5 46762.0 46877.8 47980.0 53361.7 62933.7 63101.0 66248.0 12330.3 12351.6 12557.4 12861.2 13041.5 14097.6 15275.0 15427.0 15484.6 15672.0 13860.5 14173.9 14204.3 14236.9 14722.8 13107.5 13615.5 13743.9 13842.4 13855.0 12817.1 13733.4 13753.7 13762.4 14208.5 10729.0 11185.5 11283.7 11316.9 12020.5 9983.7 10015.0 11043.4 11435.5 11441.0 22:50:53 INFO - PROCESS | 82567 | -------- Summary: end -------- 22:50:53 INFO - PROCESS | 82567 | 22:50:54 INFO - TEST-INFO | 82567: exit 0 22:50:54 INFO - TEST-OK | dromaeo_css | took 1120797ms 22:50:54 INFO - TEST-START | kraken 22:50:54 INFO - operating with platform_type : mac_ 22:50:54 INFO - Initialising browser for kraken test... 22:50:54 INFO - TEST-INFO | started process 82569 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmp0knskL/profile http://localhost:59814/getInfo.html) 22:50:56 INFO - PROCESS | 82569 | __metrics Screen width/height:1600/1200 22:50:56 INFO - PROCESS | 82569 | colorDepth:24 22:50:56 INFO - PROCESS | 82569 | Browser inner width/height: 1024/689 22:50:56 INFO - PROCESS | 82569 | __metrics 22:50:56 INFO - PROCESS | 82569 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:50:56 INFO - PROCESS | 82569 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:50:57 INFO - TEST-INFO | 82569: exit 0 22:50:57 INFO - Browser initialized. 22:50:57 INFO - Running cycle 1/1 for kraken test... 22:50:57 INFO - TEST-INFO | started process 82570 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmp0knskL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:51:09 INFO - PROCESS | 82570 | RSS: Main: 214945792 22:51:09 INFO - PROCESS | 82570 | 22:51:12 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59814/tests/kraken/driver.html?testName=audio-beat-detection) 22:51:13 INFO - PROCESS | 82570 | RSS: Main: 268091392 22:51:13 INFO - PROCESS | 82570 | 22:51:16 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59814/tests/kraken/driver.html?testName=audio-dft) 22:51:16 INFO - PROCESS | 82570 | RSS: Main: 279080960 22:51:16 INFO - PROCESS | 82570 | 22:51:19 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59814/tests/kraken/driver.html?testName=audio-fft) 22:51:20 INFO - PROCESS | 82570 | RSS: Main: 375304192 22:51:20 INFO - PROCESS | 82570 | 22:51:22 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59814/tests/kraken/driver.html?testName=audio-oscillator) 22:51:23 INFO - PROCESS | 82570 | RSS: Main: 278241280 22:51:23 INFO - PROCESS | 82570 | 22:51:25 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:51:25 INFO - PROCESS | 82570 | RSS: Main: 279605248 22:51:25 INFO - PROCESS | 82570 | 22:51:28 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59814/tests/kraken/driver.html?testName=imaging-darkroom) 22:51:29 INFO - PROCESS | 82570 | RSS: Main: 319176704 22:51:29 INFO - PROCESS | 82570 | 22:51:32 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59814/tests/kraken/driver.html?testName=imaging-desaturate) 22:51:33 INFO - PROCESS | 82570 | RSS: Main: 321409024 22:51:33 INFO - PROCESS | 82570 | 22:51:35 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59814/tests/kraken/driver.html?testName=json-parse-financial) 22:51:36 INFO - PROCESS | 82570 | RSS: Main: 316608512 22:51:36 INFO - PROCESS | 82570 | 22:51:38 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:51:38 INFO - PROCESS | 82570 | RSS: Main: 295116800 22:51:38 INFO - PROCESS | 82570 | 22:51:40 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:51:41 INFO - PROCESS | 82570 | RSS: Main: 301027328 22:51:41 INFO - PROCESS | 82570 | 22:51:43 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:51:44 INFO - PROCESS | 82570 | RSS: Main: 304189440 22:51:44 INFO - PROCESS | 82570 | 22:51:47 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:51:47 INFO - PROCESS | 82570 | RSS: Main: 319508480 22:51:47 INFO - PROCESS | 82570 | 22:51:50 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:51:51 INFO - PROCESS | 82570 | RSS: Main: 313094144 22:51:51 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | Cycle 1(1): loaded http://localhost:59814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59814/tests/kraken/driver.html?testName=ai-astar) 22:51:53 INFO - PROCESS | 82570 | RSS: Main: 357830656 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | __start_tp_report 22:51:53 INFO - PROCESS | 82570 | _x_x_mozilla_page_load 22:51:53 INFO - PROCESS | 82570 | _x_x_mozilla_page_load_details 22:51:53 INFO - PROCESS | 82570 | |i|pagename|runs| 22:51:53 INFO - PROCESS | 82570 | |0;ai-astar;117;125;172;155;115;116;117;115;116;118 22:51:53 INFO - PROCESS | 82570 | |1;audio-beat-detection;148;112;111;160;140;137;135;112;128;111 22:51:53 INFO - PROCESS | 82570 | |2;audio-dft;185;182;185;184;186;185;185;186;182;185 22:51:53 INFO - PROCESS | 82570 | |3;audio-fft;87;60;61;93;61;63;60;61;76;59 22:51:53 INFO - PROCESS | 82570 | |4;audio-oscillator;95;70;88;70;69;70;82;69;71;86 22:51:53 INFO - PROCESS | 82570 | |5;imaging-gaussian-blur;91;90;91;91;91;90;90;91;91;90 22:51:53 INFO - PROCESS | 82570 | |6;imaging-darkroom;97;97;110;127;140;150;97;97;98;96 22:51:53 INFO - PROCESS | 82570 | |7;imaging-desaturate;86;86;83;85;84;83;84;84;86;86 22:51:53 INFO - PROCESS | 82570 | |8;json-parse-financial;64;61;61;63;64;65;66;66;66;66 22:51:53 INFO - PROCESS | 82570 | |9;json-stringify-tinderbox;57;66;69;66;62;59;59;74;84;85 22:51:53 INFO - PROCESS | 82570 | |10;stanford-crypto-aes;83;82;83;84;83;84;85;83;87;85 22:51:53 INFO - PROCESS | 82570 | |11;stanford-crypto-ccm;138;139;154;128;141;136;143;144;178;148 22:51:53 INFO - PROCESS | 82570 | |12;stanford-crypto-pbkdf2;162;143;186;230;167;170;165;212;164;165 22:51:53 INFO - PROCESS | 82570 | |13;stanford-crypto-sha256-iterative;67;65;64;65;65;64;65;66;64;64 22:51:53 INFO - PROCESS | 82570 | __end_tp_report 22:51:53 INFO - PROCESS | 82570 | __start_cc_report 22:51:53 INFO - PROCESS | 82570 | _x_x_mozilla_cycle_collect,2187 22:51:53 INFO - PROCESS | 82570 | __end_cc_report 22:51:53 INFO - PROCESS | 82570 | __startTimestamp1490161913565__endTimestamp 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | ------- Summary: start ------- 22:51:53 INFO - PROCESS | 82570 | Number of tests: 14 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#0] ai-astar Cycles:10 Average:126.60 Median:117.50 stddev:20.06 (17.1%) stddev-sans-first:20.98 22:51:53 INFO - PROCESS | 82570 | Values: 117.0 125.0 172.0 155.0 115.0 116.0 117.0 115.0 116.0 118.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:136.00 stddev:17.54 (12.9%) stddev-sans-first:17.26 22:51:53 INFO - PROCESS | 82570 | Values: 148.0 112.0 111.0 160.0 140.0 137.0 135.0 112.0 128.0 111.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 22:51:53 INFO - PROCESS | 82570 | Values: 185.0 182.0 185.0 184.0 186.0 185.0 185.0 186.0 182.0 185.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#3] audio-fft Cycles:10 Average:68.10 Median:62.00 stddev:12.61 (20.3%) stddev-sans-first:11.37 22:51:53 INFO - PROCESS | 82570 | Values: 87.0 60.0 61.0 93.0 61.0 63.0 60.0 61.0 76.0 59.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:76.50 stddev:9.79 (12.8%) stddev-sans-first:7.92 22:51:53 INFO - PROCESS | 82570 | Values: 95.0 70.0 88.0 70.0 69.0 70.0 82.0 69.0 71.0 86.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:91.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 22:51:53 INFO - PROCESS | 82570 | Values: 91.0 90.0 91.0 91.0 91.0 90.0 90.0 91.0 91.0 90.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:97.00 stddev:20.54 (21.2%) stddev-sans-first:21.16 22:51:53 INFO - PROCESS | 82570 | Values: 97.0 97.0 110.0 127.0 140.0 150.0 97.0 97.0 98.0 96.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.24 22:51:53 INFO - PROCESS | 82570 | Values: 86.0 86.0 83.0 85.0 84.0 83.0 84.0 84.0 86.0 86.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:65.50 stddev:1.99 (3.0%) stddev-sans-first:2.11 22:51:53 INFO - PROCESS | 82570 | Values: 64.0 61.0 61.0 63.0 64.0 65.0 66.0 66.0 66.0 66.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:67.50 stddev:10.05 (14.9%) stddev-sans-first:9.82 22:51:53 INFO - PROCESS | 82570 | Values: 57.0 66.0 69.0 66.0 62.0 59.0 59.0 74.0 84.0 85.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.50 22:51:53 INFO - PROCESS | 82570 | Values: 83.0 82.0 83.0 84.0 83.0 84.0 85.0 83.0 87.0 85.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:143.50 stddev:13.56 (9.4%) stddev-sans-first:14.15 22:51:53 INFO - PROCESS | 82570 | Values: 138.0 139.0 154.0 128.0 141.0 136.0 143.0 144.0 178.0 148.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:168.50 stddev:26.03 (15.4%) stddev-sans-first:27.08 22:51:53 INFO - PROCESS | 82570 | Values: 162.0 143.0 186.0 230.0 167.0 170.0 165.0 212.0 164.0 165.0 22:51:53 INFO - PROCESS | 82570 | 22:51:53 INFO - PROCESS | 82570 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:0.71 22:51:53 INFO - PROCESS | 82570 | Values: 67.0 65.0 64.0 65.0 65.0 64.0 65.0 66.0 64.0 64.0 22:51:53 INFO - PROCESS | 82570 | -------- Summary: end -------- 22:51:53 INFO - PROCESS | 82570 | 22:51:54 INFO - TEST-INFO | 82570: exit 0 22:51:54 INFO - TEST-OK | kraken | took 60268ms 22:51:54 INFO - SUITE-END | took 1181s 22:51:54 INFO - Completed test suite (00:19:41) 22:51:54 INFO - javascript benchmark 22:51:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7667.085735412046, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.452620317648, 3317.651646577108, 3354.09439451348, 3364.2262279675674, 3389.084947064292, 6051.546134039942, 6055.848603784908, 6059.969700151499, 6063.757449702007, 6079.9392006079925, 4838.975805120978, 6096.573239873211, 6115.938840611592, 6116.816495505131, 6139.570230083896, 5403.243545903567, 5431.0, 5462.0441422751055, 5495.780168793243, 5535.612507124503, 4389.0, 5334.413214546396, 5334.91997620036, 5389.029974604569, 5550.583706222029, 5464.4262352453015, 5477.0415177344, 5490.56075513958, 5491.423400542945, 5507.0, 5494.890102197974, 5505.394406615269, 5507.228987941691, 5521.116621340566, 5525.143602741581, 5264.631475796696, 5289.788408463695, 5362.865928351823, 5447.700376479332, 5462.617616766828, 5864.6187997780435, 5894.793682221145, 5911.704414779287, 5929.495992840613, 5936.109583562457, 5928.318243402021, 6145.446909778141, 6366.236051673829, 6392.041193820917, 6428.164338635994, 6485.448736857373, 6523.315051919575, 6531.0, 6538.0519824625635, 6545.443637290836, 5901.0, 5905.173275741399, 6077.270727512727, 6188.350223226586, 6192.256929168483, 6451.677416129175, 6454.709538070798, 6454.903176452357, 6456.709448074848, 6472.805815825533, 6208.689565521796, 6229.657368844757, 6252.624842509464, 6254.530910181664, 6261.592996455307, 6456.967715161488, 6464.644444555594, 6483.157189565326, 6502.804915852532, 6503.7073331700185, 6211.192544969125, 6381.585196962183, 6393.584417012879, 6419.679016049272, 6441.0, 6275.748970041147, 6292.339304373067, 6327.209098862642, 6354.110424540568, 6395.97664373698, 5174.43081261061, 5176.689398636094, 5180.352455943007, 5180.585553155738, 5202.739863006835, 4556.997460558672, 4559.202139625552, 4566.771661416916, 4571.885702857388, 4589.58693717567, 5728.684922329312, 5785.074388097884, 5836.416358364215, 5847.181394604759, 6119.357467465941, 6252.781152659635, 6259.3427690091885, 6278.089676996809, 6279.623222606659, 6298.464630506367, 5844.503217226584, 5861.824145275648, 5862.8534286642325, 5866.120081987736, 5867.765289388462, 5514.724263786875, 5526.972365138148, 5583.944160558342, 5651.689157096317, 5726.885462290731, 6701.966490167518, 6730.596164230162, 6731.562448440934, 6733.091032710521, 6734.629595372302, 6467.029945508023, 6467.514936379696, 6484.902726459201, 6505.186851643544, 6509.902351464826, 6422.133012043501, 6467.902981455376, 6484.254310754135, 6727.461803055646, 6728.125343705287, 6246.6876656166105, 6348.650824204713, 6357.554971151975, 6385.840353991188, 6388.4569811566535, 6259.311475737574, 6454.805860915746, 6457.0, 6488.70800813974, 6507.934920650733, 6130.489860652556, 6232.376762323732, 6250.093736408105, 6252.124702541557, 6256.937430625636, 6111.0, 6195.4424101831055, 6239.064140378798, 6246.437820596168, 6258.906116408349, 6233.158523599437, 6240.157578726814, 6242.875142497034, 6246.063090536456, 6253.468455181179, 6161.969190154021, 6186.041163619646, 6247.375262473898, 6268.592541484789, 6287.654179020198, 6006.81979540597, 6041.486473649789, 6108.755649774137, 6155.9842625968, 6186.536009799193], "value": 5889.428534243765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.4625469661845, 787.4212453846424, 808.6805711743862, 876.1370050500257, 888.0719647967873, 28370.0, 28740.568891466617, 29338.0, 29408.41183176335, 40577.797111014406, 41511.792441037825, 41757.37363939543, 41782.0, 41791.37312940308, 41801.58198418015, 9230.030846761094, 9316.114969077928, 9415.764605884873, 9416.058394160564, 9427.764305892339, 7357.632118394085, 7533.28433798791, 7817.648205830751, 9394.577244024002, 9399.389039712396, 7517.0, 7541.472096953215, 7555.3955683545455, 7567.167611562723, 10991.395473248967, 11127.777444451107, 11142.387168705718, 11173.776524469506, 11173.888261117367, 11183.04944079746, 10845.0, 10897.509612067475, 10909.127269818395, 10912.345259284468, 10921.672349829518, 27984.580231296546, 28350.007749728662, 38759.8372048839, 39042.60957390447, 39057.023574410865, 3780.9810950945343, 3852.9614703852885, 3879.35990561557, 3896.5518965319066, 3899.0642245861072, 23524.411889702722, 26011.349716257057, 26355.0, 27057.917683292842, 28614.427711445656, 3085.537169424582, 3097.4269760094453, 3197.488401855692, 3229.1119942016135, 3272.754543409254, 364377.0, 364636.0, 364959.0, 365362.0, 366483.9999999973, 53064.14275500339, 53068.20397694038, 53084.40746777603, 53175.0, 53219.46780532145, 55242.44757552373, 55264.0, 55270.44729552734, 55317.170242446395, 55354.0, 12074.27554346742, 14661.900357473232, 14797.63005924839, 14802.555923322318, 14833.184174870486, 12657.177283476729, 12668.556600519121, 12682.746345073047, 12685.556005539946, 12701.0, 9553.808923821485, 12347.38263086842, 12375.0, 12417.875821241852, 12476.313802740755, 4794.328793968847, 4898.828541001048, 5398.811041613525, 5443.891122177534, 5485.725713714378, 1085.61583980424, 1106.3472551194673, 1151.3552410650063, 1202.320688810819, 1217.7747116783423, 26763.464730705666, 26902.880601030265, 26983.325416864736, 27318.5902211467, 27416.725832741817, 1087.2986923434341, 1214.6963259185204, 1221.945012474423, 1260.0927332320714, 1307.0654482045384, 11528.423578821026, 13931.303434828218, 14172.362243699059, 14200.218987955555, 14235.359408826627, 440442.0, 446510.0, 446786.0, 447213.0, 447737.0, 57406.0, 57409.42590574124, 57620.71189644025, 57680.423195768344, 57806.421935780105, 1428.7071150414347, 1468.8898332624883, 1471.1099784630144, 1472.374240947593, 1476.6898951220364, 24860.0, 25692.0, 26318.21045368642, 26369.4726105473, 26469.0, 33258.50112248366, 43027.12755851988, 43312.70061898148, 43359.34960975651, 43364.69905902828, 429272.0, 429665.0, 429679.85160074, 430421.0, 430864.0, 34248.97253082412, 34361.82819085989, 34786.478202826474, 34917.47623785696, 34944.82527587448, 43173.56826431696, 44051.33922991222, 44143.77928110339, 44216.55783442253, 44238.557614423444, 34002.65997339995, 35852.64147358493, 36459.90620281396, 36749.42754007194, 38042.80978595089, 35498.11254718652, 35530.467042993856, 36427.81786091052, 36433.453498198076, 36729.0, 35124.12189695278, 35607.82196089003, 36504.0, 36576.63423365732, 36715.81642091773, 29384.55923161197, 30075.849620751756, 30406.391872161992, 31931.0, 32255.032349029567, 23665.0, 23738.643920340863, 23968.76031239665, 24223.878880605484, 24236.030558778155], "value": 18626.925063838535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.02708740575247, 400.9358502639578, 403.43720509888703, 422.3200646958396, 447.76939875963865, 11413.216522099898, 20115.698264526025, 20877.47806304843, 21072.473188170305, 21327.93360331985, 21121.57756844866, 21999.450013749665, 22556.8872155639, 22722.31833045007, 23053.0, 5876.44173803488, 6603.405693487585, 6609.471242300604, 6766.15423072116, 6880.2431732509385, 6667.166604174478, 6803.625800580966, 6804.591724496546, 6805.387515123638, 6812.931870681304, 6506.349365063503, 6702.36327548882, 6793.864122717543, 6794.728210871559, 6804.761833335834, 6754.0, 6808.183018037817, 6826.795196144124, 6832.829179270509, 7092.397146242575, 7228.132624085091, 7317.853642927112, 7318.414526837893, 7333.266673332678, 7333.523320984173, 25781.0, 26305.07932222382, 26470.676466176807, 26489.0, 26777.46445071107, 2933.7506311963507, 2959.319356548006, 2963.111066680009, 2963.28881068542, 3007.5413424489107, 15658.608534786608, 16049.35802567896, 16193.595160120973, 16299.51101466946, 17054.062026588534, 1822.1618055694396, 1905.83743916211, 1965.3809050149157, 1979.9307024254083, 2000.0199902048037, 151505.24247378693, 153642.0, 162893.0, 163678.726425472, 166099.0, 15023.924880375529, 17994.460166194775, 18910.432687019413, 19539.413817585497, 19734.30929917446, 30931.69068309333, 31535.684643153734, 31570.526442103386, 31779.364412711617, 32088.83955580207, 7062.364387205176, 9313.556398758203, 10344.482775861177, 10351.430671312999, 10371.599834022461, 8534.658613655385, 8729.127087291221, 8730.384878797317, 8841.955790221136, 8853.955730221307, 9224.907750922404, 9301.302402319852, 9428.198603118812, 9443.291753118543, 9457.19613832832, 3209.245827230599, 3529.1177205698577, 3564.4355644355646, 3772.75477093988, 3856.8650097246464, 887.6759982606302, 910.517425764346, 911.129870973219, 941.764558860285, 948.9098535639104, 21670.91645417723, 22186.667199992015, 22353.776462235495, 22364.329070127922, 22375.881205939637, 931.8928323242778, 933.3419938943028, 937.8499440089553, 941.289326558444, 953.9570719317647, 11046.502907369188, 11304.692532580117, 11473.024792892531, 11613.941930290464, 11638.243514171552, 737599.3120034365, 754775.0, 755202.0, 768583.0, 770296.0, 150893.0, 151987.24006379896, 156639.0, 157574.0, 160763.19618402066, 1161.815263614715, 1177.5466445418404, 1208.7642909632536, 1218.342095268545, 1220.4934951994824, 18838.0, 19530.511737206685, 19619.803801962367, 19674.90162549235, 19710.802891970896, 50061.0, 63524.68237658782, 63643.0, 64709.67645161744, 65292.67353663201, 82371.0, 84092.57953710192, 84177.57911210405, 86277.0, 86286.0, 11327.603533876274, 11660.766784664429, 11675.065994720571, 11755.941220293844, 12314.568990085305, 13368.331583420595, 13369.732605348034, 13507.459701611826, 13774.760271575606, 13888.791668125188, 11390.487428065922, 11478.139139564399, 11575.073994080622, 11603.825942610698, 11693.649190524298, 11335.489902954552, 11454.969052784956, 11530.365829879438, 11768.70578235551, 11780.0, 11556.479958401724, 11591.6522504325, 11730.589429369931, 11926.880731192578, 11950.880491195325, 11712.590059347882, 11910.225835320676, 12001.0, 12162.20945638566, 12186.0, 11299.548018079513, 11388.804175561447, 11732.354720490455, 11765.588204412805, 12713.36433178356], "value": 11552.902127510588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.7708255276632, 1539.676667899741, 1541.7147827651893, 1559.1892216047656, 1573.229117732311, 10581.047705706485, 11184.888151118475, 11199.720006999829, 11216.607418740346, 11233.550657973692, 10721.463926803668, 10938.671839844797, 10945.616903408381, 11169.994700476955, 11184.32894026359, 1997.2310660395779, 2419.1532963462823, 2423.2851308863837, 2425.9029638814427, 2426.733059363469, 2365.95268094638, 2389.880505974703, 2400.5798985177526, 2402.9639555406684, 2405.807535397164, 2366.8934897929635, 2375.406148462884, 2384.344305316043, 2392.2823153054014, 2398.1126983016306, 2328.953420931589, 2348.4598542335275, 2355.9411014724596, 2357.0689577616918, 2369.336585755974, 2321.8258630602772, 2348.459854233519, 2376.7979721723673, 2383.7616238376195, 2387.3554140382175, 10849.837252441219, 11015.339079655167, 11086.722831929186, 11104.500297486633, 11112.722181945435, 5658.292713410824, 5842.444967728059, 5858.589898707092, 5859.29688437386, 5867.530597552186, 3493.545839040934, 3532.4104153131193, 3631.364511210528, 3655.232401195752, 3667.3215455140885, 1119.4738472917716, 1132.994335028328, 1157.6469176901041, 1167.8890505402057, 1182.0484509969472, 13330.400131994083, 13607.591772246848, 13921.164730116225, 15544.76682849758, 15785.21073946298, 4568.748718820497, 4705.106029854317, 4751.263554149113, 4753.619710423158, 4767.69010014348, 10354.585816567404, 11552.133589980785, 11655.941720291345, 11658.242214256046, 11664.591739289084, 4952.529509696573, 5593.580481463907, 5763.740631671585, 5831.154482599999, 5852.092925596539, 4738.981119059419, 4794.9280760788615, 5121.0, 5202.739863006835, 5216.295800066942, 3730.1607138393642, 3750.7374483785875, 3779.4519794629623, 3813.675837553839, 3819.8090095495113, 1030.9845352319721, 1031.3966329697062, 1034.5861655337774, 1044.368157264859, 1046.1212581431635, 760.372692528655, 915.6285221276925, 923.0999775219108, 927.1192367251003, 953.8521529162991, 6383.680815959184, 6487.740490380426, 6625.271220165778, 6655.535782127924, 6675.39921407066, 946.1437399153639, 953.9713808585753, 954.3319676226669, 985.2216748768393, 998.4458625462938, 4000.5199376075057, 4069.348904175318, 4141.7722025288895, 4191.392248124005, 4210.305299625588, 13332.93333533326, 13819.170849749047, 13852.376643051088, 13899.444022238997, 13962.0, 12959.352032398343, 13430.664233394244, 13755.79366309506, 13766.449342026408, 13803.447862085404, 9923.305368624127, 10211.438370889673, 10212.131968782736, 10228.335158214544, 10236.232282578836, 6436.742530298736, 6766.594004359754, 6838.2136054352395, 6971.721131154697, 6988.685509152202, 11933.641990740292, 12134.75730485403, 12354.444050017592, 12492.06309526771, 12493.312867791996, 12818.743625127632, 12840.293783841606, 12848.421821018264, 12927.612171634866, 13004.804927926278, 8978.506182160045, 9328.067193280618, 9398.107179817905, 9531.094546018117, 9601.663941762004, 10605.41670208146, 10611.840822387516, 10681.198910081619, 10690.679279621623, 10761.677149685522, 9237.491937943478, 9240.537973101453, 9256.72229833106, 9291.21024712907, 9306.0, 7660.846783064196, 9062.864057039282, 9133.086691330815, 9148.085191480799, 9176.587053582738, 7739.690412383442, 7803.375729941477, 7805.843883122419, 7938.166492518433, 7940.84118317642, 5753.165790960371, 5788.392218816964, 5890.410958904075, 5974.462298393166, 6013.278406591062, 4901.485344038967, 5858.238429004202, 5874.853128671817, 5903.380145084704, 6088.178095956989], "value": 5112.330228485123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.7125798763945, 376.745696654758, 377.29257641921396, 385.1507426125394, 386.33164625198407, 4509.008018235991, 5103.40210151843, 5157.4842515748405, 5193.818216362428, 5196.700095439395, 3862.918382852799, 4002.5997400259957, 4013.3177359848823, 4749.715017098976, 5025.472325405834, 3538.275527843559, 4285.700000999931, 4319.768865873227, 4337.240982828008, 4387.758673272985, 4087.3664581989838, 4345.9348109778375, 4381.0, 4402.339649052636, 4430.980874398891, 3677.963220367802, 3915.6867450604027, 4026.2350153470748, 4339.500957389893, 4448.243798554254, 3561.626029266916, 3660.924823148568, 4227.8308867645255, 4244.172386384656, 4334.978325108385, 3386.475096360068, 3773.3773927301963, 3791.7345785795005, 3912.8870409978576, 3991.2217117662067, 4756.738379389167, 4778.737169455679, 4786.253017648568, 5093.898122037575, 5160.56135228506, 3533.7349698772437, 4159.355299928516, 4488.955110448886, 4941.481144479814, 5010.398752149729, 4486.8878278042985, 5447.400785913546, 5481.917771233435, 5483.698396588186, 5493.670379777226, 4249.787510624487, 4356.019895523482, 4416.050549131952, 4458.929856834369, 4476.7090139140855, 5460.849754186807, 5498.367687715924, 5516.889662206733, 5864.6187997780435, 5936.584439089265, 3733.1227161617, 3781.9243615128094, 3952.3676211805973, 4296.131182935433, 4453.242948698664, 4389.473263208435, 4416.757078360657, 4707.552782485658, 4729.834455794031, 4747.359106520576, 3981.7212795104065, 4530.88672783183, 4807.399075115611, 4948.356713627278, 5083.288339632454, 4570.7943142558, 5084.51697088776, 5457.481539253765, 5499.6351568825785, 5537.307836520435, 1362.4073528015344, 1473.6610579566545, 1484.6956373943315, 1565.4520917678722, 1588.7775711400413, 1005.6329439754584, 1011.3527342500805, 1149.9482523286472, 1175.9823602645968, 1189.3518032672214, 4602.355670206174, 4829.8178331735435, 4890.0903962142465, 5017.84946451607, 5117.744112794346, 5692.345380281238, 5710.65736055838, 5718.828435146952, 5747.183879898819, 5766.798162064391, 4094.795260237036, 4282.066784252735, 4800.375951126401, 5120.334356533701, 5147.794088236428, 2406.374342670918, 2522.356799016239, 2538.669972903511, 2609.386794103384, 2636.0, 4691.695039822401, 5122.769475373542, 5185.936882938989, 5532.114861622202, 5688.914666280009, 5000.849974500771, 5127.3847138343635, 5531.197976293495, 5536.560494271438, 5598.5723640471415, 5774.422557744192, 5775.015239484742, 5819.912701309569, 5820.563457740686, 5862.208601838697, 4902.779374928065, 5085.923711144262, 5498.917516237179, 5534.972325138348, 5689.402612725604, 4579.610733087725, 4599.4710608280475, 5595.804146854841, 5623.662580245198, 5669.3480249770155, 5278.287431196893, 5445.809396671098, 5623.625824505264, 5624.85937851557, 5837.970810145922, 4004.7196696230985, 4196.748195108304, 4326.524082350876, 4627.583517483443, 4661.578218643346, 5651.6043876928225, 5680.403557626555, 5708.0, 5708.914366284426, 5757.092668202531, 5123.770295129217, 5149.098907691214, 5364.865878353073, 5510.972445137749, 5587.424048608812, 4776.23580227162, 5182.53357197854, 5202.505761952609, 5441.972790136024, 5514.36584792754, 4595.540445955377, 5377.343406483628, 5382.434844341287, 5401.0, 5432.429594892479, 4682.344471773887, 5526.3420973706925, 5542.7782888684005, 5562.3881373048125, 5627.0, 4777.402824646919, 4905.288733133747, 5082.33929589151, 5131.25596788471, 5426.72471969079], "value": 4142.452846251172, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.235858527838, 733.3509843788247, 768.646422645583, 830.1656834880944, 830.944700230707, 15682.76475852863, 17878.731819022723, 17886.910565447186, 17992.640147197064, 18444.90777546114, 13172.407241674124, 16444.917775411137, 16468.67062658746, 16501.33994640213, 16510.926789758658, 915.0803442540255, 935.7286386947811, 937.0722984245582, 939.7697564096806, 940.351157701184, 919.5034681272105, 947.4457442396207, 967.511406739599, 967.5936106835146, 968.7723385004518, 994.0109590957007, 996.9401835889834, 997.7156510394539, 998.4907697074472, 998.9051040151174, 980.6175591519313, 992.4987881120024, 993.2699465892563, 993.562832353762, 994.8905620381752, 739.0429393934867, 739.3973911262358, 739.4454159380465, 739.5451797144771, 739.8113481062348, 11475.483603237873, 15044.340636007073, 15197.316120774592, 15371.615709607237, 15408.998415102982, 14125.576232713034, 14222.0, 14266.859971004329, 14273.429062837475, 14345.569632911029, 11613.593524226611, 11715.297082175097, 11755.35345555994, 11822.940885295604, 11913.583024594183, 3617.7467577269604, 3630.5280313559333, 3648.1426864686778, 3747.009434951795, 3863.2466668999555, 107476.46261768797, 114916.0, 115973.84026159799, 116474.0, 121502.0, 10409.791804164026, 10546.525406356732, 10601.257911946244, 10904.236703430843, 11210.383428911326, 20700.896495517427, 22521.88739056327, 22550.661740073912, 22567.98444070021, 22628.208012719475, 7574.280443357982, 7674.347680447113, 7735.651895664709, 7896.802579935433, 7975.561344126013, 4275.358696195595, 4319.611234988866, 4483.686141970031, 4575.176468235683, 4592.7014744041535, 3406.148462884279, 3475.4439289713523, 3479.3215323012278, 3502.562179727534, 3504.667056629667, 605.8303674971015, 611.4924612571643, 619.8275391854963, 635.0537698828804, 640.6604499615212, 659.7987613777748, 684.934931181537, 697.7627606613776, 710.8887101738586, 719.9992011104569, 9165.0, 9982.35114717541, 10122.392656440637, 10190.337628054152, 10517.474126293808, 544.3250369541739, 577.206341280739, 585.6134950932365, 597.3220394851787, 600.8618017855918, 4591.4260717410325, 4736.653243491064, 4940.975295123573, 4954.826581069645, 4956.90086198274, 99472.0, 100303.49848250712, 101888.0, 105127.0, 106481.0, 48841.0, 74371.51256974938, 74624.0, 86012.5699371499, 90724.54637726769, 57758.0, 69438.65280673564, 69609.0, 71019.64490177516, 71531.28468715247, 8143.959280203561, 10658.573657053632, 10660.360378377321, 10771.676849694522, 11085.833712494481, 39412.408813867245, 41071.0, 45316.54683453255, 46762.0, 46877.76561117172, 47980.04039919112, 53361.73319133535, 62933.68533157305, 63101.0, 66248.00627990681, 12330.260184388966, 12351.567695130627, 12557.43491542901, 12861.228326300452, 13041.478340866259, 14097.577072687836, 15275.0, 15427.0, 15484.612884677974, 15672.0, 13860.528124470524, 14173.929130354281, 14204.289785510477, 14236.928815355857, 14722.779158312847, 13107.475700972236, 13615.455381784617, 13743.862561374259, 13842.377093030636, 13855.0, 12817.102802803714, 13733.381997809922, 13753.656158596115, 13762.449502020208, 14208.50270240578, 10729.03023391344, 11185.496652650812, 11283.717907052389, 11316.94341528287, 12020.519179232733, 9983.650572229937, 10015.0, 11043.447827608426, 11435.485403157045, 11441.0], "value": 7567.598375534439, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1474.2000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 125.0, 172.0, 155.0, 115.0, 116.0, 117.0, 115.0, 116.0, 118.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 111.0, 160.0, 140.0, 137.0, 135.0, 112.0, 128.0, 111.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 185.0, 184.0, 186.0, 185.0, 185.0, 186.0, 182.0, 185.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 60.0, 61.0, 93.0, 61.0, 63.0, 60.0, 61.0, 76.0, 59.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 70.0, 88.0, 70.0, 69.0, 70.0, 82.0, 69.0, 71.0, 86.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 91.0, 91.0, 91.0, 90.0, 90.0, 91.0, 91.0, 90.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 110.0, 127.0, 140.0, 150.0, 97.0, 97.0, 98.0, 96.0], "value": 110.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 83.0, 85.0, 84.0, 83.0, 84.0, 84.0, 86.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 63.0, 64.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 66.0, 69.0, 66.0, 62.0, 59.0, 59.0, 74.0, 84.0, 85.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 83.0, 84.0, 85.0, 83.0, 87.0, 85.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 154.0, 128.0, 141.0, 136.0, 143.0, 144.0, 178.0, 148.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 143.0, 186.0, 230.0, 167.0, 170.0, 165.0, 212.0, 164.0, 165.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 66.0, 64.0, 64.0], "value": 64.9, "unit": "score"}]}]} 22:51:54 INFO - Return code: 0 22:51:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:51:54 ERROR - # TBPL SUCCESS # 22:51:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:51:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:51:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:51:54 INFO - 2017-03-21 22:51:54.884 screenresolution[82574:794165] starting screenresolution argv=screenresolution get 22:51:54 INFO - 2017-03-21 22:51:54.886 screenresolution[82574:794165] Display 0: 1600x1200x32@60 22:51:54 INFO - 2017-03-21 22:51:54.893 screenresolution[82575:794168] starting screenresolution argv=screenresolution list 22:51:54 INFO - Available Modes on Display 0 22:51:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:51:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:51:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:51:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:51:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:51:55 INFO - Intel Iris: 22:51:55 INFO - Chipset Model: Intel Iris 22:51:55 INFO - Type: GPU 22:51:55 INFO - Bus: Built-In 22:51:55 INFO - VRAM (Dynamic, Max): 1536 MB 22:51:55 INFO - Vendor: Intel (0x8086) 22:51:55 INFO - Device ID: 0x0a2e 22:51:55 INFO - Revision ID: 0x0009 22:51:55 INFO - Displays: 22:51:55 INFO - Display: 22:51:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:51:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:51:55 INFO - Display Serial Number: 1600x1200 60 22:51:55 INFO - Main Display: Yes 22:51:55 INFO - Mirror: Off 22:51:55 INFO - Online: Yes 22:51:55 INFO - Rotation: Supported 22:51:55 INFO - Return code: 0 22:51:55 INFO - Running post-action listener: _resource_record_post_action 22:51:55 INFO - [mozharness: 2017-03-22 05:51:55.138214Z] Finished run-tests step (success) 22:51:55 INFO - Running post-run listener: _resource_record_post_run 22:51:55 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 737280; Write bytes: 508939264; Read time: 5; Write time: 1573 22:51:55 INFO - TinderboxPrint: CPU usage
53.7% 22:51:55 INFO - TinderboxPrint: I/O read bytes / time
737,280 / 5 22:51:55 INFO - TinderboxPrint: I/O write bytes / time
508,939,264 / 1,573 22:51:55 INFO - TinderboxPrint: CPU idle
2,227.7 (46.3%) 22:51:55 INFO - TinderboxPrint: CPU system
962.1 (20.0%) 22:51:55 INFO - TinderboxPrint: CPU user
1,619.7 (33.7%) 22:51:55 INFO - TinderboxPrint: Swap in / out
208,928,768 / 0 22:51:55 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201015808; Write bytes: 203761664; Read time: 15735; Write time: 451 22:51:55 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 737280; Write bytes: 295281664; Read time: 5; Write time: 1087 22:51:55 INFO - Running post-run listener: _upload_blobber_files 22:51:55 INFO - Blob upload gear active. 22:51:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:51:55 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 22:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:51:56 INFO - (blobuploader) - INFO - Open directory for files ... 22:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:56 INFO - (blobuploader) - INFO - Done attempting. 22:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:57 INFO - (blobuploader) - INFO - Done attempting. 22:51:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:51:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:58 INFO - (blobuploader) - INFO - Done attempting. 22:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:52:01 INFO - (blobuploader) - INFO - Done attempting. 22:52:01 INFO - (blobuploader) - INFO - Iteration through files over. 22:52:01 INFO - Return code: 0 22:52:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:52:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:52:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb46abea61566e28cf771ce8acc201b8accb933d93fafcfb1b555d5d3f3cafe318da7d7fb1a0fb867f7e6f9b209bf406c1264ed3c6627db09bbdfc25ecd8a9d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e42ad6bc4322203e94fe924c50a94a3111ffc493dcb100a30afd39cf9ce9155a61a75496d28b01441c01d1ca72a66619f1151d056c12025f3c4198b1e1d12e96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a845b03ed08bfaf971785279ad62835fbbbebc864a3e18445a8b1c1ceb71e2fb6cda875bf46109b302cdd2bf976fabe5928c591d1a5e7046c9c2f8786cd835ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60dd8786527c8bf8a54eded6013e008529ce7f12f96208c1a72edb30b97d83dc7731310e0b1158d09a0a1ca8a0c4501f959c37624b89489ba287ff1f7a2cc81"} 22:52:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:52:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:52:01 INFO - Contents: 22:52:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb46abea61566e28cf771ce8acc201b8accb933d93fafcfb1b555d5d3f3cafe318da7d7fb1a0fb867f7e6f9b209bf406c1264ed3c6627db09bbdfc25ecd8a9d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e42ad6bc4322203e94fe924c50a94a3111ffc493dcb100a30afd39cf9ce9155a61a75496d28b01441c01d1ca72a66619f1151d056c12025f3c4198b1e1d12e96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a845b03ed08bfaf971785279ad62835fbbbebc864a3e18445a8b1c1ceb71e2fb6cda875bf46109b302cdd2bf976fabe5928c591d1a5e7046c9c2f8786cd835ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60dd8786527c8bf8a54eded6013e008529ce7f12f96208c1a72edb30b97d83dc7731310e0b1158d09a0a1ca8a0c4501f959c37624b89489ba287ff1f7a2cc81"} 22:52:01 INFO - Running post-run listener: copy_logs_to_upload_dir 22:52:01 INFO - Copying logs to upload dir... 22:52:01 INFO - mkdir: /builds/slave/test/build/upload/logs 22:52:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.561888 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-21 22:52:01.434886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 22:52:01.438248) ========= 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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb46abea61566e28cf771ce8acc201b8accb933d93fafcfb1b555d5d3f3cafe318da7d7fb1a0fb867f7e6f9b209bf406c1264ed3c6627db09bbdfc25ecd8a9d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e42ad6bc4322203e94fe924c50a94a3111ffc493dcb100a30afd39cf9ce9155a61a75496d28b01441c01d1ca72a66619f1151d056c12025f3c4198b1e1d12e96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a845b03ed08bfaf971785279ad62835fbbbebc864a3e18445a8b1c1ceb71e2fb6cda875bf46109b302cdd2bf976fabe5928c591d1a5e7046c9c2f8786cd835ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60dd8786527c8bf8a54eded6013e008529ce7f12f96208c1a72edb30b97d83dc7731310e0b1158d09a0a1ca8a0c4501f959c37624b89489ba287ff1f7a2cc81"} build_url:https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/druDds56Sx-lLlmKZb9MMQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb46abea61566e28cf771ce8acc201b8accb933d93fafcfb1b555d5d3f3cafe318da7d7fb1a0fb867f7e6f9b209bf406c1264ed3c6627db09bbdfc25ecd8a9d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e42ad6bc4322203e94fe924c50a94a3111ffc493dcb100a30afd39cf9ce9155a61a75496d28b01441c01d1ca72a66619f1151d056c12025f3c4198b1e1d12e96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a845b03ed08bfaf971785279ad62835fbbbebc864a3e18445a8b1c1ceb71e2fb6cda875bf46109b302cdd2bf976fabe5928c591d1a5e7046c9c2f8786cd835ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e60dd8786527c8bf8a54eded6013e008529ce7f12f96208c1a72edb30b97d83dc7731310e0b1158d09a0a1ca8a0c4501f959c37624b89489ba287ff1f7a2cc81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 22:52:01.474239) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:52:01.474570) ========= 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.hGQ1UzYKQH/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.7FZerCnRPB/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.005651 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:52:01.524091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 22:52:01.524438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 22:52:01.524821) ========= ========= Total master_lag: 0.49 =========