builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0339 starttime: 1492625512.16 results: success (0) buildid: 20170419094242 builduid: 32c504c4b51a4a57919a07f980cca0ff revision: 5ccc50a53c8a5bb5161ac43cff4f7d009c1c2a28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.159003) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.159504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.159781) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.186553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.186940) ========= 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.6UqIxDaead/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.K58mOe8xYp/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-19 11:11:52-- 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% 161M=0s 2017-04-19 11:11:52 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.387576) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.387934) ========= 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.6UqIxDaead/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.K58mOe8xYp/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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.041252 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:52.451311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-19 11:11:52.451660) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5ccc50a53c8a5bb5161ac43cff4f7d009c1c2a28 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5ccc50a53c8a5bb5161ac43cff4f7d009c1c2a28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6UqIxDaead/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.K58mOe8xYp/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-19 11:11:52,559 truncating revision to first 12 chars 2017-04-19 11:11:52,559 Setting DEBUG logging. 2017-04-19 11:11:52,559 attempt 1/10 2017-04-19 11:11:52,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5ccc50a53c8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 11:11:54,400 unpacking tar archive at: mozilla-beta-5ccc50a53c8a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.109083 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-19 11:11:55.124513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:55.124853) ========= script_repo_revision: 5ccc50a53c8a5bb5161ac43cff4f7d009c1c2a28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:55.125259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:55.125526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 11:11:55.145920) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-19 11:11:55.146283) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6UqIxDaead/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.K58mOe8xYp/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:11:55 INFO - MultiFileLogger online at 20170419 11:11:55 in /builds/slave/test 11:11:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:11:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:55 INFO - {'append_to_log': False, 11:11:55 INFO - 'base_work_dir': '/builds/slave/test', 11:11:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:11:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:55 INFO - 'branch': 'Mozilla-Beta', 11:11:55 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:55 INFO - 'config_files': ('talos/mac_config.py',), 11:11:55 INFO - 'default_actions': ('clobber', 11:11:55 INFO - 'read-buildbot-config', 11:11:55 INFO - 'download-and-extract', 11:11:55 INFO - 'populate-webroot', 11:11:55 INFO - 'create-virtualenv', 11:11:55 INFO - 'install', 11:11:55 INFO - 'run-tests'), 11:11:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:55 INFO - 'download_minidump_stackwalk': True, 11:11:55 INFO - 'download_symbols': 'ondemand', 11:11:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:55 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:55 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:55 INFO - 'gecko_profile': False, 11:11:55 INFO - 'gecko_profile_interval': 0, 11:11:55 INFO - 'installer_path': 'installer.exe', 11:11:55 INFO - 'log_level': 'info', 11:11:55 INFO - 'log_name': 'talos', 11:11:55 INFO - 'log_to_console': True, 11:11:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:11:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:11:55 INFO - 'opt_config_files': (), 11:11:55 INFO - 'pip_index': False, 11:11:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:55 INFO - 'cmd': ('bash', 11:11:55 INFO - '-c', 11:11:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:55 INFO - 'enabled': True, 11:11:55 INFO - 'halt_on_failure': False, 11:11:55 INFO - 'name': 'check_screen_resolution'},), 11:11:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:55 INFO - 'cmd': ('bash', 11:11:55 INFO - '-c', 11:11:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:55 INFO - 'enabled': True, 11:11:55 INFO - 'halt_on_failure': False, 11:11:55 INFO - 'name': 'check_screen_resolution'},), 11:11:55 INFO - 'run_cmd_checks_enabled': True, 11:11:55 INFO - 'suite': 'dromaeojs', 11:11:55 INFO - 'system_bits': '32', 11:11:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:55 INFO - 'title': 't-yosemite-r7-0339', 11:11:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:55 INFO - 'use_talos_json': True, 11:11:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:55 INFO - 'work_dir': 'build'} 11:11:55 INFO - [mozharness: 2017-04-19 18:11:55.358270Z] Running clobber step. 11:11:55 INFO - Running pre-action listener: _resource_record_pre_action 11:11:55 INFO - Running main action method: clobber 11:11:55 INFO - rmtree: /builds/slave/test/build 11:11:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:57 INFO - Running post-action listener: _resource_record_post_action 11:11:57 INFO - [mozharness: 2017-04-19 18:11:57.830822Z] Finished clobber step (success) 11:11:57 INFO - [mozharness: 2017-04-19 18:11:57.830984Z] Running read-buildbot-config step. 11:11:57 INFO - Running pre-action listener: _resource_record_pre_action 11:11:57 INFO - Running main action method: read_buildbot_config 11:11:57 INFO - Using buildbot properties: 11:11:57 INFO - { 11:11:57 INFO - "project": "", 11:11:57 INFO - "product": "firefox", 11:11:57 INFO - "script_repo_revision": "production", 11:11:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:11:57 INFO - "repository": "", 11:11:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:11:57 INFO - "buildid": "20170419094242", 11:11:57 INFO - "pgo_build": "False", 11:11:57 INFO - "basedir": "/builds/slave/test", 11:11:57 INFO - "buildnumber": 10, 11:11:57 INFO - "slavename": "t-yosemite-r7-0339", 11:11:57 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:11:57 INFO - "platform": "yosemite_r7", 11:11:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:11:57 INFO - "branch": "mozilla-beta", 11:11:57 INFO - "repo_path": "releases/mozilla-beta", 11:11:57 INFO - "revision": "5ccc50a53c8a5bb5161ac43cff4f7d009c1c2a28", 11:11:57 INFO - "stage_platform": "macosx64", 11:11:57 INFO - "builduid": "32c504c4b51a4a57919a07f980cca0ff", 11:11:57 INFO - "slavebuilddir": "test" 11:11:57 INFO - } 11:11:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 11:11:57 INFO - Running post-action listener: _resource_record_post_action 11:11:57 INFO - [mozharness: 2017-04-19 18:11:57.834410Z] Finished read-buildbot-config step (success) 11:11:57 INFO - [mozharness: 2017-04-19 18:11:57.834551Z] Running download-and-extract step. 11:11:57 INFO - Running pre-action listener: _resource_record_pre_action 11:11:57 INFO - Running main action method: download_and_extract 11:11:57 INFO - mkdir: /builds/slave/test/build/tests 11:11:57 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')]} 11:11:57 INFO - trying https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 11:11:57 INFO - Downloading https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:11:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 11:11:59 INFO - Downloaded 1165 bytes. 11:11:59 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:11:59 INFO - Using the following test package requirements: 11:11:59 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:11:59 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:11:59 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 11:11:59 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:11:59 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 11:11:59 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:11:59 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:11:59 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 11:11:59 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:11:59 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:11:59 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 11:11:59 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:11:59 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 11:11:59 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:11:59 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 11:11:59 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:11:59 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 11:11:59 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 11:11:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:11:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:11:59 INFO - Fetch https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:12:00 INFO - Expected file size: 51220719 11:12:00 INFO - Obtained file size: 51220719 11:12:16 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:12:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:12:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:12:16 INFO - Fetch https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:12:18 INFO - Expected file size: 51220719 11:12:18 INFO - Obtained file size: 51220719 11:12:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 11:12:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 11:12:33 INFO - Fetch https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 11:12:34 INFO - Expected file size: 14404424 11:12:34 INFO - Obtained file size: 14404424 11:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:35 INFO - trying https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:12:35 INFO - Downloading https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 11:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 11:12:36 INFO - Downloaded 59193673 bytes. 11:12:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:12:36 INFO - mkdir: /builds/slave/test/properties 11:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:36 INFO - Contents: 11:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:12:37 INFO - Running post-action listener: _resource_record_post_action 11:12:37 INFO - Running post-action listener: set_extra_try_arguments 11:12:37 INFO - [mozharness: 2017-04-19 18:12:37.663621Z] Finished download-and-extract step (success) 11:12:37 INFO - [mozharness: 2017-04-19 18:12:37.663771Z] Running populate-webroot step. 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: populate_webroot 11:12:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:37 INFO - '--tppagecycles', 11:12:37 INFO - '7'], 11:12:37 INFO - 'tests': ['tsvgm']}}, 11:12:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['damp', 'tps']}, 11:12:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:12:37 INFO - 'tests': ['damp', 'tps']}, 11:12:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['dromaeo_dom']}, 11:12:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['basic_compositor_video']}, 11:12:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:12:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['a11yr', 11:12:37 INFO - 'ts_paint', 11:12:37 INFO - 'tpaint', 11:12:37 INFO - 'sessionrestore', 11:12:37 INFO - 'sessionrestore_no_auto_restore', 11:12:37 INFO - 'tabpaint']}, 11:12:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tsvgx', 11:12:37 INFO - 'tsvgr_opacity', 11:12:37 INFO - 'tart', 11:12:37 INFO - 'tscrollx', 11:12:37 INFO - 'cart', 11:12:37 INFO - 'tsvg_static']}, 11:12:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:37 INFO - 'tsvgr_opacity', 11:12:37 INFO - 'tart', 11:12:37 INFO - 'tscrollx', 11:12:37 INFO - 'cart', 11:12:37 INFO - 'tsvg_static']}, 11:12:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s'], 11:12:37 INFO - 'tests': ['tp5o']}, 11:12:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:12:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:12:37 INFO - 'talos_options': ['--disable-e10s', 11:12:37 INFO - '--xperf_path', 11:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:37 INFO - 'tests': ['tp5n']}, 11:12:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:12:37 INFO - 'talos_options': ['--xperf_path', 11:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:37 INFO - 'tests': ['tp5n']}}, 11:12:37 INFO - 'talos.zip': {'path': '', 11:12:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:37 INFO - Running post-action listener: _resource_record_post_action 11:12:37 INFO - [mozharness: 2017-04-19 18:12:37.682175Z] Finished populate-webroot step (success) 11:12:37 INFO - [mozharness: 2017-04-19 18:12:37.682284Z] Running create-virtualenv step. 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: create_virtualenv 11:12:37 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:37 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 11:12:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:37 INFO - Using real prefix '/tools/python27' 11:12:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:38 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:41 INFO - Installing pip.................done. 11:12:41 INFO - Return code: 0 11:12:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:12:41 INFO - Reading from file tmpfile_stdout 11:12:41 INFO - Output received: 11:12:41 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) 11:12:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:41 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 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:12:41 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 11:12:41 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 11:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:41 INFO - 'HOME': '/Users/cltbld', 11:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:41 INFO - 'LOGNAME': 'cltbld', 11:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:41 INFO - 'MOZ_NO_REMOTE': '1', 11:12:41 INFO - 'NO_EM_RESTART': '1', 11:12:41 INFO - 'PAGER': '/bin/cat', 11:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:41 INFO - 'PWD': '/builds/slave/test', 11:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:41 INFO - 'SHELL': '/bin/bash', 11:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:12:41 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:41 INFO - 'USER': 'cltbld', 11:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:41 INFO - 'XPC_FLAGS': '0x0', 11:12:41 INFO - 'XPC_SERVICE_NAME': '0', 11:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:41 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 11:12:41 INFO - Cleaning up... 11:12:41 INFO - Return code: 0 11:12:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:41 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 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:12:41 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 11:12:41 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 11:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:41 INFO - 'HOME': '/Users/cltbld', 11:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:41 INFO - 'LOGNAME': 'cltbld', 11:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:41 INFO - 'MOZ_NO_REMOTE': '1', 11:12:41 INFO - 'NO_EM_RESTART': '1', 11:12:41 INFO - 'PAGER': '/bin/cat', 11:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:41 INFO - 'PWD': '/builds/slave/test', 11:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:41 INFO - 'SHELL': '/bin/bash', 11:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:12:41 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:41 INFO - 'USER': 'cltbld', 11:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:41 INFO - 'XPC_FLAGS': '0x0', 11:12:41 INFO - 'XPC_SERVICE_NAME': '0', 11:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:42 INFO - Downloading/unpacking psutil>=3.1.1 11:12:42 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 11:12:42 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 11:12:42 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 11:12:42 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 11:12:42 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 11:12:42 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 11:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:45 INFO - Installing collected packages: psutil 11:12:45 INFO - Running setup.py install for psutil 11:12:45 INFO - building 'psutil._psutil_osx' extension 11:12:45 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 11:12:46 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 11:12:46 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 11:12:46 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 11:12:46 INFO - building 'psutil._psutil_posix' extension 11:12:46 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 11:12:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:12:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:12:46 INFO - ^ 11:12:46 INFO - 1 warning generated. 11:12:46 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 11:12:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:46 INFO - Successfully installed psutil 11:12:46 INFO - Cleaning up... 11:12:46 INFO - Return code: 0 11:12:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:46 INFO - 'HOME': '/Users/cltbld', 11:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:46 INFO - 'LOGNAME': 'cltbld', 11:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:46 INFO - 'MOZ_NO_REMOTE': '1', 11:12:46 INFO - 'NO_EM_RESTART': '1', 11:12:46 INFO - 'PAGER': '/bin/cat', 11:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:46 INFO - 'PWD': '/builds/slave/test', 11:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:46 INFO - 'SHELL': '/bin/bash', 11:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:12:46 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:46 INFO - 'USER': 'cltbld', 11:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:46 INFO - 'XPC_FLAGS': '0x0', 11:12:46 INFO - 'XPC_SERVICE_NAME': '0', 11:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:49 INFO - Installing collected packages: mozsystemmonitor 11:12:49 INFO - Running setup.py install for mozsystemmonitor 11:12:49 INFO - Successfully installed mozsystemmonitor 11:12:49 INFO - Cleaning up... 11:12:50 INFO - Return code: 0 11:12:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:50 INFO - 'HOME': '/Users/cltbld', 11:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:50 INFO - 'LOGNAME': 'cltbld', 11:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:50 INFO - 'MOZ_NO_REMOTE': '1', 11:12:50 INFO - 'NO_EM_RESTART': '1', 11:12:50 INFO - 'PAGER': '/bin/cat', 11:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:50 INFO - 'PWD': '/builds/slave/test', 11:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:50 INFO - 'SHELL': '/bin/bash', 11:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:12:50 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:50 INFO - 'USER': 'cltbld', 11:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:50 INFO - 'XPC_FLAGS': '0x0', 11:12:50 INFO - 'XPC_SERVICE_NAME': '0', 11:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:50 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 11:12:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:54 INFO - warning: no files found matching '*.txt' 11:12:54 INFO - no previously-included directories found matching 'build' 11:12:54 INFO - no previously-included directories found matching 'dist' 11:12:54 INFO - no previously-included directories found matching '.git*' 11:12:54 INFO - Installing collected packages: jsonschema, functools32 11:12:54 INFO - Running setup.py install for functools32 11:12:54 INFO - warning: no files found matching '*.txt' 11:12:54 INFO - no previously-included directories found matching 'build' 11:12:54 INFO - no previously-included directories found matching 'dist' 11:12:54 INFO - no previously-included directories found matching '.git*' 11:12:54 INFO - Successfully installed jsonschema functools32 11:12:54 INFO - Cleaning up... 11:12:54 INFO - Return code: 0 11:12:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:12:54 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')]} 11:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:54 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')]} 11:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:54 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 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:12:54 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 11:12:54 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 11:12:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:12:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:54 INFO - 'HOME': '/Users/cltbld', 11:12:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:54 INFO - 'LOGNAME': 'cltbld', 11:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:54 INFO - 'MOZ_NO_REMOTE': '1', 11:12:54 INFO - 'NO_EM_RESTART': '1', 11:12:54 INFO - 'PAGER': '/bin/cat', 11:12:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:54 INFO - 'PWD': '/builds/slave/test', 11:12:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:54 INFO - 'SHELL': '/bin/bash', 11:12:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:12:54 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:12:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:54 INFO - 'USER': 'cltbld', 11:12:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:54 INFO - 'XPC_FLAGS': '0x0', 11:12:54 INFO - 'XPC_SERVICE_NAME': '0', 11:12:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:55 INFO - Cleaning up... 11:12:55 INFO - Return code: 0 11:12:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:55 INFO - 'HOME': '/Users/cltbld', 11:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:55 INFO - 'LOGNAME': 'cltbld', 11:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:55 INFO - 'MOZ_NO_REMOTE': '1', 11:12:55 INFO - 'NO_EM_RESTART': '1', 11:12:55 INFO - 'PAGER': '/bin/cat', 11:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:55 INFO - 'PWD': '/builds/slave/test', 11:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:55 INFO - 'SHELL': '/bin/bash', 11:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:12:55 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:55 INFO - 'USER': 'cltbld', 11:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:55 INFO - 'XPC_FLAGS': '0x0', 11:12:55 INFO - 'XPC_SERVICE_NAME': '0', 11:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:57 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 11:12:57 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 11:12:57 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 11:12:57 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 11:12:57 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 11:12:57 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 11:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:59 INFO - Downloading docopt-0.6.1.tar.gz 11:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:59 INFO - Running setup.py install for blobuploader 11:12:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:59 INFO - Running setup.py install for requests 11:12:59 INFO - Running setup.py install for docopt 11:13:00 INFO - Successfully installed blobuploader requests docopt 11:13:00 INFO - Cleaning up... 11:13:00 INFO - Return code: 0 11:13:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:13:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:00 INFO - 'HOME': '/Users/cltbld', 11:13:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:00 INFO - 'LOGNAME': 'cltbld', 11:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:00 INFO - 'MOZ_NO_REMOTE': '1', 11:13:00 INFO - 'NO_EM_RESTART': '1', 11:13:00 INFO - 'PAGER': '/bin/cat', 11:13:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:00 INFO - 'PWD': '/builds/slave/test', 11:13:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:00 INFO - 'SHELL': '/bin/bash', 11:13:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:13:00 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:13:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:00 INFO - 'USER': 'cltbld', 11:13:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:00 INFO - 'XPC_FLAGS': '0x0', 11:13:00 INFO - 'XPC_SERVICE_NAME': '0', 11:13:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:00 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-D0z_yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:00 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-3fjvAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:00 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-_tMRdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:00 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-MXDB4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:00 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-WoXOKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:00 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-qvFY2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-xe0XTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-ojzRl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-eluoh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-mSvqFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-FrGgQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-CrydqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-ZnFDFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-Xe0VTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:01 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-MEhATe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:02 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-lv5omV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:02 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-Smj9nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:02 INFO - Running setup.py install for manifestparser 11:13:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:02 INFO - Running setup.py install for mozcrash 11:13:02 INFO - Running setup.py install for mozdebug 11:13:02 INFO - Running setup.py install for mozdevice 11:13:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:13:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:02 INFO - Running setup.py install for mozfile 11:13:02 INFO - Running setup.py install for mozhttpd 11:13:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Running setup.py install for mozinfo 11:13:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Running setup.py install for mozInstall 11:13:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Running setup.py install for mozleak 11:13:03 INFO - Running setup.py install for mozlog 11:13:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Running setup.py install for moznetwork 11:13:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:03 INFO - Running setup.py install for mozprocess 11:13:04 INFO - Running setup.py install for mozprofile 11:13:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:04 INFO - Running setup.py install for mozrunner 11:13:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:04 INFO - Running setup.py install for mozscreenshot 11:13:04 INFO - Running setup.py install for moztest 11:13:04 INFO - Running setup.py install for mozversion 11:13:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:04 INFO - Cleaning up... 11:13:04 INFO - Return code: 0 11:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 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 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:13:04 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 11:13:04 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 11:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:04 INFO - 'HOME': '/Users/cltbld', 11:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:04 INFO - 'LOGNAME': 'cltbld', 11:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:04 INFO - 'MOZ_NO_REMOTE': '1', 11:13:04 INFO - 'NO_EM_RESTART': '1', 11:13:04 INFO - 'PAGER': '/bin/cat', 11:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:04 INFO - 'PWD': '/builds/slave/test', 11:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:04 INFO - 'SHELL': '/bin/bash', 11:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:13:04 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:04 INFO - 'USER': 'cltbld', 11:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:04 INFO - 'XPC_FLAGS': '0x0', 11:13:04 INFO - 'XPC_SERVICE_NAME': '0', 11:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-ZBI3jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-vC3MLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-UqFbgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-ultT_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-9Wkg67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:05 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)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-WQJrkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:05 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)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-68g1hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:05 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)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-hTsJfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:05 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)) 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:05 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-GXDvTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-DI0lBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-3OGmKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-dhXjlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:06 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)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-o3CU3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-QLPBW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:06 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)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-yxsDK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:06 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)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-r2iifw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:06 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)) 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:06 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-uhvfM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:06 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)) 11:13:06 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)) 11:13:06 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)) 11:13:06 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)) 11:13:06 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)) 11:13:06 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)) 11:13:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:06 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 11:13:06 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 11:13:06 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 11:13:06 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 11:13:06 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 11:13:06 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 11:13:09 INFO - Downloading blessings-1.6.tar.gz 11:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:09 INFO - Installing collected packages: blessings 11:13:09 INFO - Running setup.py install for blessings 11:13:09 INFO - Successfully installed blessings 11:13:09 INFO - Cleaning up... 11:13:09 INFO - Return code: 0 11:13:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:10 INFO - Reading from file tmpfile_stdout 11:13:10 INFO - Current package versions: 11:13:10 INFO - blessings == 1.6 11:13:10 INFO - blobuploader == 1.2.4 11:13:10 INFO - docopt == 0.6.1 11:13:10 INFO - functools32 == 3.2.3-2 11:13:10 INFO - jsonschema == 2.5.1 11:13:10 INFO - manifestparser == 1.1 11:13:10 INFO - mozInstall == 1.12 11:13:10 INFO - mozcrash == 1.0 11:13:10 INFO - mozdebug == 0.1 11:13:10 INFO - mozdevice == 0.49 11:13:10 INFO - mozfile == 1.2 11:13:10 INFO - mozhttpd == 0.7 11:13:10 INFO - mozinfo == 0.9 11:13:10 INFO - mozleak == 0.1 11:13:10 INFO - mozlog == 3.4 11:13:10 INFO - moznetwork == 0.27 11:13:10 INFO - mozprocess == 0.25 11:13:10 INFO - mozprofile == 0.28 11:13:10 INFO - mozrunner == 6.13 11:13:10 INFO - mozscreenshot == 0.1 11:13:10 INFO - mozsystemmonitor == 0.3 11:13:10 INFO - moztest == 0.8 11:13:10 INFO - mozversion == 1.4 11:13:10 INFO - psutil == 3.1.1 11:13:10 INFO - requests == 1.2.3 11:13:10 INFO - wsgiref == 0.1.2 11:13:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:10 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 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:13:10 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 11:13:10 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 11:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:10 INFO - 'HOME': '/Users/cltbld', 11:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:10 INFO - 'LOGNAME': 'cltbld', 11:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:10 INFO - 'MOZ_NO_REMOTE': '1', 11:13:10 INFO - 'NO_EM_RESTART': '1', 11:13:10 INFO - 'PAGER': '/bin/cat', 11:13:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:10 INFO - 'PWD': '/builds/slave/test', 11:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:10 INFO - 'SHELL': '/bin/bash', 11:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:13:10 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:10 INFO - 'USER': 'cltbld', 11:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:10 INFO - 'XPC_FLAGS': '0x0', 11:13:10 INFO - 'XPC_SERVICE_NAME': '0', 11:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 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)) 11:13:10 INFO - Cleaning up... 11:13:10 INFO - Return code: 0 11:13:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:10 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 0x10788ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb561d8f8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, '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.6UqIxDaead/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.K58mOe8xYp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 11:13:10 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 11:13:10 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 11:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:10 INFO - 'HOME': '/Users/cltbld', 11:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:10 INFO - 'LOGNAME': 'cltbld', 11:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:10 INFO - 'MOZ_NO_REMOTE': '1', 11:13:10 INFO - 'NO_EM_RESTART': '1', 11:13:10 INFO - 'PAGER': '/bin/cat', 11:13:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:10 INFO - 'PWD': '/builds/slave/test', 11:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:10 INFO - 'SHELL': '/bin/bash', 11:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:13:10 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:10 INFO - 'USER': 'cltbld', 11:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:10 INFO - 'XPC_FLAGS': '0x0', 11:13:10 INFO - 'XPC_SERVICE_NAME': '0', 11:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:13:10 INFO - Cleaning up... 11:13:10 INFO - Return code: 0 11:13:10 INFO - Running post-action listener: _resource_record_post_action 11:13:10 INFO - Running post-action listener: _start_resource_monitoring 11:13:10 INFO - Starting resource monitoring. 11:13:10 INFO - [mozharness: 2017-04-19 18:13:10.758916Z] Finished create-virtualenv step (success) 11:13:10 INFO - [mozharness: 2017-04-19 18:13:10.759865Z] Running install step. 11:13:10 INFO - Running pre-action listener: _resource_record_pre_action 11:13:10 INFO - Running main action method: install 11:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:11 INFO - Reading from file tmpfile_stdout 11:13:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:11 INFO - Reading from file tmpfile_stdout 11:13:11 INFO - Output received: 11:13:11 INFO - Usage: mozinstall [options] installer 11:13:11 INFO - Options: 11:13:11 INFO - -h, --help show this help message and exit 11:13:11 INFO - -d DEST, --destination=DEST 11:13:11 INFO - Directory to install application into. [default: 11:13:11 INFO - "/builds/slave/test"] 11:13:11 INFO - --app=APP Application being installed. [default: firefox] 11:13:11 INFO - mkdir: /builds/slave/test/build/application 11:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:13:25 INFO - Reading from file tmpfile_stdout 11:13:25 INFO - Output received: 11:13:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:13:25 INFO - Running post-action listener: _resource_record_post_action 11:13:25 INFO - [mozharness: 2017-04-19 18:13:25.680907Z] Finished install step (success) 11:13:25 INFO - [mozharness: 2017-04-19 18:13:25.681037Z] Running run-tests step. 11:13:25 INFO - Running pre-action listener: _resource_record_pre_action 11:13:25 INFO - Running main action method: run_tests 11:13:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:13:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:13:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:13:25 INFO - 2017-04-19 11:13:25.695 screenresolution[1638:7626] starting screenresolution argv=screenresolution get 11:13:25 INFO - 2017-04-19 11:13:25.698 screenresolution[1638:7626] Display 0: 1600x1200x32@60 11:13:25 INFO - 2017-04-19 11:13:25.704 screenresolution[1639:7629] starting screenresolution argv=screenresolution list 11:13:25 INFO - Available Modes on Display 0 11:13:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:13:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:13:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:13:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:13:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:13:25 INFO - Intel Iris: 11:13:25 INFO - Chipset Model: Intel Iris 11:13:25 INFO - Type: GPU 11:13:25 INFO - Bus: Built-In 11:13:25 INFO - VRAM (Dynamic, Max): 1536 MB 11:13:25 INFO - Vendor: Intel (0x8086) 11:13:25 INFO - Device ID: 0x0a2e 11:13:25 INFO - Revision ID: 0x0009 11:13:25 INFO - Displays: 11:13:25 INFO - Display: 11:13:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:13:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:13:25 INFO - Display Serial Number: 1600x1200 60 11:13:25 INFO - Main Display: Yes 11:13:25 INFO - Mirror: Off 11:13:25 INFO - Online: Yes 11:13:25 INFO - Rotation: Supported 11:13:25 INFO - Return code: 0 11:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:25 INFO - Python 2.7.3 11:13:25 INFO - Return code: 0 11:13:25 INFO - grabbing minidump binary from tooltool 11:13:25 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')]} 11:13:25 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 0x107668d30>, '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 0x10758fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10765dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:25 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 11:13:25 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 11:13:25 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 11:13:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:26 INFO - Return code: 0 11:13:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:13:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:26 INFO - ENV: RUST_BACKTRACE is now 1 11:13:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:13:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0339', '--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 11:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0339 --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 11:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6UqIxDaead/Render', 11:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:26 INFO - 'HOME': '/Users/cltbld', 11:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:26 INFO - 'LOGNAME': 'cltbld', 11:13:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:26 INFO - 'MOZ_NO_REMOTE': '1', 11:13:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:26 INFO - 'NO_EM_RESTART': '1', 11:13:26 INFO - 'PAGER': '/bin/cat', 11:13:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:26 INFO - 'PWD': '/builds/slave/test', 11:13:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:26 INFO - 'RUST_BACKTRACE': '1', 11:13:26 INFO - 'SHELL': '/bin/bash', 11:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K58mOe8xYp/Listeners', 11:13:26 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 11:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:26 INFO - 'USER': 'cltbld', 11:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:26 INFO - 'XPC_FLAGS': '0x0', 11:13:26 INFO - 'XPC_SERVICE_NAME': '0', 11:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0339', '--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 11:13:26 INFO - mozversion application_buildid: 20170419094242 11:13:26 INFO - mozversion application_changeset: 5ccc50a53c8a5bb5161ac43cff4f7d009c1c2a28 11:13:26 INFO - mozversion application_display_name: Firefox 11:13:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:26 INFO - mozversion application_name: Firefox 11:13:26 INFO - mozversion application_remotingname: firefox 11:13:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:26 INFO - mozversion application_vendor: Mozilla 11:13:26 INFO - mozversion application_version: 54.0 11:13:26 INFO - mozversion platform_buildid: 20170419094242 11:13:26 INFO - mozversion platform_changeset: 5ccc50a53c8a5bb5161ac43cff4f7d009c1c2a28 11:13:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:26 INFO - mozversion platform_version: 54.0 11:13:26 INFO - using testdate: 1492625606 11:13:26 INFO - actual date: 1492625606 11:13:26 INFO - starting webserver on 'localhost:49237' 11:13:26 INFO - SUITE-START | Running 2 tests 11:13:26 INFO - TEST-START | dromaeo_css 11:13:26 INFO - operating with platform_type : mac_ 11:13:26 INFO - Initialising browser for dromaeo_css test... 11:13:26 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpqrwKXb/profile http://localhost:49237/getInfo.html) 11:13:28 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 11:13:28 INFO - PROCESS | 1649 | colorDepth:24 11:13:28 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 11:13:28 INFO - PROCESS | 1649 | __metrics 11:13:28 INFO - PROCESS | 1649 | 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" 11:13:28 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:29 INFO - TEST-INFO | 1649: exit 0 11:13:29 INFO - Browser initialized. 11:13:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:29 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpqrwKXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:41 INFO - PROCESS | 1652 | RSS: Main: 164880384 11:13:41 INFO - PROCESS | 1652 | 11:16:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 11:16:46 INFO - PROCESS | 1652 | RSS: Main: 291717120 11:16:46 INFO - PROCESS | 1652 | 11:19:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 11:19:50 INFO - PROCESS | 1652 | RSS: Main: 307703808 11:19:50 INFO - PROCESS | 1652 | 11:22:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 11:22:53 INFO - PROCESS | 1652 | RSS: Main: 298901504 11:22:53 INFO - PROCESS | 1652 | 11:25:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 11:25:56 INFO - PROCESS | 1652 | RSS: Main: 279900160 11:25:56 INFO - PROCESS | 1652 | 11:28:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 11:29:00 INFO - PROCESS | 1652 | RSS: Main: 273002496 11:29:00 INFO - PROCESS | 1652 | 11:32:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 11:32:03 INFO - PROCESS | 1652 | RSS: Main: 482836480 11:32:03 INFO - PROCESS | 1652 | 11:32:03 INFO - PROCESS | 1652 | __start_tp_report 11:32:03 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 11:32:03 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 11:32:03 INFO - PROCESS | 1652 | |i|pagename|runs| 11:32:03 INFO - PROCESS | 1652 | |0;dojo.html;2880.711928807118;3546.4503002034685;3582.767120137191;3586.2289607734347;3615.367310720623;6186.226721659793;6186.9999999999945;6207.689615519223;6207.875842483148;6211.751529938797;6162.784302549411;6213.099100630406;6213.937860621392;6236.84407889803;6236.937630623704;5511.889762204763;5551.861203469905;5586.581006424514;5630.634008789436;5677.829665110033;5427.83716488504;5436.510714035736;5633.7183140843;5639;5640.746166422521;5479.53423958964;5532.834014979537;5536.916946245809;5537.612367134302;5559.777608895639;5578.609497335188;5582.692951887645;5615.775368985256;5632.295963004624;5656.688882111483;5468.316460442445;5555.611107222496;5566.888662226733;5576.944230557724;5598.44015598441;6050.848728781772;6076.878462430771;6091.482224010964;6185.536084793658;6188.319284878705;6455.903161452582;6468.3208263132165;6471.449926756231;6494.090827284184;6580.967095164494;6685.4985876059;6714.6306953117555;6740.494462915301;6744.49416293775;6752.696128674222;6268.279147898004;6269.780557680459;6270.9372906271265;6287.591306565058;6293.930031894589;6544.8363790905605;6579.539432239697;6643.70103345341;6846.828829279308;6857.588544687334;6368.42684158428;6440.516961227927;6466.902996455057;6511.837204069841;6521.184851893513;6640.667966601651;6677.699503522354;6692.364225398579;6704.698288577026;6705.564138330993;6588.934110658832;6589.472842172615;6596.901046484307;6598.47212223021;6602.7028783704845;6303.936960630427;6324.810255692337;6417.647029413333;6431.356864313625;6619.536632435779;5121.692698438105;5225.216217567319;5229.320188375486;5243.790248390022;5262.3158989331905;4771.021940502189;4787.3537072495465;4795.232762758012;4799.472058073609;4805;6277.843053923689;6284.183056202664;6284.497240220771;6286.4342209201395;6308.905366419507;6377.808665740035;6702.698378572976;6715.630640314829;6730.8653826924165;6738.561993470409;6129.20597562684;6166.599171053867;6197.1324014637985;6226.6575338355915;6251.624902505864;5848.53211743068;5915.852103697442;5921.467067963904;5934.258217722785;5938.317093534212;6882.070920425778;6909.032735417046;6923.238443771081;6925.099737034153;6954.165500140117;6393.840153996187;6431.485481161402;6607.174103237096;6634.336566343327;6673.599584024974;5816.272965879265;6915.135608048994;6940.063091482787;6940.444764418935;6950.8609827804175;6557.213134423709;6558.540902136805;6595.967020164869;6611.801645950629;6632.90050649231;5821.854453638693;6407.455366293917;6420.871582568416;6596.70314835824;6709.597424154371;6483.286838447672;6483.935160648522;6497.4477169441125;6506;6511.609303441809;6471.288158302489;6502.642354670538;6516.902246466212;6525.575837570543;6532.41208291256;6168.753249869955;6211.378862113753;6260.029695397221;6316.968415157895;6407.295197528175;5763.394843541368;6469.870602587827;6505.349465053457;6512.05575191604;6521.315261897433;6328.557001009885;6345.2702939160745;6350.96824515893;6361.968190159205;6382.425581697484 11:32:03 INFO - PROCESS | 1652 | |1;ext.html;786.5320134519959;791.8020494876281;830.5805568188064;907.5371560504145;914.5290175559584;30485.237869053286;42478.78760606197;43330.56669433305;43422.782886085566;43440;42609.7869510652;42915.57084429155;42976;44898.77550612242;44936.550634493644;7977.202279772035;9753.268504862128;9914.256430767686;9929.453880036595;9930.006999300085;8006.399520035991;9701.70894873155;11767.705807354841;11770.882291177108;11779;11860.52557897683;11869.228500147463;11898.107641926847;11900;11901.226420282697;11829.526818927232;11839.526418943233;11852.525898964032;11864.050875929948;11866.228695134789;11601.593944211912;11643.301401915913;11645.359505227209;11665.533378664843;11669.766604667944;42029.949251268656;42096.73709788711;42234;42252.36621450681;42309.36535951963;3876.6704830089475;4077.938830917539;4085.3667681509414;4086;4113.341865301567;27079.323016924536;29535.113946581638;29570.408591828258;31058.689413106033;31411.37177256442;2756.60029295753;3174.777765556412;3348.631650518441;3415.5389022481895;3429.7084747796466;298845;301598;301955;302723.97276027396;303362;45856.8535786608;54293;54755;54920.72539637276;54929.45070549323;46603.766981164874;57098;57103.14345284824;57173.71413142908;57303;15520.767188492182;15839.52481425559;15874.44439444637;15879.444219452495;15907;12033.578824741267;12106;13558.728825423435;13581.932090339486;13590.728185436434;11296.717582060513;12429.254244745343;12642.115051946275;12736.235825850294;12818.871811281768;5360.571154307646;5374.11327131019;5405.621606487587;5409.810656626999;5423.403425623178;1156.3928937307812;1158.7161145519233;1171.1801738782885;1171.6075114836456;1216.30670517804;26738.93044278246;27824.026159084337;27841.32270964028;28024.85987570049;28124;1099.6700989703056;1292.2440372382262;1302.9543965961145;1308.9593772950336;1339.2366351179928;13145.277009764364;13851.099678521065;14327.212003339917;14607.634809129644;14657.780133298009;455924;458288;458658;459456;460294;59009.114863277086;59061.40938590645;59168.70415647894;59249;59508.70245648744;1468.6989167220695;1521.4294639510183;1532.9923350383176;1534.9309281082378;1540.2298850574712;25731.742682572934;26449.60325595079;27212.863935680194;27237.59143612887;27258;48933.75533122312;49075;49207.769805755146;49267;49325.50674493209;419028;419308;419447;420311;421003;35085.82457087698;35488.11279718028;35702.64297357097;35850.64149358473;35861;44674.3298850524;45730.771346143054;45822;46274;46581.3012804815;30074;30815.993920790155;31269;31713.04860854178;32186;30948.22629434282;31135.221619459695;31317.06048818539;32120.518192227602;32272.677273227906;36173.638263617024;36896;37283.06792330105;37539.24921501609;37608.43587346137;31318.373632526767;31762.364752704354;31933.882314118895;32411.837940810146;32431.351372971938;21227.787722123197;24675.629865551673;24911.656374447444;25109.87445062763;25779.871100644377 11:32:03 INFO - PROCESS | 1652 | |2;jquery.html;366.5024630541872;441.0759458933535;451.35907012042907;455.6650861616713;456.36337309453313;20506.692399614;20900.477488062807;21062.946852657362;21564.92175391232;21995.890020549876;22723.886380568074;22763.203287884888;22794;23029.424264393398;23162.30513084606;6698.928171492562;6869.278725733801;7166.498345115844;7257.455690823183;7542.6228688565625;4329.718568293067;4595.058013107322;7681.615919204045;7721.03487064117;7729.690812367527;4410.867673969786;7668.846623067563;7684.615769211517;7690.423218258625;7690.6154692265445;7443.478956473049;7576.204498527685;7676;7676.078870535515;7684.807879802994;7205.35151836332;7400.666969986363;7428.257174282582;7455.627218639101;7466.178720340758;20491.69262461064;26745.598816017777;26869.86565067162;27098;27171.86414067937;2949.2479417748336;2977.493826049577;3044.8629811658307;3054.5876306698756;3193.808371497694;13974.930125349309;16028.679426411407;16367;16385.180740963024;17380.652386952315;2064.95870082599;2122.8195603373733;2124.320217530391;2127.5106725453234;2139.711138996231;171478;171754;174593;178173;179753;13811.585652430444;13867.445302188002;19772.40682779519;20098.69851952222;20337.79662203359;23429;27743.86128069347;27789.888404464;29149.708502915124;30464.84767576192;9977.151942085004;10163.847542286872;10705.197110216764;10754.300970436896;10931.836022459669;8984.32617553686;8990.55047247635;9029.09709029105;9202.539873006323;9215.308851836138;9242.260619150451;9286.399808053755;9391.624335026523;9467.621295148117;9494.287928405398;3421.709154721827;4015.9799201003807;4080.9795951020646;4085.20338533989;4094.1811637672586;764.9634744920553;842.7893026743315;848.1560846957194;867.1675191815801;878.2447095497866;21022.579548408947;21430.924171798524;22168.556628867333;22205.333839984825;22262.666060009113;876.6756300168851;890.3722875372847;908.7682640926521;916.3814425262921;920.3649481857497;10843.240973131962;11400.94299528497;11405.258658187357;11428.771424571461;11447.313161210353;766526;772322;777785;778879;800713;162934;163825.30165517918;163839.3616063848;164305;167434.16282918752;1322.2035395139212;1335.1388354511287;1377.3182274774051;1381.1022835157028;1382.2397681275459;14605.12369257848;18583.44249672512;18861.90569047146;19068.523286917938;19097.236110555423;33920.66079339175;58883.411165887796;64596.35403645904;65722.67138664468;66134.00798987923;84123;84315;86164.56917715371;88251.1174888243;89205;11150.665480035288;11319.170207448138;11564.884351156381;11739.354335511629;11888;10634.30876992993;12716.618501444602;13007.804882926954;13170.946324294226;13181.143225690299;11014.614488492864;11122.944385278022;11403.315801051964;11407.25852819564;11579.768404632028;9263.444193348421;9554.570044347882;10441.269111162146;10682.8397574038;10796.460176990962;11392.892314921766;11678.182527223353;11743.11926605491;11750.94124529372;11843.934045935906;11387.601433949772;11474.311541307548;11562.190646654653;11604.245724027911;11820.113491488344;8581.35639827003;11158.497867595815;11335.376554289593;11423.200375973602;11508.96419322265 11:32:03 INFO - PROCESS | 1652 | |3;mootools.html;1578.0610536730642;1650.9257083431244;1661.8338166183382;1664.5172899859033;1671.5988162840918;11020.338779673226;11711.70720731981;11720.589779357735;11723.237989530675;11742.178047536676;11088.778224435506;11323.773524529524;11393.202475826696;11595.01442377399;11608.59369922053;2469.444375015625;2506.486170335077;2507.1976967370447;2515.5472015037285;2515.7735803777655;2169.305822136917;2439.878006099697;2447.547203767309;2469.5184439034397;2470.5800013997573;2427.0655797517993;2440.8291419600546;2459.8524088554655;2466.371075375777;2476.4428003699204;2015.7681866585383;2426.883633528579;2438.500107477963;2443.2670198940245;2451.4116612013167;2424.248482970267;2444.4622183119686;2452.3256104571205;2453.6442215878596;2458.483718419134;11291.096712262999;11489.482973266224;11494.712632184179;11509.366984815832;11557.942210288978;5979.790707325266;6141.232345956755;6141.263048434216;6148;6152.84617884552;3634.9818250908843;3747.475353450519;3775.6224377562025;3835.137094153821;3849.615038496156;1276.546825876819;1894.7347371368019;1909.312647446918;1941.38846263428;1984.4939540417245;14090.225037622926;14364.850811935125;14700.117992920352;15673.216339183109;15843.76234356474;4732.976335118303;4875.0493653737185;4896.534829191221;4922.950770492321;4924.975375123173;12059;12065.336406497552;12079.456424460921;12092.032637388987;12094.697632559257;4894.486078961729;4992.375953005874;5117.590592752571;5273.209018647233;6044.667543285162;5326.334208223972;5490.725463726798;5578.944210557924;5582.469665381782;5585.804496842591;4001.4397984282223;4011.618896204856;4055.026793569581;4084.36692312692;4106.753594784323;1068.060107105742;1069.272894431794;1072.5227273863056;1084.1218612923558;1086.277625379114;944.8535477001076;967.2358836519071;979.740368802268;988.3921388346115;992.9573947355392;6738.629375384401;6838;6899.206591241971;6907.13660792401;6970.756023539152;970.7136394763562;978.4520668425704;1033.966033966034;1050.6427814543092;1054.9947250263854;3720.7023438124884;4114.362273847559;4356.738595684269;4418.0059486615255;4471.5752003560265;13818.309084545732;14501.637459063608;14505.927470362582;14517.98374113802;14551.417943282362;13823.308834558231;14437.20595367244;14442.855571444152;14458.421663133568;14459.92770036164;9035.548222588845;10624.681259562225;10733.892661073445;10743.78512429747;10755.677329680122;6850.21222559412;6952.539966607069;6964.199117101395;6970.581765094111;7015.965819653821;11457.083433325148;12450.128491005542;12847.614571562868;12988.805167922299;13015.869841301845;9915.553800079158;11888;12552.74894502123;12759.61721148367;12924.612261632166;8559.400841941004;8805.559722014003;8810.691625793066;8825.205731484197;8830.735077947671;10478.528466219192;10569.9958503942;10607;10693.89306106929;10697.090747286567;9026.413283136575;9137.954310228406;9167.49578773174;9176.95411522938;9391.436513809193;8876.822463550563;8895.2883769297;8937.910620893968;8968.148025937526;8985.865212021956;8097.716579919675;8279.047909490244;8288.58557072132;8292.751217463485;8300.169983001651;5877.559183061202;5895.20414744004;5974.940250597612;6061.242344706911;6105.725242364016;6079.513638908965;6126.509879209563;6200.596961197688;6274.435300822948;6373.936260637334 11:32:04 INFO - PROCESS | 1652 | |4;prototype.html;320.30334023498887;338.5125419396068;386.9864554740584;397.73550588858404;398.7926278335266;4381.255186618275;5129.0767661820855;5186.611004174688;5199.688018718874;5210.45290244524;4704.929426058603;4893.094777466171;5021.071101846152;5056.165732654117;5122.974385128078;3296.626428971137;3716.8327425265793;4199.585238487866;4240.7243529170655;4319.114581510783;3808.3906574948014;4237.097588152125;4256.21260066887;4268.274393353122;4275.807588658502;3808.95253805203;3819.427085937104;4293.613574778269;4316.330968699841;4325.221460137174;3684.852605895761;3947;4137.91724165518;4223.683223758199;4331.5884990925815;3489.5289135966573;3877.3796192609047;3881.4954055972826;3909.257241124177;3927.155661532784;4272.6795490338345;4853.854384368439;4934.087193869145;4944.34364487897;4970.353853998993;4766.52334766524;4798.040391921595;4877.5366340197625;4878;4909.558139767438;5288.355822088955;5313.256144139824;5418.756155972991;5462.863428414322;5520.365158006841;4098.631123198897;4263.829446822124;4340.240457919851;4387.561243875587;4410.3825464435;4153.854615088458;4597.632189424838;4988.625853061035;5518.516667499641;5875.529957603424;3841.9231615367535;3848.8075596220638;4098.569650186747;4309.41822853917;4465.531119232499;3938;4593.747343896118;4616.561426664462;4622.965895006254;4624.3294722265755;4754.762261886892;4754.881127971828;4819.855404337805;4863.562279394871;4884.65807393479;4636.542632404831;4687.460941991714;4762.738049407316;5126.154184559506;5191.428942816287;1432.792245124451;1540.6225474758755;1549.7756772149876;1554.6396902710128;1564.3117028507647;1067.7117178361798;1109.0295991007868;1127.808272593661;1177.8292147638545;1202.2726250618425;4654.930176047362;4806.375171227788;4931;5050.621203409759;5065.164247899055;5044.394672639307;5197.558207552401;5701.372848986608;5739.827805165852;5744.793593345361;4706.458757242961;4878.36581244443;5076.6192535559985;5124.974375128175;5187.662801917863;2550.864865135034;2728.6862010869004;2851.6863145054026;2917.9416411672073;2925.297928497188;5271.341082364705;5506.476884695948;5703.973284808774;5834.27071616048;5839.941600584025;4923.77842997066;5012.295819421342;5346.877155797249;5695.689991302023;5900.911486327708;5792.333881603585;5807.970960145172;5828.970855145697;5832.650040997553;5840.795572154869;4631.258998560214;4922.778474968563;5315.969897158582;5323.657590660097;5541.727891564439;4685.718856868599;4976.780688731284;5615.634983726208;5658.40586738403;5663.309927784269;4918.975405122951;4942.505749425029;5079.339685840817;5920.2895652521975;5938.881222375442;3827.6363745444137;3988.282109220368;4073.5926407359025;4102.871710279697;4269.658427325744;5171.896562068662;5489.780408783764;5515.58633102527;5745.712714364181;5780.508656764222;5127.487251274992;5462.426445223195;5488.4785945335125;5530.446955304437;5559.916601250903;4830.9275360870315;4999.425066117443;5433.402325744086;5492.203630473638;5535.280413546213;4513.819447222206;4611.469680986729;5329.920051199313;5370.3287089113865;5443.510084092451;4316.84891028825;4954.405471343462;5132.897342053213;5345.262789593476;5476.274973383372;5024.824131155538;5227.3465816772905;5433.972830135982;5451.264079349237;5455.481729235875 11:32:04 INFO - PROCESS | 1652 | |5;yui.html;752.947293689442;767.2097739328493;789.5736302396703;875.964961401544;886.9911300886992;15942.760858587117;17622.29510819569;17629.911850440763;17636.73544896826;17670.46988590341;16221.91889040556;16255.51233462995;16434.83565164348;16447.424340148067;16498.917505412486;972.4554249620218;976.6191185437649;992.5136683025302;1002.0280328081785;1017.9796404071914;1004.1765752083295;1013.1641395848418;1021.1830535571513;1021.535201483327;1023.4217667018148;1066.4188017530464;1068.6633710381243;1069.315637991686;1069.663056137318;1072.7425417899688;1057.360297020307;1058.8305871060631;1059.570873796106;1062.5324857062867;1062.702443315869;673.2123415603755;792.4373694676786;792.6314263867272;793.083987993868;794.1066300412036;13845.792313115311;16538;17387.21757520902;17550.648987020315;17571.648567028587;14649.34077966494;14695.63260918475;14722.484713034992;14784.039037462531;14882.553523394316;12000;12088.395580220953;12182.634520964386;12297.139200255986;12457.370121799651;3713.424419215026;3752.887413377603;3841.2317536492815;3874.1670540833575;3984.242993831163;115365;116955.41522292334;117659.23511147339;118071.22893156609;118377;10942;11184.217104802585;11616.88383116158;11661.183717139718;11843.46704398304;23317.936721909336;23539.529209415716;23553.293401197992;23563.646545301835;24102.87948560281;7996.056739142377;8094.635741391651;8175.672973081129;8177.67289308421;8198.385121115822;4565.543445655474;4614.191547111294;4634.281686338623;4655.883602909887;4768.284757286435;2760.2823265950997;3469.3581687387914;3479.3389256041273;3485.703715184238;3500.4224302989724;604.1089393145076;605.3552966091099;607.3440684061203;617.5337620096888;619.829546874604;681.8090934538337;684.384054351078;709.3899246647878;711.8932160175912;755.7657126290867;10425.947870260752;10587.15302775776;11003.394813285186;11209.436591678215;11290.209685322114;710.5381502023623;721.2535026247808;721.3651986252064;728.8578727148155;735.4961851131885;4877.341558889504;5140.586338756872;5201.661891977085;5222.686638801684;5230.633855630145;88525.55737221273;99094;105563.47218264014;107794;111152.44423777991;76091;79544;92205;97985.08059677675;99022.50488747655;82614.58692706499;83460.7480887775;84639.57680211683;86743.56628216944;86776.56611716902;8805.955970220108;9438.95280523593;10148.898511014795;10221.9488902555;10228;53473.73263133659;54091.45908541021;54226;55158.44841551533;56284.718576406856;64764;65156.67421662861;66094.66952665205;66832;67634.66182669252;11311.038561722346;11317.71705707364;11368.772624547628;11638.06895448379;12026.037916966447;11048;13669.179849209078;14291.714165716836;14314.713705726035;14370.640733981734;12672.873271267537;12746.553870614483;12917.741645166856;12970.675733106747;13349.332533373099;11876.584319548774;12389.504419823466;12548.623541293775;12615.558455454015;12968;11817.586384476503;12452.31512266834;12464.937675311565;12857.292848893401;12907.225566466042;9133;9220.262379009797;9491.430514169171;9493.291598773783;9898.20814334837;7732.7680169595005;8662.956685216534;9378.109079637423;10014.197444460067;10528.617503963362 11:32:04 INFO - PROCESS | 1652 | __end_tp_report 11:32:04 INFO - PROCESS | 1652 | __start_cc_report 11:32:04 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1354 11:32:04 INFO - PROCESS | 1652 | __end_cc_report 11:32:04 INFO - PROCESS | 1652 | __startTimestamp1492626723988__endTimestamp 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - PROCESS | 1652 | ------- Summary: start ------- 11:32:04 INFO - PROCESS | 1652 | Number of tests: 6 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:6132.63 Median:6316.97 stddev:692.35 (11.0%) stddev-sans-first:645.77 11:32:04 INFO - PROCESS | 1652 | Values: 2880.7 3546.5 3582.8 3586.2 3615.4 6186.2 6187.0 6207.7 6207.9 6211.8 6162.8 6213.1 6213.9 6236.8 6236.9 5511.9 5551.9 5586.6 5630.6 5677.8 5427.8 5436.5 5633.7 5639.0 5640.7 5479.5 5532.8 5536.9 5537.6 5559.8 5578.6 5582.7 5615.8 5632.3 5656.7 5468.3 5555.6 5566.9 5576.9 5598.4 6050.8 6076.9 6091.5 6185.5 6188.3 6455.9 6468.3 6471.4 6494.1 6581.0 6685.5 6714.6 6740.5 6744.5 6752.7 6268.3 6269.8 6270.9 6287.6 6293.9 6544.8 6579.5 6643.7 6846.8 6857.6 6368.4 6440.5 6466.9 6511.8 6521.2 6640.7 6677.7 6692.4 6704.7 6705.6 6588.9 6589.5 6596.9 6598.5 6602.7 6303.9 6324.8 6417.6 6431.4 6619.5 5121.7 5225.2 5229.3 5243.8 5262.3 4771.0 4787.4 4795.2 4799.5 4805.0 6277.8 6284.2 6284.5 6286.4 6308.9 6377.8 6702.7 6715.6 6730.9 6738.6 6129.2 6166.6 6197.1 6226.7 6251.6 5848.5 5915.9 5921.5 5934.3 5938.3 6882.1 6909.0 6923.2 6925.1 6954.2 6393.8 6431.5 6607.2 6634.3 6673.6 5816.3 6915.1 6940.1 6940.4 6950.9 6557.2 6558.5 6596.0 6611.8 6632.9 5821.9 6407.5 6420.9 6596.7 6709.6 6483.3 6483.9 6497.4 6506.0 6511.6 6471.3 6502.6 6516.9 6525.6 6532.4 6168.8 6211.4 6260.0 6317.0 6407.3 5763.4 6469.9 6505.3 6512.1 6521.3 6328.6 6345.3 6351.0 6362.0 6382.4 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:54804.27 Median:32027.20 stddev:105531.94 (329.5%) stddev-sans-first:105750.05 11:32:04 INFO - PROCESS | 1652 | Values: 786.5 791.8 830.6 907.5 914.5 30485.2 42478.8 43330.6 43422.8 43440.0 42609.8 42915.6 42976.0 44898.8 44936.6 7977.2 9753.3 9914.3 9929.5 9930.0 8006.4 9701.7 11767.7 11770.9 11779.0 11860.5 11869.2 11898.1 11900.0 11901.2 11829.5 11839.5 11852.5 11864.1 11866.2 11601.6 11643.3 11645.4 11665.5 11669.8 42029.9 42096.7 42234.0 42252.4 42309.4 3876.7 4077.9 4085.4 4086.0 4113.3 27079.3 29535.1 29570.4 31058.7 31411.4 2756.6 3174.8 3348.6 3415.5 3429.7 298845.0 301598.0 301955.0 302724.0 303362.0 45856.9 54293.0 54755.0 54920.7 54929.5 46603.8 57098.0 57103.1 57173.7 57303.0 15520.8 15839.5 15874.4 15879.4 15907.0 12033.6 12106.0 13558.7 13581.9 13590.7 11296.7 12429.3 12642.1 12736.2 12818.9 5360.6 5374.1 5405.6 5409.8 5423.4 1156.4 1158.7 1171.2 1171.6 1216.3 26738.9 27824.0 27841.3 28024.9 28124.0 1099.7 1292.2 1303.0 1309.0 1339.2 13145.3 13851.1 14327.2 14607.6 14657.8 455924.0 458288.0 458658.0 459456.0 460294.0 59009.1 59061.4 59168.7 59249.0 59508.7 1468.7 1521.4 1533.0 1534.9 1540.2 25731.7 26449.6 27212.9 27237.6 27258.0 48933.8 49075.0 49207.8 49267.0 49325.5 419028.0 419308.0 419447.0 420311.0 421003.0 35085.8 35488.1 35702.6 35850.6 35861.0 44674.3 45730.8 45822.0 46274.0 46581.3 30074.0 30816.0 31269.0 31713.0 32186.0 30948.2 31135.2 31317.1 32120.5 32272.7 36173.6 36896.0 37283.1 37539.2 37608.4 31318.4 31762.4 31933.9 32411.8 32431.4 21227.8 24675.6 24911.7 25109.9 25779.9 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:44503.41 Median:23095.86 stddev:130552.29 (565.3%) stddev-sans-first:130876.46 11:32:04 INFO - PROCESS | 1652 | Values: 366.5 441.1 451.4 455.7 456.4 20506.7 20900.5 21062.9 21564.9 21995.9 22723.9 22763.2 22794.0 23029.4 23162.3 6698.9 6869.3 7166.5 7257.5 7542.6 4329.7 4595.1 7681.6 7721.0 7729.7 4410.9 7668.8 7684.6 7690.4 7690.6 7443.5 7576.2 7676.0 7676.1 7684.8 7205.4 7400.7 7428.3 7455.6 7466.2 20491.7 26745.6 26869.9 27098.0 27171.9 2949.2 2977.5 3044.9 3054.6 3193.8 13974.9 16028.7 16367.0 16385.2 17380.7 2065.0 2122.8 2124.3 2127.5 2139.7 171478.0 171754.0 174593.0 178173.0 179753.0 13811.6 13867.4 19772.4 20098.7 20337.8 23429.0 27743.9 27789.9 29149.7 30464.8 9977.2 10163.8 10705.2 10754.3 10931.8 8984.3 8990.6 9029.1 9202.5 9215.3 9242.3 9286.4 9391.6 9467.6 9494.3 3421.7 4016.0 4081.0 4085.2 4094.2 765.0 842.8 848.2 867.2 878.2 21022.6 21430.9 22168.6 22205.3 22262.7 876.7 890.4 908.8 916.4 920.4 10843.2 11400.9 11405.3 11428.8 11447.3 766526.0 772322.0 777785.0 778879.0 800713.0 162934.0 163825.3 163839.4 164305.0 167434.2 1322.2 1335.1 1377.3 1381.1 1382.2 14605.1 18583.4 18861.9 19068.5 19097.2 33920.7 58883.4 64596.4 65722.7 66134.0 84123.0 84315.0 86164.6 88251.1 89205.0 11150.7 11319.2 11564.9 11739.4 11888.0 10634.3 12716.6 13007.8 13170.9 13181.1 11014.6 11122.9 11403.3 11407.3 11579.8 9263.4 9554.6 10441.3 10682.8 10796.5 11392.9 11678.2 11743.1 11750.9 11843.9 11387.6 11474.3 11562.2 11604.2 11820.1 8581.4 11158.5 11335.4 11423.2 11509.0 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:6925.96 Median:2473.51 stddev:4294.00 (173.6%) stddev-sans-first:4287.24 11:32:04 INFO - PROCESS | 1652 | Values: 1578.1 1650.9 1661.8 1664.5 1671.6 11020.3 11711.7 11720.6 11723.2 11742.2 11088.8 11323.8 11393.2 11595.0 11608.6 2469.4 2506.5 2507.2 2515.5 2515.8 2169.3 2439.9 2447.5 2469.5 2470.6 2427.1 2440.8 2459.9 2466.4 2476.4 2015.8 2426.9 2438.5 2443.3 2451.4 2424.2 2444.5 2452.3 2453.6 2458.5 11291.1 11489.5 11494.7 11509.4 11557.9 5979.8 6141.2 6141.3 6148.0 6152.8 3635.0 3747.5 3775.6 3835.1 3849.6 1276.5 1894.7 1909.3 1941.4 1984.5 14090.2 14364.9 14700.1 15673.2 15843.8 4733.0 4875.0 4896.5 4923.0 4925.0 12059.0 12065.3 12079.5 12092.0 12094.7 4894.5 4992.4 5117.6 5273.2 6044.7 5326.3 5490.7 5578.9 5582.5 5585.8 4001.4 4011.6 4055.0 4084.4 4106.8 1068.1 1069.3 1072.5 1084.1 1086.3 944.9 967.2 979.7 988.4 993.0 6738.6 6838.0 6899.2 6907.1 6970.8 970.7 978.5 1034.0 1050.6 1055.0 3720.7 4114.4 4356.7 4418.0 4471.6 13818.3 14501.6 14505.9 14518.0 14551.4 13823.3 14437.2 14442.9 14458.4 14459.9 9035.5 10624.7 10733.9 10743.8 10755.7 6850.2 6952.5 6964.2 6970.6 7016.0 11457.1 12450.1 12847.6 12988.8 13015.9 9915.6 11888.0 12552.7 12759.6 12924.6 8559.4 8805.6 8810.7 8825.2 8830.7 10478.5 10570.0 10607.0 10693.9 10697.1 9026.4 9138.0 9167.5 9177.0 9391.4 8876.8 8895.3 8937.9 8968.1 8985.9 8097.7 8279.0 8288.6 8292.8 8300.2 5877.6 5895.2 5974.9 6061.2 6105.7 6079.5 6126.5 6200.6 6274.4 6373.9 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4509.02 Median:4878.18 stddev:1262.34 (25.9%) stddev-sans-first:1226.11 11:32:04 INFO - PROCESS | 1652 | Values: 320.3 338.5 387.0 397.7 398.8 4381.3 5129.1 5186.6 5199.7 5210.5 4704.9 4893.1 5021.1 5056.2 5123.0 3296.6 3716.8 4199.6 4240.7 4319.1 3808.4 4237.1 4256.2 4268.3 4275.8 3809.0 3819.4 4293.6 4316.3 4325.2 3684.9 3947.0 4137.9 4223.7 4331.6 3489.5 3877.4 3881.5 3909.3 3927.2 4272.7 4853.9 4934.1 4944.3 4970.4 4766.5 4798.0 4877.5 4878.0 4909.6 5288.4 5313.3 5418.8 5462.9 5520.4 4098.6 4263.8 4340.2 4387.6 4410.4 4153.9 4597.6 4988.6 5518.5 5875.5 3841.9 3848.8 4098.6 4309.4 4465.5 3938.0 4593.7 4616.6 4623.0 4624.3 4754.8 4754.9 4819.9 4863.6 4884.7 4636.5 4687.5 4762.7 5126.2 5191.4 1432.8 1540.6 1549.8 1554.6 1564.3 1067.7 1109.0 1127.8 1177.8 1202.3 4654.9 4806.4 4931.0 5050.6 5065.2 5044.4 5197.6 5701.4 5739.8 5744.8 4706.5 4878.4 5076.6 5125.0 5187.7 2550.9 2728.7 2851.7 2917.9 2925.3 5271.3 5506.5 5704.0 5834.3 5839.9 4923.8 5012.3 5346.9 5695.7 5900.9 5792.3 5808.0 5829.0 5832.7 5840.8 4631.3 4922.8 5316.0 5323.7 5541.7 4685.7 4976.8 5615.6 5658.4 5663.3 4919.0 4942.5 5079.3 5920.3 5938.9 3827.6 3988.3 4073.6 4102.9 4269.7 5171.9 5489.8 5515.6 5745.7 5780.5 5127.5 5462.4 5488.5 5530.4 5559.9 4830.9 4999.4 5433.4 5492.2 5535.3 4513.8 4611.5 5329.9 5370.3 5443.5 4316.8 4954.4 5132.9 5345.3 5476.3 5024.8 5227.3 5434.0 5451.3 5455.5 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:21159.77 Median:23428.73 stddev:30814.33 (131.5%) stddev-sans-first:30862.67 11:32:04 INFO - PROCESS | 1652 | Values: 752.9 767.2 789.6 876.0 887.0 15942.8 17622.3 17629.9 17636.7 17670.5 16221.9 16255.5 16434.8 16447.4 16498.9 972.5 976.6 992.5 1002.0 1018.0 1004.2 1013.2 1021.2 1021.5 1023.4 1066.4 1068.7 1069.3 1069.7 1072.7 1057.4 1058.8 1059.6 1062.5 1062.7 673.2 792.4 792.6 793.1 794.1 13845.8 16538.0 17387.2 17550.6 17571.6 14649.3 14695.6 14722.5 14784.0 14882.6 12000.0 12088.4 12182.6 12297.1 12457.4 3713.4 3752.9 3841.2 3874.2 3984.2 115365.0 116955.4 117659.2 118071.2 118377.0 10942.0 11184.2 11616.9 11661.2 11843.5 23317.9 23539.5 23553.3 23563.6 24102.9 7996.1 8094.6 8175.7 8177.7 8198.4 4565.5 4614.2 4634.3 4655.9 4768.3 2760.3 3469.4 3479.3 3485.7 3500.4 604.1 605.4 607.3 617.5 619.8 681.8 684.4 709.4 711.9 755.8 10425.9 10587.2 11003.4 11209.4 11290.2 710.5 721.3 721.4 728.9 735.5 4877.3 5140.6 5201.7 5222.7 5230.6 88525.6 99094.0 105563.5 107794.0 111152.4 76091.0 79544.0 92205.0 97985.1 99022.5 82614.6 83460.7 84639.6 86743.6 86776.6 8806.0 9439.0 10148.9 10221.9 10228.0 53473.7 54091.5 54226.0 55158.4 56284.7 64764.0 65156.7 66094.7 66832.0 67634.7 11311.0 11317.7 11368.8 11638.1 12026.0 11048.0 13669.2 14291.7 14314.7 14370.6 12672.9 12746.6 12917.7 12970.7 13349.3 11876.6 12389.5 12548.6 12615.6 12968.0 11817.6 12452.3 12464.9 12857.3 12907.2 9133.0 9220.3 9491.4 9493.3 9898.2 7732.8 8663.0 9378.1 10014.2 10528.6 11:32:04 INFO - PROCESS | 1652 | -------- Summary: end -------- 11:32:04 INFO - PROCESS | 1652 | 11:32:04 INFO - TEST-INFO | 1652: exit 0 11:32:04 INFO - TEST-OK | dromaeo_css | took 1118295ms 11:32:04 INFO - TEST-START | kraken 11:32:04 INFO - operating with platform_type : mac_ 11:32:04 INFO - Initialising browser for kraken test... 11:32:04 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpfCTg0L/profile http://localhost:49237/getInfo.html) 11:32:06 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 11:32:06 INFO - PROCESS | 1662 | colorDepth:24 11:32:06 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 11:32:06 INFO - PROCESS | 1662 | __metrics 11:32:06 INFO - PROCESS | 1662 | 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" 11:32:06 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:07 INFO - TEST-INFO | 1662: exit 0 11:32:07 INFO - Browser initialized. 11:32:07 INFO - Running cycle 1/1 for kraken test... 11:32:07 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpfCTg0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:19 INFO - PROCESS | 1664 | RSS: Main: 164880384 11:32:19 INFO - PROCESS | 1664 | 11:32:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:23 INFO - PROCESS | 1664 | RSS: Main: 215482368 11:32:23 INFO - PROCESS | 1664 | 11:32:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 11:32:26 INFO - PROCESS | 1664 | RSS: Main: 231321600 11:32:26 INFO - PROCESS | 1664 | 11:32:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 11:32:30 INFO - PROCESS | 1664 | RSS: Main: 328818688 11:32:30 INFO - PROCESS | 1664 | 11:32:32 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 11:32:33 INFO - PROCESS | 1664 | RSS: Main: 230383616 11:32:33 INFO - PROCESS | 1664 | 11:32:35 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:35 INFO - PROCESS | 1664 | RSS: Main: 231542784 11:32:35 INFO - PROCESS | 1664 | 11:32:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:39 INFO - PROCESS | 1664 | RSS: Main: 271257600 11:32:39 INFO - PROCESS | 1664 | 11:32:42 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:42 INFO - PROCESS | 1664 | RSS: Main: 272416768 11:32:42 INFO - PROCESS | 1664 | 11:32:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 11:32:46 INFO - PROCESS | 1664 | RSS: Main: 270577664 11:32:46 INFO - PROCESS | 1664 | 11:32:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:48 INFO - PROCESS | 1664 | RSS: Main: 247169024 11:32:48 INFO - PROCESS | 1664 | 11:32:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:50 INFO - PROCESS | 1664 | RSS: Main: 250916864 11:32:50 INFO - PROCESS | 1664 | 11:32:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:53 INFO - PROCESS | 1664 | RSS: Main: 257187840 11:32:53 INFO - PROCESS | 1664 | 11:32:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:57 INFO - PROCESS | 1664 | RSS: Main: 271851520 11:32:57 INFO - PROCESS | 1664 | 11:33:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:00 INFO - PROCESS | 1664 | RSS: Main: 264937472 11:33:00 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 11:33:02 INFO - PROCESS | 1664 | RSS: Main: 309469184 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | __start_tp_report 11:33:02 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 11:33:02 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 11:33:02 INFO - PROCESS | 1664 | |i|pagename|runs| 11:33:02 INFO - PROCESS | 1664 | |0;ai-astar;106;117;115;116;117;117;117;116;120;115 11:33:02 INFO - PROCESS | 1664 | |1;audio-beat-detection;152;96;123;174;138;116;108;105;130;129 11:33:02 INFO - PROCESS | 1664 | |2;audio-dft;184;181;181;183;182;184;183;182;182;184 11:33:02 INFO - PROCESS | 1664 | |3;audio-fft;83;60;60;89;64;59;58;61;78;58 11:33:02 INFO - PROCESS | 1664 | |4;audio-oscillator;89;69;86;69;69;69;82;70;68;82 11:33:02 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;121;115;86;93;134;86;88;87;87;87 11:33:02 INFO - PROCESS | 1664 | |6;imaging-darkroom;94;92;95;93;93;93;94;94;93;93 11:33:02 INFO - PROCESS | 1664 | |7;imaging-desaturate;84;84;87;83;84;83;83;83;85;83 11:33:02 INFO - PROCESS | 1664 | |8;json-parse-financial;60;58;60;60;62;63;65;64;64;63 11:33:02 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;60;71;55;63;62;59;59;60;58;60 11:33:02 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;85;82;85;82;77;71;81;93;98;102 11:33:02 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;134;144;152;143;135;137;135;138;182;140 11:33:02 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;162;162;160;162;164;162;160;161;161;162 11:33:02 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;65;64;64;63;64;63;62;62;63;62 11:33:02 INFO - PROCESS | 1664 | __end_tp_report 11:33:02 INFO - PROCESS | 1664 | __start_cc_report 11:33:02 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2089 11:33:02 INFO - PROCESS | 1664 | __end_cc_report 11:33:02 INFO - PROCESS | 1664 | __startTimestamp1492626782840__endTimestamp 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | ------- Summary: start ------- 11:33:02 INFO - PROCESS | 1664 | Number of tests: 14 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:115.60 Median:117.00 stddev:3.66 (3.1%) stddev-sans-first:1.50 11:33:02 INFO - PROCESS | 1664 | Values: 106.0 117.0 115.0 116.0 117.0 117.0 117.0 116.0 120.0 115.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:134.00 stddev:23.36 (17.4%) stddev-sans-first:22.97 11:33:02 INFO - PROCESS | 1664 | Values: 152.0 96.0 123.0 174.0 138.0 116.0 108.0 105.0 130.0 129.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.17 (0.6%) stddev-sans-first:1.13 11:33:02 INFO - PROCESS | 1664 | Values: 184.0 181.0 181.0 183.0 182.0 184.0 183.0 182.0 182.0 184.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:67.00 Median:62.50 stddev:11.69 (18.7%) stddev-sans-first:10.87 11:33:02 INFO - PROCESS | 1664 | Values: 83.0 60.0 60.0 89.0 64.0 59.0 58.0 61.0 78.0 58.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.00 stddev:8.38 (11.0%) stddev-sans-first:7.28 11:33:02 INFO - PROCESS | 1664 | Values: 89.0 69.0 86.0 69.0 69.0 69.0 82.0 70.0 68.0 82.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:98.40 Median:87.00 stddev:17.91 (20.6%) stddev-sans-first:17.03 11:33:02 INFO - PROCESS | 1664 | Values: 121.0 115.0 86.0 93.0 134.0 86.0 88.0 87.0 87.0 87.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 11:33:02 INFO - PROCESS | 1664 | Values: 94.0 92.0 95.0 93.0 93.0 93.0 94.0 94.0 93.0 93.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.29 (1.5%) stddev-sans-first:1.36 11:33:02 INFO - PROCESS | 1664 | Values: 84.0 84.0 87.0 83.0 84.0 83.0 83.0 83.0 85.0 83.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:63.00 stddev:2.28 (3.6%) stddev-sans-first:2.32 11:33:02 INFO - PROCESS | 1664 | Values: 60.0 58.0 60.0 60.0 62.0 63.0 65.0 64.0 64.0 63.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.00 stddev:4.22 (7.0%) stddev-sans-first:4.47 11:33:02 INFO - PROCESS | 1664 | Values: 60.0 71.0 55.0 63.0 62.0 59.0 59.0 60.0 58.0 60.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:83.50 stddev:9.50 (11.4%) stddev-sans-first:10.07 11:33:02 INFO - PROCESS | 1664 | Values: 85.0 82.0 85.0 82.0 77.0 71.0 81.0 93.0 98.0 102.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:141.50 stddev:14.42 (10.2%) stddev-sans-first:14.84 11:33:02 INFO - PROCESS | 1664 | Values: 134.0 144.0 152.0 143.0 135.0 137.0 135.0 138.0 182.0 140.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 11:33:02 INFO - PROCESS | 1664 | Values: 162.0 162.0 160.0 162.0 164.0 162.0 160.0 161.0 161.0 162.0 11:33:02 INFO - PROCESS | 1664 | 11:33:02 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.03 (1.6%) stddev-sans-first:0.87 11:33:02 INFO - PROCESS | 1664 | Values: 65.0 64.0 64.0 63.0 64.0 63.0 62.0 62.0 63.0 62.0 11:33:02 INFO - PROCESS | 1664 | -------- Summary: end -------- 11:33:02 INFO - PROCESS | 1664 | 11:33:03 INFO - TEST-INFO | 1664: exit 0 11:33:03 INFO - TEST-OK | kraken | took 59096ms 11:33:03 INFO - SUITE-END | took 1177s 11:33:04 INFO - Completed test suite (00:19:37) 11:33:04 INFO - javascript benchmark 11:33:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.702931172191, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2880.711928807118, 3546.4503002034685, 3582.767120137191, 3586.2289607734347, 3615.367310720623, 6186.226721659793, 6186.9999999999945, 6207.689615519223, 6207.875842483148, 6211.751529938797, 6162.784302549411, 6213.099100630406, 6213.937860621392, 6236.84407889803, 6236.937630623704, 5511.889762204763, 5551.861203469905, 5586.581006424514, 5630.634008789436, 5677.829665110033, 5427.83716488504, 5436.510714035736, 5633.7183140843, 5639.0, 5640.746166422521, 5479.53423958964, 5532.834014979537, 5536.916946245809, 5537.612367134302, 5559.777608895639, 5578.609497335188, 5582.692951887645, 5615.775368985256, 5632.295963004624, 5656.688882111483, 5468.316460442445, 5555.611107222496, 5566.888662226733, 5576.944230557724, 5598.44015598441, 6050.848728781772, 6076.878462430771, 6091.482224010964, 6185.536084793658, 6188.319284878705, 6455.903161452582, 6468.3208263132165, 6471.449926756231, 6494.090827284184, 6580.967095164494, 6685.4985876059, 6714.6306953117555, 6740.494462915301, 6744.49416293775, 6752.696128674222, 6268.279147898004, 6269.780557680459, 6270.9372906271265, 6287.591306565058, 6293.930031894589, 6544.8363790905605, 6579.539432239697, 6643.70103345341, 6846.828829279308, 6857.588544687334, 6368.42684158428, 6440.516961227927, 6466.902996455057, 6511.837204069841, 6521.184851893513, 6640.667966601651, 6677.699503522354, 6692.364225398579, 6704.698288577026, 6705.564138330993, 6588.934110658832, 6589.472842172615, 6596.901046484307, 6598.47212223021, 6602.7028783704845, 6303.936960630427, 6324.810255692337, 6417.647029413333, 6431.356864313625, 6619.536632435779, 5121.692698438105, 5225.216217567319, 5229.320188375486, 5243.790248390022, 5262.3158989331905, 4771.021940502189, 4787.3537072495465, 4795.232762758012, 4799.472058073609, 4805.0, 6277.843053923689, 6284.183056202664, 6284.497240220771, 6286.4342209201395, 6308.905366419507, 6377.808665740035, 6702.698378572976, 6715.630640314829, 6730.8653826924165, 6738.561993470409, 6129.20597562684, 6166.599171053867, 6197.1324014637985, 6226.6575338355915, 6251.624902505864, 5848.53211743068, 5915.852103697442, 5921.467067963904, 5934.258217722785, 5938.317093534212, 6882.070920425778, 6909.032735417046, 6923.238443771081, 6925.099737034153, 6954.165500140117, 6393.840153996187, 6431.485481161402, 6607.174103237096, 6634.336566343327, 6673.599584024974, 5816.272965879265, 6915.135608048994, 6940.063091482787, 6940.444764418935, 6950.8609827804175, 6557.213134423709, 6558.540902136805, 6595.967020164869, 6611.801645950629, 6632.90050649231, 5821.854453638693, 6407.455366293917, 6420.871582568416, 6596.70314835824, 6709.597424154371, 6483.286838447672, 6483.935160648522, 6497.4477169441125, 6506.0, 6511.609303441809, 6471.288158302489, 6502.642354670538, 6516.902246466212, 6525.575837570543, 6532.41208291256, 6168.753249869955, 6211.378862113753, 6260.029695397221, 6316.968415157895, 6407.295197528175, 5763.394843541368, 6469.870602587827, 6505.349465053457, 6512.05575191604, 6521.315261897433, 6328.557001009885, 6345.2702939160745, 6350.96824515893, 6361.968190159205, 6382.425581697484], "value": 6086.657081223854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.5320134519959, 791.8020494876281, 830.5805568188064, 907.5371560504145, 914.5290175559584, 30485.237869053286, 42478.78760606197, 43330.56669433305, 43422.782886085566, 43440.0, 42609.7869510652, 42915.57084429155, 42976.0, 44898.77550612242, 44936.550634493644, 7977.202279772035, 9753.268504862128, 9914.256430767686, 9929.453880036595, 9930.006999300085, 8006.399520035991, 9701.70894873155, 11767.705807354841, 11770.882291177108, 11779.0, 11860.52557897683, 11869.228500147463, 11898.107641926847, 11900.0, 11901.226420282697, 11829.526818927232, 11839.526418943233, 11852.525898964032, 11864.050875929948, 11866.228695134789, 11601.593944211912, 11643.301401915913, 11645.359505227209, 11665.533378664843, 11669.766604667944, 42029.949251268656, 42096.73709788711, 42234.0, 42252.36621450681, 42309.36535951963, 3876.6704830089475, 4077.938830917539, 4085.3667681509414, 4086.0, 4113.341865301567, 27079.323016924536, 29535.113946581638, 29570.408591828258, 31058.689413106033, 31411.37177256442, 2756.60029295753, 3174.777765556412, 3348.631650518441, 3415.5389022481895, 3429.7084747796466, 298845.0, 301598.0, 301955.0, 302723.97276027396, 303362.0, 45856.8535786608, 54293.0, 54755.0, 54920.72539637276, 54929.45070549323, 46603.766981164874, 57098.0, 57103.14345284824, 57173.71413142908, 57303.0, 15520.767188492182, 15839.52481425559, 15874.44439444637, 15879.444219452495, 15907.0, 12033.578824741267, 12106.0, 13558.728825423435, 13581.932090339486, 13590.728185436434, 11296.717582060513, 12429.254244745343, 12642.115051946275, 12736.235825850294, 12818.871811281768, 5360.571154307646, 5374.11327131019, 5405.621606487587, 5409.810656626999, 5423.403425623178, 1156.3928937307812, 1158.7161145519233, 1171.1801738782885, 1171.6075114836456, 1216.30670517804, 26738.93044278246, 27824.026159084337, 27841.32270964028, 28024.85987570049, 28124.0, 1099.6700989703056, 1292.2440372382262, 1302.9543965961145, 1308.9593772950336, 1339.2366351179928, 13145.277009764364, 13851.099678521065, 14327.212003339917, 14607.634809129644, 14657.780133298009, 455924.0, 458288.0, 458658.0, 459456.0, 460294.0, 59009.114863277086, 59061.40938590645, 59168.70415647894, 59249.0, 59508.70245648744, 1468.6989167220695, 1521.4294639510183, 1532.9923350383176, 1534.9309281082378, 1540.2298850574712, 25731.742682572934, 26449.60325595079, 27212.863935680194, 27237.59143612887, 27258.0, 48933.75533122312, 49075.0, 49207.769805755146, 49267.0, 49325.50674493209, 419028.0, 419308.0, 419447.0, 420311.0, 421003.0, 35085.82457087698, 35488.11279718028, 35702.64297357097, 35850.64149358473, 35861.0, 44674.3298850524, 45730.771346143054, 45822.0, 46274.0, 46581.3012804815, 30074.0, 30815.993920790155, 31269.0, 31713.04860854178, 32186.0, 30948.22629434282, 31135.221619459695, 31317.06048818539, 32120.518192227602, 32272.677273227906, 36173.638263617024, 36896.0, 37283.06792330105, 37539.24921501609, 37608.43587346137, 31318.373632526767, 31762.364752704354, 31933.882314118895, 32411.837940810146, 32431.351372971938, 21227.787722123197, 24675.629865551673, 24911.656374447444, 25109.87445062763, 25779.871100644377], "value": 19550.003919390947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5024630541872, 441.0759458933535, 451.35907012042907, 455.6650861616713, 456.36337309453313, 20506.692399614, 20900.477488062807, 21062.946852657362, 21564.92175391232, 21995.890020549876, 22723.886380568074, 22763.203287884888, 22794.0, 23029.424264393398, 23162.30513084606, 6698.928171492562, 6869.278725733801, 7166.498345115844, 7257.455690823183, 7542.6228688565625, 4329.718568293067, 4595.058013107322, 7681.615919204045, 7721.03487064117, 7729.690812367527, 4410.867673969786, 7668.846623067563, 7684.615769211517, 7690.423218258625, 7690.6154692265445, 7443.478956473049, 7576.204498527685, 7676.0, 7676.078870535515, 7684.807879802994, 7205.35151836332, 7400.666969986363, 7428.257174282582, 7455.627218639101, 7466.178720340758, 20491.69262461064, 26745.598816017777, 26869.86565067162, 27098.0, 27171.86414067937, 2949.2479417748336, 2977.493826049577, 3044.8629811658307, 3054.5876306698756, 3193.808371497694, 13974.930125349309, 16028.679426411407, 16367.0, 16385.180740963024, 17380.652386952315, 2064.95870082599, 2122.8195603373733, 2124.320217530391, 2127.5106725453234, 2139.711138996231, 171478.0, 171754.0, 174593.0, 178173.0, 179753.0, 13811.585652430444, 13867.445302188002, 19772.40682779519, 20098.69851952222, 20337.79662203359, 23429.0, 27743.86128069347, 27789.888404464, 29149.708502915124, 30464.84767576192, 9977.151942085004, 10163.847542286872, 10705.197110216764, 10754.300970436896, 10931.836022459669, 8984.32617553686, 8990.55047247635, 9029.09709029105, 9202.539873006323, 9215.308851836138, 9242.260619150451, 9286.399808053755, 9391.624335026523, 9467.621295148117, 9494.287928405398, 3421.709154721827, 4015.9799201003807, 4080.9795951020646, 4085.20338533989, 4094.1811637672586, 764.9634744920553, 842.7893026743315, 848.1560846957194, 867.1675191815801, 878.2447095497866, 21022.579548408947, 21430.924171798524, 22168.556628867333, 22205.333839984825, 22262.666060009113, 876.6756300168851, 890.3722875372847, 908.7682640926521, 916.3814425262921, 920.3649481857497, 10843.240973131962, 11400.94299528497, 11405.258658187357, 11428.771424571461, 11447.313161210353, 766526.0, 772322.0, 777785.0, 778879.0, 800713.0, 162934.0, 163825.30165517918, 163839.3616063848, 164305.0, 167434.16282918752, 1322.2035395139212, 1335.1388354511287, 1377.3182274774051, 1381.1022835157028, 1382.2397681275459, 14605.12369257848, 18583.44249672512, 18861.90569047146, 19068.523286917938, 19097.236110555423, 33920.66079339175, 58883.411165887796, 64596.35403645904, 65722.67138664468, 66134.00798987923, 84123.0, 84315.0, 86164.56917715371, 88251.1174888243, 89205.0, 11150.665480035288, 11319.170207448138, 11564.884351156381, 11739.354335511629, 11888.0, 10634.30876992993, 12716.618501444602, 13007.804882926954, 13170.946324294226, 13181.143225690299, 11014.614488492864, 11122.944385278022, 11403.315801051964, 11407.25852819564, 11579.768404632028, 9263.444193348421, 9554.570044347882, 10441.269111162146, 10682.8397574038, 10796.460176990962, 11392.892314921766, 11678.182527223353, 11743.11926605491, 11750.94124529372, 11843.934045935906, 11387.601433949772, 11474.311541307548, 11562.190646654653, 11604.245724027911, 11820.113491488344, 8581.35639827003, 11158.497867595815, 11335.376554289593, 11423.200375973602, 11508.96419322265], "value": 11611.657244745322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.0610536730642, 1650.9257083431244, 1661.8338166183382, 1664.5172899859033, 1671.5988162840918, 11020.338779673226, 11711.70720731981, 11720.589779357735, 11723.237989530675, 11742.178047536676, 11088.778224435506, 11323.773524529524, 11393.202475826696, 11595.01442377399, 11608.59369922053, 2469.444375015625, 2506.486170335077, 2507.1976967370447, 2515.5472015037285, 2515.7735803777655, 2169.305822136917, 2439.878006099697, 2447.547203767309, 2469.5184439034397, 2470.5800013997573, 2427.0655797517993, 2440.8291419600546, 2459.8524088554655, 2466.371075375777, 2476.4428003699204, 2015.7681866585383, 2426.883633528579, 2438.500107477963, 2443.2670198940245, 2451.4116612013167, 2424.248482970267, 2444.4622183119686, 2452.3256104571205, 2453.6442215878596, 2458.483718419134, 11291.096712262999, 11489.482973266224, 11494.712632184179, 11509.366984815832, 11557.942210288978, 5979.790707325266, 6141.232345956755, 6141.263048434216, 6148.0, 6152.84617884552, 3634.9818250908843, 3747.475353450519, 3775.6224377562025, 3835.137094153821, 3849.615038496156, 1276.546825876819, 1894.7347371368019, 1909.312647446918, 1941.38846263428, 1984.4939540417245, 14090.225037622926, 14364.850811935125, 14700.117992920352, 15673.216339183109, 15843.76234356474, 4732.976335118303, 4875.0493653737185, 4896.534829191221, 4922.950770492321, 4924.975375123173, 12059.0, 12065.336406497552, 12079.456424460921, 12092.032637388987, 12094.697632559257, 4894.486078961729, 4992.375953005874, 5117.590592752571, 5273.209018647233, 6044.667543285162, 5326.334208223972, 5490.725463726798, 5578.944210557924, 5582.469665381782, 5585.804496842591, 4001.4397984282223, 4011.618896204856, 4055.026793569581, 4084.36692312692, 4106.753594784323, 1068.060107105742, 1069.272894431794, 1072.5227273863056, 1084.1218612923558, 1086.277625379114, 944.8535477001076, 967.2358836519071, 979.740368802268, 988.3921388346115, 992.9573947355392, 6738.629375384401, 6838.0, 6899.206591241971, 6907.13660792401, 6970.756023539152, 970.7136394763562, 978.4520668425704, 1033.966033966034, 1050.6427814543092, 1054.9947250263854, 3720.7023438124884, 4114.362273847559, 4356.738595684269, 4418.0059486615255, 4471.5752003560265, 13818.309084545732, 14501.637459063608, 14505.927470362582, 14517.98374113802, 14551.417943282362, 13823.308834558231, 14437.20595367244, 14442.855571444152, 14458.421663133568, 14459.92770036164, 9035.548222588845, 10624.681259562225, 10733.892661073445, 10743.78512429747, 10755.677329680122, 6850.21222559412, 6952.539966607069, 6964.199117101395, 6970.581765094111, 7015.965819653821, 11457.083433325148, 12450.128491005542, 12847.614571562868, 12988.805167922299, 13015.869841301845, 9915.553800079158, 11888.0, 12552.74894502123, 12759.61721148367, 12924.612261632166, 8559.400841941004, 8805.559722014003, 8810.691625793066, 8825.205731484197, 8830.735077947671, 10478.528466219192, 10569.9958503942, 10607.0, 10693.89306106929, 10697.090747286567, 9026.413283136575, 9137.954310228406, 9167.49578773174, 9176.95411522938, 9391.436513809193, 8876.822463550563, 8895.2883769297, 8937.910620893968, 8968.148025937526, 8985.865212021956, 8097.716579919675, 8279.047909490244, 8288.58557072132, 8292.751217463485, 8300.169983001651, 5877.559183061202, 5895.20414744004, 5974.940250597612, 6061.242344706911, 6105.725242364016, 6079.513638908965, 6126.509879209563, 6200.596961197688, 6274.435300822948, 6373.936260637334], "value": 5332.10912380748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.30334023498887, 338.5125419396068, 386.9864554740584, 397.73550588858404, 398.7926278335266, 4381.255186618275, 5129.0767661820855, 5186.611004174688, 5199.688018718874, 5210.45290244524, 4704.929426058603, 4893.094777466171, 5021.071101846152, 5056.165732654117, 5122.974385128078, 3296.626428971137, 3716.8327425265793, 4199.585238487866, 4240.7243529170655, 4319.114581510783, 3808.3906574948014, 4237.097588152125, 4256.21260066887, 4268.274393353122, 4275.807588658502, 3808.95253805203, 3819.427085937104, 4293.613574778269, 4316.330968699841, 4325.221460137174, 3684.852605895761, 3947.0, 4137.91724165518, 4223.683223758199, 4331.5884990925815, 3489.5289135966573, 3877.3796192609047, 3881.4954055972826, 3909.257241124177, 3927.155661532784, 4272.6795490338345, 4853.854384368439, 4934.087193869145, 4944.34364487897, 4970.353853998993, 4766.52334766524, 4798.040391921595, 4877.5366340197625, 4878.0, 4909.558139767438, 5288.355822088955, 5313.256144139824, 5418.756155972991, 5462.863428414322, 5520.365158006841, 4098.631123198897, 4263.829446822124, 4340.240457919851, 4387.561243875587, 4410.3825464435, 4153.854615088458, 4597.632189424838, 4988.625853061035, 5518.516667499641, 5875.529957603424, 3841.9231615367535, 3848.8075596220638, 4098.569650186747, 4309.41822853917, 4465.531119232499, 3938.0, 4593.747343896118, 4616.561426664462, 4622.965895006254, 4624.3294722265755, 4754.762261886892, 4754.881127971828, 4819.855404337805, 4863.562279394871, 4884.65807393479, 4636.542632404831, 4687.460941991714, 4762.738049407316, 5126.154184559506, 5191.428942816287, 1432.792245124451, 1540.6225474758755, 1549.7756772149876, 1554.6396902710128, 1564.3117028507647, 1067.7117178361798, 1109.0295991007868, 1127.808272593661, 1177.8292147638545, 1202.2726250618425, 4654.930176047362, 4806.375171227788, 4931.0, 5050.621203409759, 5065.164247899055, 5044.394672639307, 5197.558207552401, 5701.372848986608, 5739.827805165852, 5744.793593345361, 4706.458757242961, 4878.36581244443, 5076.6192535559985, 5124.974375128175, 5187.662801917863, 2550.864865135034, 2728.6862010869004, 2851.6863145054026, 2917.9416411672073, 2925.297928497188, 5271.341082364705, 5506.476884695948, 5703.973284808774, 5834.27071616048, 5839.941600584025, 4923.77842997066, 5012.295819421342, 5346.877155797249, 5695.689991302023, 5900.911486327708, 5792.333881603585, 5807.970960145172, 5828.970855145697, 5832.650040997553, 5840.795572154869, 4631.258998560214, 4922.778474968563, 5315.969897158582, 5323.657590660097, 5541.727891564439, 4685.718856868599, 4976.780688731284, 5615.634983726208, 5658.40586738403, 5663.309927784269, 4918.975405122951, 4942.505749425029, 5079.339685840817, 5920.2895652521975, 5938.881222375442, 3827.6363745444137, 3988.282109220368, 4073.5926407359025, 4102.871710279697, 4269.658427325744, 5171.896562068662, 5489.780408783764, 5515.58633102527, 5745.712714364181, 5780.508656764222, 5127.487251274992, 5462.426445223195, 5488.4785945335125, 5530.446955304437, 5559.916601250903, 4830.9275360870315, 4999.425066117443, 5433.402325744086, 5492.203630473638, 5535.280413546213, 4513.819447222206, 4611.469680986729, 5329.920051199313, 5370.3287089113865, 5443.510084092451, 4316.84891028825, 4954.405471343462, 5132.897342053213, 5345.262789593476, 5476.274973383372, 5024.824131155538, 5227.3465816772905, 5433.972830135982, 5451.264079349237, 5455.481729235875], "value": 4142.723843437565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.947293689442, 767.2097739328493, 789.5736302396703, 875.964961401544, 886.9911300886992, 15942.760858587117, 17622.29510819569, 17629.911850440763, 17636.73544896826, 17670.46988590341, 16221.91889040556, 16255.51233462995, 16434.83565164348, 16447.424340148067, 16498.917505412486, 972.4554249620218, 976.6191185437649, 992.5136683025302, 1002.0280328081785, 1017.9796404071914, 1004.1765752083295, 1013.1641395848418, 1021.1830535571513, 1021.535201483327, 1023.4217667018148, 1066.4188017530464, 1068.6633710381243, 1069.315637991686, 1069.663056137318, 1072.7425417899688, 1057.360297020307, 1058.8305871060631, 1059.570873796106, 1062.5324857062867, 1062.702443315869, 673.2123415603755, 792.4373694676786, 792.6314263867272, 793.083987993868, 794.1066300412036, 13845.792313115311, 16538.0, 17387.21757520902, 17550.648987020315, 17571.648567028587, 14649.34077966494, 14695.63260918475, 14722.484713034992, 14784.039037462531, 14882.553523394316, 12000.0, 12088.395580220953, 12182.634520964386, 12297.139200255986, 12457.370121799651, 3713.424419215026, 3752.887413377603, 3841.2317536492815, 3874.1670540833575, 3984.242993831163, 115365.0, 116955.41522292334, 117659.23511147339, 118071.22893156609, 118377.0, 10942.0, 11184.217104802585, 11616.88383116158, 11661.183717139718, 11843.46704398304, 23317.936721909336, 23539.529209415716, 23553.293401197992, 23563.646545301835, 24102.87948560281, 7996.056739142377, 8094.635741391651, 8175.672973081129, 8177.67289308421, 8198.385121115822, 4565.543445655474, 4614.191547111294, 4634.281686338623, 4655.883602909887, 4768.284757286435, 2760.2823265950997, 3469.3581687387914, 3479.3389256041273, 3485.703715184238, 3500.4224302989724, 604.1089393145076, 605.3552966091099, 607.3440684061203, 617.5337620096888, 619.829546874604, 681.8090934538337, 684.384054351078, 709.3899246647878, 711.8932160175912, 755.7657126290867, 10425.947870260752, 10587.15302775776, 11003.394813285186, 11209.436591678215, 11290.209685322114, 710.5381502023623, 721.2535026247808, 721.3651986252064, 728.8578727148155, 735.4961851131885, 4877.341558889504, 5140.586338756872, 5201.661891977085, 5222.686638801684, 5230.633855630145, 88525.55737221273, 99094.0, 105563.47218264014, 107794.0, 111152.44423777991, 76091.0, 79544.0, 92205.0, 97985.08059677675, 99022.50488747655, 82614.58692706499, 83460.7480887775, 84639.57680211683, 86743.56628216944, 86776.56611716902, 8805.955970220108, 9438.95280523593, 10148.898511014795, 10221.9488902555, 10228.0, 53473.73263133659, 54091.45908541021, 54226.0, 55158.44841551533, 56284.718576406856, 64764.0, 65156.67421662861, 66094.66952665205, 66832.0, 67634.66182669252, 11311.038561722346, 11317.71705707364, 11368.772624547628, 11638.06895448379, 12026.037916966447, 11048.0, 13669.179849209078, 14291.714165716836, 14314.713705726035, 14370.640733981734, 12672.873271267537, 12746.553870614483, 12917.741645166856, 12970.675733106747, 13349.332533373099, 11876.584319548774, 12389.504419823466, 12548.623541293775, 12615.558455454015, 12968.0, 11817.586384476503, 12452.31512266834, 12464.937675311565, 12857.292848893401, 12907.225566466042, 9133.0, 9220.262379009797, 9491.430514169171, 9493.291598773783, 9898.20814334837, 7732.7680169595005, 8662.956685216534, 9378.109079637423, 10014.197444460067, 10528.617503963362], "value": 7788.149693065607, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1420.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 115.0, 116.0, 117.0, 117.0, 117.0, 116.0, 120.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 96.0, 123.0, 174.0, 138.0, 116.0, 108.0, 105.0, 130.0, 129.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 181.0, 183.0, 182.0, 184.0, 183.0, 182.0, 182.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 60.0, 89.0, 64.0, 59.0, 58.0, 61.0, 78.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 86.0, 69.0, 69.0, 69.0, 82.0, 70.0, 68.0, 82.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 115.0, 86.0, 93.0, 134.0, 86.0, 88.0, 87.0, 87.0, 87.0], "value": 98.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 95.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 87.0, 83.0, 84.0, 83.0, 83.0, 83.0, 85.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 60.0, 60.0, 62.0, 63.0, 65.0, 64.0, 64.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 71.0, 55.0, 63.0, 62.0, 59.0, 59.0, 60.0, 58.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 82.0, 77.0, 71.0, 81.0, 93.0, 98.0, 102.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 144.0, 152.0, 143.0, 135.0, 137.0, 135.0, 138.0, 182.0, 140.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 162.0, 164.0, 162.0, 160.0, 161.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 64.0, 63.0, 62.0, 62.0, 63.0, 62.0], "value": 63.2, "unit": "score"}]}]} 11:33:04 INFO - Return code: 0 11:33:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:04 INFO - # TBPL SUCCESS # 11:33:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:33:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:33:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:33:04 INFO - 2017-04-19 11:33:04.194 screenresolution[1668:9942] starting screenresolution argv=screenresolution get 11:33:04 INFO - 2017-04-19 11:33:04.196 screenresolution[1668:9942] Display 0: 1600x1200x32@60 11:33:04 INFO - 2017-04-19 11:33:04.202 screenresolution[1669:9946] starting screenresolution argv=screenresolution list 11:33:04 INFO - Available Modes on Display 0 11:33:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:33:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:33:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:33:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:33:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:33:04 INFO - Intel Iris: 11:33:04 INFO - Chipset Model: Intel Iris 11:33:04 INFO - Type: GPU 11:33:04 INFO - Bus: Built-In 11:33:04 INFO - VRAM (Dynamic, Max): 1536 MB 11:33:04 INFO - Vendor: Intel (0x8086) 11:33:04 INFO - Device ID: 0x0a2e 11:33:04 INFO - Revision ID: 0x0009 11:33:04 INFO - Displays: 11:33:04 INFO - Display: 11:33:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:33:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:33:04 INFO - Display Serial Number: 1600x1200 60 11:33:04 INFO - Main Display: Yes 11:33:04 INFO - Mirror: Off 11:33:04 INFO - Online: Yes 11:33:04 INFO - Rotation: Supported 11:33:04 INFO - Return code: 0 11:33:04 INFO - Running post-action listener: _resource_record_post_action 11:33:04 INFO - [mozharness: 2017-04-19 18:33:04.439512Z] Finished run-tests step (success) 11:33:04 INFO - Running post-run listener: _resource_record_post_run 11:33:04 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38880256; Write bytes: 421644800; Read time: 251; Write time: 1369 11:33:04 INFO - TinderboxPrint: CPU usage
53.7% 11:33:04 INFO - TinderboxPrint: I/O read bytes / time
38,880,256 / 251 11:33:04 INFO - TinderboxPrint: I/O write bytes / time
421,644,800 / 1,369 11:33:04 INFO - TinderboxPrint: CPU idle
2,208.3 (46.3%) 11:33:04 INFO - TinderboxPrint: CPU system
949.0 (19.9%) 11:33:04 INFO - TinderboxPrint: CPU user
1,616.5 (33.9%) 11:33:04 INFO - TinderboxPrint: Swap in / out
159,232,000 / 0 11:33:04 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 110410240; Write bytes: 104945664; Read time: 9935; Write time: 226 11:33:04 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37897216; Write bytes: 296911360; Read time: 238; Write time: 1085 11:33:04 INFO - Running post-run listener: _upload_blobber_files 11:33:04 INFO - Blob upload gear active. 11:33:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:04 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 11:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:33:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:05 INFO - (blobuploader) - INFO - Done attempting. 11:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:06 INFO - (blobuploader) - INFO - Done attempting. 11:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:07 INFO - (blobuploader) - INFO - Done attempting. 11:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:09 INFO - (blobuploader) - INFO - Done attempting. 11:33:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:09 INFO - Return code: 0 11:33:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b732b962172cca2e29800f7cdc8bdfff293272809464a680d6f046e6138c47d88291ab23ab54b8ea69e06551072b23acce89b4d36fc812c47c14b189a276209", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00eeed31036ead3e6f67848da66753cce5289036f033a11aa35fe1e84c349b1b9a8184d2461b9c12c3618b164b8c5d8c9e1858a693eebb4e4918bd3edb2857c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d10a76a6d72146207e394b380aedb66ac02aa62b3a028ff8bfd87eb55a36edbc2db5263c4ee4fdcf123424f60950ba68833c5d51da0af3d640bceb2fcec9ab35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb7d4d554ca25637fa678a9faf5a8f665aa9bfe16246195c7dcb34ed73b40774b1ac8d3055a978f4e0c287189ad505af21e52a33f0004715d10122a5299a449f"} 11:33:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:09 INFO - Contents: 11:33:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b732b962172cca2e29800f7cdc8bdfff293272809464a680d6f046e6138c47d88291ab23ab54b8ea69e06551072b23acce89b4d36fc812c47c14b189a276209", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00eeed31036ead3e6f67848da66753cce5289036f033a11aa35fe1e84c349b1b9a8184d2461b9c12c3618b164b8c5d8c9e1858a693eebb4e4918bd3edb2857c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d10a76a6d72146207e394b380aedb66ac02aa62b3a028ff8bfd87eb55a36edbc2db5263c4ee4fdcf123424f60950ba68833c5d51da0af3d640bceb2fcec9ab35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb7d4d554ca25637fa678a9faf5a8f665aa9bfe16246195c7dcb34ed73b40774b1ac8d3055a978f4e0c287189ad505af21e52a33f0004715d10122a5299a449f"} 11:33:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:09 INFO - Copying logs to upload dir... 11:33:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.774860 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-19 11:33:10.541915) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 11:33:10.547211) ========= 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.6UqIxDaead/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.K58mOe8xYp/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b732b962172cca2e29800f7cdc8bdfff293272809464a680d6f046e6138c47d88291ab23ab54b8ea69e06551072b23acce89b4d36fc812c47c14b189a276209", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00eeed31036ead3e6f67848da66753cce5289036f033a11aa35fe1e84c349b1b9a8184d2461b9c12c3618b164b8c5d8c9e1858a693eebb4e4918bd3edb2857c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d10a76a6d72146207e394b380aedb66ac02aa62b3a028ff8bfd87eb55a36edbc2db5263c4ee4fdcf123424f60950ba68833c5d51da0af3d640bceb2fcec9ab35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb7d4d554ca25637fa678a9faf5a8f665aa9bfe16246195c7dcb34ed73b40774b1ac8d3055a978f4e0c287189ad505af21e52a33f0004715d10122a5299a449f"} build_url:https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010857 build_url: 'https://queue.taskcluster.net/v1/task/FbwPrDuzQ-GAa1rmn4EbZA/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b732b962172cca2e29800f7cdc8bdfff293272809464a680d6f046e6138c47d88291ab23ab54b8ea69e06551072b23acce89b4d36fc812c47c14b189a276209", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00eeed31036ead3e6f67848da66753cce5289036f033a11aa35fe1e84c349b1b9a8184d2461b9c12c3618b164b8c5d8c9e1858a693eebb4e4918bd3edb2857c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d10a76a6d72146207e394b380aedb66ac02aa62b3a028ff8bfd87eb55a36edbc2db5263c4ee4fdcf123424f60950ba68833c5d51da0af3d640bceb2fcec9ab35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb7d4d554ca25637fa678a9faf5a8f665aa9bfe16246195c7dcb34ed73b40774b1ac8d3055a978f4e0c287189ad505af21e52a33f0004715d10122a5299a449f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 11:33:10.590859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 11:33:10.591469) ========= 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.6UqIxDaead/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.K58mOe8xYp/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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.004968 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 11:33:10.641667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 11:33:10.642022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 11:33:10.642422) ========= ========= Total master_lag: 1.31 =========