builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1474497361.61 results: success (0) buildid: 20160921122300 builduid: 05f4344560b449a49d509d5b1313d545 revision: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.612823) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.613281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.613582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.637376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.637793) ========= 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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 --2016-09-21 15:36:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.8M=0.001s 2016-09-21 15:36:01 (14.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.800855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.801190) ========= 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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.020690 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:01.850666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-21 15:36:01.851025) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 2016-09-21 15:36:01,925 truncating revision to first 12 chars 2016-09-21 15:36:01,925 Setting DEBUG logging. 2016-09-21 15:36:01,925 attempt 1/10 2016-09-21 15:36:01,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6757959dbba2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 15:36:03,901 unpacking tar archive at: fx-team-6757959dbba2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.246617 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-21 15:36:04.120258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:04.120599) ========= script_repo_revision: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:04.120986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:04.121252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:04.140026) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-21 15:36:04.140429) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:04 INFO - MultiFileLogger online at 20160921 15:36:04 in /builds/slave/test 15:36:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:36:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:36:04 INFO - {'append_to_log': False, 15:36:04 INFO - 'base_work_dir': '/builds/slave/test', 15:36:04 INFO - 'blob_upload_branch': 'Fx-Team', 15:36:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:36:04 INFO - 'branch': 'Fx-Team', 15:36:04 INFO - 'buildbot_json_path': 'buildprops.json', 15:36:04 INFO - 'config_files': ('talos/mac_config.py',), 15:36:04 INFO - 'default_actions': ('clobber', 15:36:04 INFO - 'read-buildbot-config', 15:36:04 INFO - 'download-and-extract', 15:36:04 INFO - 'populate-webroot', 15:36:04 INFO - 'create-virtualenv', 15:36:04 INFO - 'install', 15:36:04 INFO - 'run-tests'), 15:36:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:36:04 INFO - 'download_minidump_stackwalk': True, 15:36:04 INFO - 'download_symbols': 'ondemand', 15:36:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:36:04 INFO - 'tooltool.py': '/tools/tooltool.py', 15:36:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:36:04 INFO - '/tools/misc-python/virtualenv.py')}, 15:36:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:36:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:36:04 INFO - 'installer_path': 'installer.exe', 15:36:04 INFO - 'log_level': 'info', 15:36:04 INFO - 'log_name': 'talos', 15:36:04 INFO - 'log_to_console': True, 15:36:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:36:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:36:04 INFO - 'opt_config_files': (), 15:36:04 INFO - 'pip_index': False, 15:36:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:36:04 INFO - 'cmd': ('bash', 15:36:04 INFO - '-c', 15:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:36:04 INFO - 'enabled': True, 15:36:04 INFO - 'halt_on_failure': False, 15:36:04 INFO - 'name': 'check_screen_resolution'},), 15:36:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:36:04 INFO - 'cmd': ('bash', 15:36:04 INFO - '-c', 15:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:36:04 INFO - 'enabled': True, 15:36:04 INFO - 'halt_on_failure': False, 15:36:04 INFO - 'name': 'check_screen_resolution'},), 15:36:04 INFO - 'run_cmd_checks_enabled': True, 15:36:04 INFO - 'sps_profile': False, 15:36:04 INFO - 'sps_profile_interval': 0, 15:36:04 INFO - 'suite': 'dromaeojs', 15:36:04 INFO - 'system_bits': '32', 15:36:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:36:04 INFO - 'title': 't-yosemite-r7-0084', 15:36:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:36:04 INFO - 'use_talos_json': True, 15:36:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:36:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:36:04 INFO - 'work_dir': 'build'} 15:36:04 INFO - [mozharness: 2016-09-21 22:36:04.336492Z] Running clobber step. 15:36:04 INFO - Running pre-action listener: _resource_record_pre_action 15:36:04 INFO - Running main action method: clobber 15:36:04 INFO - rmtree: /builds/slave/test/build 15:36:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:36:05 INFO - Running post-action listener: _resource_record_post_action 15:36:05 INFO - [mozharness: 2016-09-21 22:36:05.976150Z] Finished clobber step (success) 15:36:05 INFO - [mozharness: 2016-09-21 22:36:05.976390Z] Running read-buildbot-config step. 15:36:05 INFO - Running pre-action listener: _resource_record_pre_action 15:36:05 INFO - Running main action method: read_buildbot_config 15:36:05 INFO - Using buildbot properties: 15:36:05 INFO - { 15:36:05 INFO - "project": "", 15:36:05 INFO - "product": "firefox", 15:36:05 INFO - "script_repo_revision": "production", 15:36:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:36:05 INFO - "repository": "", 15:36:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:36:05 INFO - "buildid": "20160921122300", 15:36:05 INFO - "pgo_build": "False", 15:36:05 INFO - "basedir": "/builds/slave/test", 15:36:05 INFO - "buildnumber": 156, 15:36:05 INFO - "slavename": "t-yosemite-r7-0084", 15:36:05 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:36:05 INFO - "platform": "yosemite_r7", 15:36:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:36:05 INFO - "branch": "fx-team", 15:36:05 INFO - "repo_path": "integration/fx-team", 15:36:05 INFO - "revision": "6757959dbba2a80fa1f58ea4e677c65cb5cd9e15", 15:36:05 INFO - "stage_platform": "macosx64", 15:36:05 INFO - "builduid": "05f4344560b449a49d509d5b1313d545", 15:36:05 INFO - "slavebuilddir": "test" 15:36:05 INFO - } 15:36:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:36:05 INFO - Running post-action listener: _resource_record_post_action 15:36:05 INFO - [mozharness: 2016-09-21 22:36:05.982184Z] Finished read-buildbot-config step (success) 15:36:05 INFO - [mozharness: 2016-09-21 22:36:05.982390Z] Running download-and-extract step. 15:36:05 INFO - Running pre-action listener: _resource_record_pre_action 15:36:05 INFO - Running main action method: download_and_extract 15:36:05 INFO - mkdir: /builds/slave/test/build/tests 15:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:05 INFO - trying https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:36:05 INFO - Downloading https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 15:36:07 INFO - Downloaded 1199 bytes. 15:36:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:36:07 INFO - Using the following test package requirements: 15:36:07 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:36:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:36:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:36:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'jsshell-mac.zip'], 15:36:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:36:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:36:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:36:07 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:36:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:36:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:36:07 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:36:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:36:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:36:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:36:07 INFO - Fetch https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:36:07 INFO - Expected file size: 16432587 15:36:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:36:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:36:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:36:14 INFO - Fetch https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:36:15 INFO - Expected file size: 16432587 15:36:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:36:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:36:22 INFO - Fetch https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:36:23 INFO - Expected file size: 14414059 15:36: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')]} 15:36:23 INFO - trying https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:36:23 INFO - Downloading https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:36:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 15:36:26 INFO - Downloaded 111295061 bytes. 15:36:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:36:26 INFO - mkdir: /builds/slave/test/properties 15:36:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:36:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:36:26 INFO - Contents: 15:36:26 INFO - build_url:https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:36:27 INFO - Running post-action listener: _resource_record_post_action 15:36:27 INFO - Running post-action listener: set_extra_try_arguments 15:36:27 INFO - [mozharness: 2016-09-21 22:36:27.349834Z] Finished download-and-extract step (success) 15:36:27 INFO - [mozharness: 2016-09-21 22:36:27.349981Z] Running populate-webroot step. 15:36:27 INFO - Running pre-action listener: _resource_record_pre_action 15:36:27 INFO - Running main action method: populate_webroot 15:36:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:36:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:36:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:36:27 INFO - '--tppagecycles', 15:36:27 INFO - '7'], 15:36:27 INFO - 'tests': ['tsvgm']}}, 15:36:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:36:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:36:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:36:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:36:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['damp', 'tps']}, 15:36:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'tests': ['damp', 'tps']}, 15:36:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['dromaeo_dom']}, 15:36:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:36:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['basic_compositor_video']}, 15:36:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:36:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['a11yr', 15:36:27 INFO - 'ts_paint', 15:36:27 INFO - 'tpaint', 15:36:27 INFO - 'sessionrestore', 15:36:27 INFO - 'sessionrestore_no_auto_restore', 15:36:27 INFO - 'tabpaint']}, 15:36:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:36:27 INFO - 'ts_paint', 15:36:27 INFO - 'tpaint', 15:36:27 INFO - 'sessionrestore', 15:36:27 INFO - 'sessionrestore_no_auto_restore', 15:36:27 INFO - 'tabpaint']}, 15:36:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:36:27 INFO - 'ts_paint', 15:36:27 INFO - 'tpaint', 15:36:27 INFO - 'sessionrestore', 15:36:27 INFO - 'sessionrestore_no_auto_restore', 15:36:27 INFO - 'tabpaint']}, 15:36:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:36:27 INFO - 'ts_paint', 15:36:27 INFO - 'tpaint', 15:36:27 INFO - 'sessionrestore', 15:36:27 INFO - 'sessionrestore_no_auto_restore', 15:36:27 INFO - 'tabpaint']}, 15:36:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['a11yr', 15:36:27 INFO - 'ts_paint', 15:36:27 INFO - 'tpaint', 15:36:27 INFO - 'sessionrestore', 15:36:27 INFO - 'sessionrestore_no_auto_restore', 15:36:27 INFO - 'tabpaint']}, 15:36:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['a11yr', 15:36:27 INFO - 'ts_paint', 15:36:27 INFO - 'tpaint', 15:36:27 INFO - 'sessionrestore', 15:36:27 INFO - 'sessionrestore_no_auto_restore', 15:36:27 INFO - 'tabpaint']}, 15:36:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['tsvgx', 15:36:27 INFO - 'tsvgr_opacity', 15:36:27 INFO - 'tart', 15:36:27 INFO - 'tscrollx', 15:36:27 INFO - 'cart']}, 15:36:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:36:27 INFO - 'tsvgr_opacity', 15:36:27 INFO - 'tart', 15:36:27 INFO - 'tscrollx', 15:36:27 INFO - 'cart']}, 15:36:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'talos_options': ['--disable-e10s'], 15:36:27 INFO - 'tests': ['tp5o']}, 15:36:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'tests': ['tp5o']}, 15:36:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'talos_options': ['--disable-e10s', 15:36:27 INFO - '--xperf_path', 15:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:27 INFO - 'tests': ['tp5n']}, 15:36:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:27 INFO - 'talos_options': ['--xperf_path', 15:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:27 INFO - 'tests': ['tp5n']}}, 15:36:27 INFO - 'talos.zip': {'path': '', 15:36:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:36:27 INFO - Running post-action listener: _resource_record_post_action 15:36:27 INFO - [mozharness: 2016-09-21 22:36:27.368710Z] Finished populate-webroot step (success) 15:36:27 INFO - [mozharness: 2016-09-21 22:36:27.368791Z] Running create-virtualenv step. 15:36:27 INFO - Running pre-action listener: _resource_record_pre_action 15:36:27 INFO - Running main action method: create_virtualenv 15:36:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:36:27 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 15:36:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:36:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:36:27 INFO - Using real prefix '/tools/python27' 15:36:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:36:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:36:31 INFO - Installing pip.................done. 15:36:31 INFO - Return code: 0 15:36:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:36:31 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')]} 15:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:31 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')]} 15:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:31 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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:31 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 15:36:31 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 15:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:31 INFO - 'HOME': '/Users/cltbld', 15:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:31 INFO - 'LOGNAME': 'cltbld', 15:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:31 INFO - 'MOZ_NO_REMOTE': '1', 15:36:31 INFO - 'NO_EM_RESTART': '1', 15:36:31 INFO - 'PAGER': '/bin/cat', 15:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:31 INFO - 'PWD': '/builds/slave/test', 15:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:31 INFO - 'SHELL': '/bin/bash', 15:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:31 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:31 INFO - 'USER': 'cltbld', 15:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:31 INFO - 'XPC_FLAGS': '0x0', 15:36:31 INFO - 'XPC_SERVICE_NAME': '0', 15:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:31 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 15:36:31 INFO - Cleaning up... 15:36:31 INFO - Return code: 0 15:36:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:36:31 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')]} 15:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:31 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')]} 15:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:31 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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:31 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 15:36:31 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 15:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:31 INFO - 'HOME': '/Users/cltbld', 15:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:31 INFO - 'LOGNAME': 'cltbld', 15:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:31 INFO - 'MOZ_NO_REMOTE': '1', 15:36:31 INFO - 'NO_EM_RESTART': '1', 15:36:31 INFO - 'PAGER': '/bin/cat', 15:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:31 INFO - 'PWD': '/builds/slave/test', 15:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:31 INFO - 'SHELL': '/bin/bash', 15:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:31 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:31 INFO - 'USER': 'cltbld', 15:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:31 INFO - 'XPC_FLAGS': '0x0', 15:36:31 INFO - 'XPC_SERVICE_NAME': '0', 15:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:31 INFO - Downloading/unpacking psutil>=3.1.1 15:36:31 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 15:36:31 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 15:36:31 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 15:36:31 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 15:36:31 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 15:36:31 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 15:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:34 INFO - Installing collected packages: psutil 15:36:34 INFO - Running setup.py install for psutil 15:36:34 INFO - building 'psutil._psutil_osx' extension 15:36:34 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 15:36:34 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 15:36:34 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 15:36:34 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 15:36:34 INFO - building 'psutil._psutil_posix' extension 15:36:34 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 15:36:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:36:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:36:34 INFO - ^ 15:36:34 INFO - 1 warning generated. 15:36:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:34 INFO - Successfully installed psutil 15:36:34 INFO - Cleaning up... 15:36:35 INFO - Return code: 0 15:36:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:35 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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:35 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 15:36:35 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 15:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:35 INFO - 'HOME': '/Users/cltbld', 15:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:35 INFO - 'LOGNAME': 'cltbld', 15:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:35 INFO - 'MOZ_NO_REMOTE': '1', 15:36:35 INFO - 'NO_EM_RESTART': '1', 15:36:35 INFO - 'PAGER': '/bin/cat', 15:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:35 INFO - 'PWD': '/builds/slave/test', 15:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:35 INFO - 'SHELL': '/bin/bash', 15:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:35 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:35 INFO - 'USER': 'cltbld', 15:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:35 INFO - 'XPC_FLAGS': '0x0', 15:36:35 INFO - 'XPC_SERVICE_NAME': '0', 15:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:36: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 15:36: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 15:36: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 15:36: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 15:36: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 15:36: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 15:36:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:36:37 INFO - Installing collected packages: mozsystemmonitor 15:36:37 INFO - Running setup.py install for mozsystemmonitor 15:36:37 INFO - Successfully installed mozsystemmonitor 15:36:37 INFO - Cleaning up... 15:36:38 INFO - Return code: 0 15:36:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:36: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')]} 15:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36: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')]} 15:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:36:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:38 INFO - 'HOME': '/Users/cltbld', 15:36:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:38 INFO - 'LOGNAME': 'cltbld', 15:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:38 INFO - 'MOZ_NO_REMOTE': '1', 15:36:38 INFO - 'NO_EM_RESTART': '1', 15:36:38 INFO - 'PAGER': '/bin/cat', 15:36:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:38 INFO - 'PWD': '/builds/slave/test', 15:36:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:38 INFO - 'SHELL': '/bin/bash', 15:36:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:38 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:38 INFO - 'USER': 'cltbld', 15:36:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:38 INFO - 'XPC_FLAGS': '0x0', 15:36:38 INFO - 'XPC_SERVICE_NAME': '0', 15:36:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:38 INFO - Downloading/unpacking jsonschema==2.5.1 15:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:36:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:36:40 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 15:36:40 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 15:36:40 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 15:36:40 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 15:36:40 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 15:36:40 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 15:36:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:36:41 INFO - warning: no files found matching '*.txt' 15:36:41 INFO - no previously-included directories found matching 'build' 15:36:41 INFO - no previously-included directories found matching 'dist' 15:36:41 INFO - no previously-included directories found matching '.git*' 15:36:41 INFO - Installing collected packages: jsonschema, functools32 15:36:41 INFO - Running setup.py install for functools32 15:36:41 INFO - warning: no files found matching '*.txt' 15:36:41 INFO - no previously-included directories found matching 'build' 15:36:41 INFO - no previously-included directories found matching 'dist' 15:36:41 INFO - no previously-included directories found matching '.git*' 15:36:41 INFO - Successfully installed jsonschema functools32 15:36:41 INFO - Cleaning up... 15:36:41 INFO - Return code: 0 15:36:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:36:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:41 INFO - 'HOME': '/Users/cltbld', 15:36:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:41 INFO - 'LOGNAME': 'cltbld', 15:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:41 INFO - 'MOZ_NO_REMOTE': '1', 15:36:41 INFO - 'NO_EM_RESTART': '1', 15:36:41 INFO - 'PAGER': '/bin/cat', 15:36:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:41 INFO - 'PWD': '/builds/slave/test', 15:36:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:41 INFO - 'SHELL': '/bin/bash', 15:36:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:41 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:41 INFO - 'USER': 'cltbld', 15:36:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:41 INFO - 'XPC_FLAGS': '0x0', 15:36:41 INFO - 'XPC_SERVICE_NAME': '0', 15:36:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:36:41 INFO - Cleaning up... 15:36:41 INFO - Return code: 0 15:36:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:36:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:41 INFO - 'HOME': '/Users/cltbld', 15:36:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:41 INFO - 'LOGNAME': 'cltbld', 15:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:41 INFO - 'MOZ_NO_REMOTE': '1', 15:36:41 INFO - 'NO_EM_RESTART': '1', 15:36:41 INFO - 'PAGER': '/bin/cat', 15:36:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:41 INFO - 'PWD': '/builds/slave/test', 15:36:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:41 INFO - 'SHELL': '/bin/bash', 15:36:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:41 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:41 INFO - 'USER': 'cltbld', 15:36:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:41 INFO - 'XPC_FLAGS': '0x0', 15:36:41 INFO - 'XPC_SERVICE_NAME': '0', 15:36:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:41 INFO - Downloading/unpacking blobuploader==1.2.4 15:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:36:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:36:44 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 15:36:44 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 15:36:44 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 15:36:44 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 15:36:44 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 15:36:44 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 15:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:36:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:36:45 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 15:36:45 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 15:36:45 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 15:36:45 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 15:36:45 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 15:36:45 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 15:36:45 INFO - Downloading docopt-0.6.1.tar.gz 15:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:36:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:36:45 INFO - Running setup.py install for blobuploader 15:36:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:36:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:36:45 INFO - Running setup.py install for requests 15:36:46 INFO - Running setup.py install for docopt 15:36:46 INFO - Successfully installed blobuploader requests docopt 15:36:46 INFO - Cleaning up... 15:36:46 INFO - Return code: 0 15:36:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:46 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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:46 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 15:36:46 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 15:36:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:46 INFO - 'HOME': '/Users/cltbld', 15:36:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:46 INFO - 'LOGNAME': 'cltbld', 15:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:46 INFO - 'MOZ_NO_REMOTE': '1', 15:36:46 INFO - 'NO_EM_RESTART': '1', 15:36:46 INFO - 'PAGER': '/bin/cat', 15:36:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:46 INFO - 'PWD': '/builds/slave/test', 15:36:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:46 INFO - 'SHELL': '/bin/bash', 15:36:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:46 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:46 INFO - 'USER': 'cltbld', 15:36:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:46 INFO - 'XPC_FLAGS': '0x0', 15:36:46 INFO - 'XPC_SERVICE_NAME': '0', 15:36:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:36:46 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cUymzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:36:46 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wqeRA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-9e8uex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dqpXIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4sxAFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-gGYoWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qHUSHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-R26f6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-lff0iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-VY1ujm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:36:47 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-RflUGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:36:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ZGN0_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:36:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-rp_MJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:36:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-9rZsjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jghMpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:36:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-caiD6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:36:48 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-l3BOjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:36:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:36:48 INFO - Running setup.py install for manifestparser 15:36:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:36:48 INFO - Running setup.py install for mozcrash 15:36:48 INFO - Running setup.py install for mozdebug 15:36:49 INFO - Running setup.py install for mozdevice 15:36:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Running setup.py install for mozfile 15:36:49 INFO - Running setup.py install for mozhttpd 15:36:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Running setup.py install for mozinfo 15:36:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Running setup.py install for mozInstall 15:36:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:36:49 INFO - Running setup.py install for mozleak 15:36:49 INFO - Running setup.py install for mozlog 15:36:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:36:50 INFO - Running setup.py install for moznetwork 15:36:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:36:50 INFO - Running setup.py install for mozprocess 15:36:50 INFO - Running setup.py install for mozprofile 15:36:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:36:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:36:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:36:50 INFO - Running setup.py install for mozrunner 15:36:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:36:50 INFO - Running setup.py install for mozscreenshot 15:36:50 INFO - Running setup.py install for moztest 15:36:51 INFO - Running setup.py install for mozversion 15:36:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:36:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:36:51 INFO - Cleaning up... 15:36:51 INFO - Return code: 0 15:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:51 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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:51 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 15:36:51 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 15:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:51 INFO - 'HOME': '/Users/cltbld', 15:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:51 INFO - 'LOGNAME': 'cltbld', 15:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:51 INFO - 'MOZ_NO_REMOTE': '1', 15:36:51 INFO - 'NO_EM_RESTART': '1', 15:36:51 INFO - 'PAGER': '/bin/cat', 15:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:51 INFO - 'PWD': '/builds/slave/test', 15:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:51 INFO - 'SHELL': '/bin/bash', 15:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:51 INFO - 'USER': 'cltbld', 15:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:51 INFO - 'XPC_FLAGS': '0x0', 15:36:51 INFO - 'XPC_SERVICE_NAME': '0', 15:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:36:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hRYdQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:36:51 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)) 15:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:36:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-tqbBlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 15:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:36:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-sQvoZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:36:51 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)) 15:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:36:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-B9M__G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 15:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:36:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-eXTt_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MQVfSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-z6n9nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FgKB_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jXHSZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xihIBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-pUQVDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-bVFM7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-tmqn80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:36:52 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)) 15:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:36:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-BRhTum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_qgYg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:53 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)) 15:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:36:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-saEHQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:36:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Y10kOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:36:53 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)) 15:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:36:53 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)) 15:36:53 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:36:53 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:36:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:55 INFO - Downloading blessings-1.6.tar.gz 15:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:36:55 INFO - Installing collected packages: blessings 15:36:55 INFO - Running setup.py install for blessings 15:36:56 INFO - Successfully installed blessings 15:36:56 INFO - Cleaning up... 15:36:56 INFO - Return code: 0 15:36:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:36:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:36:56 INFO - Reading from file tmpfile_stdout 15:36:56 INFO - Current package versions: 15:36:56 INFO - blessings == 1.6 15:36:56 INFO - blobuploader == 1.2.4 15:36:56 INFO - docopt == 0.6.1 15:36:56 INFO - functools32 == 3.2.3-2 15:36:56 INFO - jsonschema == 2.5.1 15:36:56 INFO - manifestparser == 1.1 15:36:56 INFO - mozInstall == 1.12 15:36:56 INFO - mozcrash == 0.17 15:36:56 INFO - mozdebug == 0.1 15:36:56 INFO - mozdevice == 0.48 15:36:56 INFO - mozfile == 1.2 15:36:56 INFO - mozhttpd == 0.7 15:36:56 INFO - mozinfo == 0.9 15:36:56 INFO - mozleak == 0.1 15:36:56 INFO - mozlog == 3.4 15:36:56 INFO - moznetwork == 0.27 15:36:56 INFO - mozprocess == 0.23 15:36:56 INFO - mozprofile == 0.28 15:36:56 INFO - mozrunner == 6.12 15:36:56 INFO - mozscreenshot == 0.1 15:36:56 INFO - mozsystemmonitor == 0.3 15:36:56 INFO - moztest == 0.7 15:36:56 INFO - mozversion == 1.4 15:36:56 INFO - psutil == 3.1.1 15:36:56 INFO - requests == 1.2.3 15:36:56 INFO - wsgiref == 0.1.2 15:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36:56 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')]} 15:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:56 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')]} 15:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:56 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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:56 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 15:36:56 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 15:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:56 INFO - 'HOME': '/Users/cltbld', 15:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:56 INFO - 'LOGNAME': 'cltbld', 15:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:56 INFO - 'MOZ_NO_REMOTE': '1', 15:36:56 INFO - 'NO_EM_RESTART': '1', 15:36:56 INFO - 'PAGER': '/bin/cat', 15:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:56 INFO - 'PWD': '/builds/slave/test', 15:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:56 INFO - 'SHELL': '/bin/bash', 15:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:56 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:56 INFO - 'USER': 'cltbld', 15:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:56 INFO - 'XPC_FLAGS': '0x0', 15:36:56 INFO - 'XPC_SERVICE_NAME': '0', 15:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 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)) 15:36:56 INFO - Cleaning up... 15:36:56 INFO - Return code: 0 15:36:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:36:56 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')]} 15:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:56 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')]} 15:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:56 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 0x10cc48490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd16ac67a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, '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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:36:56 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 15:36:56 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 15:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:56 INFO - 'HOME': '/Users/cltbld', 15:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:56 INFO - 'LOGNAME': 'cltbld', 15:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:56 INFO - 'MOZ_NO_REMOTE': '1', 15:36:56 INFO - 'NO_EM_RESTART': '1', 15:36:56 INFO - 'PAGER': '/bin/cat', 15:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:56 INFO - 'PWD': '/builds/slave/test', 15:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:56 INFO - 'SHELL': '/bin/bash', 15:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:36:56 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:56 INFO - 'USER': 'cltbld', 15:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:56 INFO - 'XPC_FLAGS': '0x0', 15:36:56 INFO - 'XPC_SERVICE_NAME': '0', 15:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:36:57 INFO - Cleaning up... 15:36:57 INFO - Return code: 0 15:36:57 INFO - Running post-action listener: _resource_record_post_action 15:36:57 INFO - Running post-action listener: _start_resource_monitoring 15:36:57 INFO - Starting resource monitoring. 15:36:57 INFO - [mozharness: 2016-09-21 22:36:57.063956Z] Finished create-virtualenv step (success) 15:36:57 INFO - [mozharness: 2016-09-21 22:36:57.064949Z] Running install step. 15:36:57 INFO - Running pre-action listener: _resource_record_pre_action 15:36:57 INFO - Running main action method: install 15:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:36:57 INFO - Reading from file tmpfile_stdout 15:36:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:36:57 INFO - Reading from file tmpfile_stdout 15:36:57 INFO - Output received: 15:36:57 INFO - Usage: mozinstall [options] installer 15:36:57 INFO - Options: 15:36:57 INFO - -h, --help show this help message and exit 15:36:57 INFO - -d DEST, --destination=DEST 15:36:57 INFO - Directory to install application into. [default: 15:36:57 INFO - "/builds/slave/test"] 15:36:57 INFO - --app=APP Application being installed. [default: firefox] 15:36:57 INFO - mkdir: /builds/slave/test/build/application 15:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:37:31 INFO - Reading from file tmpfile_stdout 15:37:31 INFO - Output received: 15:37:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:37:31 INFO - Running post-action listener: _resource_record_post_action 15:37:31 INFO - [mozharness: 2016-09-21 22:37:31.981453Z] Finished install step (success) 15:37:31 INFO - [mozharness: 2016-09-21 22:37:31.981569Z] Running run-tests step. 15:37:31 INFO - Running pre-action listener: _resource_record_pre_action 15:37:31 INFO - Running main action method: run_tests 15:37:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:37:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:37:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:37:31 INFO - 2016-09-21 15:37:31.996 screenresolution[1918:17853] starting screenresolution argv=screenresolution get 15:37:31 INFO - 2016-09-21 15:37:31.998 screenresolution[1918:17853] Display 0: 1600x1200x32@60 15:37:32 INFO - 2016-09-21 15:37:32.005 screenresolution[1919:17855] starting screenresolution argv=screenresolution list 15:37:32 INFO - Available Modes on Display 0 15:37:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:37:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:37:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:37:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:37:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:37:32 INFO - Intel Iris: 15:37:32 INFO - Chipset Model: Intel Iris 15:37:32 INFO - Type: GPU 15:37:32 INFO - Bus: Built-In 15:37:32 INFO - VRAM (Dynamic, Max): 1536 MB 15:37:32 INFO - Vendor: Intel (0x8086) 15:37:32 INFO - Device ID: 0x0a2e 15:37:32 INFO - Revision ID: 0x0009 15:37:32 INFO - Displays: 15:37:32 INFO - Display: 15:37:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:37:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:37:32 INFO - Display Serial Number: 1600x1200 60 15:37:32 INFO - Main Display: Yes 15:37:32 INFO - Mirror: Off 15:37:32 INFO - Online: Yes 15:37:32 INFO - Rotation: Supported 15:37:32 INFO - Return code: 0 15:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:37:32 INFO - Python 2.7.3 15:37:32 INFO - Return code: 0 15:37:32 INFO - grabbing minidump binary from tooltool 15:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:32 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 0x10ca5cd30>, '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 0x10c882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca54b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:37:32 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 15:37:32 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 15:37:32 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 15:37:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:37:32 INFO - Return code: 0 15:37:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:37:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:37:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:37:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:37:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 15:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 15:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6ov7zhcc4O/Render', 15:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:37:32 INFO - 'HOME': '/Users/cltbld', 15:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:37:32 INFO - 'LOGNAME': 'cltbld', 15:37:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:37:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:32 INFO - 'MOZ_NO_REMOTE': '1', 15:37:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:37:32 INFO - 'NO_EM_RESTART': '1', 15:37:32 INFO - 'PAGER': '/bin/cat', 15:37:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:32 INFO - 'PWD': '/builds/slave/test', 15:37:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:37:32 INFO - 'SHELL': '/bin/bash', 15:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EY7A0Kvc2g/Listeners', 15:37:32 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:37:32 INFO - 'USER': 'cltbld', 15:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:32 INFO - 'XPC_FLAGS': '0x0', 15:37:32 INFO - 'XPC_SERVICE_NAME': '0', 15:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:37:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 15:37:32 INFO - mozversion application_buildid: 20160921122300 15:37:32 INFO - mozversion application_changeset: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 15:37:32 INFO - mozversion application_display_name: Nightly 15:37:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:37:32 INFO - mozversion application_name: Firefox 15:37:32 INFO - mozversion application_remotingname: firefox 15:37:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:37:32 INFO - mozversion application_vendor: Mozilla 15:37:32 INFO - mozversion application_version: 52.0a1 15:37:32 INFO - mozversion platform_buildid: 20160921122300 15:37:32 INFO - mozversion platform_changeset: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 15:37:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:37:32 INFO - mozversion platform_version: 52.0a1 15:37:32 INFO - using testdate: 1474497452 15:37:32 INFO - actual date: 1474497452 15:37:32 INFO - starting webserver on 'localhost:54347' 15:37:32 INFO - SUITE-START | Running 2 tests 15:37:32 INFO - TEST-START | dromaeo_css 15:37:32 INFO - operating with platform_type : mac_ 15:37:32 INFO - Initialising browser for dromaeo_css test... 15:37:32 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpSEhfie/profile http://localhost:54347/getInfo.html) 15:37:34 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 15:37:34 INFO - PROCESS | 1929 | colorDepth:24 15:37:34 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 15:37:34 INFO - PROCESS | 1929 | __metrics 15:37:34 INFO - PROCESS | 1929 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:37:34 INFO - PROCESS | 1929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:37:35 INFO - TEST-INFO | 1929: exit 0 15:37:35 INFO - Browser initialized. 15:37:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:37:35 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpSEhfie/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:47 INFO - PROCESS | 1931 | RSS: Main: 235433984 15:37:47 INFO - PROCESS | 1931 | 15:38:39 INFO - PROCESS | 1931 | 1474497519337 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:40:51 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54347/tests/dromaeo/cssquery-ext.html) 15:40:52 INFO - PROCESS | 1931 | RSS: Main: 359792640 15:40:52 INFO - PROCESS | 1931 | 15:43:55 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54347/tests/dromaeo/cssquery-ext.html (next: http://localhost:54347/tests/dromaeo/cssquery-jquery.html) 15:43:55 INFO - PROCESS | 1931 | RSS: Main: 373735424 15:43:55 INFO - PROCESS | 1931 | 15:46:58 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54347/tests/dromaeo/cssquery-mootools.html) 15:46:58 INFO - PROCESS | 1931 | RSS: Main: 329490432 15:46:58 INFO - PROCESS | 1931 | 15:50:01 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54347/tests/dromaeo/cssquery-prototype.html) 15:50:01 INFO - PROCESS | 1931 | RSS: Main: 339169280 15:50:01 INFO - PROCESS | 1931 | 15:53:05 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54347/tests/dromaeo/cssquery-yui.html) 15:53:05 INFO - PROCESS | 1931 | RSS: Main: 333217792 15:53:05 INFO - PROCESS | 1931 | 15:56:08 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54347/tests/dromaeo/cssquery-yui.html (next: http://localhost:54347/tests/dromaeo/cssquery-dojo.html) 15:56:09 INFO - PROCESS | 1931 | RSS: Main: 613756928 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | __start_tp_report 15:56:09 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 15:56:09 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 15:56:09 INFO - PROCESS | 1931 | |i|pagename|runs| 15:56:09 INFO - PROCESS | 1931 | |0;dojo.html;3274.721648659863;3329.7169740572035;3333.7666363354565;3368.0737797105794;3371.79769213847;5710.514606258463;5796.420357964202;5862.32583252926;5960.0761881908265;5973.372795856438;5809.593328467009;5850.6782126983;5851.297844258685;5854.795082172125;5868.6478811271245;5201.193814958669;5227.424983251839;5249.212618107276;5287.312649355597;5295.4704529546925;4378.16814805186;5321.920171197435;5332.626716129873;5337.759800808973;5350.5452036576935;5265.868353291179;5272.525472707455;5289.418164001976;5303.867403314929;5308.601854860901;5328.307320048389;5342.332208473941;5344.438833922421;5355.598330125256;5409.56723462122;5134.05020071288;5186.740662966874;5188.45521220274;5256.9474305256845;5286.735663216862;5752.7986520472;5801.883962320772;5812.534997200214;5859.4140585941495;5871.031279838821;6226.813195604093;6230.844228894269;6232.283287421959;6248.094026366151;6250.9062364064575;6124.899720463007;6178.752849885999;6180.3201647818705;6249.593776404519;6289.37106289372;5870.090136028923;5883.70581470929;5907.822765317047;5944.613600115978;5994.37059108796;6277.473279668595;6302.1177035215105;6305.180326557518;6307.810765677037;6310.242770867525;6083.6045657032155;6102.633841969496;6113.083037544315;6187.659678717714;6205;5182;6142.1304578115505;6149.108379285068;6206.689665516707;6276.403741644536;6201.069839524017;6207.193064901624;6214.751409943642;6227.96886015567;6253.030780228981;6216.658083805434;6227.252729672468;6238.438540531374;6238.656873871981;6267.592606480564;4801.231802911518;4918.1884988977135;4918.680285781413;4933.703977761345;4959.231319145538;4435.756033418128;4481.3726078349055;4522.525134860858;4536.387587675687;4538.115067561794;5894.322152952465;5899.7050147492455;5919.644821310649;5924.7926322578505;5929.940700592939;6109.009944784285;6120.447133218882;6168.691565421711;6281.089242059876;6294.527910406738;5832;5883.17635531026;5900.822975310747;5958.6424814511265;5961;5457.263269458652;5459.372172200247;5460.099083651233;5468.7265636718;5477.67133971963;6134.742747059018;6179.28938172098;6279.089532017923;6289.371062893674;6294.276158241678;6167.814965551041;6185.103160041859;6217.253929528486;6237.1891654084675;6246.843828904313;6248.187735594343;6251.124842521959;6266.561340706106;6269.279032911091;6275.843103922439;6108.7670647404;6190.597611155261;6191.00943848982;6221.502279817513;6223.253209614875;6129.847850912788;6151.9384806151365;6155.446009859134;6166.321704612579;6256.468200203034;6166.876662466815;6178.505719542336;6179.351168127282;6184.567080304516;6197.845053873689;6143.293521245114;6169.598976066542;6187.938120618916;6190;6222.657753823583;5887.3523912370465;5920.615160014585;6036.004059330161;6046.084778133363;6051.364606716407;6162.907556386747;6223.004319308889;6226.719797609027;6230.252369715663;6240.656763878031;5834.7082645866685;5847.38602446754;6098.969505152446;6109.541784366102;6110.2973158085615 15:56:09 INFO - PROCESS | 1931 | |1;ext.html;456.7282466932176;474.8646635708823;530.6020484636523;534.6685055265735;556.1435389500165;24451.63322550163;39511.80244098779;40811.38782918251;40923.386149207785;41883;41809.58190418095;42206.366904496455;42207.36688949668;42271.78864105675;42338;8797.648094076229;8956.32827537934;9782.706518804429;9950.054744799232;9967.45179015154;10424.061834434899;11941.746116657756;12189.695257618541;12210.511579536807;12417;10275.794484110313;12220.327881966488;12283.324417157053;12334.691632709164;12350;12258.93870530646;12315.5073797048;12324.938375308066;12329.075319350995;12335.136540442129;11983.28100313984;12068.275903445734;12072.034237260998;12079.456424460832;12101.6369508914;33015.17462063444;39378.60621393778;39681.80159099215;39773.80113099445;39948;3488.5116083748294;3552.7690700104667;3778.6977041836585;4005.719599628027;4139.648129908961;29796.851015745;30413.47932603361;31054.844725776227;31099.533506997188;31506.842465787755;3159.9684003159905;3244.967550324514;3264.2002709336366;3287;3340.3987282289177;467912;471234;471328;471515;472637.6368118172;55877;56715.43284567184;56778;56878.14682779762;56889;60295;60357.8874739382;60407;60444;60471;15824.92087539555;16030.599235019217;16041;16085.839141608669;16094.517164485083;11395.202335836577;11606.24559403636;11614.954654081173;11880.168388212742;12622.81065784014;14530.927345363205;14662.266886655625;15792;16198.676026479405;16211.594710132342;6068.696565171724;6127.724252408652;6179.876402471926;6231.626102433868;6240.219972503437;793.4723408933111;958.1568219966524;1005.7485628592851;1016.4409574733867;1068.1348108032519;27880.860595696893;29448.705512944598;29478;29960.550591741143;30247.243818904702;935.6163972771132;1012.2003617142375;1023.2223510132353;1051.8211903976342;1096.9780604388027;14617.853821461862;15006.399744010118;15487.225638718019;15774;15899.602509937344;695540;701018;702791.7766578662;872885;911744;57377;58287.834243314894;58331.70834145887;58359.416405836244;58462;1193.1290158184574;1215.6231568213705;1215.9148859579745;1311.4754098360731;1344.2069179184327;24640.753592463847;26049.479010420066;28962;30274.789008439417;33141.19452679396;52525.47474525206;53388.93222135613;53440.46559534355;53447.465525345804;53461;501019;504542;504555;504763;505906;24978.75021249764;25254.368640784127;25520.744792551835;25641.23076307714;25905.6114158284;44021;44463.88840279019;44875.775621121684;45081.566475430285;45500.31749523826;37650;37731.43402848904;37953.62046379501;38721;39721.60278397179;37593.436098458;37923.43114853224;37938.241235175694;38540;38962.415563766;37059.6294037067;37724.43413348747;37911.62088379081;38050;38136.04659883414;31047.068587942398;33277.51029237275;33621.83189084039;33841.15397115092;34794.478082828275;20333.288334908208;24778.50442991166;24802.007919683012;24882;25447.61828572536 15:56:09 INFO - PROCESS | 1931 | |2;jquery.html;351.27637067640677;371.373384575559;377.7280358142138;383.2220592197838;403.4956304619226;15214.619634509143;15364.69270614587;19945.900270498645;21722.3483295501;21996.670049949265;18668.71996920044;19690.40928772139;20412.285570005053;21021.054052567633;21269;5848.415158484149;6177.598456100339;6182.659953702545;6182.876342473148;6187.28846182688;5914.9112763308585;6052.606580572271;6053.152558641794;6065.4844338231305;6095.939040609582;6048.969755151218;6049.274087109553;6056.878862422749;6058.969705151468;6059.909101363483;5784.363719990798;5976.282846058479;6037.034074548095;6044.909326360108;6045.3047899491685;5122.795088196468;5221.321228240343;5223.2165175223645;5229.764660590283;5233.188855727369;25780.74219257802;26116.477670446675;26186.607200892002;26413.47173056528;26480.60279095815;1965.88204707718;2363.0902102690416;2421.019487107724;2957.1128661401494;3032.105528868989;15594.37622495099;15643.452479163174;15797.289121989537;16115.91942040294;16285.104319262437;1806.719958406449;1828.5245836082581;1832.5876677747533;1885.3684015854567;1966.6951622498536;112988.435057825;117669.41165294204;118282;119540;120425;9335;9878.654247101316;10020.949895250476;10582.894171058344;10779.245452818384;12775.808362874564;13360.866391335961;13368.866311336957;32577.674223257465;34083.4887476688;10573.841392379121;10666.093382062612;10834.241603087867;10920.890791092146;11127.332360058423;8776.385653004356;8802.207801297915;8925.285977121815;9038.198158570733;9161.725148245563;9348.95325523368;9477.952610236905;9491.288153388523;9549.809003819884;9558.709574207533;3107.715828865782;3586.605473397924;3594.730395220369;3633.855335569287;3705.4256590228556;819.848113400673;820.9753707388788;846.1834329871704;918.8789676594544;930.6510058727977;20831.8958405207;21496.462588435414;21515.354539363845;21555.568888622453;21561.353159405244;876.5310558850985;886.5079880666292;920.4523308631353;950.5104870991306;976.0532283684814;10720.946395267974;10732.892671073188;11445.084393248686;11471.770564588662;11480.540778368939;496651;547344;572820;573875;588901;116219;126468;126693.36653316859;127813;132847;821.5974172655356;977.9315447918577;987.0968064221157;987.6592575561419;989.0455710239653;18422.815771842645;19082.23671053198;19503.804961950198;19766.209351625774;19785.901070494554;42676.5732342685;56014.71992640011;56547.43452565586;57043.71478142583;57075.714621426625;76860;78979.60510197643;80255.59872200602;80664.79002814845;80894;5635.0138725723655;5966.701664916824;7991.480553763987;8118.564430670894;8221.218984196492;12323.69190770238;12571.994240460925;12903.225806451643;13026.869731302566;13139.802902956271;10968.287061340987;10999.120070394189;11269.098472122374;11404.600838970597;11491.94254028758;10897.291676041032;10937;11112.666620001413;11219.425208785291;11315.943420282845;11137.387443690675;11396.715082123013;11473.311601303949;11505.309681419141;11663.941680291544;6958.338957799001;7118.644067796693;7126.714931402893;8012.919870801451;8250.793730156794;9608.9039109608;10107.3430227035;10963.14958110881;11233.494492747683;11291.266067705574 15:56:09 INFO - PROCESS | 1931 | |3;mootools.html;1373.5741920004793;1524.3597688970635;1529.2506671730853;1730.5500569851836;1899.3257393625263;7858.567778772165;8382.58087095645;8663.480191188533;8864.512451815148;8881.978572464168;8796.91203087969;8872.290216782658;8887.28901687865;8908.376413651047;8918.331125165607;1939.7769256535503;2342.730585982617;2347.295811256625;2348.0138341896445;2348.037304705071;2358.587247231736;2385.475195457005;2394.006487307774;2409.8554086754853;2411.9758802412016;2350.118705485443;2357.57563638545;2373.3117395955237;2380.0122948976154;2387.5941090014653;2002.6695595226843;2347.049444974788;2375.58427275227;2383.356493746696;2386.952260954771;2331.3239160643393;2371.3834403055157;2373.6914201153913;2379.4051487128218;2379.9524009519714;8703.912960870437;8836.204741573225;8903.287736981027;8906;8924.107589241088;5238.92141617876;5376.838694839161;5388.946110538923;5394.136938089887;5402.837914862561;3107.813531188136;3649.124210189562;3684.5025921500524;3694;3703.185299234164;1081.9567217311298;1093.2675107677876;1093.5844379135956;1106.9889301106966;1114.9609763658234;11714.824277635757;11737.295762254207;11812.232204906653;11827.586034488751;11846.585369512026;4330.610245077958;4402.185595664812;4570.680052396367;4577.427821522309;4580.152671755736;9118.81762364749;9120.771980700536;9126.634934602542;9128.954355228181;9135.725928222164;5204.297419848348;5206.427292997767;5207.1668533034535;5210.088234558937;5219.164933610604;4328.761918094472;4364.323529852878;4496.437945256843;4511.120331535385;4865.781039853145;3691.5754688210664;3764.284785890672;3772.358699021173;3830.2763756309773;3839.1745774658584;1165.5745652836822;1178.7171078940992;1183.4142099660723;1191.53530123252;1193.5404869125275;741.9591922444209;794.2494342846071;908.5502676175336;917.4816228830823;928.4986107501874;5737.627054241461;5769.278840144982;5932.2881254248905;5989.2812862456785;6195.907061394083;443.9023414848728;449.98650040498836;453.4898239480584;460.6568106760485;461.55459981118383;2937.4125174965093;3985.242803867256;4008.6793056555407;4013.8394464221687;4031.536373317106;9169.954150229207;10718.41048742311;10814.675559733063;10930.508127134299;10960.28758130719;10891.83662245067;10908.34549927007;10909.781804364027;10926.836097458545;10928;8008.439409241414;8065.314448271845;8106.83786324282;8280.917190828015;8322.084570697098;4506.774661266989;6002.909956350745;6069.119977603134;6163.414475624809;6196.969015155076;9823.705288841345;9868.161206297258;10083.991600839858;10127.037931396506;10294.433806140734;9443.433393996382;10087.193024557871;10371.325863818827;10385.376877387382;10464;6917.100776898971;7039.964800175966;7050.400715938998;7149.213586505584;7302.306280903305;7689.769306920802;7733.149353571215;7772.805679857823;7774.92225077742;7852.214778522102;6666;6761.290064543152;7139.428845692229;7177.964110179416;7184.317489838457;6928.411085057625;6953.374196322356;6980.685869136003;7014.438844892498;7022.43820494349;6490.8052758417325;6616.867662646817;6625.701843416961;6625.801225963229;6633;4336.826526938887;4346.891327716832;4698.671093023592;4785.784639691153;4845;3992.3811809169624;4724.244120940633;4756.286557016475;4901.3138160658245;5013.473585273494 15:56:09 INFO - PROCESS | 1931 | |4;prototype.html;301.37915893259884;308.5063897763579;310.6287985856901;315.8689144005238;319.0444618367988;5443.319585051869;5445.891082178364;5455.91816122758;5466.59000574957;5481.424450432707;4329.87010389688;5307.814226502073;5344.4922732340365;5419.458054194579;5421.159720243369;3849.653531182193;3957.881263562098;3983.780892050936;4001.3794413262676;4032.2741906456827;3589.838457269429;3604.6575575320303;3994.6804255659476;4061.6141466560775;4074.164796216783;3273.492608645664;3630.4735813307057;4037.878863634081;4043.564534590222;4050.392441133824;3774.735768496206;3972.7882995686305;4058.3303754880408;4059.706265959723;4065.532463766675;3029.12155474912;3204.8943114625417;3283.770136090475;3475.5308033415417;3531.4638132412224;4665.5567721066445;4874;5166.225066240057;5178.741062946838;5198.778287102527;4597.678162528624;4632.3977882875015;4649.1863923813535;4651.465081515601;4661.300804879262;5382.59630527708;5504.587155963279;5574.191742197399;5607.130894711327;5611.691356975365;3161.6996385343587;3913.2760439318818;3936.2717897188827;3936.4095385692376;3940.211957608461;5565.526930210937;5690.658560486384;5821.359650438449;5912.965231084543;5940.584159108864;3443.398819548922;3753.324401607737;3817.312883680964;3982.6614737747036;4017.4174744662446;4086.3053280942313;4088.7751173685137;4101.466809314829;4106.117184805281;4111.773852438085;4450.287953927356;4680.559788555477;4719.1033703596895;4744.8885246065165;4745.240761478147;5535.640183388067;5624.550035997192;5675.914861277084;5703.887741890291;5729.742161602655;1100.801855665988;1183.5088438298183;1284.5953524639708;1368.9178649281075;1383.3498255819748;742.3170682971679;744.6202436757293;801.2588355770889;804.3082948664144;856.648774002656;3868.570486792663;4113.197926404382;4372.179943936143;4434.162136232813;4466.888327791831;3965.8810235692977;4765.688641009107;4774.4509381420885;4843.4430040545785;4851.51484851512;3483.512308276843;4058.5738497457933;4161.583841615814;4199.9370009449885;4418.447694038246;2366.6095094309244;2437.3297343230397;3045.9592073310937;3083.856719579915;3085.629724433082;4929.637271015177;5902.468777810018;5960.910586341209;5965.73154208053;5971.373005834412;4591.553660596901;5640.520555752807;6006.909896351558;6043.123747056652;6062.454379105901;5634.7182640867795;5678.659280443187;5965.464677512126;6001.159258074748;6010.338862725097;5566.858793947312;5611.214429979725;5825.563082768894;5856.765729370777;5863.006577763581;4683.8360657376825;5399.65221562618;5567.526760225426;5740.913886291625;5773.595848290579;5657.010023245998;5817;5817.680027598522;5834.474897259267;5888.146218798164;3805.0867791729233;3900.5124359455067;3902.66827319681;3917.942155618024;3953.4465174874967;4940.654154209315;5244.423113457593;5765.8558536036935;5823.7379317931645;5833.766649333979;4705.247160454311;4924;5401.729913504388;5645.322561292671;5671.971640141938;4203.516595591546;5563.5271001963665;5622.578306626938;5626.718664066699;5632.436756324335;5236.790528378822;5477.274658482725;5500.367457742411;5502.339719233558;5509.421510741475;5056.115179843439;5546.278983732089;5701.258836351248;5754.309482862083;5777.12243520849;4835.516448355136;5493.917591236055;5622.662640241599;5635.295588051494;5667.518260947865 15:56:09 INFO - PROCESS | 1931 | |5;yui.html;719.1442183801273;722.6025685872769;775.2557544757033;801.8957535520382;823.8311146215027;15461.845381546194;16287.267072981715;16288.755668664979;16321.347146114156;16342.182890855454;14629.464865891581;14773.92613036936;14789.186594737284;14793.926030369834;14861.256937153154;671.9328067193265;693.7814588404636;695.8190870373714;825.471698113208;828.7969447485359;846.0101681033206;848.9193526614993;863.9006514250848;863.9049704532497;865.8917635295588;915.8717779510873;917.206616276919;918.9218916392115;919.3564504846634;919.3702313914956;704.8097013806243;730.4266151071383;913.7943962608393;915.4781774388601;915.7756349694301;636.7453018792473;652.4649787174519;654.1071437487794;659.5646873063755;664.0570390046146;14872.107673539622;14952.177630230333;14997.550073497812;15004.324805383783;15010.774838377432;13853.792193117111;14042.297885105805;14143.222122783243;14214.147151170859;14584.708305833823;12754.80867786984;12822.551210707674;12829.807552886714;13036.86963130366;13159.934200328937;4526.140033393644;4560.179167749804;4610.2854057621125;4663.044075964419;4690.038542098861;125659.52277397018;127562;127671.7232827669;127714;128671.06993395013;10790.51442685081;11186.32882027081;11240.269382490113;11468.369239691898;11708.356040417688;22815;22894.885525572266;22932;22947.967341469674;22972.081116755144;7805.726799561988;7852.489588176751;8029.518228906284;8104.149064348277;8177.591120443954;4278.336857787048;4350.434443522385;4403.889902752393;4428.3800267962515;4548.681592288574;3510.64893510652;3625.8549658013385;3626.9093272668392;3627.0025742920907;3627.7097832173363;599.9520038396918;606.97421357905;656.0421784195033;675.9019942108366;712.7392180772881;564.6217034586837;572.3360901354409;622.1134882792003;677.7221339250883;684.9452043836482;8010.679572817138;9557.665481708107;9665.985071567526;9722.222222222204;9796.314258002014;590.9468147866627;622.3620788691537;654.8624788794311;672.0762213502844;685.8456847209338;4657.278121891112;4826.493218212107;4858.927116093261;4875.7074575525585;4878.940968274501;97085;97109;97445;160174.1991290036;172395;103681;116071;118267;126757;128495;76470;92465.37673116317;102934;109300;110152;9641.855372169563;9815.509224538888;9881.85177222328;10070.194384449373;10087.092161705188;61908;61970.591617461476;62564.68717656383;65057.69884602187;65363.673181633785;80646;81117;83099;89710.55144724235;90286.09713903039;13330.333483325601;13503.662408439868;13600.97992650575;13727;14005.179326687465;10933.83599246028;14831.766081403797;14890.181040042902;15174;15175.317110729822;13626.386812593655;13768;14027;14077.718445631235;14253.35859886287;13069.411876465392;13849.79225311601;14146.78779818324;14268.072575282573;14579.34392952341;12275.324857132944;13824.308784560531;13826;14131.222782747047;14301.92849035748;11219.326840389604;11236.831447528457;11497.942510287396;11536.25014374063;11707.180497365103;9709.6116155353;9831.655892043744;10109.595616175271;10198.541065651914;11658 15:56:09 INFO - PROCESS | 1931 | __end_tp_report 15:56:09 INFO - PROCESS | 1931 | __start_cc_report 15:56:09 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,1191 15:56:09 INFO - PROCESS | 1931 | __end_cc_report 15:56:09 INFO - PROCESS | 1931 | __startTimestamp1474498569017__endTimestamp 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | ------- Summary: start ------- 15:56:09 INFO - PROCESS | 1931 | Number of tests: 6 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | [#0] dojo.html Cycles:165 Average:5784.57 Median:6051.36 stddev:637.01 (10.5%) stddev-sans-first:607.78 15:56:09 INFO - PROCESS | 1931 | Values: 3274.7 3329.7 3333.8 3368.1 3371.8 5710.5 5796.4 5862.3 5960.1 5973.4 5809.6 5850.7 5851.3 5854.8 5868.6 5201.2 5227.4 5249.2 5287.3 5295.5 4378.2 5321.9 5332.6 5337.8 5350.5 5265.9 5272.5 5289.4 5303.9 5308.6 5328.3 5342.3 5344.4 5355.6 5409.6 5134.1 5186.7 5188.5 5256.9 5286.7 5752.8 5801.9 5812.5 5859.4 5871.0 6226.8 6230.8 6232.3 6248.1 6250.9 6124.9 6178.8 6180.3 6249.6 6289.4 5870.1 5883.7 5907.8 5944.6 5994.4 6277.5 6302.1 6305.2 6307.8 6310.2 6083.6 6102.6 6113.1 6187.7 6205.0 5182.0 6142.1 6149.1 6206.7 6276.4 6201.1 6207.2 6214.8 6228.0 6253.0 6216.7 6227.3 6238.4 6238.7 6267.6 4801.2 4918.2 4918.7 4933.7 4959.2 4435.8 4481.4 4522.5 4536.4 4538.1 5894.3 5899.7 5919.6 5924.8 5929.9 6109.0 6120.4 6168.7 6281.1 6294.5 5832.0 5883.2 5900.8 5958.6 5961.0 5457.3 5459.4 5460.1 5468.7 5477.7 6134.7 6179.3 6279.1 6289.4 6294.3 6167.8 6185.1 6217.3 6237.2 6246.8 6248.2 6251.1 6266.6 6269.3 6275.8 6108.8 6190.6 6191.0 6221.5 6223.3 6129.8 6151.9 6155.4 6166.3 6256.5 6166.9 6178.5 6179.4 6184.6 6197.8 6143.3 6169.6 6187.9 6190.0 6222.7 5887.4 5920.6 6036.0 6046.1 6051.4 6162.9 6223.0 6226.7 6230.3 6240.7 5834.7 5847.4 6099.0 6109.5 6110.3 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | [#1] ext.html Cycles:180 Average:71176.05 Median:20306.20 stddev:161761.85 (796.6%) stddev-sans-first:162128.49 15:56:09 INFO - PROCESS | 1931 | Values: 456.7 474.9 530.6 534.7 556.1 24451.6 39511.8 40811.4 40923.4 41883.0 41809.6 42206.4 42207.4 42271.8 42338.0 8797.6 8956.3 9782.7 9950.1 9967.5 10424.1 11941.7 12189.7 12210.5 12417.0 10275.8 12220.3 12283.3 12334.7 12350.0 12258.9 12315.5 12324.9 12329.1 12335.1 11983.3 12068.3 12072.0 12079.5 12101.6 33015.2 39378.6 39681.8 39773.8 39948.0 3488.5 3552.8 3778.7 4005.7 4139.6 29796.9 30413.5 31054.8 31099.5 31506.8 3160.0 3245.0 3264.2 3287.0 3340.4 467912.0 471234.0 471328.0 471515.0 472637.6 55877.0 56715.4 56778.0 56878.1 56889.0 60295.0 60357.9 60407.0 60444.0 60471.0 15824.9 16030.6 16041.0 16085.8 16094.5 11395.2 11606.2 11615.0 11880.2 12622.8 14530.9 14662.3 15792.0 16198.7 16211.6 6068.7 6127.7 6179.9 6231.6 6240.2 793.5 958.2 1005.7 1016.4 1068.1 27880.9 29448.7 29478.0 29960.6 30247.2 935.6 1012.2 1023.2 1051.8 1097.0 14617.9 15006.4 15487.2 15774.0 15899.6 695540.0 701018.0 702791.8 872885.0 911744.0 57377.0 58287.8 58331.7 58359.4 58462.0 1193.1 1215.6 1215.9 1311.5 1344.2 24640.8 26049.5 28962.0 30274.8 33141.2 52525.5 53388.9 53440.5 53447.5 53461.0 501019.0 504542.0 504555.0 504763.0 505906.0 24978.8 25254.4 25520.7 25641.2 25905.6 44021.0 44463.9 44875.8 45081.6 45500.3 37650.0 37731.4 37953.6 38721.0 39721.6 37593.4 37923.4 37938.2 38540.0 38962.4 37059.6 37724.4 37911.6 38050.0 38136.0 31047.1 33277.5 33621.8 33841.2 34794.5 20333.3 24778.5 24802.0 24882.0 25447.6 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | [#2] jquery.html Cycles:180 Average:34418.09 Median:17842.70 stddev:93216.16 (522.4%) stddev-sans-first:93442.56 15:56:09 INFO - PROCESS | 1931 | Values: 351.3 371.4 377.7 383.2 403.5 15214.6 15364.7 19945.9 21722.3 21996.7 18668.7 19690.4 20412.3 21021.1 21269.0 5848.4 6177.6 6182.7 6182.9 6187.3 5914.9 6052.6 6053.2 6065.5 6095.9 6049.0 6049.3 6056.9 6059.0 6059.9 5784.4 5976.3 6037.0 6044.9 6045.3 5122.8 5221.3 5223.2 5229.8 5233.2 25780.7 26116.5 26186.6 26413.5 26480.6 1965.9 2363.1 2421.0 2957.1 3032.1 15594.4 15643.5 15797.3 16115.9 16285.1 1806.7 1828.5 1832.6 1885.4 1966.7 112988.4 117669.4 118282.0 119540.0 120425.0 9335.0 9878.7 10020.9 10582.9 10779.2 12775.8 13360.9 13368.9 32577.7 34083.5 10573.8 10666.1 10834.2 10920.9 11127.3 8776.4 8802.2 8925.3 9038.2 9161.7 9349.0 9478.0 9491.3 9549.8 9558.7 3107.7 3586.6 3594.7 3633.9 3705.4 819.8 821.0 846.2 918.9 930.7 20831.9 21496.5 21515.4 21555.6 21561.4 876.5 886.5 920.5 950.5 976.1 10720.9 10732.9 11445.1 11471.8 11480.5 496651.0 547344.0 572820.0 573875.0 588901.0 116219.0 126468.0 126693.4 127813.0 132847.0 821.6 977.9 987.1 987.7 989.0 18422.8 19082.2 19503.8 19766.2 19785.9 42676.6 56014.7 56547.4 57043.7 57075.7 76860.0 78979.6 80255.6 80664.8 80894.0 5635.0 5966.7 7991.5 8118.6 8221.2 12323.7 12572.0 12903.2 13026.9 13139.8 10968.3 10999.1 11269.1 11404.6 11491.9 10897.3 10937.0 11112.7 11219.4 11315.9 11137.4 11396.7 11473.3 11505.3 11663.9 6958.3 7118.6 7126.7 8012.9 8250.8 9608.9 10107.3 10963.1 11233.5 11291.3 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | [#3] mootools.html Cycles:180 Average:5582.84 Median:4578.79 stddev:3200.76 (69.9%) stddev-sans-first:3194.11 15:56:09 INFO - PROCESS | 1931 | Values: 1373.6 1524.4 1529.3 1730.6 1899.3 7858.6 8382.6 8663.5 8864.5 8882.0 8796.9 8872.3 8887.3 8908.4 8918.3 1939.8 2342.7 2347.3 2348.0 2348.0 2358.6 2385.5 2394.0 2409.9 2412.0 2350.1 2357.6 2373.3 2380.0 2387.6 2002.7 2347.0 2375.6 2383.4 2387.0 2331.3 2371.4 2373.7 2379.4 2380.0 8703.9 8836.2 8903.3 8906.0 8924.1 5238.9 5376.8 5388.9 5394.1 5402.8 3107.8 3649.1 3684.5 3694.0 3703.2 1082.0 1093.3 1093.6 1107.0 1115.0 11714.8 11737.3 11812.2 11827.6 11846.6 4330.6 4402.2 4570.7 4577.4 4580.2 9118.8 9120.8 9126.6 9129.0 9135.7 5204.3 5206.4 5207.2 5210.1 5219.2 4328.8 4364.3 4496.4 4511.1 4865.8 3691.6 3764.3 3772.4 3830.3 3839.2 1165.6 1178.7 1183.4 1191.5 1193.5 742.0 794.2 908.6 917.5 928.5 5737.6 5769.3 5932.3 5989.3 6195.9 443.9 450.0 453.5 460.7 461.6 2937.4 3985.2 4008.7 4013.8 4031.5 9170.0 10718.4 10814.7 10930.5 10960.3 10891.8 10908.3 10909.8 10926.8 10928.0 8008.4 8065.3 8106.8 8280.9 8322.1 4506.8 6002.9 6069.1 6163.4 6197.0 9823.7 9868.2 10084.0 10127.0 10294.4 9443.4 10087.2 10371.3 10385.4 10464.0 6917.1 7040.0 7050.4 7149.2 7302.3 7689.8 7733.1 7772.8 7774.9 7852.2 6666.0 6761.3 7139.4 7178.0 7184.3 6928.4 6953.4 6980.7 7014.4 7022.4 6490.8 6616.9 6625.7 6625.8 6633.0 4336.8 4346.9 4698.7 4785.8 4845.0 3992.4 4724.2 4756.3 4901.3 5013.5 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | [#4] prototype.html Cycles:180 Average:4483.02 Median:4847.48 stddev:1414.73 (29.2%) stddev-sans-first:1383.44 15:56:09 INFO - PROCESS | 1931 | Values: 301.4 308.5 310.6 315.9 319.0 5443.3 5445.9 5455.9 5466.6 5481.4 4329.9 5307.8 5344.5 5419.5 5421.2 3849.7 3957.9 3983.8 4001.4 4032.3 3589.8 3604.7 3994.7 4061.6 4074.2 3273.5 3630.5 4037.9 4043.6 4050.4 3774.7 3972.8 4058.3 4059.7 4065.5 3029.1 3204.9 3283.8 3475.5 3531.5 4665.6 4874.0 5166.2 5178.7 5198.8 4597.7 4632.4 4649.2 4651.5 4661.3 5382.6 5504.6 5574.2 5607.1 5611.7 3161.7 3913.3 3936.3 3936.4 3940.2 5565.5 5690.7 5821.4 5913.0 5940.6 3443.4 3753.3 3817.3 3982.7 4017.4 4086.3 4088.8 4101.5 4106.1 4111.8 4450.3 4680.6 4719.1 4744.9 4745.2 5535.6 5624.6 5675.9 5703.9 5729.7 1100.8 1183.5 1284.6 1368.9 1383.3 742.3 744.6 801.3 804.3 856.6 3868.6 4113.2 4372.2 4434.2 4466.9 3965.9 4765.7 4774.5 4843.4 4851.5 3483.5 4058.6 4161.6 4199.9 4418.4 2366.6 2437.3 3046.0 3083.9 3085.6 4929.6 5902.5 5960.9 5965.7 5971.4 4591.6 5640.5 6006.9 6043.1 6062.5 5634.7 5678.7 5965.5 6001.2 6010.3 5566.9 5611.2 5825.6 5856.8 5863.0 4683.8 5399.7 5567.5 5740.9 5773.6 5657.0 5817.0 5817.7 5834.5 5888.1 3805.1 3900.5 3902.7 3917.9 3953.4 4940.7 5244.4 5765.9 5823.7 5833.8 4705.2 4924.0 5401.7 5645.3 5672.0 4203.5 5563.5 5622.6 5626.7 5632.4 5236.8 5477.3 5500.4 5502.3 5509.4 5056.1 5546.3 5701.3 5754.3 5777.1 4835.5 5493.9 5622.7 5635.3 5667.5 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - PROCESS | 1931 | [#5] yui.html Cycles:180 Average:24090.92 Median:4314.39 stddev:37590.29 (871.3%) stddev-sans-first:37654.78 15:56:09 INFO - PROCESS | 1931 | Values: 719.1 722.6 775.3 801.9 823.8 15461.8 16287.3 16288.8 16321.3 16342.2 14629.5 14773.9 14789.2 14793.9 14861.3 671.9 693.8 695.8 825.5 828.8 846.0 848.9 863.9 863.9 865.9 915.9 917.2 918.9 919.4 919.4 704.8 730.4 913.8 915.5 915.8 636.7 652.5 654.1 659.6 664.1 14872.1 14952.2 14997.6 15004.3 15010.8 13853.8 14042.3 14143.2 14214.1 14584.7 12754.8 12822.6 12829.8 13036.9 13159.9 4526.1 4560.2 4610.3 4663.0 4690.0 125659.5 127562.0 127671.7 127714.0 128671.1 10790.5 11186.3 11240.3 11468.4 11708.4 22815.0 22894.9 22932.0 22948.0 22972.1 7805.7 7852.5 8029.5 8104.1 8177.6 4278.3 4350.4 4403.9 4428.4 4548.7 3510.6 3625.9 3626.9 3627.0 3627.7 600.0 607.0 656.0 675.9 712.7 564.6 572.3 622.1 677.7 684.9 8010.7 9557.7 9666.0 9722.2 9796.3 590.9 622.4 654.9 672.1 685.8 4657.3 4826.5 4858.9 4875.7 4878.9 97085.0 97109.0 97445.0 160174.2 172395.0 103681.0 116071.0 118267.0 126757.0 128495.0 76470.0 92465.4 102934.0 109300.0 110152.0 9641.9 9815.5 9881.9 10070.2 10087.1 61908.0 61970.6 62564.7 65057.7 65363.7 80646.0 81117.0 83099.0 89710.6 90286.1 13330.3 13503.7 13601.0 13727.0 14005.2 10933.8 14831.8 14890.2 15174.0 15175.3 13626.4 13768.0 14027.0 14077.7 14253.4 13069.4 13849.8 14146.8 14268.1 14579.3 12275.3 13824.3 13826.0 14131.2 14301.9 11219.3 11236.8 11497.9 11536.3 11707.2 9709.6 9831.7 10109.6 10198.5 11658.0 15:56:09 INFO - PROCESS | 1931 | -------- Summary: end -------- 15:56:09 INFO - PROCESS | 1931 | 15:56:09 INFO - TEST-INFO | 1931: exit 0 15:56:09 INFO - TEST-OK | dromaeo_css | took 1117092ms 15:56:09 INFO - TEST-START | kraken 15:56:09 INFO - operating with platform_type : mac_ 15:56:09 INFO - Initialising browser for kraken test... 15:56:09 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpZyRqRT/profile http://localhost:54347/getInfo.html) 15:56:12 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 15:56:12 INFO - PROCESS | 1935 | colorDepth:24 15:56:12 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 15:56:12 INFO - PROCESS | 1935 | __metrics 15:56:12 INFO - PROCESS | 1935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:56:12 INFO - PROCESS | 1935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:56:12 INFO - TEST-INFO | 1935: exit 0 15:56:12 INFO - Browser initialized. 15:56:12 INFO - Running cycle 1/1 for kraken test... 15:56:12 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpZyRqRT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:56:24 INFO - PROCESS | 1936 | RSS: Main: 243740672 15:56:24 INFO - PROCESS | 1936 | 15:56:27 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54347/tests/kraken/driver.html?testName=audio-beat-detection) 15:56:28 INFO - PROCESS | 1936 | RSS: Main: 295309312 15:56:28 INFO - PROCESS | 1936 | 15:56:31 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54347/tests/kraken/driver.html?testName=audio-dft) 15:56:31 INFO - PROCESS | 1936 | RSS: Main: 294232064 15:56:31 INFO - PROCESS | 1936 | 15:56:35 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54347/tests/kraken/driver.html?testName=audio-fft) 15:56:35 INFO - PROCESS | 1936 | RSS: Main: 383950848 15:56:35 INFO - PROCESS | 1936 | 15:56:38 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54347/tests/kraken/driver.html?testName=audio-oscillator) 15:56:38 INFO - PROCESS | 1936 | RSS: Main: 283717632 15:56:38 INFO - PROCESS | 1936 | 15:56:40 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:56:41 INFO - PROCESS | 1936 | RSS: Main: 287555584 15:56:41 INFO - PROCESS | 1936 | 15:56:44 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54347/tests/kraken/driver.html?testName=imaging-darkroom) 15:56:44 INFO - PROCESS | 1936 | RSS: Main: 325132288 15:56:44 INFO - PROCESS | 1936 | 15:56:47 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54347/tests/kraken/driver.html?testName=imaging-desaturate) 15:56:48 INFO - PROCESS | 1936 | RSS: Main: 326914048 15:56:48 INFO - PROCESS | 1936 | 15:56:50 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54347/tests/kraken/driver.html?testName=json-parse-financial) 15:56:51 INFO - PROCESS | 1936 | RSS: Main: 324587520 15:56:51 INFO - PROCESS | 1936 | 15:56:53 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:56:53 INFO - PROCESS | 1936 | RSS: Main: 304340992 15:56:53 INFO - PROCESS | 1936 | 15:56:55 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:56:56 INFO - PROCESS | 1936 | RSS: Main: 304975872 15:56:56 INFO - PROCESS | 1936 | 15:56:58 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:56:59 INFO - PROCESS | 1936 | RSS: Main: 304726016 15:56:59 INFO - PROCESS | 1936 | 15:57:02 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:57:02 INFO - PROCESS | 1936 | RSS: Main: 321310720 15:57:02 INFO - PROCESS | 1936 | 15:57:05 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:57:06 INFO - PROCESS | 1936 | RSS: Main: 317243392 15:57:06 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:54347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54347/tests/kraken/driver.html?testName=ai-astar) 15:57:08 INFO - PROCESS | 1936 | RSS: Main: 360820736 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | __start_tp_report 15:57:08 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 15:57:08 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 15:57:08 INFO - PROCESS | 1936 | |i|pagename|runs| 15:57:08 INFO - PROCESS | 1936 | |0;ai-astar;113;113;113;111;112;111;116;164;167;121 15:57:08 INFO - PROCESS | 1936 | |1;audio-beat-detection;148;109;111;144;112;134;140;106;140;108 15:57:08 INFO - PROCESS | 1936 | |2;audio-dft;184;183;179;186;189;183;184;185;183;184 15:57:08 INFO - PROCESS | 1936 | |3;audio-fft;81;60;59;88;62;52;74;74;111;64 15:57:08 INFO - PROCESS | 1936 | |4;audio-oscillator;89;69;94;71;68;69;91;67;68;88 15:57:08 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;94;132;116;87;90;87;91;87;89;86 15:57:08 INFO - PROCESS | 1936 | |6;imaging-darkroom;95;95;95;95;95;95;95;95;95;95 15:57:08 INFO - PROCESS | 1936 | |7;imaging-desaturate;85;84;84;85;84;83;86;84;84;113 15:57:08 INFO - PROCESS | 1936 | |8;json-parse-financial;57;55;55;51;54;55;56;54;56;55 15:57:08 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;66;73;81;76;73;73;70;71;72;71 15:57:08 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;86;88;90;75;99;95;74;96;100;107 15:57:08 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;151;153;145;140;133;139;133;160;177;120 15:57:08 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;168;168;169;168;168;167;170;168;167;168 15:57:08 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;61;79;89;87;68;67;66;67;66;67 15:57:08 INFO - PROCESS | 1936 | __end_tp_report 15:57:08 INFO - PROCESS | 1936 | __start_cc_report 15:57:08 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,2024 15:57:08 INFO - PROCESS | 1936 | __end_cc_report 15:57:08 INFO - PROCESS | 1936 | __startTimestamp1474498628400__endTimestamp 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | ------- Summary: start ------- 15:57:08 INFO - PROCESS | 1936 | Number of tests: 14 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:124.10 Median:114.50 stddev:22.03 (19.2%) stddev-sans-first:22.99 15:57:08 INFO - PROCESS | 1936 | Values: 113.0 113.0 113.0 111.0 112.0 111.0 116.0 164.0 167.0 121.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:137.00 stddev:17.29 (12.6%) stddev-sans-first:16.26 15:57:08 INFO - PROCESS | 1936 | Values: 148.0 109.0 111.0 144.0 112.0 134.0 140.0 106.0 140.0 108.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:2.54 (1.4%) stddev-sans-first:2.69 15:57:08 INFO - PROCESS | 1936 | Values: 184.0 183.0 179.0 186.0 189.0 183.0 184.0 185.0 183.0 184.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:72.50 Median:69.00 stddev:17.45 (25.3%) stddev-sans-first:18.24 15:57:08 INFO - PROCESS | 1936 | Values: 81.0 60.0 59.0 88.0 62.0 52.0 74.0 74.0 111.0 64.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:79.50 stddev:11.42 (14.4%) stddev-sans-first:11.32 15:57:08 INFO - PROCESS | 1936 | Values: 89.0 69.0 94.0 71.0 68.0 69.0 91.0 67.0 68.0 88.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:88.00 stddev:15.47 (17.6%) stddev-sans-first:16.39 15:57:08 INFO - PROCESS | 1936 | Values: 94.0 132.0 116.0 87.0 90.0 87.0 91.0 87.0 89.0 86.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:57:08 INFO - PROCESS | 1936 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:87.20 Median:84.00 stddev:9.10 (10.8%) stddev-sans-first:9.62 15:57:08 INFO - PROCESS | 1936 | Values: 85.0 84.0 84.0 85.0 84.0 83.0 86.0 84.0 84.0 113.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.62 (2.9%) stddev-sans-first:1.51 15:57:08 INFO - PROCESS | 1936 | Values: 57.0 55.0 55.0 51.0 54.0 55.0 56.0 54.0 56.0 55.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:3.92 (5.4%) stddev-sans-first:3.35 15:57:08 INFO - PROCESS | 1936 | Values: 66.0 73.0 81.0 76.0 73.0 73.0 70.0 71.0 72.0 71.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:89.00 stddev:10.66 (12.0%) stddev-sans-first:11.15 15:57:08 INFO - PROCESS | 1936 | Values: 86.0 88.0 90.0 75.0 99.0 95.0 74.0 96.0 100.0 107.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:148.00 stddev:16.07 (10.9%) stddev-sans-first:16.90 15:57:08 INFO - PROCESS | 1936 | Values: 151.0 153.0 145.0 140.0 133.0 139.0 133.0 160.0 177.0 120.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 15:57:08 INFO - PROCESS | 1936 | Values: 168.0 168.0 169.0 168.0 168.0 167.0 170.0 168.0 167.0 168.0 15:57:08 INFO - PROCESS | 1936 | 15:57:08 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:67.50 stddev:9.70 (14.4%) stddev-sans-first:9.48 15:57:08 INFO - PROCESS | 1936 | Values: 61.0 79.0 89.0 87.0 68.0 67.0 66.0 67.0 66.0 67.0 15:57:08 INFO - PROCESS | 1936 | -------- Summary: end -------- 15:57:08 INFO - PROCESS | 1936 | 15:57:09 INFO - TEST-INFO | 1936: exit 0 15:57:09 INFO - TEST-OK | kraken | took 59617ms 15:57:09 INFO - SUITE-END | took 1176s 15:57:09 INFO - Completed test suite (00:19:36) 15:57:09 INFO - javascript benchmark 15:57:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.721648659863, 3329.7169740572035, 3333.7666363354565, 3368.0737797105794, 3371.79769213847, 5710.514606258463, 5796.420357964202, 5862.32583252926, 5960.0761881908265, 5973.372795856438, 5809.593328467009, 5850.6782126983, 5851.297844258685, 5854.795082172125, 5868.6478811271245, 5201.193814958669, 5227.424983251839, 5249.212618107276, 5287.312649355597, 5295.4704529546925, 4378.16814805186, 5321.920171197435, 5332.626716129873, 5337.759800808973, 5350.5452036576935, 5265.868353291179, 5272.525472707455, 5289.418164001976, 5303.867403314929, 5308.601854860901, 5328.307320048389, 5342.332208473941, 5344.438833922421, 5355.598330125256, 5409.56723462122, 5134.05020071288, 5186.740662966874, 5188.45521220274, 5256.9474305256845, 5286.735663216862, 5752.7986520472, 5801.883962320772, 5812.534997200214, 5859.4140585941495, 5871.031279838821, 6226.813195604093, 6230.844228894269, 6232.283287421959, 6248.094026366151, 6250.9062364064575, 6124.899720463007, 6178.752849885999, 6180.3201647818705, 6249.593776404519, 6289.37106289372, 5870.090136028923, 5883.70581470929, 5907.822765317047, 5944.613600115978, 5994.37059108796, 6277.473279668595, 6302.1177035215105, 6305.180326557518, 6307.810765677037, 6310.242770867525, 6083.6045657032155, 6102.633841969496, 6113.083037544315, 6187.659678717714, 6205.0, 5182.0, 6142.1304578115505, 6149.108379285068, 6206.689665516707, 6276.403741644536, 6201.069839524017, 6207.193064901624, 6214.751409943642, 6227.96886015567, 6253.030780228981, 6216.658083805434, 6227.252729672468, 6238.438540531374, 6238.656873871981, 6267.592606480564, 4801.231802911518, 4918.1884988977135, 4918.680285781413, 4933.703977761345, 4959.231319145538, 4435.756033418128, 4481.3726078349055, 4522.525134860858, 4536.387587675687, 4538.115067561794, 5894.322152952465, 5899.7050147492455, 5919.644821310649, 5924.7926322578505, 5929.940700592939, 6109.009944784285, 6120.447133218882, 6168.691565421711, 6281.089242059876, 6294.527910406738, 5832.0, 5883.17635531026, 5900.822975310747, 5958.6424814511265, 5961.0, 5457.263269458652, 5459.372172200247, 5460.099083651233, 5468.7265636718, 5477.67133971963, 6134.742747059018, 6179.28938172098, 6279.089532017923, 6289.371062893674, 6294.276158241678, 6167.814965551041, 6185.103160041859, 6217.253929528486, 6237.1891654084675, 6246.843828904313, 6248.187735594343, 6251.124842521959, 6266.561340706106, 6269.279032911091, 6275.843103922439, 6108.7670647404, 6190.597611155261, 6191.00943848982, 6221.502279817513, 6223.253209614875, 6129.847850912788, 6151.9384806151365, 6155.446009859134, 6166.321704612579, 6256.468200203034, 6166.876662466815, 6178.505719542336, 6179.351168127282, 6184.567080304516, 6197.845053873689, 6143.293521245114, 6169.598976066542, 6187.938120618916, 6190.0, 6222.657753823583, 5887.3523912370465, 5920.615160014585, 6036.004059330161, 6046.084778133363, 6051.364606716407, 6162.907556386747, 6223.004319308889, 6226.719797609027, 6230.252369715663, 6240.656763878031, 5834.7082645866685, 5847.38602446754, 6098.969505152446, 6109.541784366102, 6110.2973158085615], "value": 5743.3795812464205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.7282466932176, 474.8646635708823, 530.6020484636523, 534.6685055265735, 556.1435389500165, 24451.63322550163, 39511.80244098779, 40811.38782918251, 40923.386149207785, 41883.0, 41809.58190418095, 42206.366904496455, 42207.36688949668, 42271.78864105675, 42338.0, 8797.648094076229, 8956.32827537934, 9782.706518804429, 9950.054744799232, 9967.45179015154, 10424.061834434899, 11941.746116657756, 12189.695257618541, 12210.511579536807, 12417.0, 10275.794484110313, 12220.327881966488, 12283.324417157053, 12334.691632709164, 12350.0, 12258.93870530646, 12315.5073797048, 12324.938375308066, 12329.075319350995, 12335.136540442129, 11983.28100313984, 12068.275903445734, 12072.034237260998, 12079.456424460832, 12101.6369508914, 33015.17462063444, 39378.60621393778, 39681.80159099215, 39773.80113099445, 39948.0, 3488.5116083748294, 3552.7690700104667, 3778.6977041836585, 4005.719599628027, 4139.648129908961, 29796.851015745, 30413.47932603361, 31054.844725776227, 31099.533506997188, 31506.842465787755, 3159.9684003159905, 3244.967550324514, 3264.2002709336366, 3287.0, 3340.3987282289177, 467912.0, 471234.0, 471328.0, 471515.0, 472637.6368118172, 55877.0, 56715.43284567184, 56778.0, 56878.14682779762, 56889.0, 60295.0, 60357.8874739382, 60407.0, 60444.0, 60471.0, 15824.92087539555, 16030.599235019217, 16041.0, 16085.839141608669, 16094.517164485083, 11395.202335836577, 11606.24559403636, 11614.954654081173, 11880.168388212742, 12622.81065784014, 14530.927345363205, 14662.266886655625, 15792.0, 16198.676026479405, 16211.594710132342, 6068.696565171724, 6127.724252408652, 6179.876402471926, 6231.626102433868, 6240.219972503437, 793.4723408933111, 958.1568219966524, 1005.7485628592851, 1016.4409574733867, 1068.1348108032519, 27880.860595696893, 29448.705512944598, 29478.0, 29960.550591741143, 30247.243818904702, 935.6163972771132, 1012.2003617142375, 1023.2223510132353, 1051.8211903976342, 1096.9780604388027, 14617.853821461862, 15006.399744010118, 15487.225638718019, 15774.0, 15899.602509937344, 695540.0, 701018.0, 702791.7766578662, 872885.0, 911744.0, 57377.0, 58287.834243314894, 58331.70834145887, 58359.416405836244, 58462.0, 1193.1290158184574, 1215.6231568213705, 1215.9148859579745, 1311.4754098360731, 1344.2069179184327, 24640.753592463847, 26049.479010420066, 28962.0, 30274.789008439417, 33141.19452679396, 52525.47474525206, 53388.93222135613, 53440.46559534355, 53447.465525345804, 53461.0, 501019.0, 504542.0, 504555.0, 504763.0, 505906.0, 24978.75021249764, 25254.368640784127, 25520.744792551835, 25641.23076307714, 25905.6114158284, 44021.0, 44463.88840279019, 44875.775621121684, 45081.566475430285, 45500.31749523826, 37650.0, 37731.43402848904, 37953.62046379501, 38721.0, 39721.60278397179, 37593.436098458, 37923.43114853224, 37938.241235175694, 38540.0, 38962.415563766, 37059.6294037067, 37724.43413348747, 37911.62088379081, 38050.0, 38136.04659883414, 31047.068587942398, 33277.51029237275, 33621.83189084039, 33841.15397115092, 34794.478082828275, 20333.288334908208, 24778.50442991166, 24802.007919683012, 24882.0, 25447.61828572536], "value": 19990.53262369257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.27637067640677, 371.373384575559, 377.7280358142138, 383.2220592197838, 403.4956304619226, 15214.619634509143, 15364.69270614587, 19945.900270498645, 21722.3483295501, 21996.670049949265, 18668.71996920044, 19690.40928772139, 20412.285570005053, 21021.054052567633, 21269.0, 5848.415158484149, 6177.598456100339, 6182.659953702545, 6182.876342473148, 6187.28846182688, 5914.9112763308585, 6052.606580572271, 6053.152558641794, 6065.4844338231305, 6095.939040609582, 6048.969755151218, 6049.274087109553, 6056.878862422749, 6058.969705151468, 6059.909101363483, 5784.363719990798, 5976.282846058479, 6037.034074548095, 6044.909326360108, 6045.3047899491685, 5122.795088196468, 5221.321228240343, 5223.2165175223645, 5229.764660590283, 5233.188855727369, 25780.74219257802, 26116.477670446675, 26186.607200892002, 26413.47173056528, 26480.60279095815, 1965.88204707718, 2363.0902102690416, 2421.019487107724, 2957.1128661401494, 3032.105528868989, 15594.37622495099, 15643.452479163174, 15797.289121989537, 16115.91942040294, 16285.104319262437, 1806.719958406449, 1828.5245836082581, 1832.5876677747533, 1885.3684015854567, 1966.6951622498536, 112988.435057825, 117669.41165294204, 118282.0, 119540.0, 120425.0, 9335.0, 9878.654247101316, 10020.949895250476, 10582.894171058344, 10779.245452818384, 12775.808362874564, 13360.866391335961, 13368.866311336957, 32577.674223257465, 34083.4887476688, 10573.841392379121, 10666.093382062612, 10834.241603087867, 10920.890791092146, 11127.332360058423, 8776.385653004356, 8802.207801297915, 8925.285977121815, 9038.198158570733, 9161.725148245563, 9348.95325523368, 9477.952610236905, 9491.288153388523, 9549.809003819884, 9558.709574207533, 3107.715828865782, 3586.605473397924, 3594.730395220369, 3633.855335569287, 3705.4256590228556, 819.848113400673, 820.9753707388788, 846.1834329871704, 918.8789676594544, 930.6510058727977, 20831.8958405207, 21496.462588435414, 21515.354539363845, 21555.568888622453, 21561.353159405244, 876.5310558850985, 886.5079880666292, 920.4523308631353, 950.5104870991306, 976.0532283684814, 10720.946395267974, 10732.892671073188, 11445.084393248686, 11471.770564588662, 11480.540778368939, 496651.0, 547344.0, 572820.0, 573875.0, 588901.0, 116219.0, 126468.0, 126693.36653316859, 127813.0, 132847.0, 821.5974172655356, 977.9315447918577, 987.0968064221157, 987.6592575561419, 989.0455710239653, 18422.815771842645, 19082.23671053198, 19503.804961950198, 19766.209351625774, 19785.901070494554, 42676.5732342685, 56014.71992640011, 56547.43452565586, 57043.71478142583, 57075.714621426625, 76860.0, 78979.60510197643, 80255.59872200602, 80664.79002814845, 80894.0, 5635.0138725723655, 5966.701664916824, 7991.480553763987, 8118.564430670894, 8221.218984196492, 12323.69190770238, 12571.994240460925, 12903.225806451643, 13026.869731302566, 13139.802902956271, 10968.287061340987, 10999.120070394189, 11269.098472122374, 11404.600838970597, 11491.94254028758, 10897.291676041032, 10937.0, 11112.666620001413, 11219.425208785291, 11315.943420282845, 11137.387443690675, 11396.715082123013, 11473.311601303949, 11505.309681419141, 11663.941680291544, 6958.338957799001, 7118.644067796693, 7126.714931402893, 8012.919870801451, 8250.793730156794, 9608.9039109608, 10107.3430227035, 10963.14958110881, 11233.494492747683, 11291.266067705574], "value": 10163.837378255646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.5741920004793, 1524.3597688970635, 1529.2506671730853, 1730.5500569851836, 1899.3257393625263, 7858.567778772165, 8382.58087095645, 8663.480191188533, 8864.512451815148, 8881.978572464168, 8796.91203087969, 8872.290216782658, 8887.28901687865, 8908.376413651047, 8918.331125165607, 1939.7769256535503, 2342.730585982617, 2347.295811256625, 2348.0138341896445, 2348.037304705071, 2358.587247231736, 2385.475195457005, 2394.006487307774, 2409.8554086754853, 2411.9758802412016, 2350.118705485443, 2357.57563638545, 2373.3117395955237, 2380.0122948976154, 2387.5941090014653, 2002.6695595226843, 2347.049444974788, 2375.58427275227, 2383.356493746696, 2386.952260954771, 2331.3239160643393, 2371.3834403055157, 2373.6914201153913, 2379.4051487128218, 2379.9524009519714, 8703.912960870437, 8836.204741573225, 8903.287736981027, 8906.0, 8924.107589241088, 5238.92141617876, 5376.838694839161, 5388.946110538923, 5394.136938089887, 5402.837914862561, 3107.813531188136, 3649.124210189562, 3684.5025921500524, 3694.0, 3703.185299234164, 1081.9567217311298, 1093.2675107677876, 1093.5844379135956, 1106.9889301106966, 1114.9609763658234, 11714.824277635757, 11737.295762254207, 11812.232204906653, 11827.586034488751, 11846.585369512026, 4330.610245077958, 4402.185595664812, 4570.680052396367, 4577.427821522309, 4580.152671755736, 9118.81762364749, 9120.771980700536, 9126.634934602542, 9128.954355228181, 9135.725928222164, 5204.297419848348, 5206.427292997767, 5207.1668533034535, 5210.088234558937, 5219.164933610604, 4328.761918094472, 4364.323529852878, 4496.437945256843, 4511.120331535385, 4865.781039853145, 3691.5754688210664, 3764.284785890672, 3772.358699021173, 3830.2763756309773, 3839.1745774658584, 1165.5745652836822, 1178.7171078940992, 1183.4142099660723, 1191.53530123252, 1193.5404869125275, 741.9591922444209, 794.2494342846071, 908.5502676175336, 917.4816228830823, 928.4986107501874, 5737.627054241461, 5769.278840144982, 5932.2881254248905, 5989.2812862456785, 6195.907061394083, 443.9023414848728, 449.98650040498836, 453.4898239480584, 460.6568106760485, 461.55459981118383, 2937.4125174965093, 3985.242803867256, 4008.6793056555407, 4013.8394464221687, 4031.536373317106, 9169.954150229207, 10718.41048742311, 10814.675559733063, 10930.508127134299, 10960.28758130719, 10891.83662245067, 10908.34549927007, 10909.781804364027, 10926.836097458545, 10928.0, 8008.439409241414, 8065.314448271845, 8106.83786324282, 8280.917190828015, 8322.084570697098, 4506.774661266989, 6002.909956350745, 6069.119977603134, 6163.414475624809, 6196.969015155076, 9823.705288841345, 9868.161206297258, 10083.991600839858, 10127.037931396506, 10294.433806140734, 9443.433393996382, 10087.193024557871, 10371.325863818827, 10385.376877387382, 10464.0, 6917.100776898971, 7039.964800175966, 7050.400715938998, 7149.213586505584, 7302.306280903305, 7689.769306920802, 7733.149353571215, 7772.805679857823, 7774.92225077742, 7852.214778522102, 6666.0, 6761.290064543152, 7139.428845692229, 7177.964110179416, 7184.317489838457, 6928.411085057625, 6953.374196322356, 6980.685869136003, 7014.438844892498, 7022.43820494349, 6490.8052758417325, 6616.867662646817, 6625.701843416961, 6625.801225963229, 6633.0, 4336.826526938887, 4346.891327716832, 4698.671093023592, 4785.784639691153, 4845.0, 3992.3811809169624, 4724.244120940633, 4756.286557016475, 4901.3138160658245, 5013.473585273494], "value": 4402.612402641542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.37915893259884, 308.5063897763579, 310.6287985856901, 315.8689144005238, 319.0444618367988, 5443.319585051869, 5445.891082178364, 5455.91816122758, 5466.59000574957, 5481.424450432707, 4329.87010389688, 5307.814226502073, 5344.4922732340365, 5419.458054194579, 5421.159720243369, 3849.653531182193, 3957.881263562098, 3983.780892050936, 4001.3794413262676, 4032.2741906456827, 3589.838457269429, 3604.6575575320303, 3994.6804255659476, 4061.6141466560775, 4074.164796216783, 3273.492608645664, 3630.4735813307057, 4037.878863634081, 4043.564534590222, 4050.392441133824, 3774.735768496206, 3972.7882995686305, 4058.3303754880408, 4059.706265959723, 4065.532463766675, 3029.12155474912, 3204.8943114625417, 3283.770136090475, 3475.5308033415417, 3531.4638132412224, 4665.5567721066445, 4874.0, 5166.225066240057, 5178.741062946838, 5198.778287102527, 4597.678162528624, 4632.3977882875015, 4649.1863923813535, 4651.465081515601, 4661.300804879262, 5382.59630527708, 5504.587155963279, 5574.191742197399, 5607.130894711327, 5611.691356975365, 3161.6996385343587, 3913.2760439318818, 3936.2717897188827, 3936.4095385692376, 3940.211957608461, 5565.526930210937, 5690.658560486384, 5821.359650438449, 5912.965231084543, 5940.584159108864, 3443.398819548922, 3753.324401607737, 3817.312883680964, 3982.6614737747036, 4017.4174744662446, 4086.3053280942313, 4088.7751173685137, 4101.466809314829, 4106.117184805281, 4111.773852438085, 4450.287953927356, 4680.559788555477, 4719.1033703596895, 4744.8885246065165, 4745.240761478147, 5535.640183388067, 5624.550035997192, 5675.914861277084, 5703.887741890291, 5729.742161602655, 1100.801855665988, 1183.5088438298183, 1284.5953524639708, 1368.9178649281075, 1383.3498255819748, 742.3170682971679, 744.6202436757293, 801.2588355770889, 804.3082948664144, 856.648774002656, 3868.570486792663, 4113.197926404382, 4372.179943936143, 4434.162136232813, 4466.888327791831, 3965.8810235692977, 4765.688641009107, 4774.4509381420885, 4843.4430040545785, 4851.51484851512, 3483.512308276843, 4058.5738497457933, 4161.583841615814, 4199.9370009449885, 4418.447694038246, 2366.6095094309244, 2437.3297343230397, 3045.9592073310937, 3083.856719579915, 3085.629724433082, 4929.637271015177, 5902.468777810018, 5960.910586341209, 5965.73154208053, 5971.373005834412, 4591.553660596901, 5640.520555752807, 6006.909896351558, 6043.123747056652, 6062.454379105901, 5634.7182640867795, 5678.659280443187, 5965.464677512126, 6001.159258074748, 6010.338862725097, 5566.858793947312, 5611.214429979725, 5825.563082768894, 5856.765729370777, 5863.006577763581, 4683.8360657376825, 5399.65221562618, 5567.526760225426, 5740.913886291625, 5773.595848290579, 5657.010023245998, 5817.0, 5817.680027598522, 5834.474897259267, 5888.146218798164, 3805.0867791729233, 3900.5124359455067, 3902.66827319681, 3917.942155618024, 3953.4465174874967, 4940.654154209315, 5244.423113457593, 5765.8558536036935, 5823.7379317931645, 5833.766649333979, 4705.247160454311, 4924.0, 5401.729913504388, 5645.322561292671, 5671.971640141938, 4203.516595591546, 5563.5271001963665, 5622.578306626938, 5626.718664066699, 5632.436756324335, 5236.790528378822, 5477.274658482725, 5500.367457742411, 5502.339719233558, 5509.421510741475, 5056.115179843439, 5546.278983732089, 5701.258836351248, 5754.309482862083, 5777.12243520849, 4835.516448355136, 5493.917591236055, 5622.662640241599, 5635.295588051494, 5667.518260947865], "value": 4027.959193728661, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.1442183801273, 722.6025685872769, 775.2557544757033, 801.8957535520382, 823.8311146215027, 15461.845381546194, 16287.267072981715, 16288.755668664979, 16321.347146114156, 16342.182890855454, 14629.464865891581, 14773.92613036936, 14789.186594737284, 14793.926030369834, 14861.256937153154, 671.9328067193265, 693.7814588404636, 695.8190870373714, 825.471698113208, 828.7969447485359, 846.0101681033206, 848.9193526614993, 863.9006514250848, 863.9049704532497, 865.8917635295588, 915.8717779510873, 917.206616276919, 918.9218916392115, 919.3564504846634, 919.3702313914956, 704.8097013806243, 730.4266151071383, 913.7943962608393, 915.4781774388601, 915.7756349694301, 636.7453018792473, 652.4649787174519, 654.1071437487794, 659.5646873063755, 664.0570390046146, 14872.107673539622, 14952.177630230333, 14997.550073497812, 15004.324805383783, 15010.774838377432, 13853.792193117111, 14042.297885105805, 14143.222122783243, 14214.147151170859, 14584.708305833823, 12754.80867786984, 12822.551210707674, 12829.807552886714, 13036.86963130366, 13159.934200328937, 4526.140033393644, 4560.179167749804, 4610.2854057621125, 4663.044075964419, 4690.038542098861, 125659.52277397018, 127562.0, 127671.7232827669, 127714.0, 128671.06993395013, 10790.51442685081, 11186.32882027081, 11240.269382490113, 11468.369239691898, 11708.356040417688, 22815.0, 22894.885525572266, 22932.0, 22947.967341469674, 22972.081116755144, 7805.726799561988, 7852.489588176751, 8029.518228906284, 8104.149064348277, 8177.591120443954, 4278.336857787048, 4350.434443522385, 4403.889902752393, 4428.3800267962515, 4548.681592288574, 3510.64893510652, 3625.8549658013385, 3626.9093272668392, 3627.0025742920907, 3627.7097832173363, 599.9520038396918, 606.97421357905, 656.0421784195033, 675.9019942108366, 712.7392180772881, 564.6217034586837, 572.3360901354409, 622.1134882792003, 677.7221339250883, 684.9452043836482, 8010.679572817138, 9557.665481708107, 9665.985071567526, 9722.222222222204, 9796.314258002014, 590.9468147866627, 622.3620788691537, 654.8624788794311, 672.0762213502844, 685.8456847209338, 4657.278121891112, 4826.493218212107, 4858.927116093261, 4875.7074575525585, 4878.940968274501, 97085.0, 97109.0, 97445.0, 160174.1991290036, 172395.0, 103681.0, 116071.0, 118267.0, 126757.0, 128495.0, 76470.0, 92465.37673116317, 102934.0, 109300.0, 110152.0, 9641.855372169563, 9815.509224538888, 9881.85177222328, 10070.194384449373, 10087.092161705188, 61908.0, 61970.591617461476, 62564.68717656383, 65057.69884602187, 65363.673181633785, 80646.0, 81117.0, 83099.0, 89710.55144724235, 90286.09713903039, 13330.333483325601, 13503.662408439868, 13600.97992650575, 13727.0, 14005.179326687465, 10933.83599246028, 14831.766081403797, 14890.181040042902, 15174.0, 15175.317110729822, 13626.386812593655, 13768.0, 14027.0, 14077.718445631235, 14253.35859886287, 13069.411876465392, 13849.79225311601, 14146.78779818324, 14268.072575282573, 14579.34392952341, 12275.324857132944, 13824.308784560531, 13826.0, 14131.222782747047, 14301.92849035748, 11219.326840389604, 11236.831447528457, 11497.942510287396, 11536.25014374063, 11707.180497365103, 9709.6116155353, 9831.655892043744, 10109.595616175271, 10198.541065651914, 11658.0], "value": 7862.654481857792, "unit": "score"}], "name": "dromaeo_css", "value": 7388.856505605122, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 111.0, 112.0, 111.0, 116.0, 164.0, 167.0, 121.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 111.0, 144.0, 112.0, 134.0, 140.0, 106.0, 140.0, 108.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 179.0, 186.0, 189.0, 183.0, 184.0, 185.0, 183.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 88.0, 62.0, 52.0, 74.0, 74.0, 111.0, 64.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 94.0, 71.0, 68.0, 69.0, 91.0, 67.0, 68.0, 88.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 132.0, 116.0, 87.0, 90.0, 87.0, 91.0, 87.0, 89.0, 86.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 83.0, 86.0, 84.0, 84.0, 113.0], "value": 87.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 51.0, 54.0, 55.0, 56.0, 54.0, 56.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 81.0, 76.0, 73.0, 73.0, 70.0, 71.0, 72.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 90.0, 75.0, 99.0, 95.0, 74.0, 96.0, 100.0, 107.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 145.0, 140.0, 133.0, 139.0, 133.0, 160.0, 177.0, 120.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 168.0, 168.0, 167.0, 170.0, 168.0, 167.0, 168.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 79.0, 89.0, 87.0, 68.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1464.6, "alertThreshold": 2.0}]} 15:57:09 INFO - Return code: 0 15:57:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:57:09 INFO - # TBPL SUCCESS # 15:57:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:57:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:57:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:57:09 INFO - 2016-09-21 15:57:09.692 screenresolution[1940:19959] starting screenresolution argv=screenresolution get 15:57:09 INFO - 2016-09-21 15:57:09.695 screenresolution[1940:19959] Display 0: 1600x1200x32@60 15:57:09 INFO - 2016-09-21 15:57:09.701 screenresolution[1941:19962] starting screenresolution argv=screenresolution list 15:57:09 INFO - Available Modes on Display 0 15:57:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:57:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:57:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:57:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:57:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:57:09 INFO - Intel Iris: 15:57:09 INFO - Chipset Model: Intel Iris 15:57:09 INFO - Type: GPU 15:57:09 INFO - Bus: Built-In 15:57:09 INFO - VRAM (Dynamic, Max): 1536 MB 15:57:09 INFO - Vendor: Intel (0x8086) 15:57:09 INFO - Device ID: 0x0a2e 15:57:09 INFO - Revision ID: 0x0009 15:57:09 INFO - Displays: 15:57:09 INFO - Display: 15:57:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:57:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:57:09 INFO - Display Serial Number: 1600x1200 60 15:57:09 INFO - Main Display: Yes 15:57:09 INFO - Mirror: Off 15:57:09 INFO - Online: Yes 15:57:09 INFO - Rotation: Supported 15:57:09 INFO - Return code: 0 15:57:09 INFO - Running post-action listener: _resource_record_post_action 15:57:09 INFO - [mozharness: 2016-09-21 22:57:09.935446Z] Finished run-tests step (success) 15:57:09 INFO - Running post-run listener: _resource_record_post_run 15:57:09 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 688128; Write bytes: 704879104; Read time: 9; Write time: 1921 15:57:09 INFO - TinderboxPrint: CPU usage
53.6% 15:57:09 INFO - TinderboxPrint: I/O read bytes / time
688,128 / 9 15:57:09 INFO - TinderboxPrint: I/O write bytes / time
704,879,104 / 1,921 15:57:09 INFO - TinderboxPrint: CPU idle
2,249.2 (46.4%) 15:57:09 INFO - TinderboxPrint: CPU system
973.4 (20.1%) 15:57:09 INFO - TinderboxPrint: CPU user
1,627.2 (33.6%) 15:57:09 INFO - TinderboxPrint: Swap in / out
405,876,736 / 0 15:57:09 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 384977408; Write bytes: 379794944; Read time: 29038; Write time: 703 15:57:10 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 679936; Write bytes: 296629248; Read time: 8; Write time: 1162 15:57:10 INFO - Running post-run listener: _upload_blobber_files 15:57:10 INFO - Blob upload gear active. 15:57:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:57:10 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 15:57:10 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:57:10 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:57:10 INFO - (blobuploader) - INFO - Open directory for files ... 15:57:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:57:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:57:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:11 INFO - (blobuploader) - INFO - Done attempting. 15:57:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:57:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:57:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:12 INFO - (blobuploader) - INFO - Done attempting. 15:57:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:57:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:57:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:15 INFO - (blobuploader) - INFO - Done attempting. 15:57:15 INFO - (blobuploader) - INFO - Iteration through files over. 15:57:15 INFO - Return code: 0 15:57:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:57:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:57:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf0bd03439a4950d984f5b5e8a59c7b6e65ea87bd0c25f13d008861683b13def2d29dfe3c63cd85ba2329f94322094b6160501ec998061f787d8969ffc4eb887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08614ebaecf73973967e47e8840e891e1d6b67cac9c28487a3c93d1dafba26ed4bd8d5c7fcaf7a011aa7976c3cb610c7a977c3f40ffc20d92b9c8a3a3513880e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d54031f74536d639bc5b3c05e93a9c29549bc6f0ab68221408588df23710b4a16eb9160f0d231b1d28c712fe5a1de37369e71a10e9a1b4b361b2aa0aaad1dbe3"} 15:57:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:57:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:57:15 INFO - Contents: 15:57:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf0bd03439a4950d984f5b5e8a59c7b6e65ea87bd0c25f13d008861683b13def2d29dfe3c63cd85ba2329f94322094b6160501ec998061f787d8969ffc4eb887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08614ebaecf73973967e47e8840e891e1d6b67cac9c28487a3c93d1dafba26ed4bd8d5c7fcaf7a011aa7976c3cb610c7a977c3f40ffc20d92b9c8a3a3513880e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d54031f74536d639bc5b3c05e93a9c29549bc6f0ab68221408588df23710b4a16eb9160f0d231b1d28c712fe5a1de37369e71a10e9a1b4b361b2aa0aaad1dbe3"} 15:57:15 INFO - Running post-run listener: copy_logs_to_upload_dir 15:57:15 INFO - Copying logs to upload dir... 15:57:15 INFO - mkdir: /builds/slave/test/build/upload/logs 15:57:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.377332 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-21 15:57:15.566596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:57:15.570022) ========= 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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/Fx-Team/sha512/cf0bd03439a4950d984f5b5e8a59c7b6e65ea87bd0c25f13d008861683b13def2d29dfe3c63cd85ba2329f94322094b6160501ec998061f787d8969ffc4eb887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08614ebaecf73973967e47e8840e891e1d6b67cac9c28487a3c93d1dafba26ed4bd8d5c7fcaf7a011aa7976c3cb610c7a977c3f40ffc20d92b9c8a3a3513880e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d54031f74536d639bc5b3c05e93a9c29549bc6f0ab68221408588df23710b4a16eb9160f0d231b1d28c712fe5a1de37369e71a10e9a1b4b361b2aa0aaad1dbe3"} build_url:https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/UzdjvJ9GTmWQEgs7TV99Ew/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf0bd03439a4950d984f5b5e8a59c7b6e65ea87bd0c25f13d008861683b13def2d29dfe3c63cd85ba2329f94322094b6160501ec998061f787d8969ffc4eb887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08614ebaecf73973967e47e8840e891e1d6b67cac9c28487a3c93d1dafba26ed4bd8d5c7fcaf7a011aa7976c3cb610c7a977c3f40ffc20d92b9c8a3a3513880e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d54031f74536d639bc5b3c05e93a9c29549bc6f0ab68221408588df23710b4a16eb9160f0d231b1d28c712fe5a1de37369e71a10e9a1b4b361b2aa0aaad1dbe3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:57:15.604283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:57:15.604673) ========= 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.6ov7zhcc4O/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.EY7A0Kvc2g/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005269 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:57:15.653851) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 15:57:15.654236) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 15:57:15.654662) ========= ========= Total master_lag: 0.19 =========