builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0024 starttime: 1491307779.12 results: success (0) buildid: 20170404033628 builduid: 29a01335436845b6b8fde3750d7b0e8f revision: 891981e67948aaebf7a63bba5181ef0a538ce163 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.117473) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.117909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.118218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.145284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.145579) ========= 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.gM20ANQyLP/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.q64oj9OmOK/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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-04 05:09:39-- 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% 153M=0s 2017-04-04 05:09:39 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.295011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.295364) ========= 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.gM20ANQyLP/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.q64oj9OmOK/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.028296 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:39.345966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 05:09:39.346364) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 891981e67948aaebf7a63bba5181ef0a538ce163 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 891981e67948aaebf7a63bba5181ef0a538ce163 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gM20ANQyLP/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.q64oj9OmOK/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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-04 05:09:39,451 truncating revision to first 12 chars 2017-04-04 05:09:39,451 Setting DEBUG logging. 2017-04-04 05:09:39,451 attempt 1/10 2017-04-04 05:09:39,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/891981e67948?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 05:09:40,430 unpacking tar archive at: mozilla-central-891981e67948/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 05:09:40.639513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:40.639845) ========= script_repo_revision: 891981e67948aaebf7a63bba5181ef0a538ce163 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:40.640251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:40.640529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 05:09:40.660281) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-04 05:09:40.660618) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gM20ANQyLP/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.q64oj9OmOK/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:09:40 INFO - MultiFileLogger online at 20170404 05:09:40 in /builds/slave/test 05:09:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:09:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:40 INFO - {'append_to_log': False, 05:09:40 INFO - 'base_work_dir': '/builds/slave/test', 05:09:40 INFO - 'blob_upload_branch': 'Firefox', 05:09:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:40 INFO - 'branch': 'Firefox', 05:09:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:40 INFO - 'config_files': ('talos/mac_config.py',), 05:09:40 INFO - 'default_actions': ('clobber', 05:09:40 INFO - 'read-buildbot-config', 05:09:40 INFO - 'download-and-extract', 05:09:40 INFO - 'populate-webroot', 05:09:40 INFO - 'create-virtualenv', 05:09:40 INFO - 'install', 05:09:40 INFO - 'run-tests'), 05:09:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:40 INFO - 'download_minidump_stackwalk': True, 05:09:40 INFO - 'download_symbols': 'ondemand', 05:09:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:40 INFO - 'gecko_profile': False, 05:09:40 INFO - 'gecko_profile_interval': 0, 05:09:40 INFO - 'installer_path': 'installer.exe', 05:09:40 INFO - 'log_level': 'info', 05:09:40 INFO - 'log_name': 'talos', 05:09:40 INFO - 'log_to_console': True, 05:09:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:09:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:09:40 INFO - 'opt_config_files': (), 05:09:40 INFO - 'pip_index': False, 05:09:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:40 INFO - 'cmd': ('bash', 05:09:40 INFO - '-c', 05:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:40 INFO - 'enabled': True, 05:09:40 INFO - 'halt_on_failure': False, 05:09:40 INFO - 'name': 'check_screen_resolution'},), 05:09:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:40 INFO - 'cmd': ('bash', 05:09:40 INFO - '-c', 05:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:40 INFO - 'enabled': True, 05:09:40 INFO - 'halt_on_failure': False, 05:09:40 INFO - 'name': 'check_screen_resolution'},), 05:09:40 INFO - 'run_cmd_checks_enabled': True, 05:09:40 INFO - 'suite': 'dromaeojs', 05:09:40 INFO - 'system_bits': '32', 05:09:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:40 INFO - 'title': 't-yosemite-r7-0024', 05:09:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:40 INFO - 'use_talos_json': True, 05:09:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:40 INFO - 'work_dir': 'build'} 05:09:40 INFO - [mozharness: 2017-04-04 12:09:40.874212Z] Running clobber step. 05:09:40 INFO - Running pre-action listener: _resource_record_pre_action 05:09:40 INFO - Running main action method: clobber 05:09:40 INFO - rmtree: /builds/slave/test/build 05:09:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:43 INFO - Running post-action listener: _resource_record_post_action 05:09:43 INFO - [mozharness: 2017-04-04 12:09:43.404164Z] Finished clobber step (success) 05:09:43 INFO - [mozharness: 2017-04-04 12:09:43.404306Z] Running read-buildbot-config step. 05:09:43 INFO - Running pre-action listener: _resource_record_pre_action 05:09:43 INFO - Running main action method: read_buildbot_config 05:09:43 INFO - Using buildbot properties: 05:09:43 INFO - { 05:09:43 INFO - "project": "", 05:09:43 INFO - "product": "firefox", 05:09:43 INFO - "script_repo_revision": "production", 05:09:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:09:43 INFO - "repository": "", 05:09:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:09:43 INFO - "buildid": "20170404033628", 05:09:43 INFO - "pgo_build": "False", 05:09:43 INFO - "basedir": "/builds/slave/test", 05:09:43 INFO - "buildnumber": 4, 05:09:43 INFO - "slavename": "t-yosemite-r7-0024", 05:09:43 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:09:43 INFO - "platform": "yosemite_r7", 05:09:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:09:43 INFO - "branch": "mozilla-central", 05:09:43 INFO - "repo_path": "mozilla-central", 05:09:43 INFO - "revision": "891981e67948aaebf7a63bba5181ef0a538ce163", 05:09:43 INFO - "stage_platform": "macosx64", 05:09:43 INFO - "builduid": "29a01335436845b6b8fde3750d7b0e8f", 05:09:43 INFO - "slavebuilddir": "test" 05:09:43 INFO - } 05:09:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:09:43 INFO - Running post-action listener: _resource_record_post_action 05:09:43 INFO - [mozharness: 2017-04-04 12:09:43.407613Z] Finished read-buildbot-config step (success) 05:09:43 INFO - [mozharness: 2017-04-04 12:09:43.407699Z] Running download-and-extract step. 05:09:43 INFO - Running pre-action listener: _resource_record_pre_action 05:09:43 INFO - Running main action method: download_and_extract 05:09:43 INFO - mkdir: /builds/slave/test/build/tests 05:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:43 INFO - trying https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:09:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:09:44 INFO - Downloaded 1325 bytes. 05:09:44 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:09:44 INFO - Using the following test package requirements: 05:09:44 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:09:44 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:09:44 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:09:44 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:09:44 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'jsshell-mac.zip'], 05:09:44 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:09:44 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:09:44 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:09:44 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:09:44 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:09:44 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:09:44 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:09:44 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:09:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:09:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:09:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:09:46 INFO - Expected file size: 52517582 05:09:46 INFO - Obtained file size: 52517582 05:10:02 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:10:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:10:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:10:04 INFO - Expected file size: 52517582 05:10:04 INFO - Obtained file size: 52517582 05:10:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:10:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:10:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:10:21 INFO - Expected file size: 14404152 05:10:21 INFO - Obtained file size: 14404152 05:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:22 INFO - trying https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:10:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:10:24 INFO - Downloaded 75600925 bytes. 05:10:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:10:24 INFO - mkdir: /builds/slave/test/properties 05:10:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:24 INFO - Contents: 05:10:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:10:25 INFO - Running post-action listener: _resource_record_post_action 05:10:25 INFO - Running post-action listener: set_extra_try_arguments 05:10:25 INFO - [mozharness: 2017-04-04 12:10:25.000449Z] Finished download-and-extract step (success) 05:10:25 INFO - [mozharness: 2017-04-04 12:10:25.000576Z] Running populate-webroot step. 05:10:25 INFO - Running pre-action listener: _resource_record_pre_action 05:10:25 INFO - Running main action method: populate_webroot 05:10:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:25 INFO - '--tppagecycles', 05:10:25 INFO - '7'], 05:10:25 INFO - 'tests': ['tsvgm']}}, 05:10:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['damp', 'tps']}, 05:10:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'tests': ['damp', 'tps']}, 05:10:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['dromaeo_dom']}, 05:10:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['basic_compositor_video']}, 05:10:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:10:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tsvgx', 05:10:25 INFO - 'tsvgr_opacity', 05:10:25 INFO - 'tart', 05:10:25 INFO - 'tscrollx', 05:10:25 INFO - 'cart', 05:10:25 INFO - 'tsvg_static']}, 05:10:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:25 INFO - 'tsvgr_opacity', 05:10:25 INFO - 'tart', 05:10:25 INFO - 'tscrollx', 05:10:25 INFO - 'cart', 05:10:25 INFO - 'tsvg_static']}, 05:10:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tp5o']}, 05:10:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:10:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s', 05:10:25 INFO - '--xperf_path', 05:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:25 INFO - 'tests': ['tp5n']}, 05:10:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--xperf_path', 05:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:25 INFO - 'tests': ['tp5n']}}, 05:10:25 INFO - 'talos.zip': {'path': '', 05:10:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:25 INFO - Running post-action listener: _resource_record_post_action 05:10:25 INFO - [mozharness: 2017-04-04 12:10:25.018669Z] Finished populate-webroot step (success) 05:10:25 INFO - [mozharness: 2017-04-04 12:10:25.018766Z] Running create-virtualenv step. 05:10:25 INFO - Running pre-action listener: _resource_record_pre_action 05:10:25 INFO - Running main action method: create_virtualenv 05:10:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:25 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 05:10:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:25 INFO - Using real prefix '/tools/python27' 05:10:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:28 INFO - Installing pip.................done. 05:10:28 INFO - Return code: 0 05:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:10:29 INFO - Reading from file tmpfile_stdout 05:10:29 INFO - Output received: 05:10:29 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) 05:10:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:29 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')]} 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 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')]} 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:29 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 05:10:29 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 05:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:29 INFO - 'HOME': '/Users/cltbld', 05:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:29 INFO - 'LOGNAME': 'cltbld', 05:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:29 INFO - 'MOZ_NO_REMOTE': '1', 05:10:29 INFO - 'NO_EM_RESTART': '1', 05:10:29 INFO - 'PAGER': '/bin/cat', 05:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:29 INFO - 'PWD': '/builds/slave/test', 05:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:29 INFO - 'SHELL': '/bin/bash', 05:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:29 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:29 INFO - 'USER': 'cltbld', 05:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:29 INFO - 'XPC_FLAGS': '0x0', 05:10:29 INFO - 'XPC_SERVICE_NAME': '0', 05:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:29 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 05:10:29 INFO - Cleaning up... 05:10:29 INFO - Return code: 0 05:10:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:29 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')]} 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 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')]} 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:29 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 05:10:29 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 05:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:29 INFO - 'HOME': '/Users/cltbld', 05:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:29 INFO - 'LOGNAME': 'cltbld', 05:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:29 INFO - 'MOZ_NO_REMOTE': '1', 05:10:29 INFO - 'NO_EM_RESTART': '1', 05:10:29 INFO - 'PAGER': '/bin/cat', 05:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:29 INFO - 'PWD': '/builds/slave/test', 05:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:29 INFO - 'SHELL': '/bin/bash', 05:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:29 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:29 INFO - 'USER': 'cltbld', 05:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:29 INFO - 'XPC_FLAGS': '0x0', 05:10:29 INFO - 'XPC_SERVICE_NAME': '0', 05:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:29 INFO - Downloading/unpacking psutil>=3.1.1 05:10:29 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 05:10:29 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 05:10:29 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 05:10:29 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 05:10:29 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 05:10:29 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 05:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:32 INFO - Installing collected packages: psutil 05:10:32 INFO - Running setup.py install for psutil 05:10:33 INFO - building 'psutil._psutil_osx' extension 05:10:33 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 05:10:33 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 05:10:33 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 05:10:33 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 05:10:33 INFO - building 'psutil._psutil_posix' extension 05:10:33 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 05:10:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:10:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:10:33 INFO - ^ 05:10:33 INFO - 1 warning generated. 05:10:34 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 05:10:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:34 INFO - Successfully installed psutil 05:10:34 INFO - Cleaning up... 05:10:34 INFO - Return code: 0 05:10:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:34 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')]} 05:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:34 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')]} 05:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:34 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:34 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 05:10:34 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 05:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:34 INFO - 'HOME': '/Users/cltbld', 05:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:34 INFO - 'LOGNAME': 'cltbld', 05:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:34 INFO - 'MOZ_NO_REMOTE': '1', 05:10:34 INFO - 'NO_EM_RESTART': '1', 05:10:34 INFO - 'PAGER': '/bin/cat', 05:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:34 INFO - 'PWD': '/builds/slave/test', 05:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:34 INFO - 'SHELL': '/bin/bash', 05:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:34 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:34 INFO - 'USER': 'cltbld', 05:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:34 INFO - 'XPC_FLAGS': '0x0', 05:10:34 INFO - 'XPC_SERVICE_NAME': '0', 05:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:38 INFO - Installing collected packages: mozsystemmonitor 05:10:38 INFO - Running setup.py install for mozsystemmonitor 05:10:38 INFO - Successfully installed mozsystemmonitor 05:10:38 INFO - Cleaning up... 05:10:38 INFO - Return code: 0 05:10:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:38 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')]} 05:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:38 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')]} 05:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:38 INFO - 'HOME': '/Users/cltbld', 05:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:38 INFO - 'LOGNAME': 'cltbld', 05:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:38 INFO - 'MOZ_NO_REMOTE': '1', 05:10:38 INFO - 'NO_EM_RESTART': '1', 05:10:38 INFO - 'PAGER': '/bin/cat', 05:10:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:38 INFO - 'PWD': '/builds/slave/test', 05:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:38 INFO - 'SHELL': '/bin/bash', 05:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:38 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:38 INFO - 'USER': 'cltbld', 05:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:38 INFO - 'XPC_FLAGS': '0x0', 05:10:38 INFO - 'XPC_SERVICE_NAME': '0', 05:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:41 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 05:10:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:42 INFO - warning: no files found matching '*.txt' 05:10:42 INFO - no previously-included directories found matching 'build' 05:10:42 INFO - no previously-included directories found matching 'dist' 05:10:42 INFO - no previously-included directories found matching '.git*' 05:10:42 INFO - Installing collected packages: jsonschema, functools32 05:10:42 INFO - Running setup.py install for functools32 05:10:42 INFO - warning: no files found matching '*.txt' 05:10:42 INFO - no previously-included directories found matching 'build' 05:10:42 INFO - no previously-included directories found matching 'dist' 05:10:42 INFO - no previously-included directories found matching '.git*' 05:10:42 INFO - Successfully installed jsonschema functools32 05:10:42 INFO - Cleaning up... 05:10:42 INFO - Return code: 0 05:10:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:10:42 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')]} 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 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')]} 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:42 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 05:10:42 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 05:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:42 INFO - 'HOME': '/Users/cltbld', 05:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:42 INFO - 'LOGNAME': 'cltbld', 05:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:42 INFO - 'MOZ_NO_REMOTE': '1', 05:10:42 INFO - 'NO_EM_RESTART': '1', 05:10:42 INFO - 'PAGER': '/bin/cat', 05:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:42 INFO - 'PWD': '/builds/slave/test', 05:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:42 INFO - 'SHELL': '/bin/bash', 05:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:42 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:42 INFO - 'USER': 'cltbld', 05:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:42 INFO - 'XPC_FLAGS': '0x0', 05:10:42 INFO - 'XPC_SERVICE_NAME': '0', 05:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:10:42 INFO - Cleaning up... 05:10:42 INFO - Return code: 0 05:10:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:42 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')]} 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 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')]} 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:42 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 05:10:42 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 05:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:42 INFO - 'HOME': '/Users/cltbld', 05:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:42 INFO - 'LOGNAME': 'cltbld', 05:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:42 INFO - 'MOZ_NO_REMOTE': '1', 05:10:42 INFO - 'NO_EM_RESTART': '1', 05:10:42 INFO - 'PAGER': '/bin/cat', 05:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:42 INFO - 'PWD': '/builds/slave/test', 05:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:42 INFO - 'SHELL': '/bin/bash', 05:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:42 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:42 INFO - 'USER': 'cltbld', 05:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:42 INFO - 'XPC_FLAGS': '0x0', 05:10:42 INFO - 'XPC_SERVICE_NAME': '0', 05:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:47 INFO - Downloading docopt-0.6.1.tar.gz 05:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:47 INFO - Running setup.py install for blobuploader 05:10:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:47 INFO - Running setup.py install for requests 05:10:47 INFO - Running setup.py install for docopt 05:10:48 INFO - Successfully installed blobuploader requests docopt 05:10:48 INFO - Cleaning up... 05:10:48 INFO - Return code: 0 05:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:48 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:48 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 05:10:48 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 05:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:48 INFO - 'HOME': '/Users/cltbld', 05:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:48 INFO - 'LOGNAME': 'cltbld', 05:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:48 INFO - 'MOZ_NO_REMOTE': '1', 05:10:48 INFO - 'NO_EM_RESTART': '1', 05:10:48 INFO - 'PAGER': '/bin/cat', 05:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:48 INFO - 'PWD': '/builds/slave/test', 05:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:48 INFO - 'SHELL': '/bin/bash', 05:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:48 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:48 INFO - 'USER': 'cltbld', 05:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:48 INFO - 'XPC_FLAGS': '0x0', 05:10:48 INFO - 'XPC_SERVICE_NAME': '0', 05:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:48 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Sj3Vvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:48 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-uEfhWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:48 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-290gDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:48 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ltdIBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:48 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-XUsvu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:48 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-9Nh71p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:48 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-GM0g38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-I5rPuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-H_zkj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-vviWBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-5GFThy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-TCDQIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-BpgEZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-_iQPDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Ntk3NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-CyENdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-f6JPK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:50 INFO - Running setup.py install for manifestparser 05:10:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozcrash 05:10:50 INFO - Running setup.py install for mozdebug 05:10:50 INFO - Running setup.py install for mozdevice 05:10:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozfile 05:10:50 INFO - Running setup.py install for mozhttpd 05:10:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozinfo 05:10:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Running setup.py install for mozInstall 05:10:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Running setup.py install for mozleak 05:10:51 INFO - Running setup.py install for mozlog 05:10:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Running setup.py install for moznetwork 05:10:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Running setup.py install for mozprocess 05:10:51 INFO - Running setup.py install for mozprofile 05:10:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Running setup.py install for mozrunner 05:10:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Running setup.py install for mozscreenshot 05:10:52 INFO - Running setup.py install for moztest 05:10:52 INFO - Running setup.py install for mozversion 05:10:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:52 INFO - Cleaning up... 05:10:52 INFO - Return code: 0 05:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:52 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')]} 05:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:52 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')]} 05:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:52 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:52 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 05:10:52 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 05:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:52 INFO - 'HOME': '/Users/cltbld', 05:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:52 INFO - 'LOGNAME': 'cltbld', 05:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:52 INFO - 'MOZ_NO_REMOTE': '1', 05:10:52 INFO - 'NO_EM_RESTART': '1', 05:10:52 INFO - 'PAGER': '/bin/cat', 05:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:52 INFO - 'PWD': '/builds/slave/test', 05:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:52 INFO - 'SHELL': '/bin/bash', 05:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:52 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:52 INFO - 'USER': 'cltbld', 05:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:52 INFO - 'XPC_FLAGS': '0x0', 05:10:52 INFO - 'XPC_SERVICE_NAME': '0', 05:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-00pFUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-7vj6jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-vFqmMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-r6S_eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-FUD96M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-NdPmiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-OxHsZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-nMGfBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-o3Xxjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-cAH2cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:53 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-q2RMeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-f4yrLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-zz5g8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-O8Qhfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-C92V2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-n9kI9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:54 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)) 05:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-_C5aIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:57 INFO - Downloading blessings-1.6.tar.gz 05:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:57 INFO - Installing collected packages: blessings 05:10:57 INFO - Running setup.py install for blessings 05:10:57 INFO - Successfully installed blessings 05:10:57 INFO - Cleaning up... 05:10:57 INFO - Return code: 0 05:10:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:58 INFO - Reading from file tmpfile_stdout 05:10:58 INFO - Current package versions: 05:10:58 INFO - blessings == 1.6 05:10:58 INFO - blobuploader == 1.2.4 05:10:58 INFO - docopt == 0.6.1 05:10:58 INFO - functools32 == 3.2.3-2 05:10:58 INFO - jsonschema == 2.5.1 05:10:58 INFO - manifestparser == 1.1 05:10:58 INFO - mozInstall == 1.12 05:10:58 INFO - mozcrash == 1.0 05:10:58 INFO - mozdebug == 0.1 05:10:58 INFO - mozdevice == 0.49 05:10:58 INFO - mozfile == 1.2 05:10:58 INFO - mozhttpd == 0.7 05:10:58 INFO - mozinfo == 0.9 05:10:58 INFO - mozleak == 0.1 05:10:58 INFO - mozlog == 3.4 05:10:58 INFO - moznetwork == 0.27 05:10:58 INFO - mozprocess == 0.25 05:10:58 INFO - mozprofile == 0.28 05:10:58 INFO - mozrunner == 6.13 05:10:58 INFO - mozscreenshot == 0.1 05:10:58 INFO - mozsystemmonitor == 0.3 05:10:58 INFO - moztest == 0.8 05:10:58 INFO - mozversion == 1.4 05:10:58 INFO - psutil == 3.1.1 05:10:58 INFO - requests == 1.2.3 05:10:58 INFO - wsgiref == 0.1.2 05:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:58 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 05:10:58 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 05:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:58 INFO - 'HOME': '/Users/cltbld', 05:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:58 INFO - 'LOGNAME': 'cltbld', 05:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:58 INFO - 'MOZ_NO_REMOTE': '1', 05:10:58 INFO - 'NO_EM_RESTART': '1', 05:10:58 INFO - 'PAGER': '/bin/cat', 05:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:58 INFO - 'PWD': '/builds/slave/test', 05:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:58 INFO - 'SHELL': '/bin/bash', 05:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:58 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:58 INFO - 'USER': 'cltbld', 05:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:58 INFO - 'XPC_FLAGS': '0x0', 05:10:58 INFO - 'XPC_SERVICE_NAME': '0', 05:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 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)) 05:10:58 INFO - Cleaning up... 05:10:58 INFO - Return code: 0 05:10:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 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 0x10546bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10546e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d09c7bfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, '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.gM20ANQyLP/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.q64oj9OmOK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 05:10:58 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 05:10:58 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 05:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:58 INFO - 'HOME': '/Users/cltbld', 05:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:58 INFO - 'LOGNAME': 'cltbld', 05:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:58 INFO - 'MOZ_NO_REMOTE': '1', 05:10:58 INFO - 'NO_EM_RESTART': '1', 05:10:58 INFO - 'PAGER': '/bin/cat', 05:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:58 INFO - 'PWD': '/builds/slave/test', 05:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:58 INFO - 'SHELL': '/bin/bash', 05:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:10:58 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:58 INFO - 'USER': 'cltbld', 05:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:58 INFO - 'XPC_FLAGS': '0x0', 05:10:58 INFO - 'XPC_SERVICE_NAME': '0', 05:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:58 INFO - Cleaning up... 05:10:58 INFO - Return code: 0 05:10:58 INFO - Running post-action listener: _resource_record_post_action 05:10:58 INFO - Running post-action listener: _start_resource_monitoring 05:10:58 INFO - Starting resource monitoring. 05:10:58 INFO - [mozharness: 2017-04-04 12:10:58.603530Z] Finished create-virtualenv step (success) 05:10:58 INFO - [mozharness: 2017-04-04 12:10:58.604506Z] Running install step. 05:10:58 INFO - Running pre-action listener: _resource_record_pre_action 05:10:58 INFO - Running main action method: install 05:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:58 INFO - Reading from file tmpfile_stdout 05:10:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:58 INFO - Reading from file tmpfile_stdout 05:10:58 INFO - Output received: 05:10:58 INFO - Usage: mozinstall [options] installer 05:10:58 INFO - Options: 05:10:58 INFO - -h, --help show this help message and exit 05:10:58 INFO - -d DEST, --destination=DEST 05:10:58 INFO - Directory to install application into. [default: 05:10:58 INFO - "/builds/slave/test"] 05:10:58 INFO - --app=APP Application being installed. [default: firefox] 05:10:58 INFO - mkdir: /builds/slave/test/build/application 05:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:11:19 INFO - Reading from file tmpfile_stdout 05:11:19 INFO - Output received: 05:11:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:11:19 INFO - Running post-action listener: _resource_record_post_action 05:11:19 INFO - [mozharness: 2017-04-04 12:11:19.354620Z] Finished install step (success) 05:11:19 INFO - [mozharness: 2017-04-04 12:11:19.354770Z] Running run-tests step. 05:11:19 INFO - Running pre-action listener: _resource_record_pre_action 05:11:19 INFO - Running main action method: run_tests 05:11:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:19 INFO - 2017-04-04 05:11:19.368 screenresolution[1624:7437] starting screenresolution argv=screenresolution get 05:11:19 INFO - 2017-04-04 05:11:19.371 screenresolution[1624:7437] Display 0: 1600x1200x32@60 05:11:19 INFO - 2017-04-04 05:11:19.377 screenresolution[1625:7440] starting screenresolution argv=screenresolution list 05:11:19 INFO - Available Modes on Display 0 05:11:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:19 INFO - Intel Iris: 05:11:19 INFO - Chipset Model: Intel Iris 05:11:19 INFO - Type: GPU 05:11:19 INFO - Bus: Built-In 05:11:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:11:19 INFO - Vendor: Intel (0x8086) 05:11:19 INFO - Device ID: 0x0a2e 05:11:19 INFO - Revision ID: 0x0009 05:11:19 INFO - Displays: 05:11:19 INFO - Display: 05:11:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:19 INFO - Display Serial Number: 1600x1200 60 05:11:19 INFO - Main Display: Yes 05:11:19 INFO - Mirror: Off 05:11:19 INFO - Online: Yes 05:11:19 INFO - Rotation: Supported 05:11:19 INFO - Return code: 0 05:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:19 INFO - Python 2.7.3 05:11:19 INFO - Return code: 0 05:11:19 INFO - grabbing minidump binary from tooltool 05:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:19 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 0x105249d30>, '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 0x105170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:19 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 05:11:19 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 05:11:19 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 05:11:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:19 INFO - Return code: 0 05:11:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:11:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:19 INFO - ENV: RUST_BACKTRACE is now 1 05:11:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:11:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 05:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --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 05:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gM20ANQyLP/Render', 05:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:19 INFO - 'HOME': '/Users/cltbld', 05:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:19 INFO - 'LOGNAME': 'cltbld', 05:11:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:19 INFO - 'MOZ_NO_REMOTE': '1', 05:11:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:19 INFO - 'NO_EM_RESTART': '1', 05:11:19 INFO - 'PAGER': '/bin/cat', 05:11:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:19 INFO - 'PWD': '/builds/slave/test', 05:11:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:19 INFO - 'RUST_BACKTRACE': '1', 05:11:19 INFO - 'SHELL': '/bin/bash', 05:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q64oj9OmOK/Listeners', 05:11:19 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 05:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:19 INFO - 'USER': 'cltbld', 05:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:19 INFO - 'XPC_FLAGS': '0x0', 05:11:19 INFO - 'XPC_SERVICE_NAME': '0', 05:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 05:11:19 INFO - mozversion application_buildid: 20170404033628 05:11:19 INFO - mozversion application_changeset: 891981e67948aaebf7a63bba5181ef0a538ce163 05:11:19 INFO - mozversion application_display_name: Nightly 05:11:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:19 INFO - mozversion application_name: Firefox 05:11:19 INFO - mozversion application_remotingname: firefox 05:11:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:11:19 INFO - mozversion application_vendor: Mozilla 05:11:19 INFO - mozversion application_version: 55.0a1 05:11:19 INFO - mozversion platform_buildid: 20170404033628 05:11:19 INFO - mozversion platform_changeset: 891981e67948aaebf7a63bba5181ef0a538ce163 05:11:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:11:19 INFO - mozversion platform_version: 55.0a1 05:11:19 INFO - using testdate: 1491307879 05:11:19 INFO - actual date: 1491307879 05:11:19 INFO - starting webserver on 'localhost:49253' 05:11:19 INFO - SUITE-START | Running 2 tests 05:11:19 INFO - TEST-START | dromaeo_css 05:11:19 INFO - operating with platform_type : mac_ 05:11:19 INFO - Initialising browser for dromaeo_css test... 05:11:19 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpZc8JeA/profile http://localhost:49253/getInfo.html) 05:11:22 INFO - PID 1635 | __metrics Screen width/height:1600/1200 05:11:22 INFO - PID 1635 | colorDepth:24 05:11:22 INFO - PID 1635 | Browser inner width/height: 1024/689 05:11:22 INFO - PID 1635 | __metrics 05:11:22 INFO - PID 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:11:22 INFO - PID 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:23 INFO - TEST-INFO | 1635: exit 0 05:11:23 INFO - Browser initialized. 05:11:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:23 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpZc8JeA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:35 INFO - PID 1637 | RSS: Main: 232542208 05:11:35 INFO - PID 1637 | 05:14:40 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49253/tests/dromaeo/cssquery-ext.html) 05:14:42 INFO - PID 1637 | RSS: Main: 384589824 05:14:42 INFO - PID 1637 | 05:16:25 INFO - PID 1637 | ************************* 05:16:25 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 05:16:25 INFO - PID 1637 | 05:16:25 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:16:25 INFO - PID 1637 | Full stack: 05:16:25 INFO - PID 1637 | ************************* 05:16:25 INFO - PID 1637 | ************************* 05:16:25 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 05:16:25 INFO - PID 1637 | 05:16:25 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:16:25 INFO - PID 1637 | Full stack: 05:16:25 INFO - PID 1637 | ************************* 05:16:25 INFO - PID 1637 | ************************* 05:16:25 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 05:16:25 INFO - PID 1637 | 05:16:25 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:16:25 INFO - PID 1637 | Full stack: 05:16:25 INFO - PID 1637 | ************************* 05:16:25 INFO - PID 1637 | ************************* 05:16:25 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 05:16:25 INFO - PID 1637 | 05:16:25 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:16:25 INFO - PID 1637 | Full stack: 05:16:25 INFO - PID 1637 | ************************* 05:17:45 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-ext.html (next: http://localhost:49253/tests/dromaeo/cssquery-jquery.html) 05:17:45 INFO - PID 1637 | RSS: Main: 371257344 05:17:45 INFO - PID 1637 | 05:20:47 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49253/tests/dromaeo/cssquery-mootools.html) 05:20:48 INFO - PID 1637 | RSS: Main: 362098688 05:20:48 INFO - PID 1637 | 05:23:50 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49253/tests/dromaeo/cssquery-prototype.html) 05:23:51 INFO - PID 1637 | RSS: Main: 337784832 05:23:51 INFO - PID 1637 | 05:26:55 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49253/tests/dromaeo/cssquery-yui.html) 05:26:55 INFO - PID 1637 | RSS: Main: 343404544 05:26:55 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-yui.html (next: http://localhost:49253/tests/dromaeo/cssquery-dojo.html) 05:29:59 INFO - PID 1637 | RSS: Main: 505892864 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | __start_tp_report 05:29:59 INFO - PID 1637 | _x_x_mozilla_page_load 05:29:59 INFO - PID 1637 | _x_x_mozilla_page_load_details 05:29:59 INFO - PID 1637 | |i|pagename|runs| 05:29:59 INFO - PID 1637 | |0;dojo.html;3464.9480257796135;3472.9999999999995;3489.5114683944266;3498.930021399572;3534.0988048047743;5943.732532036058;6078.392160783925;6082.057281121433;6091.939080609192;6123.081537769337;5996.220491336131;6071;6071.483923866465;6071.696415179245;6071.78748743794;5234.581233501321;5243;5259.237410575464;5275.894482110355;5373.946260537384;4530.754042638285;5211.244369566411;5357.981983423157;5366.731663416833;5376.381716102659;5343.358796944372;5348.946510534904;5352;5354.839354819362;5364.7317634118135;5339.519443250126;5344.331958505187;5352.464753524636;5359.169328754049;5370.087085195526;5185.299984502081;5298.364196296469;5312.1766126250495;5330.866728331784;5335.359756829166;6150.630962142241;6183.505319574423;6207.751689932397;6209.099680546341;6218.595791273553;6416.914502786566;6443.420092191725;6472.708728107246;6484.124643173159;6485.805425837185;6279.654618995954;6292.842678933018;6331.33520980295;6346.4922806175855;6350.777722779727;5578.665280083208;6108.827782940766;6134.038624681843;6266.968665156645;6268.529860260407;5570.6657600543285;6660.067590537328;6684.197896252481;6710.765123220664;6719.160104986877;5486.533644640171;6341.017142342944;6352.2694890087305;6380.106785050097;6387.680615969183;6197.411245931629;6247.781327653601;6406.583572067801;6503.837404064936;6507.414332710079;6296.275928268308;6371.904421433682;6425;6441.3880681335195;6458.741650333934;6417.262014868256;6420.1974753155855;6430.0676401921455;6438.935610643927;6463.515236357292;5116.872078198075;5199.6880187188135;5232.03207406631;5263.815766448156;5269.235960785664;4595.931061034087;4656.092062047868;4669.719816811003;4678.087772884323;4690.671652984327;6186.81439556814;6190.659513726699;6200.193974783249;6203.503719702413;6205.503559715212;6268.435840774352;6528.183977002875;6536.444402225864;6543.476521878239;6562.934370656328;6013.51891848651;6077.36187700294;6080.087986802015;6082;6093.756249750049;5662.915056274159;5677.09166533361;5682.289713785777;5686.545076393962;5691.886162276731;5516.475934786269;6439.8068057958335;6516.934830651822;6524.804255872332;6638.137042184485;5937.228160339128;6153.661548614869;6458.935410645833;6542.771003014872;6555.737770489127;6739.191297044386;6761.053452516553;6762.594244345355;6762.966185169043;6765.8985115224295;6191.442770150708;6266.467350275278;6433.099366088845;6436.871262574628;6459.806205813833;6447.0329450582785;6493.253275873335;6499.38255865692;6516.120323756232;6527.11883895668;6281.842953926189;6293;6301.117843501822;6303.180586523906;6308.27454842699;6183.350748171557;6255.31191568918;6305.8108256752375;6331.366863313632;6341.8097457076365;6175.567710260419;6180.196574445473;6226.50187984951;6236.719347629277;6256;6348;6349.079383489276;6366.29970703213;6372.203474565679;6375;6078.483328917092;6192.040233763593;6192.349803270592;6238.376162383725;6266.248050234001 05:29:59 INFO - PID 1637 | |1;ext.html;775.7129861951075;808.1151139502244;824.3528829868554;1152.5620264299564;1173.096715529042;28494.00270990516;29111.417771644556;29194.27014324643;37860.24279514415;38577;40312;40651.796741016326;40687.98280042993;40705.98235044118;40818.18363632725;8511.872321915176;8689.435186712875;8693.347998900077;8697.7825554361;8709.172628600272;6115.69421528924;6309.9369006310035;8497.362697797658;8731;8749.912500875005;8744.256738177231;8841.29269658429;8845.336599755012;8856.114388561156;8857.335699822506;8732.738017859443;8806.955965220197;8814.647414103429;8821.985471670776;8829.779255518632;8561.743147705578;8623.525706086162;8629.69796057135;8632.266257368132;8640.524771137585;38211.23577528434;38515.42226866599;38528.22943541141;38539.8073009636;38568.03579910497;3433.124553238933;3468.3063387322636;3474.1835668617855;3477.565304336958;3483.164040630256;22576.88711556448;30533;30558.236044098852;30597.235069123228;30615.40768884663;3105.068479456154;3135.0751528299206;3152.8896488622786;3166.335069635379;3173.5239714042846;311347;314214;314315.42842285644;314685;321769;50745.74627126841;50766.49233507692;50850;50880.49119508832;51001;53313.93372132535;53396.73301633545;53439;53503.46496535063;53544.73227633837;14168.079074860101;14449.494267700791;14474.986750927334;14479;14479.914006449559;10145.594176232868;11813.232139910879;11826.699063103051;11828.52685892572;11863.16957812962;11150.776984460266;11227.933346332085;12257.57098501566;12329.630111096682;12518.374081295899;5319.568878073621;5394.300795249484;5394.514493695587;5407.945920540744;5410.729463526808;936.2556767369957;944.1644144931647;960.3805545423303;982.3712823792779;989.094978095035;22176.88911555432;23299.883500582728;23608.173713920274;23639.645405318934;23831.880840596034;899.2937611495244;1072.120860894075;1084.0514549768952;1085.8218832566754;1146.931184128955;9867.197086648419;11928.76142477163;12154.939225303817;15945.123018233877;15963.281652325673;383581;384142;384454;384779;385350;55582.72208638931;55660.16509752357;55733.721331393084;55848.44151558432;56062;1350.3518311210478;1374.3540535948089;1472.6893065172005;1478.970420591582;1482.6071091161066;21251.46871328229;21357.145714171882;22075.889620552436;25308.987640494175;28401;30646.693533065274;37639.435408468344;37642;37657.43513847349;37744;302379.46430804;364633;366517;366703;366956;26121.477570448864;30809.383812324075;31374.843125784224;31492.685073149893;31503.527447087854;32848;36045.63954360423;40238.1952360957;42328;42387;23061.65407518855;27199.59200611953;28937.276568085967;29689.406211875208;29858.402831943673;28768.712312876603;29047.7095229045;29341.559876602296;29573.704262957093;29958;34051;34818;34866.65133348634;34908.65091349054;35062;28369.432611347245;29036.564451533668;29345.70654293515;29357.119286421443;29622.96319628889;20839.645423047452;21610.567788643824;21798.45503862416;23328;23709.64435533503 05:29:59 INFO - PID 1637 | |2;jquery.html;427.2895598917533;431.65683281791013;436.18433529300205;437.5078037208142;450.83769842856566;19721.11254993527;21465.141394344228;22033.449163770874;22328.553428931413;22357.10571577135;18447.81552184478;21470;22624.547509049808;22758.772412275874;23059.769402306014;5377.731113444332;6115.235595550545;6320.925442674733;6385.393387628168;6392.55252132351;5978.701064946736;6285;6371.331010243927;6373.490120790326;6375.075614035985;4968.577670897978;6305.716242769064;6328.430441260286;6329.2404911410695;6332.715027823736;6097.176881121059;6283.5287353448675;6294.433500984934;6294.559380843343;6314.6842657867155;4737.905241895142;5216.921746173811;5549.0289199390345;5592.664440133605;5613.887722245573;27109;28179.43641127166;28235.717642823514;28245.717542824514;28541.429171416665;2121.862078964862;2185.344396681005;2194.2868567715554;2202.757696653367;2215.102883332253;16924.069176195306;17165.14174291293;17751.934883907008;17864.017479038648;18022.098895055326;2011.8994050297426;2028.8174064334132;2109.5886302171084;2113.144176608476;2116.386247988082;149818;158511;160612;161266;163670.18164909218;11514.76970460586;12151.817722734166;12218.450169742382;12230.938845305716;12237.20458170216;16180.919095404683;16224.918875405547;16265.349386024664;16280.918595406947;16281.348746050262;8700.216980471789;8883.822323553493;8917;9024.458532488072;9108.043655416219;8311.709090181814;8510.106438823834;8591.312694984386;8594.097619749962;8769.736907892773;7500.437467189982;7616.961915190389;7654.2345765424125;7660.387169026464;7668.693252269847;2077.5013996640696;2083.593699228666;2089.8119169274837;2091.288961752981;2229.743579488347;884.964601415949;906.7823722306599;911.3711539038043;948.307735353196;955.3885513271512;13914;19042.714359284346;19070;19583;19832.70250946237;944.9811003780023;951.2104952889085;978.0659470205936;987.1757082835769;989.5744829723288;10307.742306442398;10413.271071025107;10421.583136674448;10450.372977621368;10763.461826908624;618395;677077;690262;691592;694742;142106.28946855405;144376.27811860872;147897.2605136989;148707;149298;1151.8157094864948;1154.2151337090859;1179.2452830188859;1180.073642190876;1182.1665725663386;16931.407400740914;17488.125593720517;17526.474205773848;17631.647367052843;17698.380556680455;60990.69504652448;62074.758504830555;62081;62217.688911556965;63517;82111.17888821036;83862;85440;88594.55702721445;91583.54208228916;8070.83858322842;8577.656893724181;8645.308375330083;8974.820503590023;9213.953930230306;12982.494726424002;13794.724105518035;14003.50987715425;14425.85574144287;14514.709705806035;11577.189596728149;11993.160478766402;12071.879281207075;12111.12277596974;12158.75682486363;10161.237907157141;11038.44807759625;11128.833067503832;11512.251703639236;11696.941515292368;10932.617358392417;11886.940565297118;12004.639860804189;12244.571439999558;12259.264444133381;8588.527630980356;8724.171203735636;8924.375293729376;8978.685745998859;9160.58777355034;10085.647002354883;11344.659660210207;11568.13239007061;11748.765024699629;12140.392980351124 05:29:59 INFO - PID 1637 | |3;mootools.html;1179.2158214787166;1312.4946895445253;1439.3594850291618;1456.5047883719526;1459.2995362226131;9260.675876344329;9721.659741909025;9724.076212759794;9731.562079706413;9737.074977877108;9533.713988580337;10159.847602285972;10609.893901060987;10938.781224375507;10997.835032474519;2376.869272190029;2431.3435372449426;2433.5132973405302;2433.707955045397;2437.2566367257978;2288.622377307742;2408.6989126359204;2423.260905423845;2425.7816796488314;2430.307362401716;2067.4107879254416;2146.527763891941;2153.849230553862;2344.9882750586307;2431.404305945046;2404.446977195237;2429.331933718224;2432.4526981429212;2437.6587277781123;2437.7074751029813;2404.627282771156;2405.0500052479174;2407.987960060206;2417.5648383291;2419.2379400488967;10855.131589472901;10973.890261097367;10983.890161098447;10987.230893837435;10993.945030274877;6170.8765824683705;6422.935770642281;6428.582142160792;6433.453156481704;6445.065465507475;3727.4967879336214;3833.769973801553;3906.8827935161708;3985.5416627087966;3986.5016872890887;1177.0701146094575;1204.482072708735;1227.355638289896;1234.8950339221176;1239.0830785218964;15307.387704491919;15327.923360383238;15334.386624535005;15340.539783806615;15353.232338383035;5325.547328477122;5607.186957891083;5629.324481062299;5642.816744887602;5697.202391665171;12763.808542871864;12776.61670149897;12798.232106073665;12800.103992720606;12804.10371274002;6457.031445283245;6481.449076828428;6481.643509606923;6483.773067942694;6485.77299794505;5782.335031471351;5978.432048955342;5992.67040312787;6033.698315084228;6035.547333949971;4243.405923170759;4343.978280108579;4363.192809330284;4422.115576884636;4437.090396468716;1398.8111604933204;1419.0629790336118;1425.0808228692435;1442.1419255542935;1443.8700516953525;754.6377738685462;765.1315756616281;792.4452882981935;795.6499140378215;806.8345989072226;5950.137230101611;6412.67936603168;6472.741090356333;6654.401103900575;6654.900176497356;572.1160806553884;579.9705522697246;592.3010847200259;601.2574470528893;603.562417247492;3728.962710372916;3764.5106136202116;3801.828917698655;4337.327714204303;4608.5621865922685;13656.24890631005;14146.504872329419;14157;14170.362333695008;14173.85826141746;13738.793918091236;14072.085314454527;14357.425702971974;14368.640783980483;14461.710765784836;10009;10398.844017339747;10530.631427899987;10531.05220530156;10546.998035186645;5841.912371314349;6185.443310102112;6625.138731964814;6685.264620891795;6845.0759147514445;11557.884421156017;12504.374781260718;12562.37188140571;12735.936320318338;12811.231326120462;12959.157654752411;13009;13138.737225255632;13218.140820846615;13278.601641950758;9061.592228349607;9189.494577798285;9226.215771659485;9269.212116970133;9286.582103805209;10033.749156271151;10038.548265328223;10136.18910487174;10142.797144057226;10155.136813370651;7009.088818453569;8619.95690021571;8670.436421632574;8686.044535101008;8912.86630700553;8470.110638383128;8533.189347012023;8546.529940853312;8568.52873091986;8618.612162452579;7677.654505547375;7693.076830780342;7852.450328476952;7853.685852565834;7855.685772569033;5330.760115794721;5923.733431995484;5945.613535120204;5997.580169388101;6014.338422773404;5861.1501332307425;5943.989521781394;6051.062085376773;6060.696965151813;6251.374862513712 05:29:59 INFO - PID 1637 | |4;prototype.html;394.10144869697086;400.1017715229311;403.29624804715775;407.91841631673634;411.28231236492326;5839.5620328475325;5843.386444423333;5865.266841644794;5888.1462187982825;5896.439838215363;5528.253685752422;5636.464535869096;5745.655260684352;5745.827625171241;5793.449622285887;3605.819709014552;3795.544534655838;4423.491298500681;4427.180971520279;4440.578145076212;4431.534688857656;4433.756143412127;4443.4445694288215;4448.28827387618;4449.866504004869;3361.7310615150727;4223.387608796723;4324.37296591994;4401.713888597247;4425.867223983286;3797.677197438221;3906.5312162540536;4360.956390436087;4378.846740364103;4388.188185185719;3307.057488615733;3876.9418458723144;3889.5138107736534;3907.433422153772;3923.6664883484937;5244.501772331622;5543.556515478752;5620.241267428885;5686.402927692574;5714.799982000652;4380.824767009316;5000.62495312853;5016.372953380827;5036.143855544567;5039.899202015976;6124.96937515314;6138.815835524942;6176.84557886052;6183.443490085914;6187.597806142587;4071.857484988041;4080.7362894048347;4119.196756632457;4187.45563076798;4218.746875187468;5558.609248358498;5800.651960882361;5806.88386232273;6132;6252.874942501125;3603.477495763152;4156.25187466259;4157.792110394468;4233.967695506174;4274;3417.8974630761118;3607.9639203608153;4302.720323178984;4310.568943105727;4315.136972605492;4781.665283430196;4906.975465122651;4912.336834527293;4914;4971.90056198874;4672.719636821802;5349.8230389314285;5590.720463976866;5878.470937615635;6118.3269840317525;1110.3337997201616;1234.7900856854355;1460.8685218330402;1463.7804329350683;1465.216109381497;909.3634455880909;984.7931934293879;989.4953573677333;995.2784231432298;997.3517213811081;4779.330893674888;5677.630953987978;5711.8857622848145;5720.427957204246;5733.799317023884;4905.681130726492;6281.183446151971;6334.5565810393755;6337.683115844282;6361.681915904186;5073.847784566469;5430.5927055471;5431.6740995540395;5705.4579814917515;5726.1410788381245;3225.661305562929;3250.73994080473;3264.689854463822;3273.5580696605653;3279.2293810954407;5575.944240557624;6208.627482351073;6493.70778314977;6509.414152726277;6554.442872355903;5217.58259339252;5749.080147176432;6545.21457425112;6607.669616519155;6678.89798183304;5670.829875103754;6348.619082854951;6569.178852643419;6574.901376479356;6591.934080659132;5543.808081262548;6326.9683651581445;6350.555461117678;6354.459870911024;6375.458086062551;6260.530460215411;6273.905891411724;6279.623222606659;6302.1492098566105;6341.904871427025;5688.40271771458;6450.451891546089;6485.481161507162;6531.967340163459;6557.147570815763;3653.9269214616093;3778.9055273617278;3880.1269714314053;4072.898177545585;4181.97909010453;6105.084237364431;6298.370162983848;6349.253955162368;6428.292887782433;6431.549791514549;6118.235220597426;6153.600015998945;6158.952977993662;6161.784337548164;6179.16581261524;6123.755049797958;6124.724387402489;6169.383061693795;6179;6214.161088253209;5814.04068328721;5970.223870896755;5985.6408615483215;6025.487833534199;6048.455638992512;6144.56988010835;6148.846278843064;6151.9384806151365;6152.907706384318;6184.783532576338;5719.2279042328755;5909.23179986599;5986.4013598639785;6027.57806953509;6029 05:29:59 INFO - PID 1637 | |5;yui.html;799.2087833045287;817.9345652347812;832.6919039955213;833.266725281752;840.7393707950532;13998.650033749149;14319.64200894978;15307.846921530767;16560.171991400442;16881.493555193334;14964.102153870748;15150.621234469143;15320.387184512634;15506.84493155068;15528.378864845392;987.9456629885353;1012.9848052279222;1013.6705570689519;1016.8169729448696;1019.0522813783178;974.780674348273;1017.1760873692333;1026.630413051301;1027.9691609251734;1031.0514326819343;1065.9253852230347;1067.4876059491448;1068.722132245614;1069.4652673663168;1070.6038765656717;1057.820170571001;1061.4745700878077;1061.9150467962545;1061.936283822973;1070.5664205996584;784.9843003139962;789.960501974899;790.4190420041265;794.5034353529045;796.1401686178913;16373.181340932906;16644.916775416168;16736.748948765657;16920.746188807178;17194.226259818213;11939.641810745692;11999.460024298927;14718.92640536801;14892;15042.197253433209;13253.204807711569;13415.731685366336;13566.864331356757;13572.253526056063;13579;3343.983280083584;3348.2299071213756;3372.578427696538;3377.814220217887;3387.1701433149037;93993.02118639847;108468.457657712;110605.44697276462;110726;111749;11444.198906076495;11531.423428828524;11560.190786645022;11662.825057624143;12076.879231207751;23866.761332386453;24388.146414875748;24411.26766197017;24424.145154919494;24506.264812055666;7863.724769633035;8081.434299598972;8111.18888111196;8161.67353305873;8331.416800824005;4045.2516284487465;4115.403266526397;4176.561461046607;4192.895177620523;4318.114786468766;4129.091599848029;4203.621674049289;4231.259529582311;4234.915301693949;4251.596098370712;723.2803360656076;922.2207234886511;932.4824722279064;935.6070450410843;936.7470782888582;618.3445547719432;618.6226401894841;618.9071639254148;634.4004915354946;649.9122618446544;9665.71002869915;10131.313481814905;10289.691309260734;10312.432816195182;10345.689629311133;546.2325432766969;585.493548080907;635.4693830651365;645.5416654175588;648.5071345777243;4669.2062349400685;5042.672226305279;5189.195674670432;5208.270842082112;5286.471352864683;100890;101873.98126018794;103701.48149259356;103829.48085259525;103956;76810.6159469199;78722;81763;84248.15751842404;87499;50577.747111264944;55919;68868.6556567214;73580.63209683917;74413.25586744171;10062.647807326708;10501.737456563647;10732.087772539422;10799.73000674958;10971.44111820277;34777.9566613002;34888.47667284942;35358;35808.28383432369;38294.80852595719;44321.556784433036;49158;49450.50549494459;49484;50336.49663503318;11064.225504214628;13359.465621375424;13661.521846735317;13847.376868041163;13920.164790112625;14470;14478.638034049232;14564.635884102981;14605.269736513344;14802.6299342513;13125.54060607874;13167.60497185086;13780.724385512434;13788.310584470937;13790.862091378958;13313.400896959854;13354.399052042487;13465.259410732504;13476.258805765778;14240.572782816533;12954.157979731288;13243.404046817725;13270.668233293858;13710.314484275546;13710.657233568842;9956.900430995598;9982.301238913496;10085.546150423103;10126.607546548277;10236.232282578985;9478.550991515647;9638.9036109638;9695.22438204956;11140.832887506856;11258.38078905668 05:29:59 INFO - PID 1637 | __end_tp_report 05:29:59 INFO - PID 1637 | __start_cc_report 05:29:59 INFO - PID 1637 | _x_x_mozilla_cycle_collect,1558 05:29:59 INFO - PID 1637 | __end_cc_report 05:29:59 INFO - PID 1637 | __startTimestamp1491308999361__endTimestamp 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | ------- Summary: start ------- 05:29:59 INFO - PID 1637 | Number of tests: 6 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:5966.57 Median:6205.50 stddev:677.50 (10.9%) stddev-sans-first:650.53 05:29:59 INFO - PID 1637 | Values: 3464.9 3473.0 3489.5 3498.9 3534.1 5943.7 6078.4 6082.1 6091.9 6123.1 5996.2 6071.0 6071.5 6071.7 6071.8 5234.6 5243.0 5259.2 5275.9 5373.9 4530.8 5211.2 5358.0 5366.7 5376.4 5343.4 5348.9 5352.0 5354.8 5364.7 5339.5 5344.3 5352.5 5359.2 5370.1 5185.3 5298.4 5312.2 5330.9 5335.4 6150.6 6183.5 6207.8 6209.1 6218.6 6416.9 6443.4 6472.7 6484.1 6485.8 6279.7 6292.8 6331.3 6346.5 6350.8 5578.7 6108.8 6134.0 6267.0 6268.5 5570.7 6660.1 6684.2 6710.8 6719.2 5486.5 6341.0 6352.3 6380.1 6387.7 6197.4 6247.8 6406.6 6503.8 6507.4 6296.3 6371.9 6425.0 6441.4 6458.7 6417.3 6420.2 6430.1 6438.9 6463.5 5116.9 5199.7 5232.0 5263.8 5269.2 4595.9 4656.1 4669.7 4678.1 4690.7 6186.8 6190.7 6200.2 6203.5 6205.5 6268.4 6528.2 6536.4 6543.5 6562.9 6013.5 6077.4 6080.1 6082.0 6093.8 5662.9 5677.1 5682.3 5686.5 5691.9 5516.5 6439.8 6516.9 6524.8 6638.1 5937.2 6153.7 6458.9 6542.8 6555.7 6739.2 6761.1 6762.6 6763.0 6765.9 6191.4 6266.5 6433.1 6436.9 6459.8 6447.0 6493.3 6499.4 6516.1 6527.1 6281.8 6293.0 6301.1 6303.2 6308.3 6183.4 6255.3 6305.8 6331.4 6341.8 6175.6 6180.2 6226.5 6236.7 6256.0 6348.0 6349.1 6366.3 6372.2 6375.0 6078.5 6192.0 6192.3 6238.4 6266.2 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:48873.36 Median:19147.78 stddev:93139.29 (486.4%) stddev-sans-first:93330.56 05:29:59 INFO - PID 1637 | Values: 775.7 808.1 824.4 1152.6 1173.1 28494.0 29111.4 29194.3 37860.2 38577.0 40312.0 40651.8 40688.0 40706.0 40818.2 8511.9 8689.4 8693.3 8697.8 8709.2 6115.7 6309.9 8497.4 8731.0 8749.9 8744.3 8841.3 8845.3 8856.1 8857.3 8732.7 8807.0 8814.6 8822.0 8829.8 8561.7 8623.5 8629.7 8632.3 8640.5 38211.2 38515.4 38528.2 38539.8 38568.0 3433.1 3468.3 3474.2 3477.6 3483.2 22576.9 30533.0 30558.2 30597.2 30615.4 3105.1 3135.1 3152.9 3166.3 3173.5 311347.0 314214.0 314315.4 314685.0 321769.0 50745.7 50766.5 50850.0 50880.5 51001.0 53313.9 53396.7 53439.0 53503.5 53544.7 14168.1 14449.5 14475.0 14479.0 14479.9 10145.6 11813.2 11826.7 11828.5 11863.2 11150.8 11227.9 12257.6 12329.6 12518.4 5319.6 5394.3 5394.5 5407.9 5410.7 936.3 944.2 960.4 982.4 989.1 22176.9 23299.9 23608.2 23639.6 23831.9 899.3 1072.1 1084.1 1085.8 1146.9 9867.2 11928.8 12154.9 15945.1 15963.3 383581.0 384142.0 384454.0 384779.0 385350.0 55582.7 55660.2 55733.7 55848.4 56062.0 1350.4 1374.4 1472.7 1479.0 1482.6 21251.5 21357.1 22075.9 25309.0 28401.0 30646.7 37639.4 37642.0 37657.4 37744.0 302379.5 364633.0 366517.0 366703.0 366956.0 26121.5 30809.4 31374.8 31492.7 31503.5 32848.0 36045.6 40238.2 42328.0 42387.0 23061.7 27199.6 28937.3 29689.4 29858.4 28768.7 29047.7 29341.6 29573.7 29958.0 34051.0 34818.0 34866.7 34908.7 35062.0 28369.4 29036.6 29345.7 29357.1 29623.0 20839.6 21610.6 21798.5 23328.0 23709.6 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:39845.11 Median:22342.83 stddev:113479.76 (507.9%) stddev-sans-first:113759.50 05:29:59 INFO - PID 1637 | Values: 427.3 431.7 436.2 437.5 450.8 19721.1 21465.1 22033.4 22328.6 22357.1 18447.8 21470.0 22624.5 22758.8 23059.8 5377.7 6115.2 6320.9 6385.4 6392.6 5978.7 6285.0 6371.3 6373.5 6375.1 4968.6 6305.7 6328.4 6329.2 6332.7 6097.2 6283.5 6294.4 6294.6 6314.7 4737.9 5216.9 5549.0 5592.7 5613.9 27109.0 28179.4 28235.7 28245.7 28541.4 2121.9 2185.3 2194.3 2202.8 2215.1 16924.1 17165.1 17751.9 17864.0 18022.1 2011.9 2028.8 2109.6 2113.1 2116.4 149818.0 158511.0 160612.0 161266.0 163670.2 11514.8 12151.8 12218.5 12230.9 12237.2 16180.9 16224.9 16265.3 16280.9 16281.3 8700.2 8883.8 8917.0 9024.5 9108.0 8311.7 8510.1 8591.3 8594.1 8769.7 7500.4 7617.0 7654.2 7660.4 7668.7 2077.5 2083.6 2089.8 2091.3 2229.7 885.0 906.8 911.4 948.3 955.4 13914.0 19042.7 19070.0 19583.0 19832.7 945.0 951.2 978.1 987.2 989.6 10307.7 10413.3 10421.6 10450.4 10763.5 618395.0 677077.0 690262.0 691592.0 694742.0 142106.3 144376.3 147897.3 148707.0 149298.0 1151.8 1154.2 1179.2 1180.1 1182.2 16931.4 17488.1 17526.5 17631.6 17698.4 60990.7 62074.8 62081.0 62217.7 63517.0 82111.2 83862.0 85440.0 88594.6 91583.5 8070.8 8577.7 8645.3 8974.8 9214.0 12982.5 13794.7 14003.5 14425.9 14514.7 11577.2 11993.2 12071.9 12111.1 12158.8 10161.2 11038.4 11128.8 11512.3 11696.9 10932.6 11886.9 12004.6 12244.6 12259.3 8588.5 8724.2 8924.4 8978.7 9160.6 10085.6 11344.7 11568.1 11748.8 12140.4 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:6836.58 Median:3746.74 stddev:4269.97 (114.0%) stddev-sans-first:4260.78 05:29:59 INFO - PID 1637 | Values: 1179.2 1312.5 1439.4 1456.5 1459.3 9260.7 9721.7 9724.1 9731.6 9737.1 9533.7 10159.8 10609.9 10938.8 10997.8 2376.9 2431.3 2433.5 2433.7 2437.3 2288.6 2408.7 2423.3 2425.8 2430.3 2067.4 2146.5 2153.8 2345.0 2431.4 2404.4 2429.3 2432.5 2437.7 2437.7 2404.6 2405.1 2408.0 2417.6 2419.2 10855.1 10973.9 10983.9 10987.2 10993.9 6170.9 6422.9 6428.6 6433.5 6445.1 3727.5 3833.8 3906.9 3985.5 3986.5 1177.1 1204.5 1227.4 1234.9 1239.1 15307.4 15327.9 15334.4 15340.5 15353.2 5325.5 5607.2 5629.3 5642.8 5697.2 12763.8 12776.6 12798.2 12800.1 12804.1 6457.0 6481.4 6481.6 6483.8 6485.8 5782.3 5978.4 5992.7 6033.7 6035.5 4243.4 4344.0 4363.2 4422.1 4437.1 1398.8 1419.1 1425.1 1442.1 1443.9 754.6 765.1 792.4 795.6 806.8 5950.1 6412.7 6472.7 6654.4 6654.9 572.1 580.0 592.3 601.3 603.6 3729.0 3764.5 3801.8 4337.3 4608.6 13656.2 14146.5 14157.0 14170.4 14173.9 13738.8 14072.1 14357.4 14368.6 14461.7 10009.0 10398.8 10530.6 10531.1 10547.0 5841.9 6185.4 6625.1 6685.3 6845.1 11557.9 12504.4 12562.4 12735.9 12811.2 12959.2 13009.0 13138.7 13218.1 13278.6 9061.6 9189.5 9226.2 9269.2 9286.6 10033.7 10038.5 10136.2 10142.8 10155.1 7009.1 8620.0 8670.4 8686.0 8912.9 8470.1 8533.2 8546.5 8568.5 8618.6 7677.7 7693.1 7852.5 7853.7 7855.7 5330.8 5923.7 5945.6 5997.6 6014.3 5861.2 5944.0 6051.1 6060.7 6251.4 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:4962.06 Median:5696.93 stddev:1556.47 (27.3%) stddev-sans-first:1522.60 05:29:59 INFO - PID 1637 | Values: 394.1 400.1 403.3 407.9 411.3 5839.6 5843.4 5865.3 5888.1 5896.4 5528.3 5636.5 5745.7 5745.8 5793.4 3605.8 3795.5 4423.5 4427.2 4440.6 4431.5 4433.8 4443.4 4448.3 4449.9 3361.7 4223.4 4324.4 4401.7 4425.9 3797.7 3906.5 4361.0 4378.8 4388.2 3307.1 3876.9 3889.5 3907.4 3923.7 5244.5 5543.6 5620.2 5686.4 5714.8 4380.8 5000.6 5016.4 5036.1 5039.9 6125.0 6138.8 6176.8 6183.4 6187.6 4071.9 4080.7 4119.2 4187.5 4218.7 5558.6 5800.7 5806.9 6132.0 6252.9 3603.5 4156.3 4157.8 4234.0 4274.0 3417.9 3608.0 4302.7 4310.6 4315.1 4781.7 4907.0 4912.3 4914.0 4971.9 4672.7 5349.8 5590.7 5878.5 6118.3 1110.3 1234.8 1460.9 1463.8 1465.2 909.4 984.8 989.5 995.3 997.4 4779.3 5677.6 5711.9 5720.4 5733.8 4905.7 6281.2 6334.6 6337.7 6361.7 5073.8 5430.6 5431.7 5705.5 5726.1 3225.7 3250.7 3264.7 3273.6 3279.2 5575.9 6208.6 6493.7 6509.4 6554.4 5217.6 5749.1 6545.2 6607.7 6678.9 5670.8 6348.6 6569.2 6574.9 6591.9 5543.8 6327.0 6350.6 6354.5 6375.5 6260.5 6273.9 6279.6 6302.1 6341.9 5688.4 6450.5 6485.5 6532.0 6557.1 3653.9 3778.9 3880.1 4072.9 4182.0 6105.1 6298.4 6349.3 6428.3 6431.5 6118.2 6153.6 6159.0 6161.8 6179.2 6123.8 6124.7 6169.4 6179.0 6214.2 5814.0 5970.2 5985.6 6025.5 6048.5 6144.6 6148.8 6151.9 6152.9 6184.8 5719.2 5909.2 5986.4 6027.6 6029.0 05:29:59 INFO - PID 1637 | 05:29:59 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:19267.22 Median:16602.54 stddev:27318.45 (164.5%) stddev-sans-first:27359.89 05:29:59 INFO - PID 1637 | Values: 799.2 817.9 832.7 833.3 840.7 13998.7 14319.6 15307.8 16560.2 16881.5 14964.1 15150.6 15320.4 15506.8 15528.4 987.9 1013.0 1013.7 1016.8 1019.1 974.8 1017.2 1026.6 1028.0 1031.1 1065.9 1067.5 1068.7 1069.5 1070.6 1057.8 1061.5 1061.9 1061.9 1070.6 785.0 790.0 790.4 794.5 796.1 16373.2 16644.9 16736.7 16920.7 17194.2 11939.6 11999.5 14718.9 14892.0 15042.2 13253.2 13415.7 13566.9 13572.3 13579.0 3344.0 3348.2 3372.6 3377.8 3387.2 93993.0 108468.5 110605.4 110726.0 111749.0 11444.2 11531.4 11560.2 11662.8 12076.9 23866.8 24388.1 24411.3 24424.1 24506.3 7863.7 8081.4 8111.2 8161.7 8331.4 4045.3 4115.4 4176.6 4192.9 4318.1 4129.1 4203.6 4231.3 4234.9 4251.6 723.3 922.2 932.5 935.6 936.7 618.3 618.6 618.9 634.4 649.9 9665.7 10131.3 10289.7 10312.4 10345.7 546.2 585.5 635.5 645.5 648.5 4669.2 5042.7 5189.2 5208.3 5286.5 100890.0 101874.0 103701.5 103829.5 103956.0 76810.6 78722.0 81763.0 84248.2 87499.0 50577.7 55919.0 68868.7 73580.6 74413.3 10062.6 10501.7 10732.1 10799.7 10971.4 34778.0 34888.5 35358.0 35808.3 38294.8 44321.6 49158.0 49450.5 49484.0 50336.5 11064.2 13359.5 13661.5 13847.4 13920.2 14470.0 14478.6 14564.6 14605.3 14802.6 13125.5 13167.6 13780.7 13788.3 13790.9 13313.4 13354.4 13465.3 13476.3 14240.6 12954.2 13243.4 13270.7 13710.3 13710.7 9956.9 9982.3 10085.5 10126.6 10236.2 9478.6 9638.9 9695.2 11140.8 11258.4 05:29:59 INFO - PID 1637 | -------- Summary: end -------- 05:29:59 INFO - PID 1637 | 05:30:00 INFO - TEST-INFO | 1637: exit 0 05:30:00 INFO - TEST-OK | dromaeo_css | took 1120123ms 05:30:00 INFO - TEST-START | kraken 05:30:00 INFO - operating with platform_type : mac_ 05:30:00 INFO - Initialising browser for kraken test... 05:30:00 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmp83xreh/profile http://localhost:49253/getInfo.html) 05:30:02 INFO - PID 1648 | __metrics Screen width/height:1600/1200 05:30:02 INFO - PID 1648 | colorDepth:24 05:30:02 INFO - PID 1648 | Browser inner width/height: 1024/689 05:30:02 INFO - PID 1648 | __metrics 05:30:02 INFO - PID 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:30:02 INFO - PID 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:03 INFO - TEST-INFO | 1648: exit 0 05:30:03 INFO - Browser initialized. 05:30:03 INFO - Running cycle 1/1 for kraken test... 05:30:03 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmp83xreh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:15 INFO - PID 1649 | RSS: Main: 232214528 05:30:15 INFO - PID 1649 | 05:30:18 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:19 INFO - PID 1649 | RSS: Main: 286720000 05:30:19 INFO - PID 1649 | 05:30:22 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-dft) 05:30:23 INFO - PID 1649 | RSS: Main: 286425088 05:30:23 INFO - PID 1649 | 05:30:26 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-fft) 05:30:27 INFO - PID 1649 | RSS: Main: 380882944 05:30:27 INFO - PID 1649 | 05:30:29 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator) 05:30:30 INFO - PID 1649 | RSS: Main: 283934720 05:30:30 INFO - PID 1649 | 05:30:32 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:32 INFO - PID 1649 | RSS: Main: 285933568 05:30:32 INFO - PID 1649 | 05:30:36 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:36 INFO - PID 1649 | RSS: Main: 328826880 05:30:36 INFO - PID 1649 | 05:30:39 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:40 INFO - PID 1649 | RSS: Main: 339271680 05:30:40 INFO - PID 1649 | 05:30:43 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial) 05:30:44 INFO - PID 1649 | RSS: Main: 342310912 05:30:44 INFO - PID 1649 | 05:30:45 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:46 INFO - PID 1649 | RSS: Main: 304607232 05:30:46 INFO - PID 1649 | 05:30:48 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:49 INFO - PID 1649 | RSS: Main: 306462720 05:30:49 INFO - PID 1649 | 05:30:51 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:52 INFO - PID 1649 | RSS: Main: 309444608 05:30:52 INFO - PID 1649 | 05:30:55 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:56 INFO - PID 1649 | RSS: Main: 327880704 05:30:56 INFO - PID 1649 | 05:30:59 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:59 INFO - PID 1649 | RSS: Main: 321855488 05:30:59 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49253/tests/kraken/driver.html?testName=ai-astar) 05:31:01 INFO - PID 1649 | RSS: Main: 384901120 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | __start_tp_report 05:31:01 INFO - PID 1649 | _x_x_mozilla_page_load 05:31:01 INFO - PID 1649 | _x_x_mozilla_page_load_details 05:31:01 INFO - PID 1649 | |i|pagename|runs| 05:31:01 INFO - PID 1649 | |0;ai-astar;173;180;140;120;123;122;121;122;123;121 05:31:01 INFO - PID 1649 | |1;audio-beat-detection;155;123;119;164;122;119;117;139;184;142 05:31:01 INFO - PID 1649 | |2;audio-dft;211;218;218;212;213;211;211;213;209;210 05:31:01 INFO - PID 1649 | |3;audio-fft;87;72;93;128;87;64;64;62;81;63 05:31:01 INFO - PID 1649 | |4;audio-oscillator;97;78;94;75;76;73;89;74;74;94 05:31:01 INFO - PID 1649 | |5;imaging-gaussian-blur;90;98;127;138;88;90;98;90;89;90 05:31:01 INFO - PID 1649 | |6;imaging-darkroom;99;96;97;98;109;98;100;98;97;97 05:31:01 INFO - PID 1649 | |7;imaging-desaturate;100;101;100;103;102;110;85;146;152;100 05:31:01 INFO - PID 1649 | |8;json-parse-financial;53;51;51;51;51;52;52;52;51;52 05:31:01 INFO - PID 1649 | |9;json-stringify-tinderbox;58;70;63;68;67;64;64;64;64;62 05:31:01 INFO - PID 1649 | |10;stanford-crypto-aes;91;91;88;91;89;89;91;83;92;105 05:31:01 INFO - PID 1649 | |11;stanford-crypto-ccm;153;154;148;147;147;150;148;149;241;209 05:31:01 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;200;205;203;201;202;201;199;198;201;199 05:31:01 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;71;74;74;74;73;72;74;74;72;74 05:31:01 INFO - PID 1649 | __end_tp_report 05:31:01 INFO - PID 1649 | __start_cc_report 05:31:01 INFO - PID 1649 | _x_x_mozilla_cycle_collect,2191 05:31:01 INFO - PID 1649 | __end_cc_report 05:31:01 INFO - PID 1649 | __startTimestamp1491309061973__endTimestamp 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | ------- Summary: start ------- 05:31:01 INFO - PID 1649 | Number of tests: 14 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:134.50 Median:123.00 stddev:22.94 (18.6%) stddev-sans-first:19.65 05:31:01 INFO - PID 1649 | Values: 173.0 180.0 140.0 120.0 123.0 122.0 121.0 122.0 123.0 121.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:140.50 stddev:22.95 (16.3%) stddev-sans-first:23.54 05:31:01 INFO - PID 1649 | Values: 155.0 123.0 119.0 164.0 122.0 119.0 117.0 139.0 184.0 142.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:212.60 Median:212.50 stddev:3.10 (1.5%) stddev-sans-first:3.23 05:31:01 INFO - PID 1649 | Values: 211.0 218.0 218.0 212.0 213.0 211.0 211.0 213.0 209.0 210.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:80.10 Median:76.50 stddev:20.44 (26.7%) stddev-sans-first:21.53 05:31:01 INFO - PID 1649 | Values: 87.0 72.0 93.0 128.0 87.0 64.0 64.0 62.0 81.0 63.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:83.50 stddev:9.83 (11.8%) stddev-sans-first:8.90 05:31:01 INFO - PID 1649 | Values: 97.0 78.0 94.0 75.0 76.0 73.0 89.0 74.0 74.0 94.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:99.80 Median:90.00 stddev:17.78 (19.8%) stddev-sans-first:18.50 05:31:01 INFO - PID 1649 | Values: 90.0 98.0 127.0 138.0 88.0 90.0 98.0 90.0 89.0 90.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:98.90 Median:97.50 stddev:3.73 (3.8%) stddev-sans-first:3.95 05:31:01 INFO - PID 1649 | Values: 99.0 96.0 97.0 98.0 109.0 98.0 100.0 98.0 97.0 97.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:109.90 Median:106.50 stddev:21.55 (20.2%) stddev-sans-first:22.56 05:31:01 INFO - PID 1649 | Values: 100.0 101.0 100.0 103.0 102.0 110.0 85.0 146.0 152.0 100.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.53 05:31:01 INFO - PID 1649 | Values: 53.0 51.0 51.0 51.0 51.0 52.0 52.0 52.0 51.0 52.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:3.34 (5.2%) stddev-sans-first:2.62 05:31:01 INFO - PID 1649 | Values: 58.0 70.0 63.0 68.0 67.0 64.0 64.0 64.0 64.0 62.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:91.00 stddev:5.56 (6.1%) stddev-sans-first:5.89 05:31:01 INFO - PID 1649 | Values: 91.0 91.0 88.0 91.0 89.0 89.0 91.0 83.0 92.0 105.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:164.60 Median:151.50 stddev:32.80 (21.6%) stddev-sans-first:34.52 05:31:01 INFO - PID 1649 | Values: 153.0 154.0 148.0 147.0 147.0 150.0 148.0 149.0 241.0 209.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.90 Median:201.00 stddev:2.08 (1.0%) stddev-sans-first:2.18 05:31:01 INFO - PID 1649 | Values: 200.0 205.0 203.0 201.0 202.0 201.0 199.0 198.0 201.0 199.0 05:31:01 INFO - PID 1649 | 05:31:01 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:1.14 (1.5%) stddev-sans-first:0.88 05:31:01 INFO - PID 1649 | Values: 71.0 74.0 74.0 74.0 73.0 72.0 74.0 74.0 72.0 74.0 05:31:01 INFO - PID 1649 | -------- Summary: end -------- 05:31:01 INFO - PID 1649 | 05:31:02 INFO - TEST-INFO | 1649: exit 0 05:31:02 INFO - TEST-OK | kraken | took 62825ms 05:31:02 INFO - SUITE-END | took 1182s 05:31:03 INFO - Completed test suite (00:19:43) 05:31:03 INFO - javascript benchmark 05:31:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7582.083608500845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3464.9480257796135, 3472.9999999999995, 3489.5114683944266, 3498.930021399572, 3534.0988048047743, 5943.732532036058, 6078.392160783925, 6082.057281121433, 6091.939080609192, 6123.081537769337, 5996.220491336131, 6071.0, 6071.483923866465, 6071.696415179245, 6071.78748743794, 5234.581233501321, 5243.0, 5259.237410575464, 5275.894482110355, 5373.946260537384, 4530.754042638285, 5211.244369566411, 5357.981983423157, 5366.731663416833, 5376.381716102659, 5343.358796944372, 5348.946510534904, 5352.0, 5354.839354819362, 5364.7317634118135, 5339.519443250126, 5344.331958505187, 5352.464753524636, 5359.169328754049, 5370.087085195526, 5185.299984502081, 5298.364196296469, 5312.1766126250495, 5330.866728331784, 5335.359756829166, 6150.630962142241, 6183.505319574423, 6207.751689932397, 6209.099680546341, 6218.595791273553, 6416.914502786566, 6443.420092191725, 6472.708728107246, 6484.124643173159, 6485.805425837185, 6279.654618995954, 6292.842678933018, 6331.33520980295, 6346.4922806175855, 6350.777722779727, 5578.665280083208, 6108.827782940766, 6134.038624681843, 6266.968665156645, 6268.529860260407, 5570.6657600543285, 6660.067590537328, 6684.197896252481, 6710.765123220664, 6719.160104986877, 5486.533644640171, 6341.017142342944, 6352.2694890087305, 6380.106785050097, 6387.680615969183, 6197.411245931629, 6247.781327653601, 6406.583572067801, 6503.837404064936, 6507.414332710079, 6296.275928268308, 6371.904421433682, 6425.0, 6441.3880681335195, 6458.741650333934, 6417.262014868256, 6420.1974753155855, 6430.0676401921455, 6438.935610643927, 6463.515236357292, 5116.872078198075, 5199.6880187188135, 5232.03207406631, 5263.815766448156, 5269.235960785664, 4595.931061034087, 4656.092062047868, 4669.719816811003, 4678.087772884323, 4690.671652984327, 6186.81439556814, 6190.659513726699, 6200.193974783249, 6203.503719702413, 6205.503559715212, 6268.435840774352, 6528.183977002875, 6536.444402225864, 6543.476521878239, 6562.934370656328, 6013.51891848651, 6077.36187700294, 6080.087986802015, 6082.0, 6093.756249750049, 5662.915056274159, 5677.09166533361, 5682.289713785777, 5686.545076393962, 5691.886162276731, 5516.475934786269, 6439.8068057958335, 6516.934830651822, 6524.804255872332, 6638.137042184485, 5937.228160339128, 6153.661548614869, 6458.935410645833, 6542.771003014872, 6555.737770489127, 6739.191297044386, 6761.053452516553, 6762.594244345355, 6762.966185169043, 6765.8985115224295, 6191.442770150708, 6266.467350275278, 6433.099366088845, 6436.871262574628, 6459.806205813833, 6447.0329450582785, 6493.253275873335, 6499.38255865692, 6516.120323756232, 6527.11883895668, 6281.842953926189, 6293.0, 6301.117843501822, 6303.180586523906, 6308.27454842699, 6183.350748171557, 6255.31191568918, 6305.8108256752375, 6331.366863313632, 6341.8097457076365, 6175.567710260419, 6180.196574445473, 6226.50187984951, 6236.719347629277, 6256.0, 6348.0, 6349.079383489276, 6366.29970703213, 6372.203474565679, 6375.0, 6078.483328917092, 6192.040233763593, 6192.349803270592, 6238.376162383725, 6266.248050234001], "value": 5923.249844924413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.7129861951075, 808.1151139502244, 824.3528829868554, 1152.5620264299564, 1173.096715529042, 28494.00270990516, 29111.417771644556, 29194.27014324643, 37860.24279514415, 38577.0, 40312.0, 40651.796741016326, 40687.98280042993, 40705.98235044118, 40818.18363632725, 8511.872321915176, 8689.435186712875, 8693.347998900077, 8697.7825554361, 8709.172628600272, 6115.69421528924, 6309.9369006310035, 8497.362697797658, 8731.0, 8749.912500875005, 8744.256738177231, 8841.29269658429, 8845.336599755012, 8856.114388561156, 8857.335699822506, 8732.738017859443, 8806.955965220197, 8814.647414103429, 8821.985471670776, 8829.779255518632, 8561.743147705578, 8623.525706086162, 8629.69796057135, 8632.266257368132, 8640.524771137585, 38211.23577528434, 38515.42226866599, 38528.22943541141, 38539.8073009636, 38568.03579910497, 3433.124553238933, 3468.3063387322636, 3474.1835668617855, 3477.565304336958, 3483.164040630256, 22576.88711556448, 30533.0, 30558.236044098852, 30597.235069123228, 30615.40768884663, 3105.068479456154, 3135.0751528299206, 3152.8896488622786, 3166.335069635379, 3173.5239714042846, 311347.0, 314214.0, 314315.42842285644, 314685.0, 321769.0, 50745.74627126841, 50766.49233507692, 50850.0, 50880.49119508832, 51001.0, 53313.93372132535, 53396.73301633545, 53439.0, 53503.46496535063, 53544.73227633837, 14168.079074860101, 14449.494267700791, 14474.986750927334, 14479.0, 14479.914006449559, 10145.594176232868, 11813.232139910879, 11826.699063103051, 11828.52685892572, 11863.16957812962, 11150.776984460266, 11227.933346332085, 12257.57098501566, 12329.630111096682, 12518.374081295899, 5319.568878073621, 5394.300795249484, 5394.514493695587, 5407.945920540744, 5410.729463526808, 936.2556767369957, 944.1644144931647, 960.3805545423303, 982.3712823792779, 989.094978095035, 22176.88911555432, 23299.883500582728, 23608.173713920274, 23639.645405318934, 23831.880840596034, 899.2937611495244, 1072.120860894075, 1084.0514549768952, 1085.8218832566754, 1146.931184128955, 9867.197086648419, 11928.76142477163, 12154.939225303817, 15945.123018233877, 15963.281652325673, 383581.0, 384142.0, 384454.0, 384779.0, 385350.0, 55582.72208638931, 55660.16509752357, 55733.721331393084, 55848.44151558432, 56062.0, 1350.3518311210478, 1374.3540535948089, 1472.6893065172005, 1478.970420591582, 1482.6071091161066, 21251.46871328229, 21357.145714171882, 22075.889620552436, 25308.987640494175, 28401.0, 30646.693533065274, 37639.435408468344, 37642.0, 37657.43513847349, 37744.0, 302379.46430804, 364633.0, 366517.0, 366703.0, 366956.0, 26121.477570448864, 30809.383812324075, 31374.843125784224, 31492.685073149893, 31503.527447087854, 32848.0, 36045.63954360423, 40238.1952360957, 42328.0, 42387.0, 23061.65407518855, 27199.59200611953, 28937.276568085967, 29689.406211875208, 29858.402831943673, 28768.712312876603, 29047.7095229045, 29341.559876602296, 29573.704262957093, 29958.0, 34051.0, 34818.0, 34866.65133348634, 34908.65091349054, 35062.0, 28369.432611347245, 29036.564451533668, 29345.70654293515, 29357.119286421443, 29622.96319628889, 20839.645423047452, 21610.567788643824, 21798.45503862416, 23328.0, 23709.64435533503], "value": 17322.947408651562, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.2895598917533, 431.65683281791013, 436.18433529300205, 437.5078037208142, 450.83769842856566, 19721.11254993527, 21465.141394344228, 22033.449163770874, 22328.553428931413, 22357.10571577135, 18447.81552184478, 21470.0, 22624.547509049808, 22758.772412275874, 23059.769402306014, 5377.731113444332, 6115.235595550545, 6320.925442674733, 6385.393387628168, 6392.55252132351, 5978.701064946736, 6285.0, 6371.331010243927, 6373.490120790326, 6375.075614035985, 4968.577670897978, 6305.716242769064, 6328.430441260286, 6329.2404911410695, 6332.715027823736, 6097.176881121059, 6283.5287353448675, 6294.433500984934, 6294.559380843343, 6314.6842657867155, 4737.905241895142, 5216.921746173811, 5549.0289199390345, 5592.664440133605, 5613.887722245573, 27109.0, 28179.43641127166, 28235.717642823514, 28245.717542824514, 28541.429171416665, 2121.862078964862, 2185.344396681005, 2194.2868567715554, 2202.757696653367, 2215.102883332253, 16924.069176195306, 17165.14174291293, 17751.934883907008, 17864.017479038648, 18022.098895055326, 2011.8994050297426, 2028.8174064334132, 2109.5886302171084, 2113.144176608476, 2116.386247988082, 149818.0, 158511.0, 160612.0, 161266.0, 163670.18164909218, 11514.76970460586, 12151.817722734166, 12218.450169742382, 12230.938845305716, 12237.20458170216, 16180.919095404683, 16224.918875405547, 16265.349386024664, 16280.918595406947, 16281.348746050262, 8700.216980471789, 8883.822323553493, 8917.0, 9024.458532488072, 9108.043655416219, 8311.709090181814, 8510.106438823834, 8591.312694984386, 8594.097619749962, 8769.736907892773, 7500.437467189982, 7616.961915190389, 7654.2345765424125, 7660.387169026464, 7668.693252269847, 2077.5013996640696, 2083.593699228666, 2089.8119169274837, 2091.288961752981, 2229.743579488347, 884.964601415949, 906.7823722306599, 911.3711539038043, 948.307735353196, 955.3885513271512, 13914.0, 19042.714359284346, 19070.0, 19583.0, 19832.70250946237, 944.9811003780023, 951.2104952889085, 978.0659470205936, 987.1757082835769, 989.5744829723288, 10307.742306442398, 10413.271071025107, 10421.583136674448, 10450.372977621368, 10763.461826908624, 618395.0, 677077.0, 690262.0, 691592.0, 694742.0, 142106.28946855405, 144376.27811860872, 147897.2605136989, 148707.0, 149298.0, 1151.8157094864948, 1154.2151337090859, 1179.2452830188859, 1180.073642190876, 1182.1665725663386, 16931.407400740914, 17488.125593720517, 17526.474205773848, 17631.647367052843, 17698.380556680455, 60990.69504652448, 62074.758504830555, 62081.0, 62217.688911556965, 63517.0, 82111.17888821036, 83862.0, 85440.0, 88594.55702721445, 91583.54208228916, 8070.83858322842, 8577.656893724181, 8645.308375330083, 8974.820503590023, 9213.953930230306, 12982.494726424002, 13794.724105518035, 14003.50987715425, 14425.85574144287, 14514.709705806035, 11577.189596728149, 11993.160478766402, 12071.879281207075, 12111.12277596974, 12158.75682486363, 10161.237907157141, 11038.44807759625, 11128.833067503832, 11512.251703639236, 11696.941515292368, 10932.617358392417, 11886.940565297118, 12004.639860804189, 12244.571439999558, 12259.264444133381, 8588.527630980356, 8724.171203735636, 8924.375293729376, 8978.685745998859, 9160.58777355034, 10085.647002354883, 11344.659660210207, 11568.13239007061, 11748.765024699629, 12140.392980351124], "value": 10450.772185999911, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1179.2158214787166, 1312.4946895445253, 1439.3594850291618, 1456.5047883719526, 1459.2995362226131, 9260.675876344329, 9721.659741909025, 9724.076212759794, 9731.562079706413, 9737.074977877108, 9533.713988580337, 10159.847602285972, 10609.893901060987, 10938.781224375507, 10997.835032474519, 2376.869272190029, 2431.3435372449426, 2433.5132973405302, 2433.707955045397, 2437.2566367257978, 2288.622377307742, 2408.6989126359204, 2423.260905423845, 2425.7816796488314, 2430.307362401716, 2067.4107879254416, 2146.527763891941, 2153.849230553862, 2344.9882750586307, 2431.404305945046, 2404.446977195237, 2429.331933718224, 2432.4526981429212, 2437.6587277781123, 2437.7074751029813, 2404.627282771156, 2405.0500052479174, 2407.987960060206, 2417.5648383291, 2419.2379400488967, 10855.131589472901, 10973.890261097367, 10983.890161098447, 10987.230893837435, 10993.945030274877, 6170.8765824683705, 6422.935770642281, 6428.582142160792, 6433.453156481704, 6445.065465507475, 3727.4967879336214, 3833.769973801553, 3906.8827935161708, 3985.5416627087966, 3986.5016872890887, 1177.0701146094575, 1204.482072708735, 1227.355638289896, 1234.8950339221176, 1239.0830785218964, 15307.387704491919, 15327.923360383238, 15334.386624535005, 15340.539783806615, 15353.232338383035, 5325.547328477122, 5607.186957891083, 5629.324481062299, 5642.816744887602, 5697.202391665171, 12763.808542871864, 12776.61670149897, 12798.232106073665, 12800.103992720606, 12804.10371274002, 6457.031445283245, 6481.449076828428, 6481.643509606923, 6483.773067942694, 6485.77299794505, 5782.335031471351, 5978.432048955342, 5992.67040312787, 6033.698315084228, 6035.547333949971, 4243.405923170759, 4343.978280108579, 4363.192809330284, 4422.115576884636, 4437.090396468716, 1398.8111604933204, 1419.0629790336118, 1425.0808228692435, 1442.1419255542935, 1443.8700516953525, 754.6377738685462, 765.1315756616281, 792.4452882981935, 795.6499140378215, 806.8345989072226, 5950.137230101611, 6412.67936603168, 6472.741090356333, 6654.401103900575, 6654.900176497356, 572.1160806553884, 579.9705522697246, 592.3010847200259, 601.2574470528893, 603.562417247492, 3728.962710372916, 3764.5106136202116, 3801.828917698655, 4337.327714204303, 4608.5621865922685, 13656.24890631005, 14146.504872329419, 14157.0, 14170.362333695008, 14173.85826141746, 13738.793918091236, 14072.085314454527, 14357.425702971974, 14368.640783980483, 14461.710765784836, 10009.0, 10398.844017339747, 10530.631427899987, 10531.05220530156, 10546.998035186645, 5841.912371314349, 6185.443310102112, 6625.138731964814, 6685.264620891795, 6845.0759147514445, 11557.884421156017, 12504.374781260718, 12562.37188140571, 12735.936320318338, 12811.231326120462, 12959.157654752411, 13009.0, 13138.737225255632, 13218.140820846615, 13278.601641950758, 9061.592228349607, 9189.494577798285, 9226.215771659485, 9269.212116970133, 9286.582103805209, 10033.749156271151, 10038.548265328223, 10136.18910487174, 10142.797144057226, 10155.136813370651, 7009.088818453569, 8619.95690021571, 8670.436421632574, 8686.044535101008, 8912.86630700553, 8470.110638383128, 8533.189347012023, 8546.529940853312, 8568.52873091986, 8618.612162452579, 7677.654505547375, 7693.076830780342, 7852.450328476952, 7853.685852565834, 7855.685772569033, 5330.760115794721, 5923.733431995484, 5945.613535120204, 5997.580169388101, 6014.338422773404, 5861.1501332307425, 5943.989521781394, 6051.062085376773, 6060.696965151813, 6251.374862513712], "value": 5154.9885517366265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.10144869697086, 400.1017715229311, 403.29624804715775, 407.91841631673634, 411.28231236492326, 5839.5620328475325, 5843.386444423333, 5865.266841644794, 5888.1462187982825, 5896.439838215363, 5528.253685752422, 5636.464535869096, 5745.655260684352, 5745.827625171241, 5793.449622285887, 3605.819709014552, 3795.544534655838, 4423.491298500681, 4427.180971520279, 4440.578145076212, 4431.534688857656, 4433.756143412127, 4443.4445694288215, 4448.28827387618, 4449.866504004869, 3361.7310615150727, 4223.387608796723, 4324.37296591994, 4401.713888597247, 4425.867223983286, 3797.677197438221, 3906.5312162540536, 4360.956390436087, 4378.846740364103, 4388.188185185719, 3307.057488615733, 3876.9418458723144, 3889.5138107736534, 3907.433422153772, 3923.6664883484937, 5244.501772331622, 5543.556515478752, 5620.241267428885, 5686.402927692574, 5714.799982000652, 4380.824767009316, 5000.62495312853, 5016.372953380827, 5036.143855544567, 5039.899202015976, 6124.96937515314, 6138.815835524942, 6176.84557886052, 6183.443490085914, 6187.597806142587, 4071.857484988041, 4080.7362894048347, 4119.196756632457, 4187.45563076798, 4218.746875187468, 5558.609248358498, 5800.651960882361, 5806.88386232273, 6132.0, 6252.874942501125, 3603.477495763152, 4156.25187466259, 4157.792110394468, 4233.967695506174, 4274.0, 3417.8974630761118, 3607.9639203608153, 4302.720323178984, 4310.568943105727, 4315.136972605492, 4781.665283430196, 4906.975465122651, 4912.336834527293, 4914.0, 4971.90056198874, 4672.719636821802, 5349.8230389314285, 5590.720463976866, 5878.470937615635, 6118.3269840317525, 1110.3337997201616, 1234.7900856854355, 1460.8685218330402, 1463.7804329350683, 1465.216109381497, 909.3634455880909, 984.7931934293879, 989.4953573677333, 995.2784231432298, 997.3517213811081, 4779.330893674888, 5677.630953987978, 5711.8857622848145, 5720.427957204246, 5733.799317023884, 4905.681130726492, 6281.183446151971, 6334.5565810393755, 6337.683115844282, 6361.681915904186, 5073.847784566469, 5430.5927055471, 5431.6740995540395, 5705.4579814917515, 5726.1410788381245, 3225.661305562929, 3250.73994080473, 3264.689854463822, 3273.5580696605653, 3279.2293810954407, 5575.944240557624, 6208.627482351073, 6493.70778314977, 6509.414152726277, 6554.442872355903, 5217.58259339252, 5749.080147176432, 6545.21457425112, 6607.669616519155, 6678.89798183304, 5670.829875103754, 6348.619082854951, 6569.178852643419, 6574.901376479356, 6591.934080659132, 5543.808081262548, 6326.9683651581445, 6350.555461117678, 6354.459870911024, 6375.458086062551, 6260.530460215411, 6273.905891411724, 6279.623222606659, 6302.1492098566105, 6341.904871427025, 5688.40271771458, 6450.451891546089, 6485.481161507162, 6531.967340163459, 6557.147570815763, 3653.9269214616093, 3778.9055273617278, 3880.1269714314053, 4072.898177545585, 4181.97909010453, 6105.084237364431, 6298.370162983848, 6349.253955162368, 6428.292887782433, 6431.549791514549, 6118.235220597426, 6153.600015998945, 6158.952977993662, 6161.784337548164, 6179.16581261524, 6123.755049797958, 6124.724387402489, 6169.383061693795, 6179.0, 6214.161088253209, 5814.04068328721, 5970.223870896755, 5985.6408615483215, 6025.487833534199, 6048.455638992512, 6144.56988010835, 6148.846278843064, 6151.9384806151365, 6152.907706384318, 6184.783532576338, 5719.2279042328755, 5909.23179986599, 5986.4013598639785, 6027.57806953509, 6029.0], "value": 4482.20873224915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.2087833045287, 817.9345652347812, 832.6919039955213, 833.266725281752, 840.7393707950532, 13998.650033749149, 14319.64200894978, 15307.846921530767, 16560.171991400442, 16881.493555193334, 14964.102153870748, 15150.621234469143, 15320.387184512634, 15506.84493155068, 15528.378864845392, 987.9456629885353, 1012.9848052279222, 1013.6705570689519, 1016.8169729448696, 1019.0522813783178, 974.780674348273, 1017.1760873692333, 1026.630413051301, 1027.9691609251734, 1031.0514326819343, 1065.9253852230347, 1067.4876059491448, 1068.722132245614, 1069.4652673663168, 1070.6038765656717, 1057.820170571001, 1061.4745700878077, 1061.9150467962545, 1061.936283822973, 1070.5664205996584, 784.9843003139962, 789.960501974899, 790.4190420041265, 794.5034353529045, 796.1401686178913, 16373.181340932906, 16644.916775416168, 16736.748948765657, 16920.746188807178, 17194.226259818213, 11939.641810745692, 11999.460024298927, 14718.92640536801, 14892.0, 15042.197253433209, 13253.204807711569, 13415.731685366336, 13566.864331356757, 13572.253526056063, 13579.0, 3343.983280083584, 3348.2299071213756, 3372.578427696538, 3377.814220217887, 3387.1701433149037, 93993.02118639847, 108468.457657712, 110605.44697276462, 110726.0, 111749.0, 11444.198906076495, 11531.423428828524, 11560.190786645022, 11662.825057624143, 12076.879231207751, 23866.761332386453, 24388.146414875748, 24411.26766197017, 24424.145154919494, 24506.264812055666, 7863.724769633035, 8081.434299598972, 8111.18888111196, 8161.67353305873, 8331.416800824005, 4045.2516284487465, 4115.403266526397, 4176.561461046607, 4192.895177620523, 4318.114786468766, 4129.091599848029, 4203.621674049289, 4231.259529582311, 4234.915301693949, 4251.596098370712, 723.2803360656076, 922.2207234886511, 932.4824722279064, 935.6070450410843, 936.7470782888582, 618.3445547719432, 618.6226401894841, 618.9071639254148, 634.4004915354946, 649.9122618446544, 9665.71002869915, 10131.313481814905, 10289.691309260734, 10312.432816195182, 10345.689629311133, 546.2325432766969, 585.493548080907, 635.4693830651365, 645.5416654175588, 648.5071345777243, 4669.2062349400685, 5042.672226305279, 5189.195674670432, 5208.270842082112, 5286.471352864683, 100890.0, 101873.98126018794, 103701.48149259356, 103829.48085259525, 103956.0, 76810.6159469199, 78722.0, 81763.0, 84248.15751842404, 87499.0, 50577.747111264944, 55919.0, 68868.6556567214, 73580.63209683917, 74413.25586744171, 10062.647807326708, 10501.737456563647, 10732.087772539422, 10799.73000674958, 10971.44111820277, 34777.9566613002, 34888.47667284942, 35358.0, 35808.28383432369, 38294.80852595719, 44321.556784433036, 49158.0, 49450.50549494459, 49484.0, 50336.49663503318, 11064.225504214628, 13359.465621375424, 13661.521846735317, 13847.376868041163, 13920.164790112625, 14470.0, 14478.638034049232, 14564.635884102981, 14605.269736513344, 14802.6299342513, 13125.54060607874, 13167.60497185086, 13780.724385512434, 13788.310584470937, 13790.862091378958, 13313.400896959854, 13354.399052042487, 13465.259410732504, 13476.258805765778, 14240.572782816533, 12954.157979731288, 13243.404046817725, 13270.668233293858, 13710.314484275546, 13710.657233568842, 9956.900430995598, 9982.301238913496, 10085.546150423103, 10126.607546548277, 10236.232282578985, 9478.550991515647, 9638.9036109638, 9695.22438204956, 11140.832887506856, 11258.38078905668], "value": 7667.386695221584, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 180.0, 140.0, 120.0, 123.0, 122.0, 121.0, 122.0, 123.0, 121.0], "value": 134.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 119.0, 164.0, 122.0, 119.0, 117.0, 139.0, 184.0, 142.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 218.0, 218.0, 212.0, 213.0, 211.0, 211.0, 213.0, 209.0, 210.0], "value": 212.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 93.0, 128.0, 87.0, 64.0, 64.0, 62.0, 81.0, 63.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 78.0, 94.0, 75.0, 76.0, 73.0, 89.0, 74.0, 74.0, 94.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 98.0, 127.0, 138.0, 88.0, 90.0, 98.0, 90.0, 89.0, 90.0], "value": 99.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 97.0, 98.0, 109.0, 98.0, 100.0, 98.0, 97.0, 97.0], "value": 98.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 100.0, 103.0, 102.0, 110.0, 85.0, 146.0, 152.0, 100.0], "value": 109.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 51.0, 52.0, 52.0, 52.0, 51.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 70.0, 63.0, 68.0, 67.0, 64.0, 64.0, 64.0, 64.0, 62.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 88.0, 91.0, 89.0, 89.0, 91.0, 83.0, 92.0, 105.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 148.0, 147.0, 147.0, 150.0, 148.0, 149.0, 241.0, 209.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 205.0, 203.0, 201.0, 202.0, 201.0, 199.0, 198.0, 201.0, 199.0], "value": 200.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 74.0, 74.0, 73.0, 72.0, 74.0, 74.0, 72.0, 74.0], "value": 73.2, "unit": "score"}]}]} 05:31:03 INFO - Return code: 0 05:31:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:03 ERROR - # TBPL SUCCESS # 05:31:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:03 INFO - 2017-04-04 05:31:03.288 screenresolution[1653:9748] starting screenresolution argv=screenresolution get 05:31:03 INFO - 2017-04-04 05:31:03.291 screenresolution[1653:9748] Display 0: 1600x1200x32@60 05:31:03 INFO - 2017-04-04 05:31:03.297 screenresolution[1654:9751] starting screenresolution argv=screenresolution list 05:31:03 INFO - Available Modes on Display 0 05:31:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:03 INFO - Intel Iris: 05:31:03 INFO - Chipset Model: Intel Iris 05:31:03 INFO - Type: GPU 05:31:03 INFO - Bus: Built-In 05:31:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:03 INFO - Vendor: Intel (0x8086) 05:31:03 INFO - Device ID: 0x0a2e 05:31:03 INFO - Revision ID: 0x0009 05:31:03 INFO - Displays: 05:31:03 INFO - Display: 05:31:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:03 INFO - Display Serial Number: 1600x1200 60 05:31:03 INFO - Main Display: Yes 05:31:03 INFO - Mirror: Off 05:31:03 INFO - Online: Yes 05:31:03 INFO - Rotation: Supported 05:31:03 INFO - Return code: 0 05:31:03 INFO - Running post-action listener: _resource_record_post_action 05:31:03 INFO - [mozharness: 2017-04-04 12:31:03.540200Z] Finished run-tests step (success) 05:31:03 INFO - Running post-run listener: _resource_record_post_run 05:31:03 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 39560192; Write bytes: 512620544; Read time: 382; Write time: 1502 05:31:03 INFO - TinderboxPrint: CPU usage
53.4% 05:31:03 INFO - TinderboxPrint: I/O read bytes / time
39,560,192 / 382 05:31:03 INFO - TinderboxPrint: I/O write bytes / time
512,620,544 / 1,502 05:31:03 INFO - TinderboxPrint: CPU idle
2,242.7 (46.6%) 05:31:03 INFO - TinderboxPrint: CPU system
962.2 (20.0%) 05:31:03 INFO - TinderboxPrint: CPU user
1,612.7 (33.5%) 05:31:03 INFO - TinderboxPrint: Swap in / out
250,843,136 / 0 05:31:03 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204229120; Write bytes: 203905024; Read time: 15400; Write time: 363 05:31:03 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 38544384; Write bytes: 298766336; Read time: 364; Write time: 1110 05:31:04 INFO - Running post-run listener: _upload_blobber_files 05:31:04 INFO - Blob upload gear active. 05:31:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31: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 05:31: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:05 INFO - (blobuploader) - INFO - Done attempting. 05:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:06 INFO - (blobuploader) - INFO - Done attempting. 05:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:07 INFO - (blobuploader) - INFO - Done attempting. 05:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:09 INFO - (blobuploader) - INFO - Done attempting. 05:31:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:09 INFO - Return code: 0 05:31:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b673cba221c7dcb0df2f7b96dd02b208f511e6b4ad3d557777360b64c8257ba3415a9a1d9de131206d03f587d61f64403dd1f19d506d2e41768c1bc1b585171d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a6e62b742ced04d1dbde93cdf797fbd094bb17eae1673a934952a54275f2fc12d83b2d4c3b034ef8f908f368865c1c57023c4c3ca6f986d3e681d3f53129aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b7426461e0c7937ef2d7e8728d2c4cfdfc37407c3bef8f1415e70a1592af49e54263739544ef608549a17f76d098ae6dbf8a9f76615e77bc998a1be0a86e8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc3431cd675f7291271beeeaa211b050bab4fa7aea9744cd945ac7d506155691de035a8f70eceec44c3b1e47e0a9685ca5df8f4dc93f569c2a74e905aae390ba"} 05:31:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:09 INFO - Contents: 05:31:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b673cba221c7dcb0df2f7b96dd02b208f511e6b4ad3d557777360b64c8257ba3415a9a1d9de131206d03f587d61f64403dd1f19d506d2e41768c1bc1b585171d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a6e62b742ced04d1dbde93cdf797fbd094bb17eae1673a934952a54275f2fc12d83b2d4c3b034ef8f908f368865c1c57023c4c3ca6f986d3e681d3f53129aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b7426461e0c7937ef2d7e8728d2c4cfdfc37407c3bef8f1415e70a1592af49e54263739544ef608549a17f76d098ae6dbf8a9f76615e77bc998a1be0a86e8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc3431cd675f7291271beeeaa211b050bab4fa7aea9744cd945ac7d506155691de035a8f70eceec44c3b1e47e0a9685ca5df8f4dc93f569c2a74e905aae390ba"} 05:31:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:09 INFO - Copying logs to upload dir... 05:31:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.031713 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-04 05:31:09.916434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 05:31:09.919565) ========= 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.gM20ANQyLP/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.q64oj9OmOK/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b673cba221c7dcb0df2f7b96dd02b208f511e6b4ad3d557777360b64c8257ba3415a9a1d9de131206d03f587d61f64403dd1f19d506d2e41768c1bc1b585171d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a6e62b742ced04d1dbde93cdf797fbd094bb17eae1673a934952a54275f2fc12d83b2d4c3b034ef8f908f368865c1c57023c4c3ca6f986d3e681d3f53129aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b7426461e0c7937ef2d7e8728d2c4cfdfc37407c3bef8f1415e70a1592af49e54263739544ef608549a17f76d098ae6dbf8a9f76615e77bc998a1be0a86e8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc3431cd675f7291271beeeaa211b050bab4fa7aea9744cd945ac7d506155691de035a8f70eceec44c3b1e47e0a9685ca5df8f4dc93f569c2a74e905aae390ba"} build_url:https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011017 build_url: 'https://queue.taskcluster.net/v1/task/Tze_tzhbR8aN9F38XUrMlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b673cba221c7dcb0df2f7b96dd02b208f511e6b4ad3d557777360b64c8257ba3415a9a1d9de131206d03f587d61f64403dd1f19d506d2e41768c1bc1b585171d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a6e62b742ced04d1dbde93cdf797fbd094bb17eae1673a934952a54275f2fc12d83b2d4c3b034ef8f908f368865c1c57023c4c3ca6f986d3e681d3f53129aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b7426461e0c7937ef2d7e8728d2c4cfdfc37407c3bef8f1415e70a1592af49e54263739544ef608549a17f76d098ae6dbf8a9f76615e77bc998a1be0a86e8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc3431cd675f7291271beeeaa211b050bab4fa7aea9744cd945ac7d506155691de035a8f70eceec44c3b1e47e0a9685ca5df8f4dc93f569c2a74e905aae390ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 05:31:09.954674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:31:09.955020) ========= 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.gM20ANQyLP/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.q64oj9OmOK/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005195 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:31:10.007526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 05:31:10.007821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 05:31:10.008109) ========= ========= Total master_lag: 0.37 =========