builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0228 starttime: 1491321982.13 results: success (0) buildid: 20170404075227 builduid: dbfa79210e92461094ac3fcd5a70eace revision: 81e37ef1360ba4505726ddf542ebdcc952a57578 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.135519) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.136459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.137009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.505437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.505941) ========= 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.t0OtaylNg8/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.pwg2TMSvIK/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:06:22-- 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% 13.6M=0.001s 2017-04-04 09:06:22 (13.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135426 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.673919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.674242) ========= 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.t0OtaylNg8/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.pwg2TMSvIK/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.021170 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:22.731983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 09:06:22.732775) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 81e37ef1360ba4505726ddf542ebdcc952a57578 --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 81e37ef1360ba4505726ddf542ebdcc952a57578 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t0OtaylNg8/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.pwg2TMSvIK/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:06:22,829 truncating revision to first 12 chars 2017-04-04 09:06:22,829 Setting DEBUG logging. 2017-04-04 09:06:22,830 attempt 1/10 2017-04-04 09:06:22,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/81e37ef1360b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 09:06:24,836 unpacking tar archive at: mozilla-central-81e37ef1360b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.274820 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 09:06:25.035517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:25.035903) ========= script_repo_revision: 81e37ef1360ba4505726ddf542ebdcc952a57578 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:25.036366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:25.036686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 09:06:25.056899) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-04 09:06:25.057263) ========= /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.t0OtaylNg8/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.pwg2TMSvIK/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:06:25 INFO - MultiFileLogger online at 20170404 09:06:25 in /builds/slave/test 09:06:25 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 09:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:06:25 INFO - {'append_to_log': False, 09:06:25 INFO - 'base_work_dir': '/builds/slave/test', 09:06:25 INFO - 'blob_upload_branch': 'Firefox', 09:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:06:25 INFO - 'branch': 'Firefox', 09:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:06:25 INFO - 'config_files': ('talos/mac_config.py',), 09:06:25 INFO - 'default_actions': ('clobber', 09:06:25 INFO - 'read-buildbot-config', 09:06:25 INFO - 'download-and-extract', 09:06:25 INFO - 'populate-webroot', 09:06:25 INFO - 'create-virtualenv', 09:06:25 INFO - 'install', 09:06:25 INFO - 'run-tests'), 09:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:06:25 INFO - 'download_minidump_stackwalk': True, 09:06:25 INFO - 'download_symbols': 'ondemand', 09:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:06:25 INFO - 'gecko_profile': False, 09:06:25 INFO - 'gecko_profile_interval': 0, 09:06:25 INFO - 'installer_path': 'installer.exe', 09:06:25 INFO - 'log_level': 'info', 09:06:25 INFO - 'log_name': 'talos', 09:06:25 INFO - 'log_to_console': True, 09:06:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:06:25 INFO - 'opt_config_files': (), 09:06:25 INFO - 'pip_index': False, 09:06:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:06:25 INFO - 'cmd': ('bash', 09:06:25 INFO - '-c', 09:06:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:06:25 INFO - 'enabled': True, 09:06:25 INFO - 'halt_on_failure': False, 09:06:25 INFO - 'name': 'check_screen_resolution'},), 09:06:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:06:25 INFO - 'cmd': ('bash', 09:06:25 INFO - '-c', 09:06:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:06:25 INFO - 'enabled': True, 09:06:25 INFO - 'halt_on_failure': False, 09:06:25 INFO - 'name': 'check_screen_resolution'},), 09:06:25 INFO - 'run_cmd_checks_enabled': True, 09:06:25 INFO - 'suite': 'dromaeojs', 09:06:25 INFO - 'system_bits': '32', 09:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:06:25 INFO - 'title': 't-yosemite-r7-0228', 09:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:06:25 INFO - 'use_talos_json': True, 09:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:06:25 INFO - 'work_dir': 'build'} 09:06:25 INFO - [mozharness: 2017-04-04 16:06:25.273555Z] Running clobber step. 09:06:25 INFO - Running pre-action listener: _resource_record_pre_action 09:06:25 INFO - Running main action method: clobber 09:06:25 INFO - rmtree: /builds/slave/test/build 09:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:06:26 INFO - Running post-action listener: _resource_record_post_action 09:06:26 INFO - [mozharness: 2017-04-04 16:06:26.184921Z] Finished clobber step (success) 09:06:26 INFO - [mozharness: 2017-04-04 16:06:26.185057Z] Running read-buildbot-config step. 09:06:26 INFO - Running pre-action listener: _resource_record_pre_action 09:06:26 INFO - Running main action method: read_buildbot_config 09:06:26 INFO - Using buildbot properties: 09:06:26 INFO - { 09:06:26 INFO - "project": "", 09:06:26 INFO - "product": "firefox", 09:06:26 INFO - "script_repo_revision": "production", 09:06:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:06:26 INFO - "repository": "", 09:06:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:06:26 INFO - "buildid": "20170404075227", 09:06:26 INFO - "pgo_build": "False", 09:06:26 INFO - "basedir": "/builds/slave/test", 09:06:26 INFO - "buildnumber": 69, 09:06:26 INFO - "slavename": "t-yosemite-r7-0228", 09:06:26 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:06:26 INFO - "platform": "yosemite_r7", 09:06:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:06:26 INFO - "branch": "mozilla-central", 09:06:26 INFO - "repo_path": "mozilla-central", 09:06:26 INFO - "revision": "81e37ef1360ba4505726ddf542ebdcc952a57578", 09:06:26 INFO - "stage_platform": "macosx64", 09:06:26 INFO - "builduid": "dbfa79210e92461094ac3fcd5a70eace", 09:06:26 INFO - "slavebuilddir": "test" 09:06:26 INFO - } 09:06:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:06:26 INFO - Running post-action listener: _resource_record_post_action 09:06:26 INFO - [mozharness: 2017-04-04 16:06:26.188292Z] Finished read-buildbot-config step (success) 09:06:26 INFO - [mozharness: 2017-04-04 16:06:26.188382Z] Running download-and-extract step. 09:06:26 INFO - Running pre-action listener: _resource_record_pre_action 09:06:26 INFO - Running main action method: download_and_extract 09:06:26 INFO - mkdir: /builds/slave/test/build/tests 09:06:26 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')]} 09:06:26 INFO - trying https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:06:26 INFO - Downloading https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/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 09:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/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 09:06:27 INFO - Downloaded 1325 bytes. 09:06:27 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:06:27 INFO - Using the following test package requirements: 09:06:27 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:06:27 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:06:27 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:06:27 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:06:27 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'jsshell-mac.zip'], 09:06:27 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:06:27 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:06:27 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:06:27 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:06:27 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:06:27 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:27 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:06:27 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:06:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:06:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:06:27 INFO - Fetch https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:06:28 INFO - Expected file size: 52518044 09:06:28 INFO - Obtained file size: 52518044 09:06:44 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 09:06:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:06:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:06:44 INFO - Fetch https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:06:46 INFO - Expected file size: 52518044 09:06:46 INFO - Obtained file size: 52518044 09:07:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:07:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:07:02 INFO - Fetch https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:07:03 INFO - Expected file size: 14404152 09:07:03 INFO - Obtained file size: 14404152 09:07:03 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')]} 09:07:03 INFO - trying https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:07:03 INFO - Downloading https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/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 09:07:05 INFO - Downloaded 75588485 bytes. 09:07:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:07:05 INFO - mkdir: /builds/slave/test/properties 09:07:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:05 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:05 INFO - Contents: 09:07:05 INFO - build_url:https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:07:06 INFO - Running post-action listener: _resource_record_post_action 09:07:06 INFO - Running post-action listener: set_extra_try_arguments 09:07:06 INFO - [mozharness: 2017-04-04 16:07:06.544399Z] Finished download-and-extract step (success) 09:07:06 INFO - [mozharness: 2017-04-04 16:07:06.544556Z] Running populate-webroot step. 09:07:06 INFO - Running pre-action listener: _resource_record_pre_action 09:07:06 INFO - Running main action method: populate_webroot 09:07:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:06 INFO - '--tppagecycles', 09:07:06 INFO - '7'], 09:07:06 INFO - 'tests': ['tsvgm']}}, 09:07:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:07:06 INFO - 'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:07:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:07:06 INFO - 'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['damp', 'tps']}, 09:07:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:07:06 INFO - 'tests': ['damp', 'tps']}, 09:07:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['dromaeo_dom']}, 09:07:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['basic_compositor_video']}, 09:07:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:07:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['a11yr', 09:07:06 INFO - 'ts_paint', 09:07:06 INFO - 'tpaint', 09:07:06 INFO - 'sessionrestore', 09:07:06 INFO - 'sessionrestore_no_auto_restore', 09:07:06 INFO - 'tabpaint']}, 09:07:06 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:06 INFO - 'ts_paint', 09:07:06 INFO - 'tpaint', 09:07:06 INFO - 'sessionrestore', 09:07:06 INFO - 'sessionrestore_no_auto_restore', 09:07:06 INFO - 'tabpaint']}, 09:07:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:06 INFO - 'ts_paint', 09:07:06 INFO - 'tpaint', 09:07:06 INFO - 'sessionrestore', 09:07:06 INFO - 'sessionrestore_no_auto_restore', 09:07:06 INFO - 'tabpaint']}, 09:07:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:06 INFO - 'ts_paint', 09:07:06 INFO - 'tpaint', 09:07:06 INFO - 'sessionrestore', 09:07:06 INFO - 'sessionrestore_no_auto_restore', 09:07:06 INFO - 'tabpaint']}, 09:07:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['a11yr', 09:07:06 INFO - 'ts_paint', 09:07:06 INFO - 'tpaint', 09:07:06 INFO - 'sessionrestore', 09:07:06 INFO - 'sessionrestore_no_auto_restore', 09:07:06 INFO - 'tabpaint']}, 09:07:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['a11yr', 09:07:06 INFO - 'ts_paint', 09:07:06 INFO - 'tpaint', 09:07:06 INFO - 'sessionrestore', 09:07:06 INFO - 'sessionrestore_no_auto_restore', 09:07:06 INFO - 'tabpaint']}, 09:07:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['tsvgx', 09:07:06 INFO - 'tsvgr_opacity', 09:07:06 INFO - 'tart', 09:07:06 INFO - 'tscrollx', 09:07:06 INFO - 'cart', 09:07:06 INFO - 'tsvg_static']}, 09:07:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:06 INFO - 'tsvgr_opacity', 09:07:06 INFO - 'tart', 09:07:06 INFO - 'tscrollx', 09:07:06 INFO - 'cart', 09:07:06 INFO - 'tsvg_static']}, 09:07:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:07:06 INFO - 'talos_options': ['--disable-e10s'], 09:07:06 INFO - 'tests': ['tp5o']}, 09:07:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:07:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:07:06 INFO - 'talos_options': ['--disable-e10s', 09:07:06 INFO - '--xperf_path', 09:07:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:06 INFO - 'tests': ['tp5n']}, 09:07:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:07:06 INFO - 'talos_options': ['--xperf_path', 09:07:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:06 INFO - 'tests': ['tp5n']}}, 09:07:06 INFO - 'talos.zip': {'path': '', 09:07:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:06 INFO - Running post-action listener: _resource_record_post_action 09:07:06 INFO - [mozharness: 2017-04-04 16:07:06.562855Z] Finished populate-webroot step (success) 09:07:06 INFO - [mozharness: 2017-04-04 16:07:06.562993Z] Running create-virtualenv step. 09:07:06 INFO - Running pre-action listener: _resource_record_pre_action 09:07:06 INFO - Running main action method: create_virtualenv 09:07:06 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:06 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 09:07:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:06 INFO - Using real prefix '/tools/python27' 09:07:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:10 INFO - Installing pip.................done. 09:07:10 INFO - Return code: 0 09:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:07:10 INFO - Reading from file tmpfile_stdout 09:07:10 INFO - Output received: 09:07:10 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) 09:07:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:10 INFO - 'HOME': '/Users/cltbld', 09:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:10 INFO - 'LOGNAME': 'cltbld', 09:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:10 INFO - 'MOZ_NO_REMOTE': '1', 09:07:10 INFO - 'NO_EM_RESTART': '1', 09:07:10 INFO - 'PAGER': '/bin/cat', 09:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:10 INFO - 'PWD': '/builds/slave/test', 09:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:10 INFO - 'SHELL': '/bin/bash', 09:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:10 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:10 INFO - 'USER': 'cltbld', 09:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:10 INFO - 'XPC_FLAGS': '0x0', 09:07:10 INFO - 'XPC_SERVICE_NAME': '0', 09:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:10 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 09:07:10 INFO - Cleaning up... 09:07:10 INFO - Return code: 0 09:07:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:10 INFO - 'HOME': '/Users/cltbld', 09:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:10 INFO - 'LOGNAME': 'cltbld', 09:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:10 INFO - 'MOZ_NO_REMOTE': '1', 09:07:10 INFO - 'NO_EM_RESTART': '1', 09:07:10 INFO - 'PAGER': '/bin/cat', 09:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:10 INFO - 'PWD': '/builds/slave/test', 09:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:10 INFO - 'SHELL': '/bin/bash', 09:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:10 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:10 INFO - 'USER': 'cltbld', 09:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:10 INFO - 'XPC_FLAGS': '0x0', 09:07:10 INFO - 'XPC_SERVICE_NAME': '0', 09:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:11 INFO - Downloading/unpacking psutil>=3.1.1 09:07:11 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 09:07:11 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 09:07:11 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 09:07:11 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 09:07:11 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 09:07:11 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 09:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:14 INFO - Installing collected packages: psutil 09:07:14 INFO - Running setup.py install for psutil 09:07:14 INFO - building 'psutil._psutil_osx' extension 09:07:14 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 09:07:14 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 09:07:14 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 09:07:15 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 09:07:15 INFO - building 'psutil._psutil_posix' extension 09:07:15 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 09:07:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:07:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:07:15 INFO - ^ 09:07:15 INFO - 1 warning generated. 09:07:15 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 09:07:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:15 INFO - Successfully installed psutil 09:07:15 INFO - Cleaning up... 09:07:15 INFO - Return code: 0 09:07:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:16 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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:16 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 09:07:16 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 09:07:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:16 INFO - 'HOME': '/Users/cltbld', 09:07:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:16 INFO - 'LOGNAME': 'cltbld', 09:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:16 INFO - 'MOZ_NO_REMOTE': '1', 09:07:16 INFO - 'NO_EM_RESTART': '1', 09:07:16 INFO - 'PAGER': '/bin/cat', 09:07:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:16 INFO - 'PWD': '/builds/slave/test', 09:07:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:16 INFO - 'SHELL': '/bin/bash', 09:07:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:16 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:16 INFO - 'USER': 'cltbld', 09:07:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:16 INFO - 'XPC_FLAGS': '0x0', 09:07:16 INFO - 'XPC_SERVICE_NAME': '0', 09:07:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:07:19 INFO - Installing collected packages: mozsystemmonitor 09:07:19 INFO - Running setup.py install for mozsystemmonitor 09:07:19 INFO - Successfully installed mozsystemmonitor 09:07:19 INFO - Cleaning up... 09:07:19 INFO - Return code: 0 09:07:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:07:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:19 INFO - 'HOME': '/Users/cltbld', 09:07:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:19 INFO - 'LOGNAME': 'cltbld', 09:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:19 INFO - 'MOZ_NO_REMOTE': '1', 09:07:19 INFO - 'NO_EM_RESTART': '1', 09:07:19 INFO - 'PAGER': '/bin/cat', 09:07:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:19 INFO - 'PWD': '/builds/slave/test', 09:07:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:19 INFO - 'SHELL': '/bin/bash', 09:07:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:19 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:19 INFO - 'USER': 'cltbld', 09:07:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:19 INFO - 'XPC_FLAGS': '0x0', 09:07:19 INFO - 'XPC_SERVICE_NAME': '0', 09:07:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:20 INFO - Downloading/unpacking jsonschema==2.5.1 09:07:20 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 09:07:20 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 09:07:20 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 09:07:20 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 09:07:20 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 09:07:20 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 09:07:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:23 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:23 INFO - warning: no files found matching '*.txt' 09:07:23 INFO - no previously-included directories found matching 'build' 09:07:23 INFO - no previously-included directories found matching 'dist' 09:07:23 INFO - no previously-included directories found matching '.git*' 09:07:23 INFO - Installing collected packages: jsonschema, functools32 09:07:23 INFO - Running setup.py install for functools32 09:07:23 INFO - warning: no files found matching '*.txt' 09:07:23 INFO - no previously-included directories found matching 'build' 09:07:23 INFO - no previously-included directories found matching 'dist' 09:07:23 INFO - no previously-included directories found matching '.git*' 09:07:23 INFO - Successfully installed jsonschema functools32 09:07:23 INFO - Cleaning up... 09:07:23 INFO - Return code: 0 09:07:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:07:23 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')]} 09:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 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')]} 09:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:23 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 09:07:23 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 09:07:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:23 INFO - 'HOME': '/Users/cltbld', 09:07:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:23 INFO - 'LOGNAME': 'cltbld', 09:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:23 INFO - 'MOZ_NO_REMOTE': '1', 09:07:23 INFO - 'NO_EM_RESTART': '1', 09:07:23 INFO - 'PAGER': '/bin/cat', 09:07:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:23 INFO - 'PWD': '/builds/slave/test', 09:07:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:23 INFO - 'SHELL': '/bin/bash', 09:07:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:23 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:23 INFO - 'USER': 'cltbld', 09:07:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:23 INFO - 'XPC_FLAGS': '0x0', 09:07:23 INFO - 'XPC_SERVICE_NAME': '0', 09:07:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:07:23 INFO - Cleaning up... 09:07:23 INFO - Return code: 0 09:07:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:23 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')]} 09:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 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')]} 09:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:23 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 09:07:23 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 09:07:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:23 INFO - 'HOME': '/Users/cltbld', 09:07:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:23 INFO - 'LOGNAME': 'cltbld', 09:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:23 INFO - 'MOZ_NO_REMOTE': '1', 09:07:23 INFO - 'NO_EM_RESTART': '1', 09:07:23 INFO - 'PAGER': '/bin/cat', 09:07:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:23 INFO - 'PWD': '/builds/slave/test', 09:07:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:23 INFO - 'SHELL': '/bin/bash', 09:07:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:23 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:23 INFO - 'USER': 'cltbld', 09:07:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:23 INFO - 'XPC_FLAGS': '0x0', 09:07:23 INFO - 'XPC_SERVICE_NAME': '0', 09:07:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:24 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:24 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 09:07:24 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 09:07:24 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 09:07:24 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 09:07:24 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 09:07:24 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 09:07:26 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:26 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 09:07:26 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 09:07:26 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 09:07:26 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 09:07:26 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 09:07:26 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 09:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:27 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 09:07:27 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 09:07:27 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 09:07:27 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 09:07:27 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 09:07:27 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 09:07:27 INFO - Downloading docopt-0.6.1.tar.gz 09:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:28 INFO - Running setup.py install for blobuploader 09:07:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:28 INFO - Running setup.py install for requests 09:07:28 INFO - Running setup.py install for docopt 09:07:28 INFO - Successfully installed blobuploader requests docopt 09:07:28 INFO - Cleaning up... 09:07:28 INFO - Return code: 0 09:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:28 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')]} 09:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:28 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')]} 09:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:28 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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:28 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 09:07:28 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 09:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:28 INFO - 'HOME': '/Users/cltbld', 09:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:28 INFO - 'LOGNAME': 'cltbld', 09:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:28 INFO - 'MOZ_NO_REMOTE': '1', 09:07:28 INFO - 'NO_EM_RESTART': '1', 09:07:28 INFO - 'PAGER': '/bin/cat', 09:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:28 INFO - 'PWD': '/builds/slave/test', 09:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:28 INFO - 'SHELL': '/bin/bash', 09:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:28 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:28 INFO - 'USER': 'cltbld', 09:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:28 INFO - 'XPC_FLAGS': '0x0', 09:07:28 INFO - 'XPC_SERVICE_NAME': '0', 09:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-XAdak9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-9miJZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-cPT3OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-COpFqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-jzF75z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-0Zjd46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-dL6BEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:29 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-PYwdZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-z_ACUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-OPyDvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-OVWbqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-7SLh4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-0kvdnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-581BuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-hEsPbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-mW8HIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:30 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-jjZ0db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:30 INFO - Running setup.py install for manifestparser 09:07:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:31 INFO - Running setup.py install for mozcrash 09:07:31 INFO - Running setup.py install for mozdebug 09:07:31 INFO - Running setup.py install for mozdevice 09:07:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:31 INFO - Running setup.py install for mozfile 09:07:31 INFO - Running setup.py install for mozhttpd 09:07:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:31 INFO - Running setup.py install for mozinfo 09:07:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:31 INFO - Running setup.py install for mozInstall 09:07:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Running setup.py install for mozleak 09:07:32 INFO - Running setup.py install for mozlog 09:07:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Running setup.py install for moznetwork 09:07:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Running setup.py install for mozprocess 09:07:32 INFO - Running setup.py install for mozprofile 09:07:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:32 INFO - Running setup.py install for mozrunner 09:07:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:33 INFO - Running setup.py install for mozscreenshot 09:07:33 INFO - Running setup.py install for moztest 09:07:33 INFO - Running setup.py install for mozversion 09:07:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:33 INFO - Cleaning up... 09:07:33 INFO - Return code: 0 09:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:33 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')]} 09:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:33 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')]} 09:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:33 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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:33 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 09:07:33 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 09:07:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:33 INFO - 'HOME': '/Users/cltbld', 09:07:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:33 INFO - 'LOGNAME': 'cltbld', 09:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:33 INFO - 'MOZ_NO_REMOTE': '1', 09:07:33 INFO - 'NO_EM_RESTART': '1', 09:07:33 INFO - 'PAGER': '/bin/cat', 09:07:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:33 INFO - 'PWD': '/builds/slave/test', 09:07:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:33 INFO - 'SHELL': '/bin/bash', 09:07:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:33 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:33 INFO - 'USER': 'cltbld', 09:07:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:33 INFO - 'XPC_FLAGS': '0x0', 09:07:33 INFO - 'XPC_SERVICE_NAME': '0', 09:07:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:33 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-inHDlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:33 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)) 09:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:33 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-dxN5VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-jLxBrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-ruBR0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-ZOP5DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-u8EVq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-HkXOaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-JommQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-j4kT6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-0Xlm6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-8OIuMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:34 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)) 09:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:34 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-_IXkHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:35 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)) 09:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:35 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-dAHERm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:35 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)) 09:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:35 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-_p3aJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:35 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)) 09:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:35 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-6UsAJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:35 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)) 09:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:35 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-qCuBtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:35 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)) 09:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:35 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-QcYW9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:35 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)) 09:07:35 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)) 09:07:35 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)) 09:07:35 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)) 09:07:35 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)) 09:07:35 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)) 09:07:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:38 INFO - Downloading blessings-1.6.tar.gz 09:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:38 INFO - Installing collected packages: blessings 09:07:38 INFO - Running setup.py install for blessings 09:07:38 INFO - Successfully installed blessings 09:07:38 INFO - Cleaning up... 09:07:38 INFO - Return code: 0 09:07:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:38 INFO - Reading from file tmpfile_stdout 09:07:38 INFO - Current package versions: 09:07:38 INFO - blessings == 1.6 09:07:38 INFO - blobuploader == 1.2.4 09:07:38 INFO - docopt == 0.6.1 09:07:38 INFO - functools32 == 3.2.3-2 09:07:38 INFO - jsonschema == 2.5.1 09:07:38 INFO - manifestparser == 1.1 09:07:38 INFO - mozInstall == 1.12 09:07:38 INFO - mozcrash == 1.0 09:07:38 INFO - mozdebug == 0.1 09:07:38 INFO - mozdevice == 0.49 09:07:38 INFO - mozfile == 1.2 09:07:38 INFO - mozhttpd == 0.7 09:07:38 INFO - mozinfo == 0.9 09:07:38 INFO - mozleak == 0.1 09:07:38 INFO - mozlog == 3.4 09:07:38 INFO - moznetwork == 0.27 09:07:38 INFO - mozprocess == 0.25 09:07:38 INFO - mozprofile == 0.28 09:07:38 INFO - mozrunner == 6.13 09:07:38 INFO - mozscreenshot == 0.1 09:07:38 INFO - mozsystemmonitor == 0.3 09:07:38 INFO - moztest == 0.8 09:07:38 INFO - mozversion == 1.4 09:07:38 INFO - psutil == 3.1.1 09:07:38 INFO - requests == 1.2.3 09:07:38 INFO - wsgiref == 0.1.2 09:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:38 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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:38 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 09:07:38 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 09:07:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:38 INFO - 'HOME': '/Users/cltbld', 09:07:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:38 INFO - 'LOGNAME': 'cltbld', 09:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:38 INFO - 'MOZ_NO_REMOTE': '1', 09:07:38 INFO - 'NO_EM_RESTART': '1', 09:07:38 INFO - 'PAGER': '/bin/cat', 09:07:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:38 INFO - 'PWD': '/builds/slave/test', 09:07:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:38 INFO - 'SHELL': '/bin/bash', 09:07:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:38 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:38 INFO - 'USER': 'cltbld', 09:07:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:38 INFO - 'XPC_FLAGS': '0x0', 09:07:38 INFO - 'XPC_SERVICE_NAME': '0', 09:07:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 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)) 09:07:39 INFO - Cleaning up... 09:07:39 INFO - Return code: 0 09:07:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:39 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')]} 09:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:39 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')]} 09:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:39 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 0x10cc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6b355b2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, '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.t0OtaylNg8/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.pwg2TMSvIK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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 09:07:39 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 09:07:39 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 09:07:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:07:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:39 INFO - 'HOME': '/Users/cltbld', 09:07:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:39 INFO - 'LOGNAME': 'cltbld', 09:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:39 INFO - 'MOZ_NO_REMOTE': '1', 09:07:39 INFO - 'NO_EM_RESTART': '1', 09:07:39 INFO - 'PAGER': '/bin/cat', 09:07:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:39 INFO - 'PWD': '/builds/slave/test', 09:07:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:39 INFO - 'SHELL': '/bin/bash', 09:07:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:07:39 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:07:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:39 INFO - 'USER': 'cltbld', 09:07:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:39 INFO - 'XPC_FLAGS': '0x0', 09:07:39 INFO - 'XPC_SERVICE_NAME': '0', 09:07:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:07:39 INFO - Cleaning up... 09:07:39 INFO - Return code: 0 09:07:39 INFO - Running post-action listener: _resource_record_post_action 09:07:39 INFO - Running post-action listener: _start_resource_monitoring 09:07:39 INFO - Starting resource monitoring. 09:07:39 INFO - [mozharness: 2017-04-04 16:07:39.465949Z] Finished create-virtualenv step (success) 09:07:39 INFO - [mozharness: 2017-04-04 16:07:39.466920Z] Running install step. 09:07:39 INFO - Running pre-action listener: _resource_record_pre_action 09:07:39 INFO - Running main action method: install 09:07:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:39 INFO - Reading from file tmpfile_stdout 09:07:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:39 INFO - Reading from file tmpfile_stdout 09:07:39 INFO - Output received: 09:07:39 INFO - Usage: mozinstall [options] installer 09:07:39 INFO - Options: 09:07:39 INFO - -h, --help show this help message and exit 09:07:39 INFO - -d DEST, --destination=DEST 09:07:39 INFO - Directory to install application into. [default: 09:07:39 INFO - "/builds/slave/test"] 09:07:39 INFO - --app=APP Application being installed. [default: firefox] 09:07:39 INFO - mkdir: /builds/slave/test/build/application 09:07:39 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'] 09:07:39 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 09:08:00 INFO - Reading from file tmpfile_stdout 09:08:00 INFO - Output received: 09:08:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:08:00 INFO - Running post-action listener: _resource_record_post_action 09:08:00 INFO - [mozharness: 2017-04-04 16:08:00.239175Z] Finished install step (success) 09:08:00 INFO - [mozharness: 2017-04-04 16:08:00.239327Z] Running run-tests step. 09:08:00 INFO - Running pre-action listener: _resource_record_pre_action 09:08:00 INFO - Running main action method: run_tests 09:08:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:08:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:08:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:08:00 INFO - 2017-04-04 09:08:00.253 screenresolution[1894:14726] starting screenresolution argv=screenresolution get 09:08:00 INFO - 2017-04-04 09:08:00.256 screenresolution[1894:14726] Display 0: 1600x1200x32@60 09:08:00 INFO - 2017-04-04 09:08:00.262 screenresolution[1895:14729] starting screenresolution argv=screenresolution list 09:08:00 INFO - Available Modes on Display 0 09:08:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:08:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:08:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:08:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:08:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:08:00 INFO - Intel Iris: 09:08:00 INFO - Chipset Model: Intel Iris 09:08:00 INFO - Type: GPU 09:08:00 INFO - Bus: Built-In 09:08:00 INFO - VRAM (Dynamic, Max): 1536 MB 09:08:00 INFO - Vendor: Intel (0x8086) 09:08:00 INFO - Device ID: 0x0a2e 09:08:00 INFO - Revision ID: 0x0009 09:08:00 INFO - Displays: 09:08:00 INFO - Display: 09:08:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:08:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:08:00 INFO - Display Serial Number: 1600x1200 60 09:08:00 INFO - Main Display: Yes 09:08:00 INFO - Mirror: Off 09:08:00 INFO - Online: Yes 09:08:00 INFO - Rotation: Supported 09:08:00 INFO - Return code: 0 09:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:00 INFO - Python 2.7.3 09:08:00 INFO - Return code: 0 09:08:00 INFO - grabbing minidump binary from tooltool 09:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:00 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 0x10c9fbd30>, '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 0x10c922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:00 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 09:08:00 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 09:08:00 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 09:08:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:00 INFO - Return code: 0 09:08:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:08:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:00 INFO - ENV: RUST_BACKTRACE is now 1 09:08:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:08:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:00 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/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--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 09:08:00 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/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0228 --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 09:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t0OtaylNg8/Render', 09:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:08:00 INFO - 'HOME': '/Users/cltbld', 09:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:08:00 INFO - 'LOGNAME': 'cltbld', 09:08:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:00 INFO - 'MOZ_NO_REMOTE': '1', 09:08:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:00 INFO - 'NO_EM_RESTART': '1', 09:08:00 INFO - 'PAGER': '/bin/cat', 09:08:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:00 INFO - 'PWD': '/builds/slave/test', 09:08:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:08:00 INFO - 'RUST_BACKTRACE': '1', 09:08:00 INFO - 'SHELL': '/bin/bash', 09:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwg2TMSvIK/Listeners', 09:08:00 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 09:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:08:00 INFO - 'USER': 'cltbld', 09:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:00 INFO - 'XPC_FLAGS': '0x0', 09:08:00 INFO - 'XPC_SERVICE_NAME': '0', 09:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:08:00 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/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--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 09:08:00 INFO - mozversion application_buildid: 20170404075227 09:08:00 INFO - mozversion application_changeset: 81e37ef1360ba4505726ddf542ebdcc952a57578 09:08:00 INFO - mozversion application_display_name: Nightly 09:08:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:00 INFO - mozversion application_name: Firefox 09:08:00 INFO - mozversion application_remotingname: firefox 09:08:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:08:00 INFO - mozversion application_vendor: Mozilla 09:08:00 INFO - mozversion application_version: 55.0a1 09:08:00 INFO - mozversion platform_buildid: 20170404075227 09:08:00 INFO - mozversion platform_changeset: 81e37ef1360ba4505726ddf542ebdcc952a57578 09:08:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:08:00 INFO - mozversion platform_version: 55.0a1 09:08:00 INFO - using testdate: 1491322080 09:08:00 INFO - actual date: 1491322080 09:08:00 INFO - starting webserver on 'localhost:49375' 09:08:00 INFO - SUITE-START | Running 2 tests 09:08:00 INFO - TEST-START | dromaeo_css 09:08:00 INFO - operating with platform_type : mac_ 09:08:00 INFO - Initialising browser for dromaeo_css test... 09:08:00 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpxZK04w/profile http://localhost:49375/getInfo.html) 09:08:03 INFO - PID 1905 | __metrics Screen width/height:1600/1200 09:08:03 INFO - PID 1905 | colorDepth:24 09:08:03 INFO - PID 1905 | Browser inner width/height: 1024/689 09:08:03 INFO - PID 1905 | __metrics 09:08:03 INFO - PID 1905 | 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" 09:08:03 INFO - PID 1905 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:04 INFO - TEST-INFO | 1905: exit 0 09:08:04 INFO - Browser initialized. 09:08:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:04 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpxZK04w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:16 INFO - PID 1907 | RSS: Main: 233586688 09:08:16 INFO - PID 1907 | 09:11:22 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49375/tests/dromaeo/cssquery-ext.html) 09:11:23 INFO - PID 1907 | RSS: Main: 374059008 09:11:23 INFO - PID 1907 | 09:13:06 INFO - PID 1907 | ************************* 09:13:06 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 09:13:06 INFO - PID 1907 | 09:13:06 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:06 INFO - PID 1907 | Full stack: 09:13:06 INFO - PID 1907 | ************************* 09:13:06 INFO - PID 1907 | ************************* 09:13:06 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 09:13:06 INFO - PID 1907 | 09:13:06 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:06 INFO - PID 1907 | Full stack: 09:13:06 INFO - PID 1907 | ************************* 09:13:06 INFO - PID 1907 | ************************* 09:13:06 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 09:13:06 INFO - PID 1907 | 09:13:06 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:06 INFO - PID 1907 | Full stack: 09:13:06 INFO - PID 1907 | ************************* 09:13:06 INFO - PID 1907 | ************************* 09:13:06 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 09:13:06 INFO - PID 1907 | 09:13:06 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:06 INFO - PID 1907 | Full stack: 09:13:06 INFO - PID 1907 | ************************* 09:14:26 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-ext.html (next: http://localhost:49375/tests/dromaeo/cssquery-jquery.html) 09:14:27 INFO - PID 1907 | RSS: Main: 370577408 09:14:27 INFO - PID 1907 | 09:17:29 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49375/tests/dromaeo/cssquery-mootools.html) 09:17:30 INFO - PID 1907 | RSS: Main: 335171584 09:17:30 INFO - PID 1907 | 09:20:32 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49375/tests/dromaeo/cssquery-prototype.html) 09:20:33 INFO - PID 1907 | RSS: Main: 358658048 09:20:33 INFO - PID 1907 | 09:23:36 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49375/tests/dromaeo/cssquery-yui.html) 09:23:37 INFO - PID 1907 | RSS: Main: 335151104 09:23:37 INFO - PID 1907 | 09:26:40 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-yui.html (next: http://localhost:49375/tests/dromaeo/cssquery-dojo.html) 09:26:41 INFO - PID 1907 | RSS: Main: 418549760 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | __start_tp_report 09:26:41 INFO - PID 1907 | _x_x_mozilla_page_load 09:26:41 INFO - PID 1907 | _x_x_mozilla_page_load_details 09:26:41 INFO - PID 1907 | |i|pagename|runs| 09:26:41 INFO - PID 1907 | |0;dojo.html;3458.481227815829;3465.826708664567;3466.445368741002;3509.368313703534;3543.2913417316527;5936.465718085371;6060.787872424466;6200.565960382775;6221.00463925772;6227.314995350508;6078.665673387962;6092.1454343602545;6098.734805259241;6116.031445915019;6196.876062478747;5327.360716713981;5336.519713225809;5347.839564813062;5362.946370536303;5447.291852059227;5285.2600635911;5354.27717258171;5404;5414.458554144593;5427.294451721271;5230.189320655304;5270.2358158067245;5369.44286157014;5380.2736630555155;5397.919031214535;5308.628396012281;5331;5342.652727572696;5348.956953394089;5359.705216213107;5244.535068517791;5263.394709608406;5297.099493086184;5314.388845282803;5319.441458646864;6099.5425343099005;6114.419130182626;6125.927962606571;6142.880706156369;6166;6489.156409666713;6506.316836732122;6512.15342005541;6515.7393704252245;6521.739130434777;6377.01156320771;6431.22825260967;6549.083128362033;6619.735210591571;6621;6090.817275481742;6129.431244638657;6149.631022138641;6155.6614386209185;6268.811935641938;6714.764983225564;6747.190337159573;6754.392104710501;6775.830604234933;6811.182658080963;6299.842503937438;6360.872782544416;6444.194475690539;6458.967705161538;6460.547761656733;6437.969924812008;6544.9672751635935;6548.770793022317;6576.901346479806;6592.406683398517;6442.871142577123;6455.838604034937;6467.094606755058;6480.157579514727;6484.675766211671;6402.647854367961;6409.839754006187;6419.903701444482;6423.710933008026;6425.839354016187;5117.181250999822;5187.740612969336;5200.92198617021;5242.082635538765;5253.816116435906;4673.649476289292;4678.836240731558;4680.578747912704;4713.7643117844655;4718.363020992191;6205.6586887721605;6214.2542894852;6215.192025036717;6220.315765265817;6226.003839385677;6356.618602883842;6426.453751431087;6434.292227854932;6600.273969863311;6611.239707433707;6135.385782596134;6192.783252586138;6224.875502489925;6225.346338634378;6247.468965137923;5761.020626493422;5766.394528574439;5767.567432442584;5776.249087618583;5806.970965145148;6751.594904305757;6756.155480564929;6790.320967903269;6796.422304104108;6815.965920170367;6359.236891573041;6419.2296924369375;6434.485241180788;6500.057491663588;6623.370779775913;6785.660716964231;6821.556598821061;6831.351021652935;6831.385175334244;6833.145856767904;6432.13166222554;6531.11829902957;6535.248446428722;6544.934550654432;6546.738130474918;6376.139221205078;6424.93575064262;6514.54398192122;6634.03806448072;6636.469082473487;6352.587081839665;6401.423871851555;6403.679816009274;6430.935690643034;6443.065755465337;6260.467860231931;6284.685765711604;6339.714712837841;6407.8718425630295;6424.421802037839;5722.542196624343;6208.844778880383;6366.172397588284;6379.266384365857;6401.87196256063;6256.937430625636;6337.144485494584;6371.299157092809;6445.774397896239;6477.611343319416;6298.370162983848;6303.6532990685955;6324.367563243639;6361.491080713439;6386.744530218925 09:26:41 INFO - PID 1907 | |1;ext.html;726.7165805335919;755.4938191411753;817.5830326533468;1124.4434005167438;1151.832984217288;28472.857635711818;37600.62399376009;37918.62081379182;37938.62061379386;37988;40009.59990400095;40101.598984010154;40102;40111;40132.99667508314;6197.845053873644;8541.530215838142;8757.386982911199;8766.386352955296;8766.956165219164;6238.1266622672865;7027.578345299298;8673.306135509145;8679.826403471927;8683.522406267653;8697.913020869773;8747.606357713887;8755.036945935943;8761.56192190388;8768.868466972968;7401.296876796696;8676.132386761305;8726.127387261287;8729.170728780755;8740.4755714657;8460.619272132768;8526.232639062515;8537.18896704812;8553.315734741269;8560.571971401467;38668;38912.61087389146;38919.8324050279;38959.220815583816;38994.24525896341;3470.687638112582;3512.0868574170645;3515.2617950230483;3520.929581408383;3521.7182625389905;30728;30751;30802;30826;30841.691583084106;3077.7383922366625;3088.8764449421997;3130.373925214966;3143.9685603143903;3153.022563005453;330448;334408;334431;334687;335987;50789.682876955136;50868.491315087114;50891.236631450556;50901;50948;53092;53101.2034819478;53116.73441632767;53125;53174.08736864183;14312.06971546846;14660.193689346976;14695.26523673812;14703.55889323322;14725.55823325302;8649.610767515476;10284.228682848816;11951.04391648666;11951.940240298743;11979.46092425843;11475.54097836094;11711;11727.824082638766;11955.34245616482;11963.342016189194;4571.405717256802;5015.498450155028;5155.742212889416;5162.845114646567;5189.948100519022;848.410354803418;925.9814803703888;969.0648524174205;973.78576713123;1005.4319309590059;21355.03902324399;22485.550288994127;22576.435589110402;23764.405889852547;23864.045438182624;1055.9598795186735;1068.759529105945;1080.4327727942737;1121.2935850414187;1123.5618108937522;9866.703998880044;11698.66386070792;12067.517299308105;12131.33277669719;12171.0871684624;441837;442336;442556.14887702063;442699;443432;52302.47697523052;52337;52523.737381313615;52525.474745252825;52533.737331313096;1327.7278157977591;1427.3006226948928;1503.5038437315877;1505.668752874366;1526.114853385034;22203.333899983027;22360.664590031487;23075.423114422272;23236.41908952222;23456.53086938286;38209.426858596584;38239.42640860445;38304;38312;38325.233495330496;441552;441787;442638;443333;443349;32485.35029299448;33175.502367464025;33194.67221311217;33235.50146747849;33255.00234992954;42181;42254;42893.356599651655;43325.3501197476;43412.34881476843;26458.94164233486;29056.607546339772;29276;29346.413071738873;30971.69028309778;21908.890455547622;23204;27704.58443123395;29247.515853597473;30391.54412683856;34940.30119397547;35529.64470355367;36427.63572364242;36526.634733652325;36568.45147322845;26104.73895261023;29702.55446168266;29877;30552.84723576368;31109.8444507776;22286.55710911589;23667.64498532489;24051.037958481465;24345.26964191077;24481.020759169434 09:26:41 INFO - PID 1907 | |2;jquery.html;389.943458198561;412.8369294128817;422.62808728319084;424.6942201614837;431.8661215023341;14605.634859128528;19001.809981900176;21597.46006349842;22725.863706814675;23008.539829203404;19109.617807643837;22684;23065.769342306572;23881.16415925443;23949.154560609662;6075.726592303335;6119.08213767935;6242.313345531988;6263.968680156593;6343.365663433666;3680.7423480356388;6151.384861513858;6262.499000079983;6281.842953926165;6283.560150789446;3800.7909564973916;3868.535775706905;3876.108495046141;5971;6232.906506402408;6173.969130154321;6192.225971753531;6263.843403914916;6271.34150914152;6280.623162610258;5519.834404967857;5543.417941116165;5550.611457197998;5559.722013899329;5561.193626924073;27431.314217144532;27584.310392240153;28177.71822281792;28517.28706782326;28946.27634309138;2117.788221177885;2210.0938615167865;2248.932532024042;2252.2004688335733;2252.2117258959397;17779.73330400045;17817.02006389648;18139.183736731746;18311.816881831146;18356.357527486474;1822.298415110179;2093.2568938027084;2110.968335474969;2137.294692751388;2141.775113613079;171386;172772;172775.99999999875;176393.1180344103;177970;11386.146039047104;12395.132340736242;12455;12481;12617.369131543386;15271.694566108838;15289.6177595561;15673;16221.756673649668;16283.674326513641;8583.785405364915;8642.567871606394;8751.124887511198;8846.380753347205;8887.466751994902;8153.836923261501;8158.836823263501;8181;8335;8357.498550087013;7404.407647388196;7516.887246691304;7555.9244407555225;7558;7568.5458872467825;2125.5961367340465;2142.3358758784825;2150.2044243629957;2151.5911976724374;2304.2280835920155;902.9187373136318;905.542700936023;912.7900582865979;943.127606963556;965.584798536622;20727.58544829095;21362.679559806616;21366.89316553407;21460.03429845661;21505.032273547728;810.6061730777711;953.5280036382036;958.5159494455255;988.4267125067444;989.8267803134422;8756.781080472912;10330.328528645614;11248.94375528117;11274.492647830868;11276.830847537129;684860;694403;709567;709597;710254;159137.20431398;166290.33709662748;168122.15938920472;168732.15633921753;171696;1097.5554900265406;1133.1331531378503;1160.2690305107728;1161.2742036227357;1161.3902701082168;13997.860021399656;17252.913735431244;17675;18037.639247215244;18123.27506899762;60560.697196513735;61243.693781530805;61300;61377.69311153416;61411.07883381842;79736.80394794198;81295.59352203201;83559.74660380221;83697.58151209205;85768;7856.685732570633;8430.578471076298;8509.149085091442;9118.589663465027;12840.807387889003;13695.657608559468;14060.718785624025;14278.286085695467;14290.28548572588;14832.25838708082;11562.421878905852;11668.649940501798;12052.09609279325;12219.327936963553;12410;11082.556697732323;11332.490037948148;11352.091832653534;11727.413629318671;11739.471723772622;11517.078633709116;12053.397330133283;12111.81832272499;12376.81434778461;12432.75134497323;12853;13003.764642358961;13218.735625287249;13387.598372048855;13649.498555158725;9303.72088837336;9764.267679924176;12008.279503229835;12073.335966521925;12111.0327969648 09:26:41 INFO - PID 1907 | |3;mootools.html;1393.7909313602959;1450.1009374188004;1468.214505239697;1483.0508474576272;1488.1815001749035;9230.16928476437;10541.31481453706;10930;10982.615608453705;10993.83509247361;10625.46872656368;10687.893121068788;10949.069329107035;10976.12191024718;11001.559937602486;2420.987895060522;2470.6788117544693;2471.295680730992;2473.023155853437;2473.987630061847;2404.350825277174;2423.75762423758;2447.7429869863586;2448.8040956723507;2449.081594402099;2375.9168429104984;2422.5760491913934;2426.9757302427015;2456.7297597264287;2461.52000359929;2358.3750306168877;2414.0947144820693;2425.624028275629;2428.307932239303;2444.559979203743;2408.9759102408925;2422.2733180046093;2425.5876500994873;2426.6481360202847;2427.647991041307;10871.021608055235;11089.500972456259;11091.778164436666;11092.445377731161;11103.611373601885;6132.662703551303;6376.29860715321;6381.968090159519;6382.1384113144595;6383.265924418705;3811.104390468238;4035.3745169498775;4092.161106973093;4095.5494895561465;4124.896877578055;999.860019597257;1078.9190810689229;1207.1368971185557;1227.999180667762;1229.9938500307442;13600.979926505453;14217.57347279573;14220.288985550682;15076.773848392282;15179.316930738143;5086.618503612244;5152.201408781645;5345.198220266913;5345.70598617072;5354.625176237626;11324.94337528307;11331.206815522833;11334.94332528332;11345.773084538263;11352.262102963281;5425.267588875451;5637.210790489253;6297.527685423612;6300.495960323163;6306.49548036156;4910.337104490919;5098.056859480934;5182.844514664566;5897.970510147422;5993.041113421831;3644.635536446387;4188;4302.978485107555;4328.826846926151;4341.196878577473;1220.1946715167946;1253.4108968784656;1254.2161149281699;1271.774394809084;1272.7772639788;741.8293792427772;743.2994180292169;774.148436719604;795.6618437164182;796.7808852565475;4481.417415735934;5976.103584462366;6128.9855144880175;6142.723577439026;6230.563860529719;573.2919843992665;583.7664934026424;586.8444862111544;596.2278848890697;597.9790707325222;3635.4728564358547;3741.8690345837763;3848;3851.67260782831;3855.691544676419;12640.115191936477;12912.354382280848;13491.123076999964;13521.797173042412;13525;12240.938795305967;13524.188548686914;13546.390412431465;13547.729045419037;13549.864501355058;9770;10001.899981000242;10144.543495542719;10181.134603558781;10191.94904025475;4983.5763960063805;5407.567394608501;5766.452187042224;6658;6952.582845029315;11423.485943132746;11937.224080434744;12195.658477567284;12242.816357754818;12261.080418968791;12431.813522797345;12637.620871373874;12860.421281042189;12861.97104231678;12906;8612.78468038304;8972.102789720975;9188.58651360677;9189.310801690033;9209.631614735335;10138.746531336776;10158.746031349276;10264.743381415226;10272.972702729667;10274.589016439259;8300.086990430927;8530.402871799162;8545.145485451405;8565;8790.94508658965;8306.501609903426;8367.372447066617;8368.163273449189;8415.116412776815;8476.745697629081;6518.315576864551;6606.810774060523;7753.030871141107;7785.182555831782;7789.493682910593;5750.396208398058;5844.1136644131175;5903.881922361615;5954.702264886651;6061.15143879866;5874.647521148745;5886.293644762656;5998.1002849572915;6118.969405152946;6308.589941653778 09:26:41 INFO - PID 1907 | |4;prototype.html;335.2540597171294;374.67029014467266;382.4931965146181;396.071213005502;398.65516328375963;5650.559107427611;5826.969975612679;5873.353931067584;5931;5970.79102231422;5647.745851436685;5700.629459085167;5806.245188125537;5866.354700982888;5867.735951882165;4508.819647214107;4508.864734057984;4530.546945305476;4548.636109111263;4560.954390456086;4344.761038142901;4385.714928529651;4463.660901729484;4546.681732278742;4557.7721113944335;4431.578999995011;4450.710703804259;4474.865754027384;4479.686421950465;4482.910341793178;3314.6519615440393;4083.6528895043957;4497.280435130363;4497.932531012005;4509.977450112761;2903.477374072666;3676.4485327201132;3996.6003399660094;4009.4186342980106;4029.033032072311;5105.438401775802;5602.971985140048;5633.633813802131;5639.548836093103;5693.772249110072;3900.7659540427667;4568.383268258775;5067.847964561069;5078.31442755227;5084.593232541388;5871.383504732027;6071;6148;6222.848772977014;6247.625142491465;3757.530308711411;4091.345384738457;4211.831526738927;4212.178625168093;4231.238377092122;5308.416074231832;5594.832155035356;6232.3144454110015;6548.770793022317;6578.835529111762;4101.302778527657;4265.3601959705675;4294.809647080012;4297.699161058696;4299.591538803808;4360.8443762402985;4378.299472084451;4379.649628029813;4379.781010949439;4386.166628340605;4507.346434766941;5056.797728090909;5082.872928176751;5097.133487307166;5152.948470515322;5950.375210602911;5989.970050149721;6237.282712488031;6306.24325080984;6315.905261421082;1419.9148051116965;1437.1448987852211;1450.3980847947983;1495.5289083938524;1509.1171664576127;925.838073218107;959.712086374085;992.1219720547223;997.2969056814928;999.7650552120245;5814.680192589448;5822.505087067647;5838.591298609142;5840.474357307863;5865.872964348252;4908.4846091160625;5138.922916156261;5561.972190139104;6408.935910640834;6431.196100487439;5532.34029791061;5835.854103647358;5838.328592211865;5855.180274761537;5922.703864806828;3070.3245286037036;3377;3380.1887546989037;3382.864685412556;3388.542546756206;6078.237311179797;6200.472959798378;6393.520485963571;6642.568233064932;6719.496037797087;6570.310117437696;6617.86764264712;6652.301508341651;6660.9000864987065;6672.99905014242;6425.5823371482575;6678.599284042973;6680.632565208863;6687.76592819249;6701.966490167518;5185.974070129625;5981.252343457068;6311.706100249346;6393;6448.645324507197;6398.232212134573;6412.198475190601;6435.388638079375;6436.034594810816;6439.710213040331;4854.029194161111;5434.402215756343;6527.9673601633585;6646.136002319668;6705.994100884906;3591.4792355108884;3591.51514545533;3597.6222496637474;4303.569643035671;4321.503027151918;5143.871403214949;5721.971390143189;6278.780242691484;6388.872222555616;6448.580842245239;5754.942450575608;6149.600275982047;6253.718582663882;6279.780207692892;6345.841353966188;6027.36712645166;6210.937890621036;6262.436380725757;6269.529785266032;6274.215723034621;6045.455908968214;6091.634501929899;6111.694415279129;6116.5106791457465;6136.815895523141;5550.917571073602;5790.726040271134;6226.879161750929;6233.781817636543;6286.465650419583;5326.813561525328;5523.558115350682;6006.48944839676;6041.68019865798;6084.9007092553 09:26:41 INFO - PID 1907 | |5;yui.html;705.8306006558425;802.9437939344244;828.0436096308762;833.5957060825494;837.7444879311811;15799.28903199356;16007.83992160078;16241.187940602968;16912.746308805377;17095.658086838255;15071.246437678099;15102.395904163848;15368.61578460539;15563.455279065234;15769.92115039426;980.7401038724744;991.7173605522428;992.8709267795176;996.0686757881368;998.4907697074472;981.5730157381527;996.9551370188323;1023.6570748799161;1031.1132426113536;1032.8915463876297;1073.3506228731621;1077.428962649793;1077.5851297250576;1077.7575045614713;1077.9730506737355;1071.983920241197;1073.3613499967507;1073.726199819049;1073.8603981482436;1074.2963358999828;792.4888446951742;792.9127795942442;794.0907660728434;795.1094773853322;796.120287082771;16315.184240788032;16722.66554668912;16739.414120505844;16838.915805420893;16993.830061699347;12580.937095314557;14404.711905761826;14746.70506589873;14774.113553186844;14790.926045369704;11773.705657358549;13400.664983375396;13490.865091349058;13628.114172578751;13739.793903091462;3248.5614442050255;3293.6047674279002;3295.96704032959;3296.703296703284;3297.1262615406936;108080.45959770151;108212.91787082107;108236.99999999921;113563;116424.41787791006;11493.57497363521;11528.31985006404;11589.594364197214;11914.582989595323;11988.820167697491;24349.63475547868;24470.14354497584;24870.12954546582;24954.00183992656;24969.87515062413;7952.3638108951145;7985.520868747778;8037.67849286022;8062.879056814152;8226.42415030954;3657.8902632921054;4075.8777236682945;4106.835726570904;4152.280122190249;4201.159768046403;4071.91856162881;4091.161311931047;4179.811908464127;4180.811863466151;4197.9370309445385;895.54327293081;897.1253028297358;911.2072496927715;911.3438324406417;913.3515204205089;537.4464301769184;618.3322012226785;627.3318915355133;631.5137344244906;646.9385408386196;10658.840117398246;10958.945205274082;11144.944275278734;11175.552977880956;11293.15301352402;579.3164066401603;586.7853543165692;611.2023808929301;646.3730181723721;660.0561197487639;4063.79681015948;4346.065595896897;4465.709728867613;4781.856544303677;4782.473927867932;99759;101863;104209;104310.87492313572;107261;89830.65254021194;90701;91312;91958;92218.61672074924;58384;80062;80342.59828700936;81118.37763244702;85956.71064934031;10631.521581529005;10830.620928267474;10938.398388088413;11078.723031923944;11250.66248012561;36954.26091478209;39900.40149397819;40924.386134207416;41238.9690257734;41926.58073419227;52462.68843278949;52846.414607561834;53335.733321333144;53391.73304133455;53994.730026349614;13653.522126725517;13654.180749155083;13850.16898986064;14119.717605648035;14138;14621.853781462049;14666.706665866835;14792.482263120739;14909.25453727331;15172.317245723749;13914.791278130633;14029.859701402855;14053.718925621635;14196.219207943663;14257.928710356382;13761.724765504834;14014.369353379327;14259.969915256357;14687.41250349974;14903.54091574878;13618.455261789417;13891.722165556834;13901.86098139046;13955.651108722363;14160.362783674966;8125.634346454305;9617;9931.702048938543;10347.172226222036;10510.564434069418;10094.444805535766;10144.594216231268;10996.175286853679;11074.778504429705;11284.09727221804 09:26:41 INFO - PID 1907 | __end_tp_report 09:26:41 INFO - PID 1907 | __start_cc_report 09:26:41 INFO - PID 1907 | _x_x_mozilla_cycle_collect,1564 09:26:41 INFO - PID 1907 | __end_cc_report 09:26:41 INFO - PID 1907 | __startTimestamp1491323201023__endTimestamp 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | ------- Summary: start ------- 09:26:41 INFO - PID 1907 | Number of tests: 6 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | [#0] dojo.html Cycles:165 Average:6051.41 Median:6303.65 stddev:697.18 (11.1%) stddev-sans-first:668.99 09:26:41 INFO - PID 1907 | Values: 3458.5 3465.8 3466.4 3509.4 3543.3 5936.5 6060.8 6200.6 6221.0 6227.3 6078.7 6092.1 6098.7 6116.0 6196.9 5327.4 5336.5 5347.8 5362.9 5447.3 5285.3 5354.3 5404.0 5414.5 5427.3 5230.2 5270.2 5369.4 5380.3 5397.9 5308.6 5331.0 5342.7 5349.0 5359.7 5244.5 5263.4 5297.1 5314.4 5319.4 6099.5 6114.4 6125.9 6142.9 6166.0 6489.2 6506.3 6512.2 6515.7 6521.7 6377.0 6431.2 6549.1 6619.7 6621.0 6090.8 6129.4 6149.6 6155.7 6268.8 6714.8 6747.2 6754.4 6775.8 6811.2 6299.8 6360.9 6444.2 6459.0 6460.5 6438.0 6545.0 6548.8 6576.9 6592.4 6442.9 6455.8 6467.1 6480.2 6484.7 6402.6 6409.8 6419.9 6423.7 6425.8 5117.2 5187.7 5200.9 5242.1 5253.8 4673.6 4678.8 4680.6 4713.8 4718.4 6205.7 6214.3 6215.2 6220.3 6226.0 6356.6 6426.5 6434.3 6600.3 6611.2 6135.4 6192.8 6224.9 6225.3 6247.5 5761.0 5766.4 5767.6 5776.2 5807.0 6751.6 6756.2 6790.3 6796.4 6816.0 6359.2 6419.2 6434.5 6500.1 6623.4 6785.7 6821.6 6831.4 6831.4 6833.1 6432.1 6531.1 6535.2 6544.9 6546.7 6376.1 6424.9 6514.5 6634.0 6636.5 6352.6 6401.4 6403.7 6430.9 6443.1 6260.5 6284.7 6339.7 6407.9 6424.4 5722.5 6208.8 6366.2 6379.3 6401.9 6256.9 6337.1 6371.3 6445.8 6477.6 6298.4 6303.7 6324.4 6361.5 6386.7 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | [#1] ext.html Cycles:180 Average:53685.17 Median:36547.54 stddev:108800.30 (297.7%) stddev-sans-first:109032.86 09:26:41 INFO - PID 1907 | Values: 726.7 755.5 817.6 1124.4 1151.8 28472.9 37600.6 37918.6 37938.6 37988.0 40009.6 40101.6 40102.0 40111.0 40133.0 6197.8 8541.5 8757.4 8766.4 8767.0 6238.1 7027.6 8673.3 8679.8 8683.5 8697.9 8747.6 8755.0 8761.6 8768.9 7401.3 8676.1 8726.1 8729.2 8740.5 8460.6 8526.2 8537.2 8553.3 8560.6 38668.0 38912.6 38919.8 38959.2 38994.2 3470.7 3512.1 3515.3 3520.9 3521.7 30728.0 30751.0 30802.0 30826.0 30841.7 3077.7 3088.9 3130.4 3144.0 3153.0 330448.0 334408.0 334431.0 334687.0 335987.0 50789.7 50868.5 50891.2 50901.0 50948.0 53092.0 53101.2 53116.7 53125.0 53174.1 14312.1 14660.2 14695.3 14703.6 14725.6 8649.6 10284.2 11951.0 11951.9 11979.5 11475.5 11711.0 11727.8 11955.3 11963.3 4571.4 5015.5 5155.7 5162.8 5189.9 848.4 926.0 969.1 973.8 1005.4 21355.0 22485.6 22576.4 23764.4 23864.0 1056.0 1068.8 1080.4 1121.3 1123.6 9866.7 11698.7 12067.5 12131.3 12171.1 441837.0 442336.0 442556.1 442699.0 443432.0 52302.5 52337.0 52523.7 52525.5 52533.7 1327.7 1427.3 1503.5 1505.7 1526.1 22203.3 22360.7 23075.4 23236.4 23456.5 38209.4 38239.4 38304.0 38312.0 38325.2 441552.0 441787.0 442638.0 443333.0 443349.0 32485.4 33175.5 33194.7 33235.5 33255.0 42181.0 42254.0 42893.4 43325.4 43412.3 26458.9 29056.6 29276.0 29346.4 30971.7 21908.9 23204.0 27704.6 29247.5 30391.5 34940.3 35529.6 36427.6 36526.6 36568.5 26104.7 29702.6 29877.0 30552.8 31109.8 22286.6 23667.6 24051.0 24345.3 24481.0 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | [#2] jquery.html Cycles:180 Average:41634.73 Median:12468.11 stddev:118610.84 (951.3%) stddev-sans-first:118903.14 09:26:41 INFO - PID 1907 | Values: 389.9 412.8 422.6 424.7 431.9 14605.6 19001.8 21597.5 22725.9 23008.5 19109.6 22684.0 23065.8 23881.2 23949.2 6075.7 6119.1 6242.3 6264.0 6343.4 3680.7 6151.4 6262.5 6281.8 6283.6 3800.8 3868.5 3876.1 5971.0 6232.9 6174.0 6192.2 6263.8 6271.3 6280.6 5519.8 5543.4 5550.6 5559.7 5561.2 27431.3 27584.3 28177.7 28517.3 28946.3 2117.8 2210.1 2248.9 2252.2 2252.2 17779.7 17817.0 18139.2 18311.8 18356.4 1822.3 2093.3 2111.0 2137.3 2141.8 171386.0 172772.0 172776.0 176393.1 177970.0 11386.1 12395.1 12455.0 12481.0 12617.4 15271.7 15289.6 15673.0 16221.8 16283.7 8583.8 8642.6 8751.1 8846.4 8887.5 8153.8 8158.8 8181.0 8335.0 8357.5 7404.4 7516.9 7555.9 7558.0 7568.5 2125.6 2142.3 2150.2 2151.6 2304.2 902.9 905.5 912.8 943.1 965.6 20727.6 21362.7 21366.9 21460.0 21505.0 810.6 953.5 958.5 988.4 989.8 8756.8 10330.3 11248.9 11274.5 11276.8 684860.0 694403.0 709567.0 709597.0 710254.0 159137.2 166290.3 168122.2 168732.2 171696.0 1097.6 1133.1 1160.3 1161.3 1161.4 13997.9 17252.9 17675.0 18037.6 18123.3 60560.7 61243.7 61300.0 61377.7 61411.1 79736.8 81295.6 83559.7 83697.6 85768.0 7856.7 8430.6 8509.1 9118.6 12840.8 13695.7 14060.7 14278.3 14290.3 14832.3 11562.4 11668.6 12052.1 12219.3 12410.0 11082.6 11332.5 11352.1 11727.4 11739.5 11517.1 12053.4 12111.8 12376.8 12432.8 12853.0 13003.8 13218.7 13387.6 13649.5 9303.7 9764.3 12008.3 12073.3 12111.0 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | [#3] mootools.html Cycles:180 Average:6640.63 Median:2473.51 stddev:4102.10 (165.8%) stddev-sans-first:4094.66 09:26:41 INFO - PID 1907 | Values: 1393.8 1450.1 1468.2 1483.1 1488.2 9230.2 10541.3 10930.0 10982.6 10993.8 10625.5 10687.9 10949.1 10976.1 11001.6 2421.0 2470.7 2471.3 2473.0 2474.0 2404.4 2423.8 2447.7 2448.8 2449.1 2375.9 2422.6 2427.0 2456.7 2461.5 2358.4 2414.1 2425.6 2428.3 2444.6 2409.0 2422.3 2425.6 2426.6 2427.6 10871.0 11089.5 11091.8 11092.4 11103.6 6132.7 6376.3 6382.0 6382.1 6383.3 3811.1 4035.4 4092.2 4095.5 4124.9 999.9 1078.9 1207.1 1228.0 1230.0 13601.0 14217.6 14220.3 15076.8 15179.3 5086.6 5152.2 5345.2 5345.7 5354.6 11324.9 11331.2 11334.9 11345.8 11352.3 5425.3 5637.2 6297.5 6300.5 6306.5 4910.3 5098.1 5182.8 5898.0 5993.0 3644.6 4188.0 4303.0 4328.8 4341.2 1220.2 1253.4 1254.2 1271.8 1272.8 741.8 743.3 774.1 795.7 796.8 4481.4 5976.1 6129.0 6142.7 6230.6 573.3 583.8 586.8 596.2 598.0 3635.5 3741.9 3848.0 3851.7 3855.7 12640.1 12912.4 13491.1 13521.8 13525.0 12240.9 13524.2 13546.4 13547.7 13549.9 9770.0 10001.9 10144.5 10181.1 10191.9 4983.6 5407.6 5766.5 6658.0 6952.6 11423.5 11937.2 12195.7 12242.8 12261.1 12431.8 12637.6 12860.4 12862.0 12906.0 8612.8 8972.1 9188.6 9189.3 9209.6 10138.7 10158.7 10264.7 10273.0 10274.6 8300.1 8530.4 8545.1 8565.0 8790.9 8306.5 8367.4 8368.2 8415.1 8476.7 6518.3 6606.8 7753.0 7785.2 7789.5 5750.4 5844.1 5903.9 5954.7 6061.2 5874.6 5886.3 5998.1 6119.0 6308.6 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | [#4] prototype.html Cycles:180 Average:5030.85 Median:5711.30 stddev:1562.36 (27.4%) stddev-sans-first:1526.47 09:26:41 INFO - PID 1907 | Values: 335.3 374.7 382.5 396.1 398.7 5650.6 5827.0 5873.4 5931.0 5970.8 5647.7 5700.6 5806.2 5866.4 5867.7 4508.8 4508.9 4530.5 4548.6 4561.0 4344.8 4385.7 4463.7 4546.7 4557.8 4431.6 4450.7 4474.9 4479.7 4482.9 3314.7 4083.7 4497.3 4497.9 4510.0 2903.5 3676.4 3996.6 4009.4 4029.0 5105.4 5603.0 5633.6 5639.5 5693.8 3900.8 4568.4 5067.8 5078.3 5084.6 5871.4 6071.0 6148.0 6222.8 6247.6 3757.5 4091.3 4211.8 4212.2 4231.2 5308.4 5594.8 6232.3 6548.8 6578.8 4101.3 4265.4 4294.8 4297.7 4299.6 4360.8 4378.3 4379.6 4379.8 4386.2 4507.3 5056.8 5082.9 5097.1 5152.9 5950.4 5990.0 6237.3 6306.2 6315.9 1419.9 1437.1 1450.4 1495.5 1509.1 925.8 959.7 992.1 997.3 999.8 5814.7 5822.5 5838.6 5840.5 5865.9 4908.5 5138.9 5562.0 6408.9 6431.2 5532.3 5835.9 5838.3 5855.2 5922.7 3070.3 3377.0 3380.2 3382.9 3388.5 6078.2 6200.5 6393.5 6642.6 6719.5 6570.3 6617.9 6652.3 6660.9 6673.0 6425.6 6678.6 6680.6 6687.8 6702.0 5186.0 5981.3 6311.7 6393.0 6448.6 6398.2 6412.2 6435.4 6436.0 6439.7 4854.0 5434.4 6528.0 6646.1 6706.0 3591.5 3591.5 3597.6 4303.6 4321.5 5143.9 5722.0 6278.8 6388.9 6448.6 5754.9 6149.6 6253.7 6279.8 6345.8 6027.4 6210.9 6262.4 6269.5 6274.2 6045.5 6091.6 6111.7 6116.5 6136.8 5550.9 5790.7 6226.9 6233.8 6286.5 5326.8 5523.6 6006.5 6041.7 6084.9 09:26:41 INFO - PID 1907 | 09:26:41 INFO - PID 1907 | [#5] yui.html Cycles:180 Average:20386.32 Median:16875.83 stddev:29137.06 (172.7%) stddev-sans-first:29181.32 09:26:41 INFO - PID 1907 | Values: 705.8 802.9 828.0 833.6 837.7 15799.3 16007.8 16241.2 16912.7 17095.7 15071.2 15102.4 15368.6 15563.5 15769.9 980.7 991.7 992.9 996.1 998.5 981.6 997.0 1023.7 1031.1 1032.9 1073.4 1077.4 1077.6 1077.8 1078.0 1072.0 1073.4 1073.7 1073.9 1074.3 792.5 792.9 794.1 795.1 796.1 16315.2 16722.7 16739.4 16838.9 16993.8 12580.9 14404.7 14746.7 14774.1 14790.9 11773.7 13400.7 13490.9 13628.1 13739.8 3248.6 3293.6 3296.0 3296.7 3297.1 108080.5 108212.9 108237.0 113563.0 116424.4 11493.6 11528.3 11589.6 11914.6 11988.8 24349.6 24470.1 24870.1 24954.0 24969.9 7952.4 7985.5 8037.7 8062.9 8226.4 3657.9 4075.9 4106.8 4152.3 4201.2 4071.9 4091.2 4179.8 4180.8 4197.9 895.5 897.1 911.2 911.3 913.4 537.4 618.3 627.3 631.5 646.9 10658.8 10958.9 11144.9 11175.6 11293.2 579.3 586.8 611.2 646.4 660.1 4063.8 4346.1 4465.7 4781.9 4782.5 99759.0 101863.0 104209.0 104310.9 107261.0 89830.7 90701.0 91312.0 91958.0 92218.6 58384.0 80062.0 80342.6 81118.4 85956.7 10631.5 10830.6 10938.4 11078.7 11250.7 36954.3 39900.4 40924.4 41239.0 41926.6 52462.7 52846.4 53335.7 53391.7 53994.7 13653.5 13654.2 13850.2 14119.7 14138.0 14621.9 14666.7 14792.5 14909.3 15172.3 13914.8 14029.9 14053.7 14196.2 14257.9 13761.7 14014.4 14260.0 14687.4 14903.5 13618.5 13891.7 13901.9 13955.7 14160.4 8125.6 9617.0 9931.7 10347.2 10510.6 10094.4 10144.6 10996.2 11074.8 11284.1 09:26:41 INFO - PID 1907 | -------- Summary: end -------- 09:26:41 INFO - PID 1907 | 09:26:41 INFO - TEST-INFO | 1907: exit 0 09:26:41 INFO - TEST-OK | dromaeo_css | took 1121015ms 09:26:41 INFO - TEST-START | kraken 09:26:41 INFO - operating with platform_type : mac_ 09:26:41 INFO - Initialising browser for kraken test... 09:26:41 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpLLZ7Qp/profile http://localhost:49375/getInfo.html) 09:26:44 INFO - PID 1911 | __metrics Screen width/height:1600/1200 09:26:44 INFO - PID 1911 | colorDepth:24 09:26:44 INFO - PID 1911 | Browser inner width/height: 1024/689 09:26:44 INFO - PID 1911 | __metrics 09:26:44 INFO - PID 1911 | 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" 09:26:44 INFO - PID 1911 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:45 INFO - TEST-INFO | 1911: exit 0 09:26:45 INFO - Browser initialized. 09:26:45 INFO - Running cycle 1/1 for kraken test... 09:26:45 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpLLZ7Qp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:57 INFO - PID 1912 | RSS: Main: 233517056 09:26:57 INFO - PID 1912 | 09:27:00 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:01 INFO - PID 1912 | RSS: Main: 286400512 09:27:01 INFO - PID 1912 | 09:27:04 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-dft) 09:27:04 INFO - PID 1912 | RSS: Main: 286822400 09:27:04 INFO - PID 1912 | 09:27:08 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-fft) 09:27:09 INFO - PID 1912 | RSS: Main: 380403712 09:27:09 INFO - PID 1912 | 09:27:11 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator) 09:27:11 INFO - PID 1912 | RSS: Main: 284880896 09:27:11 INFO - PID 1912 | 09:27:13 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:14 INFO - PID 1912 | RSS: Main: 287027200 09:27:14 INFO - PID 1912 | 09:27:17 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:18 INFO - PID 1912 | RSS: Main: 327065600 09:27:18 INFO - PID 1912 | 09:27:21 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:22 INFO - PID 1912 | RSS: Main: 341299200 09:27:22 INFO - PID 1912 | 09:27:25 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial) 09:27:25 INFO - PID 1912 | RSS: Main: 347389952 09:27:25 INFO - PID 1912 | 09:27:27 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:28 INFO - PID 1912 | RSS: Main: 303865856 09:27:28 INFO - PID 1912 | 09:27:29 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:30 INFO - PID 1912 | RSS: Main: 308285440 09:27:30 INFO - PID 1912 | 09:27:33 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:33 INFO - PID 1912 | RSS: Main: 309010432 09:27:33 INFO - PID 1912 | 09:27:36 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:37 INFO - PID 1912 | RSS: Main: 321978368 09:27:37 INFO - PID 1912 | 09:27:41 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:41 INFO - PID 1912 | RSS: Main: 310185984 09:27:41 INFO - PID 1912 | 09:27:43 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49375/tests/kraken/driver.html?testName=ai-astar) 09:27:44 INFO - PID 1912 | RSS: Main: 377229312 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | __start_tp_report 09:27:44 INFO - PID 1912 | _x_x_mozilla_page_load 09:27:44 INFO - PID 1912 | _x_x_mozilla_page_load_details 09:27:44 INFO - PID 1912 | |i|pagename|runs| 09:27:44 INFO - PID 1912 | |0;ai-astar;112;122;122;124;121;122;121;123;121;122 09:27:44 INFO - PID 1912 | |1;audio-beat-detection;159;120;119;163;122;117;118;118;144;120 09:27:44 INFO - PID 1912 | |2;audio-dft;286;251;221;211;210;210;207;212;209;214 09:27:44 INFO - PID 1912 | |3;audio-fft;81;66;61;97;64;61;61;63;86;61 09:27:44 INFO - PID 1912 | |4;audio-oscillator;94;77;97;76;76;74;92;74;73;92 09:27:44 INFO - PID 1912 | |5;imaging-gaussian-blur;92;92;93;92;92;95;93;93;92;91 09:27:44 INFO - PID 1912 | |6;imaging-darkroom;147;135;100;101;100;100;101;100;100;100 09:27:44 INFO - PID 1912 | |7;imaging-desaturate;100;100;102;100;101;100;99;101;102;98 09:27:44 INFO - PID 1912 | |8;json-parse-financial;54;51;51;50;52;52;52;51;53;51 09:27:44 INFO - PID 1912 | |9;json-stringify-tinderbox;59;62;70;75;68;71;66;66;65;66 09:27:44 INFO - PID 1912 | |10;stanford-crypto-aes;88;90;88;116;116;117;113;89;89;107 09:27:44 INFO - PID 1912 | |11;stanford-crypto-ccm;156;152;150;152;149;149;158;173;286;195 09:27:44 INFO - PID 1912 | |12;stanford-crypto-pbkdf2;202;192;240;259;234;204;204;205;202;208 09:27:44 INFO - PID 1912 | |13;stanford-crypto-sha256-iterative;74;73;76;73;72;73;77;97;110;75 09:27:44 INFO - PID 1912 | __end_tp_report 09:27:44 INFO - PID 1912 | __start_cc_report 09:27:44 INFO - PID 1912 | _x_x_mozilla_cycle_collect,2258 09:27:44 INFO - PID 1912 | __end_cc_report 09:27:44 INFO - PID 1912 | __startTimestamp1491323264017__endTimestamp 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | ------- Summary: start ------- 09:27:44 INFO - PID 1912 | Number of tests: 14 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#0] ai-astar Cycles:10 Average:121.00 Median:122.00 stddev:3.30 (2.7%) stddev-sans-first:1.00 09:27:44 INFO - PID 1912 | Values: 112.0 122.0 122.0 124.0 121.0 122.0 121.0 123.0 121.0 122.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:121.00 stddev:18.16 (15.0%) stddev-sans-first:15.94 09:27:44 INFO - PID 1912 | Values: 159.0 120.0 119.0 163.0 122.0 117.0 118.0 118.0 144.0 120.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#2] audio-dft Cycles:10 Average:223.10 Median:213.00 stddev:25.59 (12.0%) stddev-sans-first:13.68 09:27:44 INFO - PID 1912 | Values: 286.0 251.0 221.0 211.0 210.0 210.0 207.0 212.0 209.0 214.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#3] audio-fft Cycles:10 Average:70.10 Median:65.00 stddev:13.04 (20.1%) stddev-sans-first:13.22 09:27:44 INFO - PID 1912 | Values: 81.0 66.0 61.0 97.0 64.0 61.0 61.0 63.0 86.0 61.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:84.50 stddev:9.85 (11.7%) stddev-sans-first:9.52 09:27:44 INFO - PID 1912 | Values: 94.0 77.0 97.0 76.0 76.0 74.0 92.0 74.0 73.0 92.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:92.50 stddev:1.08 (1.2%) stddev-sans-first:1.13 09:27:44 INFO - PID 1912 | Values: 92.0 92.0 93.0 92.0 92.0 95.0 93.0 93.0 92.0 91.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#6] imaging-darkroom Cycles:10 Average:108.40 Median:100.50 stddev:17.42 (17.3%) stddev-sans-first:11.59 09:27:44 INFO - PID 1912 | Values: 147.0 135.0 100.0 101.0 100.0 100.0 101.0 100.0 100.0 100.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#7] imaging-desaturate Cycles:10 Average:100.30 Median:101.50 stddev:1.25 (1.2%) stddev-sans-first:1.32 09:27:44 INFO - PID 1912 | Values: 100.0 100.0 102.0 100.0 101.0 100.0 99.0 101.0 102.0 98.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.16 (2.2%) stddev-sans-first:0.88 09:27:44 INFO - PID 1912 | Values: 54.0 51.0 51.0 50.0 52.0 52.0 52.0 51.0 53.0 51.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:4.54 (6.8%) stddev-sans-first:3.84 09:27:44 INFO - PID 1912 | Values: 59.0 62.0 70.0 75.0 68.0 71.0 66.0 66.0 65.0 66.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#10] stanford-crypto-aes Cycles:10 Average:101.30 Median:88.00 stddev:13.47 (15.3%) stddev-sans-first:13.40 09:27:44 INFO - PID 1912 | Values: 88.0 90.0 88.0 116.0 116.0 117.0 113.0 89.0 89.0 107.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#11] stanford-crypto-ccm Cycles:10 Average:172.00 Median:157.00 stddev:42.58 (27.1%) stddev-sans-first:44.77 09:27:44 INFO - PID 1912 | Values: 156.0 152.0 150.0 152.0 149.0 149.0 158.0 173.0 286.0 195.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:215.00 Median:206.50 stddev:21.55 (10.4%) stddev-sans-first:22.34 09:27:44 INFO - PID 1912 | Values: 202.0 192.0 240.0 259.0 234.0 204.0 204.0 205.0 202.0 208.0 09:27:44 INFO - PID 1912 | 09:27:44 INFO - PID 1912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.00 Median:74.50 stddev:12.85 (17.2%) stddev-sans-first:13.44 09:27:44 INFO - PID 1912 | Values: 74.0 73.0 76.0 73.0 72.0 73.0 77.0 97.0 110.0 75.0 09:27:44 INFO - PID 1912 | -------- Summary: end -------- 09:27:44 INFO - PID 1912 | 09:27:44 INFO - TEST-INFO | 1912: exit 0 09:27:44 INFO - TEST-OK | kraken | took 63102ms 09:27:44 INFO - SUITE-END | took 1184s 09:27:45 INFO - Completed test suite (00:19:44) 09:27:45 INFO - javascript benchmark 09:27:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7642.042242699846, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3458.481227815829, 3465.826708664567, 3466.445368741002, 3509.368313703534, 3543.2913417316527, 5936.465718085371, 6060.787872424466, 6200.565960382775, 6221.00463925772, 6227.314995350508, 6078.665673387962, 6092.1454343602545, 6098.734805259241, 6116.031445915019, 6196.876062478747, 5327.360716713981, 5336.519713225809, 5347.839564813062, 5362.946370536303, 5447.291852059227, 5285.2600635911, 5354.27717258171, 5404.0, 5414.458554144593, 5427.294451721271, 5230.189320655304, 5270.2358158067245, 5369.44286157014, 5380.2736630555155, 5397.919031214535, 5308.628396012281, 5331.0, 5342.652727572696, 5348.956953394089, 5359.705216213107, 5244.535068517791, 5263.394709608406, 5297.099493086184, 5314.388845282803, 5319.441458646864, 6099.5425343099005, 6114.419130182626, 6125.927962606571, 6142.880706156369, 6166.0, 6489.156409666713, 6506.316836732122, 6512.15342005541, 6515.7393704252245, 6521.739130434777, 6377.01156320771, 6431.22825260967, 6549.083128362033, 6619.735210591571, 6621.0, 6090.817275481742, 6129.431244638657, 6149.631022138641, 6155.6614386209185, 6268.811935641938, 6714.764983225564, 6747.190337159573, 6754.392104710501, 6775.830604234933, 6811.182658080963, 6299.842503937438, 6360.872782544416, 6444.194475690539, 6458.967705161538, 6460.547761656733, 6437.969924812008, 6544.9672751635935, 6548.770793022317, 6576.901346479806, 6592.406683398517, 6442.871142577123, 6455.838604034937, 6467.094606755058, 6480.157579514727, 6484.675766211671, 6402.647854367961, 6409.839754006187, 6419.903701444482, 6423.710933008026, 6425.839354016187, 5117.181250999822, 5187.740612969336, 5200.92198617021, 5242.082635538765, 5253.816116435906, 4673.649476289292, 4678.836240731558, 4680.578747912704, 4713.7643117844655, 4718.363020992191, 6205.6586887721605, 6214.2542894852, 6215.192025036717, 6220.315765265817, 6226.003839385677, 6356.618602883842, 6426.453751431087, 6434.292227854932, 6600.273969863311, 6611.239707433707, 6135.385782596134, 6192.783252586138, 6224.875502489925, 6225.346338634378, 6247.468965137923, 5761.020626493422, 5766.394528574439, 5767.567432442584, 5776.249087618583, 5806.970965145148, 6751.594904305757, 6756.155480564929, 6790.320967903269, 6796.422304104108, 6815.965920170367, 6359.236891573041, 6419.2296924369375, 6434.485241180788, 6500.057491663588, 6623.370779775913, 6785.660716964231, 6821.556598821061, 6831.351021652935, 6831.385175334244, 6833.145856767904, 6432.13166222554, 6531.11829902957, 6535.248446428722, 6544.934550654432, 6546.738130474918, 6376.139221205078, 6424.93575064262, 6514.54398192122, 6634.03806448072, 6636.469082473487, 6352.587081839665, 6401.423871851555, 6403.679816009274, 6430.935690643034, 6443.065755465337, 6260.467860231931, 6284.685765711604, 6339.714712837841, 6407.8718425630295, 6424.421802037839, 5722.542196624343, 6208.844778880383, 6366.172397588284, 6379.266384365857, 6401.87196256063, 6256.937430625636, 6337.144485494584, 6371.299157092809, 6445.774397896239, 6477.611343319416, 6298.370162983848, 6303.6532990685955, 6324.367563243639, 6361.491080713439, 6386.744530218925], "value": 6004.186106855213, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.7165805335919, 755.4938191411753, 817.5830326533468, 1124.4434005167438, 1151.832984217288, 28472.857635711818, 37600.62399376009, 37918.62081379182, 37938.62061379386, 37988.0, 40009.59990400095, 40101.598984010154, 40102.0, 40111.0, 40132.99667508314, 6197.845053873644, 8541.530215838142, 8757.386982911199, 8766.386352955296, 8766.956165219164, 6238.1266622672865, 7027.578345299298, 8673.306135509145, 8679.826403471927, 8683.522406267653, 8697.913020869773, 8747.606357713887, 8755.036945935943, 8761.56192190388, 8768.868466972968, 7401.296876796696, 8676.132386761305, 8726.127387261287, 8729.170728780755, 8740.4755714657, 8460.619272132768, 8526.232639062515, 8537.18896704812, 8553.315734741269, 8560.571971401467, 38668.0, 38912.61087389146, 38919.8324050279, 38959.220815583816, 38994.24525896341, 3470.687638112582, 3512.0868574170645, 3515.2617950230483, 3520.929581408383, 3521.7182625389905, 30728.0, 30751.0, 30802.0, 30826.0, 30841.691583084106, 3077.7383922366625, 3088.8764449421997, 3130.373925214966, 3143.9685603143903, 3153.022563005453, 330448.0, 334408.0, 334431.0, 334687.0, 335987.0, 50789.682876955136, 50868.491315087114, 50891.236631450556, 50901.0, 50948.0, 53092.0, 53101.2034819478, 53116.73441632767, 53125.0, 53174.08736864183, 14312.06971546846, 14660.193689346976, 14695.26523673812, 14703.55889323322, 14725.55823325302, 8649.610767515476, 10284.228682848816, 11951.04391648666, 11951.940240298743, 11979.46092425843, 11475.54097836094, 11711.0, 11727.824082638766, 11955.34245616482, 11963.342016189194, 4571.405717256802, 5015.498450155028, 5155.742212889416, 5162.845114646567, 5189.948100519022, 848.410354803418, 925.9814803703888, 969.0648524174205, 973.78576713123, 1005.4319309590059, 21355.03902324399, 22485.550288994127, 22576.435589110402, 23764.405889852547, 23864.045438182624, 1055.9598795186735, 1068.759529105945, 1080.4327727942737, 1121.2935850414187, 1123.5618108937522, 9866.703998880044, 11698.66386070792, 12067.517299308105, 12131.33277669719, 12171.0871684624, 441837.0, 442336.0, 442556.14887702063, 442699.0, 443432.0, 52302.47697523052, 52337.0, 52523.737381313615, 52525.474745252825, 52533.737331313096, 1327.7278157977591, 1427.3006226948928, 1503.5038437315877, 1505.668752874366, 1526.114853385034, 22203.333899983027, 22360.664590031487, 23075.423114422272, 23236.41908952222, 23456.53086938286, 38209.426858596584, 38239.42640860445, 38304.0, 38312.0, 38325.233495330496, 441552.0, 441787.0, 442638.0, 443333.0, 443349.0, 32485.35029299448, 33175.502367464025, 33194.67221311217, 33235.50146747849, 33255.00234992954, 42181.0, 42254.0, 42893.356599651655, 43325.3501197476, 43412.34881476843, 26458.94164233486, 29056.607546339772, 29276.0, 29346.413071738873, 30971.69028309778, 21908.890455547622, 23204.0, 27704.58443123395, 29247.515853597473, 30391.54412683856, 34940.30119397547, 35529.64470355367, 36427.63572364242, 36526.634733652325, 36568.45147322845, 26104.73895261023, 29702.55446168266, 29877.0, 30552.84723576368, 31109.8444507776, 22286.55710911589, 23667.64498532489, 24051.037958481465, 24345.26964191077, 24481.020759169434], "value": 17524.743998347913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.943458198561, 412.8369294128817, 422.62808728319084, 424.6942201614837, 431.8661215023341, 14605.634859128528, 19001.809981900176, 21597.46006349842, 22725.863706814675, 23008.539829203404, 19109.617807643837, 22684.0, 23065.769342306572, 23881.16415925443, 23949.154560609662, 6075.726592303335, 6119.08213767935, 6242.313345531988, 6263.968680156593, 6343.365663433666, 3680.7423480356388, 6151.384861513858, 6262.499000079983, 6281.842953926165, 6283.560150789446, 3800.7909564973916, 3868.535775706905, 3876.108495046141, 5971.0, 6232.906506402408, 6173.969130154321, 6192.225971753531, 6263.843403914916, 6271.34150914152, 6280.623162610258, 5519.834404967857, 5543.417941116165, 5550.611457197998, 5559.722013899329, 5561.193626924073, 27431.314217144532, 27584.310392240153, 28177.71822281792, 28517.28706782326, 28946.27634309138, 2117.788221177885, 2210.0938615167865, 2248.932532024042, 2252.2004688335733, 2252.2117258959397, 17779.73330400045, 17817.02006389648, 18139.183736731746, 18311.816881831146, 18356.357527486474, 1822.298415110179, 2093.2568938027084, 2110.968335474969, 2137.294692751388, 2141.775113613079, 171386.0, 172772.0, 172775.99999999875, 176393.1180344103, 177970.0, 11386.146039047104, 12395.132340736242, 12455.0, 12481.0, 12617.369131543386, 15271.694566108838, 15289.6177595561, 15673.0, 16221.756673649668, 16283.674326513641, 8583.785405364915, 8642.567871606394, 8751.124887511198, 8846.380753347205, 8887.466751994902, 8153.836923261501, 8158.836823263501, 8181.0, 8335.0, 8357.498550087013, 7404.407647388196, 7516.887246691304, 7555.9244407555225, 7558.0, 7568.5458872467825, 2125.5961367340465, 2142.3358758784825, 2150.2044243629957, 2151.5911976724374, 2304.2280835920155, 902.9187373136318, 905.542700936023, 912.7900582865979, 943.127606963556, 965.584798536622, 20727.58544829095, 21362.679559806616, 21366.89316553407, 21460.03429845661, 21505.032273547728, 810.6061730777711, 953.5280036382036, 958.5159494455255, 988.4267125067444, 989.8267803134422, 8756.781080472912, 10330.328528645614, 11248.94375528117, 11274.492647830868, 11276.830847537129, 684860.0, 694403.0, 709567.0, 709597.0, 710254.0, 159137.20431398, 166290.33709662748, 168122.15938920472, 168732.15633921753, 171696.0, 1097.5554900265406, 1133.1331531378503, 1160.2690305107728, 1161.2742036227357, 1161.3902701082168, 13997.860021399656, 17252.913735431244, 17675.0, 18037.639247215244, 18123.27506899762, 60560.697196513735, 61243.693781530805, 61300.0, 61377.69311153416, 61411.07883381842, 79736.80394794198, 81295.59352203201, 83559.74660380221, 83697.58151209205, 85768.0, 7856.685732570633, 8430.578471076298, 8509.149085091442, 9118.589663465027, 12840.807387889003, 13695.657608559468, 14060.718785624025, 14278.286085695467, 14290.28548572588, 14832.25838708082, 11562.421878905852, 11668.649940501798, 12052.09609279325, 12219.327936963553, 12410.0, 11082.556697732323, 11332.490037948148, 11352.091832653534, 11727.413629318671, 11739.471723772622, 11517.078633709116, 12053.397330133283, 12111.81832272499, 12376.81434778461, 12432.75134497323, 12853.0, 13003.764642358961, 13218.735625287249, 13387.598372048855, 13649.498555158725, 9303.72088837336, 9764.267679924176, 12008.279503229835, 12073.335966521925, 12111.0327969648], "value": 10575.19472957803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.7909313602959, 1450.1009374188004, 1468.214505239697, 1483.0508474576272, 1488.1815001749035, 9230.16928476437, 10541.31481453706, 10930.0, 10982.615608453705, 10993.83509247361, 10625.46872656368, 10687.893121068788, 10949.069329107035, 10976.12191024718, 11001.559937602486, 2420.987895060522, 2470.6788117544693, 2471.295680730992, 2473.023155853437, 2473.987630061847, 2404.350825277174, 2423.75762423758, 2447.7429869863586, 2448.8040956723507, 2449.081594402099, 2375.9168429104984, 2422.5760491913934, 2426.9757302427015, 2456.7297597264287, 2461.52000359929, 2358.3750306168877, 2414.0947144820693, 2425.624028275629, 2428.307932239303, 2444.559979203743, 2408.9759102408925, 2422.2733180046093, 2425.5876500994873, 2426.6481360202847, 2427.647991041307, 10871.021608055235, 11089.500972456259, 11091.778164436666, 11092.445377731161, 11103.611373601885, 6132.662703551303, 6376.29860715321, 6381.968090159519, 6382.1384113144595, 6383.265924418705, 3811.104390468238, 4035.3745169498775, 4092.161106973093, 4095.5494895561465, 4124.896877578055, 999.860019597257, 1078.9190810689229, 1207.1368971185557, 1227.999180667762, 1229.9938500307442, 13600.979926505453, 14217.57347279573, 14220.288985550682, 15076.773848392282, 15179.316930738143, 5086.618503612244, 5152.201408781645, 5345.198220266913, 5345.70598617072, 5354.625176237626, 11324.94337528307, 11331.206815522833, 11334.94332528332, 11345.773084538263, 11352.262102963281, 5425.267588875451, 5637.210790489253, 6297.527685423612, 6300.495960323163, 6306.49548036156, 4910.337104490919, 5098.056859480934, 5182.844514664566, 5897.970510147422, 5993.041113421831, 3644.635536446387, 4188.0, 4302.978485107555, 4328.826846926151, 4341.196878577473, 1220.1946715167946, 1253.4108968784656, 1254.2161149281699, 1271.774394809084, 1272.7772639788, 741.8293792427772, 743.2994180292169, 774.148436719604, 795.6618437164182, 796.7808852565475, 4481.417415735934, 5976.103584462366, 6128.9855144880175, 6142.723577439026, 6230.563860529719, 573.2919843992665, 583.7664934026424, 586.8444862111544, 596.2278848890697, 597.9790707325222, 3635.4728564358547, 3741.8690345837763, 3848.0, 3851.67260782831, 3855.691544676419, 12640.115191936477, 12912.354382280848, 13491.123076999964, 13521.797173042412, 13525.0, 12240.938795305967, 13524.188548686914, 13546.390412431465, 13547.729045419037, 13549.864501355058, 9770.0, 10001.899981000242, 10144.543495542719, 10181.134603558781, 10191.94904025475, 4983.5763960063805, 5407.567394608501, 5766.452187042224, 6658.0, 6952.582845029315, 11423.485943132746, 11937.224080434744, 12195.658477567284, 12242.816357754818, 12261.080418968791, 12431.813522797345, 12637.620871373874, 12860.421281042189, 12861.97104231678, 12906.0, 8612.78468038304, 8972.102789720975, 9188.58651360677, 9189.310801690033, 9209.631614735335, 10138.746531336776, 10158.746031349276, 10264.743381415226, 10272.972702729667, 10274.589016439259, 8300.086990430927, 8530.402871799162, 8545.145485451405, 8565.0, 8790.94508658965, 8306.501609903426, 8367.372447066617, 8368.163273449189, 8415.116412776815, 8476.745697629081, 6518.315576864551, 6606.810774060523, 7753.030871141107, 7785.182555831782, 7789.493682910593, 5750.396208398058, 5844.1136644131175, 5903.881922361615, 5954.702264886651, 6061.15143879866, 5874.647521148745, 5886.293644762656, 5998.1002849572915, 6118.969405152946, 6308.589941653778], "value": 5033.391545168491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.2540597171294, 374.67029014467266, 382.4931965146181, 396.071213005502, 398.65516328375963, 5650.559107427611, 5826.969975612679, 5873.353931067584, 5931.0, 5970.79102231422, 5647.745851436685, 5700.629459085167, 5806.245188125537, 5866.354700982888, 5867.735951882165, 4508.819647214107, 4508.864734057984, 4530.546945305476, 4548.636109111263, 4560.954390456086, 4344.761038142901, 4385.714928529651, 4463.660901729484, 4546.681732278742, 4557.7721113944335, 4431.578999995011, 4450.710703804259, 4474.865754027384, 4479.686421950465, 4482.910341793178, 3314.6519615440393, 4083.6528895043957, 4497.280435130363, 4497.932531012005, 4509.977450112761, 2903.477374072666, 3676.4485327201132, 3996.6003399660094, 4009.4186342980106, 4029.033032072311, 5105.438401775802, 5602.971985140048, 5633.633813802131, 5639.548836093103, 5693.772249110072, 3900.7659540427667, 4568.383268258775, 5067.847964561069, 5078.31442755227, 5084.593232541388, 5871.383504732027, 6071.0, 6148.0, 6222.848772977014, 6247.625142491465, 3757.530308711411, 4091.345384738457, 4211.831526738927, 4212.178625168093, 4231.238377092122, 5308.416074231832, 5594.832155035356, 6232.3144454110015, 6548.770793022317, 6578.835529111762, 4101.302778527657, 4265.3601959705675, 4294.809647080012, 4297.699161058696, 4299.591538803808, 4360.8443762402985, 4378.299472084451, 4379.649628029813, 4379.781010949439, 4386.166628340605, 4507.346434766941, 5056.797728090909, 5082.872928176751, 5097.133487307166, 5152.948470515322, 5950.375210602911, 5989.970050149721, 6237.282712488031, 6306.24325080984, 6315.905261421082, 1419.9148051116965, 1437.1448987852211, 1450.3980847947983, 1495.5289083938524, 1509.1171664576127, 925.838073218107, 959.712086374085, 992.1219720547223, 997.2969056814928, 999.7650552120245, 5814.680192589448, 5822.505087067647, 5838.591298609142, 5840.474357307863, 5865.872964348252, 4908.4846091160625, 5138.922916156261, 5561.972190139104, 6408.935910640834, 6431.196100487439, 5532.34029791061, 5835.854103647358, 5838.328592211865, 5855.180274761537, 5922.703864806828, 3070.3245286037036, 3377.0, 3380.1887546989037, 3382.864685412556, 3388.542546756206, 6078.237311179797, 6200.472959798378, 6393.520485963571, 6642.568233064932, 6719.496037797087, 6570.310117437696, 6617.86764264712, 6652.301508341651, 6660.9000864987065, 6672.99905014242, 6425.5823371482575, 6678.599284042973, 6680.632565208863, 6687.76592819249, 6701.966490167518, 5185.974070129625, 5981.252343457068, 6311.706100249346, 6393.0, 6448.645324507197, 6398.232212134573, 6412.198475190601, 6435.388638079375, 6436.034594810816, 6439.710213040331, 4854.029194161111, 5434.402215756343, 6527.9673601633585, 6646.136002319668, 6705.994100884906, 3591.4792355108884, 3591.51514545533, 3597.6222496637474, 4303.569643035671, 4321.503027151918, 5143.871403214949, 5721.971390143189, 6278.780242691484, 6388.872222555616, 6448.580842245239, 5754.942450575608, 6149.600275982047, 6253.718582663882, 6279.780207692892, 6345.841353966188, 6027.36712645166, 6210.937890621036, 6262.436380725757, 6269.529785266032, 6274.215723034621, 6045.455908968214, 6091.634501929899, 6111.694415279129, 6116.5106791457465, 6136.815895523141, 5550.917571073602, 5790.726040271134, 6226.879161750929, 6233.781817636543, 6286.465650419583, 5326.813561525328, 5523.558115350682, 6006.48944839676, 6041.68019865798, 6084.9007092553], "value": 4544.384937148261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.8306006558425, 802.9437939344244, 828.0436096308762, 833.5957060825494, 837.7444879311811, 15799.28903199356, 16007.83992160078, 16241.187940602968, 16912.746308805377, 17095.658086838255, 15071.246437678099, 15102.395904163848, 15368.61578460539, 15563.455279065234, 15769.92115039426, 980.7401038724744, 991.7173605522428, 992.8709267795176, 996.0686757881368, 998.4907697074472, 981.5730157381527, 996.9551370188323, 1023.6570748799161, 1031.1132426113536, 1032.8915463876297, 1073.3506228731621, 1077.428962649793, 1077.5851297250576, 1077.7575045614713, 1077.9730506737355, 1071.983920241197, 1073.3613499967507, 1073.726199819049, 1073.8603981482436, 1074.2963358999828, 792.4888446951742, 792.9127795942442, 794.0907660728434, 795.1094773853322, 796.120287082771, 16315.184240788032, 16722.66554668912, 16739.414120505844, 16838.915805420893, 16993.830061699347, 12580.937095314557, 14404.711905761826, 14746.70506589873, 14774.113553186844, 14790.926045369704, 11773.705657358549, 13400.664983375396, 13490.865091349058, 13628.114172578751, 13739.793903091462, 3248.5614442050255, 3293.6047674279002, 3295.96704032959, 3296.703296703284, 3297.1262615406936, 108080.45959770151, 108212.91787082107, 108236.99999999921, 113563.0, 116424.41787791006, 11493.57497363521, 11528.31985006404, 11589.594364197214, 11914.582989595323, 11988.820167697491, 24349.63475547868, 24470.14354497584, 24870.12954546582, 24954.00183992656, 24969.87515062413, 7952.3638108951145, 7985.520868747778, 8037.67849286022, 8062.879056814152, 8226.42415030954, 3657.8902632921054, 4075.8777236682945, 4106.835726570904, 4152.280122190249, 4201.159768046403, 4071.91856162881, 4091.161311931047, 4179.811908464127, 4180.811863466151, 4197.9370309445385, 895.54327293081, 897.1253028297358, 911.2072496927715, 911.3438324406417, 913.3515204205089, 537.4464301769184, 618.3322012226785, 627.3318915355133, 631.5137344244906, 646.9385408386196, 10658.840117398246, 10958.945205274082, 11144.944275278734, 11175.552977880956, 11293.15301352402, 579.3164066401603, 586.7853543165692, 611.2023808929301, 646.3730181723721, 660.0561197487639, 4063.79681015948, 4346.065595896897, 4465.709728867613, 4781.856544303677, 4782.473927867932, 99759.0, 101863.0, 104209.0, 104310.87492313572, 107261.0, 89830.65254021194, 90701.0, 91312.0, 91958.0, 92218.61672074924, 58384.0, 80062.0, 80342.59828700936, 81118.37763244702, 85956.71064934031, 10631.521581529005, 10830.620928267474, 10938.398388088413, 11078.723031923944, 11250.66248012561, 36954.26091478209, 39900.40149397819, 40924.386134207416, 41238.9690257734, 41926.58073419227, 52462.68843278949, 52846.414607561834, 53335.733321333144, 53391.73304133455, 53994.730026349614, 13653.522126725517, 13654.180749155083, 13850.16898986064, 14119.717605648035, 14138.0, 14621.853781462049, 14666.706665866835, 14792.482263120739, 14909.25453727331, 15172.317245723749, 13914.791278130633, 14029.859701402855, 14053.718925621635, 14196.219207943663, 14257.928710356382, 13761.724765504834, 14014.369353379327, 14259.969915256357, 14687.41250349974, 14903.54091574878, 13618.455261789417, 13891.722165556834, 13901.86098139046, 13955.651108722363, 14160.362783674966, 8125.634346454305, 9617.0, 9931.702048938543, 10347.172226222036, 10510.564434069418, 10094.444805535766, 10144.594216231268, 10996.175286853679, 11074.778504429705, 11284.09727221804], "value": 7825.138483198124, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 122.0, 122.0, 124.0, 121.0, 122.0, 121.0, 123.0, 121.0, 122.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 120.0, 119.0, 163.0, 122.0, 117.0, 118.0, 118.0, 144.0, 120.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [286.0, 251.0, 221.0, 211.0, 210.0, 210.0, 207.0, 212.0, 209.0, 214.0], "value": 223.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 66.0, 61.0, 97.0, 64.0, 61.0, 61.0, 63.0, 86.0, 61.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 77.0, 97.0, 76.0, 76.0, 74.0, 92.0, 74.0, 73.0, 92.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 92.0, 92.0, 95.0, 93.0, 93.0, 92.0, 91.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 135.0, 100.0, 101.0, 100.0, 100.0, 101.0, 100.0, 100.0, 100.0], "value": 108.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 102.0, 100.0, 101.0, 100.0, 99.0, 101.0, 102.0, 98.0], "value": 100.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 50.0, 52.0, 52.0, 52.0, 51.0, 53.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 70.0, 75.0, 68.0, 71.0, 66.0, 66.0, 65.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 88.0, 116.0, 116.0, 117.0, 113.0, 89.0, 89.0, 107.0], "value": 101.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 150.0, 152.0, 149.0, 149.0, 158.0, 173.0, 286.0, 195.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 192.0, 240.0, 259.0, 234.0, 204.0, 204.0, 205.0, 202.0, 208.0], "value": 215.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 73.0, 72.0, 73.0, 77.0, 97.0, 110.0, 75.0], "value": 80.0, "unit": "score"}]}]} 09:27:45 INFO - Return code: 0 09:27:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:27:45 ERROR - # TBPL SUCCESS # 09:27:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:27:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:27:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:27:45 INFO - 2017-04-04 09:27:45.351 screenresolution[1916:16827] starting screenresolution argv=screenresolution get 09:27:45 INFO - 2017-04-04 09:27:45.354 screenresolution[1916:16827] Display 0: 1600x1200x32@60 09:27:45 INFO - 2017-04-04 09:27:45.361 screenresolution[1917:16830] starting screenresolution argv=screenresolution list 09:27:45 INFO - Available Modes on Display 0 09:27:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:27:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:27:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:27:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:27:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:27:45 INFO - Intel Iris: 09:27:45 INFO - Chipset Model: Intel Iris 09:27:45 INFO - Type: GPU 09:27:45 INFO - Bus: Built-In 09:27:45 INFO - VRAM (Dynamic, Max): 1536 MB 09:27:45 INFO - Vendor: Intel (0x8086) 09:27:45 INFO - Device ID: 0x0a2e 09:27:45 INFO - Revision ID: 0x0009 09:27:45 INFO - Displays: 09:27:45 INFO - Display: 09:27:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:27:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:27:45 INFO - Display Serial Number: 1600x1200 60 09:27:45 INFO - Main Display: Yes 09:27:45 INFO - Mirror: Off 09:27:45 INFO - Online: Yes 09:27:45 INFO - Rotation: Supported 09:27:45 INFO - Return code: 0 09:27:45 INFO - Running post-action listener: _resource_record_post_action 09:27:45 INFO - [mozharness: 2017-04-04 16:27:45.599992Z] Finished run-tests step (success) 09:27:45 INFO - Running post-run listener: _resource_record_post_run 09:27:45 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 1347584; Write bytes: 513508352; Read time: 16; Write time: 1552 09:27:45 INFO - TinderboxPrint: CPU usage
53.4% 09:27:45 INFO - TinderboxPrint: I/O read bytes / time
1,347,584 / 16 09:27:45 INFO - TinderboxPrint: I/O write bytes / time
513,508,352 / 1,552 09:27:45 INFO - TinderboxPrint: CPU idle
2,249.2 (46.6%) 09:27:45 INFO - TinderboxPrint: CPU system
957.5 (19.9%) 09:27:45 INFO - TinderboxPrint: CPU user
1,615.0 (33.5%) 09:27:45 INFO - TinderboxPrint: Swap in / out
213,626,880 / 0 09:27:45 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203897344; Write bytes: 204736000; Read time: 15572; Write time: 444 09:27:45 INFO - run-tests - Wall time: 1185s; CPU: 53.0%; Read bytes: 1347584; Write bytes: 298823168; Read time: 16; Write time: 1078 09:27:46 INFO - Running post-run listener: _upload_blobber_files 09:27:46 INFO - Blob upload gear active. 09:27:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:46 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 09:27:46 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'] 09:27:46 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 09:27:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:27:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:27:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:47 INFO - (blobuploader) - INFO - Done attempting. 09:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:27:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:48 INFO - (blobuploader) - INFO - Done attempting. 09:27:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:27:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:27:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:49 INFO - (blobuploader) - INFO - Done attempting. 09:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:52 INFO - (blobuploader) - INFO - Done attempting. 09:27:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:52 INFO - Return code: 0 09:27:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfc39cb864048142fbcf3e378c4f4a9c2a585198508aab91bc94c40e2cd8c0039288bc63fd1446be0fbabf73e4c4ffe609d3bebd8d55df1ecf8aae7c3909461d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6da0306d4957e9424031b5b83cd89caf41a4a57bea392a83701584b30438b06524ed9ce3099844321a8eb08d0a5be03951a41d1a1da4587cacf84ed7f24aac4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7c1b6364b22303b7f9b51bedc7d59ec6abc80710f0b0d2fea979700958df63d84eb5bac10432cac9bfdf3861deb0a0eb8fd981b7341ec68c7f68cce49b8d4dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d827fc4ed1ad27cb4843a8bd0a81c57aa46ed709eca311c075ea967500e418c904aa48e7a8e79f98fc173d7fc8339c44734cc6f0d56d7e58b53931947ae338"} 09:27:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:52 INFO - Contents: 09:27:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfc39cb864048142fbcf3e378c4f4a9c2a585198508aab91bc94c40e2cd8c0039288bc63fd1446be0fbabf73e4c4ffe609d3bebd8d55df1ecf8aae7c3909461d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6da0306d4957e9424031b5b83cd89caf41a4a57bea392a83701584b30438b06524ed9ce3099844321a8eb08d0a5be03951a41d1a1da4587cacf84ed7f24aac4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7c1b6364b22303b7f9b51bedc7d59ec6abc80710f0b0d2fea979700958df63d84eb5bac10432cac9bfdf3861deb0a0eb8fd981b7341ec68c7f68cce49b8d4dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d827fc4ed1ad27cb4843a8bd0a81c57aa46ed709eca311c075ea967500e418c904aa48e7a8e79f98fc173d7fc8339c44734cc6f0d56d7e58b53931947ae338"} 09:27:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:52 INFO - Copying logs to upload dir... 09:27:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.402251 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-04 09:27:52.497850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:52.501596) ========= 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.t0OtaylNg8/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.pwg2TMSvIK/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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/bfc39cb864048142fbcf3e378c4f4a9c2a585198508aab91bc94c40e2cd8c0039288bc63fd1446be0fbabf73e4c4ffe609d3bebd8d55df1ecf8aae7c3909461d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6da0306d4957e9424031b5b83cd89caf41a4a57bea392a83701584b30438b06524ed9ce3099844321a8eb08d0a5be03951a41d1a1da4587cacf84ed7f24aac4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7c1b6364b22303b7f9b51bedc7d59ec6abc80710f0b0d2fea979700958df63d84eb5bac10432cac9bfdf3861deb0a0eb8fd981b7341ec68c7f68cce49b8d4dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d827fc4ed1ad27cb4843a8bd0a81c57aa46ed709eca311c075ea967500e418c904aa48e7a8e79f98fc173d7fc8339c44734cc6f0d56d7e58b53931947ae338"} build_url:https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/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/bfc39cb864048142fbcf3e378c4f4a9c2a585198508aab91bc94c40e2cd8c0039288bc63fd1446be0fbabf73e4c4ffe609d3bebd8d55df1ecf8aae7c3909461d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6da0306d4957e9424031b5b83cd89caf41a4a57bea392a83701584b30438b06524ed9ce3099844321a8eb08d0a5be03951a41d1a1da4587cacf84ed7f24aac4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7c1b6364b22303b7f9b51bedc7d59ec6abc80710f0b0d2fea979700958df63d84eb5bac10432cac9bfdf3861deb0a0eb8fd981b7341ec68c7f68cce49b8d4dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d827fc4ed1ad27cb4843a8bd0a81c57aa46ed709eca311c075ea967500e418c904aa48e7a8e79f98fc173d7fc8339c44734cc6f0d56d7e58b53931947ae338"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:52.535734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:52.536064) ========= 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.t0OtaylNg8/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.pwg2TMSvIK/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.005278 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:52.584818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:27:52.585126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:27:52.585423) ========= ========= Total master_lag: 0.20 =========