builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0164 starttime: 1477975042.72 results: success (0) buildid: 20161031192504 builduid: 571b25a594b04242b8802b541649ef78 revision: d9ce0a0617634b3d5d8fec265a394e4128df84c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.724979) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.725548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.725871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.753104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.753793) ========= 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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-10-31 21:37:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2016-10-31 21:37:22 (15.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145077 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.924745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.925177) ========= 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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.026113 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:22.976860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 21:37:22.977287) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9ce0a0617634b3d5d8fec265a394e4128df84c2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9ce0a0617634b3d5d8fec265a394e4128df84c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fbUwYHkIcw/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.pWcfCdMlIT/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-10-31 21:37:23,081 truncating revision to first 12 chars 2016-10-31 21:37:23,081 Setting DEBUG logging. 2016-10-31 21:37:23,082 attempt 1/10 2016-10-31 21:37:23,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9ce0a061763?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 21:37:24,055 unpacking tar archive at: mozilla-aurora-d9ce0a061763/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246459 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 21:37:24.271930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.272310) ========= script_repo_revision: d9ce0a0617634b3d5d8fec265a394e4128df84c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.272777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.273130) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:37:24.293166) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-31 21:37:24.293599) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fbUwYHkIcw/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.pWcfCdMlIT/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:37:24 INFO - MultiFileLogger online at 20161031 21:37:24 in /builds/slave/test 21:37:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:37:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:37:24 INFO - {'append_to_log': False, 21:37:24 INFO - 'base_work_dir': '/builds/slave/test', 21:37:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:37:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:37:24 INFO - 'branch': 'Mozilla-Aurora', 21:37:24 INFO - 'buildbot_json_path': 'buildprops.json', 21:37:24 INFO - 'config_files': ('talos/mac_config.py',), 21:37:24 INFO - 'default_actions': ('clobber', 21:37:24 INFO - 'read-buildbot-config', 21:37:24 INFO - 'download-and-extract', 21:37:24 INFO - 'populate-webroot', 21:37:24 INFO - 'create-virtualenv', 21:37:24 INFO - 'install', 21:37:24 INFO - 'run-tests'), 21:37:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:37:24 INFO - 'download_minidump_stackwalk': True, 21:37:24 INFO - 'download_symbols': 'ondemand', 21:37:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:37:24 INFO - 'tooltool.py': '/tools/tooltool.py', 21:37:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:37:24 INFO - '/tools/misc-python/virtualenv.py')}, 21:37:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:37:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:37:24 INFO - 'installer_path': 'installer.exe', 21:37:24 INFO - 'log_level': 'info', 21:37:24 INFO - 'log_name': 'talos', 21:37:24 INFO - 'log_to_console': True, 21:37:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:37:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:37:24 INFO - 'opt_config_files': (), 21:37:24 INFO - 'pip_index': False, 21:37:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:24 INFO - 'cmd': ('bash', 21:37:24 INFO - '-c', 21:37:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:24 INFO - 'enabled': True, 21:37:24 INFO - 'halt_on_failure': False, 21:37:24 INFO - 'name': 'check_screen_resolution'},), 21:37:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:24 INFO - 'cmd': ('bash', 21:37:24 INFO - '-c', 21:37:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:24 INFO - 'enabled': True, 21:37:24 INFO - 'halt_on_failure': False, 21:37:24 INFO - 'name': 'check_screen_resolution'},), 21:37:24 INFO - 'run_cmd_checks_enabled': True, 21:37:24 INFO - 'sps_profile': False, 21:37:24 INFO - 'sps_profile_interval': 0, 21:37:24 INFO - 'suite': 'dromaeojs', 21:37:24 INFO - 'system_bits': '32', 21:37:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:37:24 INFO - 'title': 't-yosemite-r7-0164', 21:37:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:37:24 INFO - 'use_talos_json': True, 21:37:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:37:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:37:24 INFO - 'work_dir': 'build'} 21:37:24 INFO - [mozharness: 2016-11-01 04:37:24.507841Z] Running clobber step. 21:37:24 INFO - Running pre-action listener: _resource_record_pre_action 21:37:24 INFO - Running main action method: clobber 21:37:24 INFO - rmtree: /builds/slave/test/build 21:37:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:37:26 INFO - Running post-action listener: _resource_record_post_action 21:37:26 INFO - [mozharness: 2016-11-01 04:37:26.622226Z] Finished clobber step (success) 21:37:26 INFO - [mozharness: 2016-11-01 04:37:26.622354Z] Running read-buildbot-config step. 21:37:26 INFO - Running pre-action listener: _resource_record_pre_action 21:37:26 INFO - Running main action method: read_buildbot_config 21:37:26 INFO - Using buildbot properties: 21:37:26 INFO - { 21:37:26 INFO - "project": "", 21:37:26 INFO - "product": "firefox", 21:37:26 INFO - "script_repo_revision": "production", 21:37:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:37:26 INFO - "repository": "", 21:37:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:37:26 INFO - "buildid": "20161031192504", 21:37:26 INFO - "pgo_build": "False", 21:37:26 INFO - "basedir": "/builds/slave/test", 21:37:26 INFO - "buildnumber": 64, 21:37:26 INFO - "slavename": "t-yosemite-r7-0164", 21:37:26 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:37:26 INFO - "platform": "yosemite_r7", 21:37:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:37:26 INFO - "branch": "mozilla-aurora", 21:37:26 INFO - "repo_path": "releases/mozilla-aurora", 21:37:26 INFO - "revision": "d9ce0a0617634b3d5d8fec265a394e4128df84c2", 21:37:26 INFO - "stage_platform": "macosx64", 21:37:26 INFO - "builduid": "571b25a594b04242b8802b541649ef78", 21:37:26 INFO - "slavebuilddir": "test" 21:37:26 INFO - } 21:37:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:37:26 INFO - Running post-action listener: _resource_record_post_action 21:37:26 INFO - [mozharness: 2016-11-01 04:37:26.625530Z] Finished read-buildbot-config step (success) 21:37:26 INFO - [mozharness: 2016-11-01 04:37:26.625664Z] Running download-and-extract step. 21:37:26 INFO - Running pre-action listener: _resource_record_pre_action 21:37:26 INFO - Running main action method: download_and_extract 21:37:26 INFO - mkdir: /builds/slave/test/build/tests 21:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:26 INFO - trying https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 21:37:27 INFO - Downloaded 1199 bytes. 21:37:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:27 INFO - Using the following test package requirements: 21:37:27 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:37:27 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:37:27 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:37:27 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'jsshell-mac.zip'], 21:37:27 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:37:27 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:37:27 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:37:27 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:37:27 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:37:27 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:27 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:37:27 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:37:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:37:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:37:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:37:28 INFO - Expected file size: 16421563 21:37:35 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 21:37:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:37:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:37:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:37:36 INFO - Expected file size: 16421563 21:37:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:37:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:37:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:37:43 INFO - Expected file size: 14414089 21:37:44 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')]} 21:37:44 INFO - trying https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 21:37:47 INFO - Downloaded 115422385 bytes. 21:37:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:47 INFO - mkdir: /builds/slave/test/properties 21:37:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:37:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:37:47 INFO - Contents: 21:37:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:47 INFO - Running post-action listener: _resource_record_post_action 21:37:47 INFO - Running post-action listener: set_extra_try_arguments 21:37:47 INFO - [mozharness: 2016-11-01 04:37:47.767977Z] Finished download-and-extract step (success) 21:37:47 INFO - [mozharness: 2016-11-01 04:37:47.768098Z] Running populate-webroot step. 21:37:47 INFO - Running pre-action listener: _resource_record_pre_action 21:37:47 INFO - Running main action method: populate_webroot 21:37:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:37:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:37:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:37:47 INFO - '--tppagecycles', 21:37:47 INFO - '7'], 21:37:47 INFO - 'tests': ['tsvgm']}}, 21:37:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:37:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:37:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:37:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:37:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['damp', 'tps']}, 21:37:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'tests': ['damp', 'tps']}, 21:37:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['dromaeo_dom']}, 21:37:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:37:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['basic_compositor_video']}, 21:37:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:37:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['a11yr', 21:37:47 INFO - 'ts_paint', 21:37:47 INFO - 'tpaint', 21:37:47 INFO - 'sessionrestore', 21:37:47 INFO - 'sessionrestore_no_auto_restore', 21:37:47 INFO - 'tabpaint']}, 21:37:47 INFO - 'other-e10s': {'tests': ['a11yr', 21:37:47 INFO - 'ts_paint', 21:37:47 INFO - 'tpaint', 21:37:47 INFO - 'sessionrestore', 21:37:47 INFO - 'sessionrestore_no_auto_restore', 21:37:47 INFO - 'tabpaint']}, 21:37:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:37:47 INFO - 'ts_paint', 21:37:47 INFO - 'tpaint', 21:37:47 INFO - 'sessionrestore', 21:37:47 INFO - 'sessionrestore_no_auto_restore', 21:37:47 INFO - 'tabpaint']}, 21:37:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:37:47 INFO - 'ts_paint', 21:37:47 INFO - 'tpaint', 21:37:47 INFO - 'sessionrestore', 21:37:47 INFO - 'sessionrestore_no_auto_restore', 21:37:47 INFO - 'tabpaint']}, 21:37:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['a11yr', 21:37:47 INFO - 'ts_paint', 21:37:47 INFO - 'tpaint', 21:37:47 INFO - 'sessionrestore', 21:37:47 INFO - 'sessionrestore_no_auto_restore', 21:37:47 INFO - 'tabpaint']}, 21:37:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['a11yr', 21:37:47 INFO - 'ts_paint', 21:37:47 INFO - 'tpaint', 21:37:47 INFO - 'sessionrestore', 21:37:47 INFO - 'sessionrestore_no_auto_restore', 21:37:47 INFO - 'tabpaint']}, 21:37:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['tsvgx', 21:37:47 INFO - 'tsvgr_opacity', 21:37:47 INFO - 'tart', 21:37:47 INFO - 'tscrollx', 21:37:47 INFO - 'cart']}, 21:37:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:37:47 INFO - 'tsvgr_opacity', 21:37:47 INFO - 'tart', 21:37:47 INFO - 'tscrollx', 21:37:47 INFO - 'cart']}, 21:37:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'talos_options': ['--disable-e10s'], 21:37:47 INFO - 'tests': ['tp5o']}, 21:37:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'tests': ['tp5o']}, 21:37:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'talos_options': ['--disable-e10s', 21:37:47 INFO - '--xperf_path', 21:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:47 INFO - 'tests': ['tp5n']}, 21:37:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:47 INFO - 'talos_options': ['--xperf_path', 21:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:47 INFO - 'tests': ['tp5n']}}, 21:37:47 INFO - 'talos.zip': {'path': '', 21:37:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:37:47 INFO - Running post-action listener: _resource_record_post_action 21:37:47 INFO - [mozharness: 2016-11-01 04:37:47.787092Z] Finished populate-webroot step (success) 21:37:47 INFO - [mozharness: 2016-11-01 04:37:47.787203Z] Running create-virtualenv step. 21:37:47 INFO - Running pre-action listener: _resource_record_pre_action 21:37:47 INFO - Running main action method: create_virtualenv 21:37:47 INFO - Creating virtualenv /builds/slave/test/build/venv 21:37:47 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 21:37:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:37:47 INFO - Using real prefix '/tools/python27' 21:37:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:37:48 INFO - Installing distribute.............................................................................................................................................................................................done. 21:37:51 INFO - Installing pip.................done. 21:37:51 INFO - Return code: 0 21:37:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:37:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:37:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:51 INFO - 'HOME': '/Users/cltbld', 21:37:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:51 INFO - 'LOGNAME': 'cltbld', 21:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:51 INFO - 'MOZ_NO_REMOTE': '1', 21:37:51 INFO - 'NO_EM_RESTART': '1', 21:37:51 INFO - 'PAGER': '/bin/cat', 21:37:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:51 INFO - 'PWD': '/builds/slave/test', 21:37:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:51 INFO - 'SHELL': '/bin/bash', 21:37:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:37:51 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:37:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:51 INFO - 'USER': 'cltbld', 21:37:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:51 INFO - 'XPC_FLAGS': '0x0', 21:37:51 INFO - 'XPC_SERVICE_NAME': '0', 21:37:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:51 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 21:37:51 INFO - Cleaning up... 21:37:51 INFO - Return code: 0 21:37:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:37:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:37:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:51 INFO - 'HOME': '/Users/cltbld', 21:37:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:51 INFO - 'LOGNAME': 'cltbld', 21:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:51 INFO - 'MOZ_NO_REMOTE': '1', 21:37:51 INFO - 'NO_EM_RESTART': '1', 21:37:51 INFO - 'PAGER': '/bin/cat', 21:37:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:51 INFO - 'PWD': '/builds/slave/test', 21:37:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:51 INFO - 'SHELL': '/bin/bash', 21:37:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:37:51 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:37:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:51 INFO - 'USER': 'cltbld', 21:37:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:51 INFO - 'XPC_FLAGS': '0x0', 21:37:51 INFO - 'XPC_SERVICE_NAME': '0', 21:37:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:52 INFO - Downloading/unpacking psutil>=3.1.1 21:37:52 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 21:37:52 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 21:37:52 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 21:37:52 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 21:37:52 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 21:37:52 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 21:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:55 INFO - Installing collected packages: psutil 21:37:55 INFO - Running setup.py install for psutil 21:37:55 INFO - building 'psutil._psutil_osx' extension 21:37:55 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 21:37:56 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 21:37:56 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 21:37:56 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 21:37:56 INFO - building 'psutil._psutil_posix' extension 21:37:56 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 21:37:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:37:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:37:56 INFO - ^ 21:37:56 INFO - 1 warning generated. 21:37:56 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 21:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:56 INFO - Successfully installed psutil 21:37:56 INFO - Cleaning up... 21:37:57 INFO - Return code: 0 21:37:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:57 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:37:57 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 21:37:57 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 21:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:57 INFO - 'HOME': '/Users/cltbld', 21:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:57 INFO - 'LOGNAME': 'cltbld', 21:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:57 INFO - 'MOZ_NO_REMOTE': '1', 21:37:57 INFO - 'NO_EM_RESTART': '1', 21:37:57 INFO - 'PAGER': '/bin/cat', 21:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:57 INFO - 'PWD': '/builds/slave/test', 21:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:57 INFO - 'SHELL': '/bin/bash', 21:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:37:57 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:57 INFO - 'USER': 'cltbld', 21:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:57 INFO - 'XPC_FLAGS': '0x0', 21:37:57 INFO - 'XPC_SERVICE_NAME': '0', 21:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:37:59 INFO - Installing collected packages: mozsystemmonitor 21:37:59 INFO - Running setup.py install for mozsystemmonitor 21:38:00 INFO - Successfully installed mozsystemmonitor 21:38:00 INFO - Cleaning up... 21:38:00 INFO - Return code: 0 21:38:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:00 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:38:00 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 21:38:00 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 21:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:00 INFO - 'HOME': '/Users/cltbld', 21:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:00 INFO - 'LOGNAME': 'cltbld', 21:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:00 INFO - 'MOZ_NO_REMOTE': '1', 21:38:00 INFO - 'NO_EM_RESTART': '1', 21:38:00 INFO - 'PAGER': '/bin/cat', 21:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:00 INFO - 'PWD': '/builds/slave/test', 21:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:00 INFO - 'SHELL': '/bin/bash', 21:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:00 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:00 INFO - 'USER': 'cltbld', 21:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:00 INFO - 'XPC_FLAGS': '0x0', 21:38:00 INFO - 'XPC_SERVICE_NAME': '0', 21:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:00 INFO - Downloading/unpacking jsonschema==2.5.1 21:38:00 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 21:38:00 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 21:38:00 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 21:38:00 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 21:38:00 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 21:38:00 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 21:38:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38:02 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 21:38:02 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 21:38:02 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 21:38:02 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 21:38:02 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 21:38:02 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 21:38:03 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:03 INFO - warning: no files found matching '*.txt' 21:38:03 INFO - no previously-included directories found matching 'build' 21:38:03 INFO - no previously-included directories found matching 'dist' 21:38:03 INFO - no previously-included directories found matching '.git*' 21:38:03 INFO - Installing collected packages: jsonschema, functools32 21:38:03 INFO - Running setup.py install for functools32 21:38:03 INFO - warning: no files found matching '*.txt' 21:38:03 INFO - no previously-included directories found matching 'build' 21:38:03 INFO - no previously-included directories found matching 'dist' 21:38:03 INFO - no previously-included directories found matching '.git*' 21:38:03 INFO - Successfully installed jsonschema functools32 21:38:03 INFO - Cleaning up... 21:38:03 INFO - Return code: 0 21:38:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:03 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:38:03 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 21:38:03 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 21:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:03 INFO - 'HOME': '/Users/cltbld', 21:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:03 INFO - 'LOGNAME': 'cltbld', 21:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:03 INFO - 'MOZ_NO_REMOTE': '1', 21:38:03 INFO - 'NO_EM_RESTART': '1', 21:38:03 INFO - 'PAGER': '/bin/cat', 21:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:03 INFO - 'PWD': '/builds/slave/test', 21:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:03 INFO - 'SHELL': '/bin/bash', 21:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:03 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:03 INFO - 'USER': 'cltbld', 21:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:03 INFO - 'XPC_FLAGS': '0x0', 21:38:03 INFO - 'XPC_SERVICE_NAME': '0', 21:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:03 INFO - Cleaning up... 21:38:03 INFO - Return code: 0 21:38:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:03 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:38:03 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 21:38:03 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 21:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:03 INFO - 'HOME': '/Users/cltbld', 21:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:03 INFO - 'LOGNAME': 'cltbld', 21:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:03 INFO - 'MOZ_NO_REMOTE': '1', 21:38:03 INFO - 'NO_EM_RESTART': '1', 21:38:03 INFO - 'PAGER': '/bin/cat', 21:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:03 INFO - 'PWD': '/builds/slave/test', 21:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:03 INFO - 'SHELL': '/bin/bash', 21:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:03 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:03 INFO - 'USER': 'cltbld', 21:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:03 INFO - 'XPC_FLAGS': '0x0', 21:38:03 INFO - 'XPC_SERVICE_NAME': '0', 21:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:04 INFO - Downloading/unpacking blobuploader==1.2.4 21:38:04 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 21:38:04 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 21:38:04 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 21:38:04 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 21:38:04 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 21:38:04 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 21:38:06 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:07 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 21:38:07 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 21:38:07 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 21:38:07 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 21:38:07 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 21:38:07 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 21:38:07 INFO - Downloading docopt-0.6.1.tar.gz 21:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:07 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:07 INFO - Running setup.py install for blobuploader 21:38:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:08 INFO - Running setup.py install for requests 21:38:08 INFO - Running setup.py install for docopt 21:38:08 INFO - Successfully installed blobuploader requests docopt 21:38:08 INFO - Cleaning up... 21:38:08 INFO - Return code: 0 21:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:08 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')]} 21:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:08 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')]} 21:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:08 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:38:08 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 21:38:08 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 21:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:08 INFO - 'HOME': '/Users/cltbld', 21:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:08 INFO - 'LOGNAME': 'cltbld', 21:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:08 INFO - 'MOZ_NO_REMOTE': '1', 21:38:08 INFO - 'NO_EM_RESTART': '1', 21:38:08 INFO - 'PAGER': '/bin/cat', 21:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:08 INFO - 'PWD': '/builds/slave/test', 21:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:08 INFO - 'SHELL': '/bin/bash', 21:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:08 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:08 INFO - 'USER': 'cltbld', 21:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:08 INFO - 'XPC_FLAGS': '0x0', 21:38:08 INFO - 'XPC_SERVICE_NAME': '0', 21:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-DHSYo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Ib3MsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-hn4Qne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-rHAsrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ODrl4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-bzUotB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-uz4B5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-DcwHeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:09 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-QHUShP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-PlnBj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Boyxvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-KvmtEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mpBGud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Uhin57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ls2dCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-FJyGvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:10 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-UZZrcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:10 INFO - Running setup.py install for manifestparser 21:38:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:11 INFO - Running setup.py install for mozcrash 21:38:11 INFO - Running setup.py install for mozdebug 21:38:11 INFO - Running setup.py install for mozdevice 21:38:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:38:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:11 INFO - Running setup.py install for mozfile 21:38:11 INFO - Running setup.py install for mozhttpd 21:38:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:11 INFO - Running setup.py install for mozinfo 21:38:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:11 INFO - Running setup.py install for mozInstall 21:38:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Running setup.py install for mozleak 21:38:12 INFO - Running setup.py install for mozlog 21:38:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Running setup.py install for moznetwork 21:38:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Running setup.py install for mozprocess 21:38:12 INFO - Running setup.py install for mozprofile 21:38:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Running setup.py install for mozrunner 21:38:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:12 INFO - Running setup.py install for mozscreenshot 21:38:13 INFO - Running setup.py install for moztest 21:38:13 INFO - Running setup.py install for mozversion 21:38:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:13 INFO - Cleaning up... 21:38:13 INFO - Return code: 0 21:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:13 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:38:13 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 21:38:13 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 21:38:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:13 INFO - 'HOME': '/Users/cltbld', 21:38:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:13 INFO - 'LOGNAME': 'cltbld', 21:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:13 INFO - 'MOZ_NO_REMOTE': '1', 21:38:13 INFO - 'NO_EM_RESTART': '1', 21:38:13 INFO - 'PAGER': '/bin/cat', 21:38:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:13 INFO - 'PWD': '/builds/slave/test', 21:38:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:13 INFO - 'SHELL': '/bin/bash', 21:38:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:13 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:13 INFO - 'USER': 'cltbld', 21:38:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:13 INFO - 'XPC_FLAGS': '0x0', 21:38:13 INFO - 'XPC_SERVICE_NAME': '0', 21:38:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:13 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ko6XFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:13 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)) 21:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:13 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-NYQToo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:13 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)) 21:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:13 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ik6GJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-sR3olb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Kc5pdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-5lgHyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Aj3CNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ClVvQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-kH5xdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-O8y1ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Jqah82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-riMZNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:14 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)) 21:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:14 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-gX7Tf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:15 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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:15 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-BRONAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:15 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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:15 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-METRM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:15 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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:15 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-LbsjeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:15 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)) 21:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:15 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-5FndmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:15 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)) 21:38:15 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)) 21:38:15 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)) 21:38:15 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)) 21:38:15 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)) 21:38:15 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)) 21:38:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38:15 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 21:38:15 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 21:38:15 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 21:38:15 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 21:38:15 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 21:38:15 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 21:38:18 INFO - Downloading blessings-1.6.tar.gz 21:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:38:18 INFO - Installing collected packages: blessings 21:38:18 INFO - Running setup.py install for blessings 21:38:18 INFO - Successfully installed blessings 21:38:18 INFO - Cleaning up... 21:38:18 INFO - Return code: 0 21:38:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:18 INFO - Reading from file tmpfile_stdout 21:38:18 INFO - Current package versions: 21:38:18 INFO - blessings == 1.6 21:38:18 INFO - blobuploader == 1.2.4 21:38:18 INFO - docopt == 0.6.1 21:38:18 INFO - functools32 == 3.2.3-2 21:38:18 INFO - jsonschema == 2.5.1 21:38:18 INFO - manifestparser == 1.1 21:38:18 INFO - mozInstall == 1.12 21:38:18 INFO - mozcrash == 0.17 21:38:18 INFO - mozdebug == 0.1 21:38:18 INFO - mozdevice == 0.48 21:38:18 INFO - mozfile == 1.2 21:38:18 INFO - mozhttpd == 0.7 21:38:18 INFO - mozinfo == 0.9 21:38:18 INFO - mozleak == 0.1 21:38:18 INFO - mozlog == 3.4 21:38:18 INFO - moznetwork == 0.27 21:38:18 INFO - mozprocess == 0.23 21:38:18 INFO - mozprofile == 0.28 21:38:18 INFO - mozrunner == 6.12 21:38:18 INFO - mozscreenshot == 0.1 21:38:18 INFO - mozsystemmonitor == 0.3 21:38:18 INFO - moztest == 0.7 21:38:18 INFO - mozversion == 1.4 21:38:18 INFO - psutil == 3.1.1 21:38:18 INFO - requests == 1.2.3 21:38:18 INFO - wsgiref == 0.1.2 21:38:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:18 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')]} 21:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:18 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')]} 21:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:18 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:38:18 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 21:38:18 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 21:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:18 INFO - 'HOME': '/Users/cltbld', 21:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:18 INFO - 'LOGNAME': 'cltbld', 21:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:18 INFO - 'MOZ_NO_REMOTE': '1', 21:38:18 INFO - 'NO_EM_RESTART': '1', 21:38:18 INFO - 'PAGER': '/bin/cat', 21:38:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:18 INFO - 'PWD': '/builds/slave/test', 21:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:18 INFO - 'SHELL': '/bin/bash', 21:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:18 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:18 INFO - 'USER': 'cltbld', 21:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:18 INFO - 'XPC_FLAGS': '0x0', 21:38:18 INFO - 'XPC_SERVICE_NAME': '0', 21:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 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)) 21:38:18 INFO - Cleaning up... 21:38:18 INFO - Return code: 0 21:38:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:38:18 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')]} 21:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:18 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')]} 21:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:18 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 0x10bfc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb30597720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, '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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 21:38:18 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 21:38:18 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 21:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:18 INFO - 'HOME': '/Users/cltbld', 21:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:18 INFO - 'LOGNAME': 'cltbld', 21:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:18 INFO - 'MOZ_NO_REMOTE': '1', 21:38:18 INFO - 'NO_EM_RESTART': '1', 21:38:18 INFO - 'PAGER': '/bin/cat', 21:38:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:18 INFO - 'PWD': '/builds/slave/test', 21:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:18 INFO - 'SHELL': '/bin/bash', 21:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:18 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:18 INFO - 'USER': 'cltbld', 21:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:18 INFO - 'XPC_FLAGS': '0x0', 21:38:18 INFO - 'XPC_SERVICE_NAME': '0', 21:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:38:19 INFO - Cleaning up... 21:38:19 INFO - Return code: 0 21:38:19 INFO - Running post-action listener: _resource_record_post_action 21:38:19 INFO - Running post-action listener: _start_resource_monitoring 21:38:19 INFO - Starting resource monitoring. 21:38:19 INFO - [mozharness: 2016-11-01 04:38:19.224611Z] Finished create-virtualenv step (success) 21:38:19 INFO - [mozharness: 2016-11-01 04:38:19.225583Z] Running install step. 21:38:19 INFO - Running pre-action listener: _resource_record_pre_action 21:38:19 INFO - Running main action method: install 21:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:19 INFO - Reading from file tmpfile_stdout 21:38:19 INFO - Detecting whether we're running mozinstall >=1.0... 21:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:38:19 INFO - Reading from file tmpfile_stdout 21:38:19 INFO - Output received: 21:38:19 INFO - Usage: mozinstall [options] installer 21:38:19 INFO - Options: 21:38:19 INFO - -h, --help show this help message and exit 21:38:19 INFO - -d DEST, --destination=DEST 21:38:19 INFO - Directory to install application into. [default: 21:38:19 INFO - "/builds/slave/test"] 21:38:19 INFO - --app=APP Application being installed. [default: firefox] 21:38:19 INFO - mkdir: /builds/slave/test/build/application 21:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 21:38:51 INFO - Reading from file tmpfile_stdout 21:38:51 INFO - Output received: 21:38:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:38:51 INFO - Running post-action listener: _resource_record_post_action 21:38:51 INFO - [mozharness: 2016-11-01 04:38:51.944776Z] Finished install step (success) 21:38:51 INFO - [mozharness: 2016-11-01 04:38:51.944922Z] Running run-tests step. 21:38:51 INFO - Running pre-action listener: _resource_record_pre_action 21:38:51 INFO - Running main action method: run_tests 21:38:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:38:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:38:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:38:51 INFO - 2016-10-31 21:38:51.959 screenresolution[1645:8873] starting screenresolution argv=screenresolution get 21:38:51 INFO - 2016-10-31 21:38:51.962 screenresolution[1645:8873] Display 0: 1600x1200x32@60 21:38:51 INFO - 2016-10-31 21:38:51.968 screenresolution[1646:8875] starting screenresolution argv=screenresolution list 21:38:51 INFO - Available Modes on Display 0 21:38:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:38:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:38:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:38:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:38:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:38:52 INFO - Intel Iris: 21:38:52 INFO - Chipset Model: Intel Iris 21:38:52 INFO - Type: GPU 21:38:52 INFO - Bus: Built-In 21:38:52 INFO - VRAM (Dynamic, Max): 1536 MB 21:38:52 INFO - Vendor: Intel (0x8086) 21:38:52 INFO - Device ID: 0x0a2e 21:38:52 INFO - Revision ID: 0x0009 21:38:52 INFO - Displays: 21:38:52 INFO - Display: 21:38:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:38:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:38:52 INFO - Display Serial Number: 1600x1200 60 21:38:52 INFO - Main Display: Yes 21:38:52 INFO - Mirror: Off 21:38:52 INFO - Online: Yes 21:38:52 INFO - Rotation: Supported 21:38:52 INFO - Return code: 0 21:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:38:52 INFO - Python 2.7.3 21:38:52 INFO - Return code: 0 21:38:52 INFO - grabbing minidump binary from tooltool 21:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:52 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 0x10bdd7d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdcfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:38:52 INFO - Return code: 0 21:38:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:38:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:38:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:38:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:38:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 21:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0164 --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 21:38:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fbUwYHkIcw/Render', 21:38:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:52 INFO - 'HOME': '/Users/cltbld', 21:38:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:52 INFO - 'LOGNAME': 'cltbld', 21:38:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:38:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:52 INFO - 'MOZ_NO_REMOTE': '1', 21:38:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:38:52 INFO - 'NO_EM_RESTART': '1', 21:38:52 INFO - 'PAGER': '/bin/cat', 21:38:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:52 INFO - 'PWD': '/builds/slave/test', 21:38:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:38:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:52 INFO - 'SHELL': '/bin/bash', 21:38:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWcfCdMlIT/Listeners', 21:38:52 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:52 INFO - 'USER': 'cltbld', 21:38:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:52 INFO - 'XPC_FLAGS': '0x0', 21:38:52 INFO - 'XPC_SERVICE_NAME': '0', 21:38:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 21:38:52 INFO - mozversion application_buildid: 20161031192504 21:38:52 INFO - mozversion application_changeset: d9ce0a0617634b3d5d8fec265a394e4128df84c2 21:38:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:38:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:38:52 INFO - mozversion application_name: Firefox 21:38:52 INFO - mozversion application_remotingname: firefox-dev 21:38:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:38:52 INFO - mozversion application_vendor: Mozilla 21:38:52 INFO - mozversion application_version: 51.0a2 21:38:52 INFO - mozversion platform_buildid: 20161031192504 21:38:52 INFO - mozversion platform_changeset: d9ce0a0617634b3d5d8fec265a394e4128df84c2 21:38:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:38:52 INFO - mozversion platform_version: 51.0a2 21:38:52 INFO - using testdate: 1477975132 21:38:52 INFO - actual date: 1477975132 21:38:52 INFO - starting webserver on 'localhost:49273' 21:38:52 INFO - SUITE-START | Running 2 tests 21:38:52 INFO - TEST-START | dromaeo_css 21:38:52 INFO - operating with platform_type : mac_ 21:38:52 INFO - Initialising browser for dromaeo_css test... 21:38:52 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpnlZ5gT/profile http://localhost:49273/getInfo.html) 21:38:54 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 21:38:54 INFO - PROCESS | 1656 | colorDepth:24 21:38:54 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 21:38:54 INFO - PROCESS | 1656 | __metrics 21:38:55 INFO - PROCESS | 1656 | 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" 21:38:55 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:38:55 INFO - TEST-INFO | 1656: exit 0 21:38:55 INFO - Browser initialized. 21:38:55 INFO - Running cycle 1/1 for dromaeo_css test... 21:38:55 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpnlZ5gT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:07 INFO - PROCESS | 1659 | RSS: Main: 219820032 21:39:07 INFO - PROCESS | 1659 | 21:40:02 INFO - PROCESS | 1659 | 1477975202695 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] 21:42:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 21:42:13 INFO - PROCESS | 1659 | RSS: Main: 413310976 21:42:13 INFO - PROCESS | 1659 | 21:45:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 21:45:17 INFO - PROCESS | 1659 | RSS: Main: 349138944 21:45:17 INFO - PROCESS | 1659 | 21:48:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 21:48:19 INFO - PROCESS | 1659 | RSS: Main: 324509696 21:48:19 INFO - PROCESS | 1659 | 21:51:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 21:51:22 INFO - PROCESS | 1659 | RSS: Main: 319086592 21:51:22 INFO - PROCESS | 1659 | 21:54:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 21:54:26 INFO - PROCESS | 1659 | RSS: Main: 310427648 21:54:26 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 21:57:29 INFO - PROCESS | 1659 | RSS: Main: 357326848 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | __start_tp_report 21:57:29 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 21:57:29 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 21:57:29 INFO - PROCESS | 1659 | |i|pagename|runs| 21:57:29 INFO - PROCESS | 1659 | |0;dojo.html;3304.9339013219737;3308.818015009175;3354.966450335496;3378.3918894598964;3381.0364046246823;5667.291588551431;5756.481916627513;5782.450667186621;5790.36306006339;5854.238948936643;5725.370209276986;5780;5802.100674395476;5803.593748437611;5814.825555233349;5221.373435187783;5271.551918086967;5292.550133238679;5292.947070529303;5335.093034184179;5201;5204.739763011834;5209.088409528336;5332.600054995872;5342.786288548454;5328.600354973373;5331.360236771573;5331.866703332428;5337.626366154371;5339.786408543654;5251.054810134175;5303.7082960437165;5304.443033481487;5313.043652142613;5317.680939143625;5200.115980283361;5204.661696989683;5218.139007063868;5222.686638801646;5314.97342513285;5815.767369305223;5856.531477481792;5907.02534081876;5920.171176035358;5954.851128721816;5687.232223649796;5885.558583106242;6142.744345496893;6145.170401995718;6167.87664246717;6223.097650840603;6257.5619706620555;6279.654618995954;6292.590981586228;6325.557210995232;5387.973060134675;5414.431484694129;5824.88350232993;5837.88324233513;5851.356350801409;6167.352427995085;6240.469560087353;6258.843528911813;6286.277078135981;6299.905501417483;5188.351456067991;6149.754009839646;6220.906686399708;6227.408396202353;6233.3143354231;6265.373462653789;6279.968600157062;6300.401461861115;6302.086197501337;6320;6120.326764055951;6149.5080393568405;6256.061590761331;6295.96852015737;6346;6177.444030037318;6189.597676151126;6255.812325630239;6263.6241825490615;6273.905891411632;4975.427825800007;4987.276844857548;5003;5007.223880298559;5012.348394708664;4394.846180383671;4410.647148228134;4411.117776444724;4439.955600443955;4446.82212711488;5597.944020559742;5695.886082278331;5746.9712651436475;5781.248437703071;5804.709764511757;6201.10084037812;6254.843628909313;6271.592346497463;6286.748530058838;6476.805695829133;5795.565332600072;5801.622894511843;5814.738336774855;5817.854553636193;5857.326407463196;5396.271503347077;5454.345478542521;5471.5896307777075;5472.288602481652;5485.698286594195;6289.182406287154;6289.40250676185;6293.056041593798;6342.302346741947;6353.459955903615;6233.563650544418;6241.21984751906;6255.218097737783;6255.843603909757;6256.812295631138;6336.239651241881;6343.207099112611;6382.106505089384;6382.521310901608;6391.456726178327;5979.910301345396;6039.667818270037;6083.908741368971;6090.421409966046;6136.88672321611;6159.137720719193;6252.249730032243;6261.874762504815;6296.992481202986;6348.619082855043;5582.720863956704;5891.852703682443;6176.81469555914;6177.96911015442;6181.505479561534;6081.118237855575;6129.693515324127;6144.1398204250545;6171.537134714825;6173.753049878134;5808.186853840381;5869.383714709894;5870.442307980735;5876;5896.882062358814;6135.631862088289;6143.32423433413;6144.047672610753;6150.692465376803;6153.2616086068165;5783.595148339576;5799.2750906136735;5854.619449735754;5862.384449632727;5916.881662366814 21:57:29 INFO - PROCESS | 1659 | |1;ext.html;494.7680276112479;499.2162305180868;510.3416592595552;516.7571241516488;535.9946400535994;31088;42239.78880105599;42387.576124238825;42391.36412953808;44616.330755038616;43988.78005609968;44008;44285.557144428545;44351;44387.334189987174;8764.956175219148;9899.010098990097;10082.495875206247;10089.041541053588;10090.646827361044;8879.600417981206;12144.149909506337;12442.875571244262;12457;12617.495300187982;12289.446974886107;12359.567415140427;12369.443375048144;12374.319412432313;12411.875881241162;8892.244159246407;12359.752804943895;12444.128910976235;12449.937750311281;12466.189697669713;8725.258353039999;11998.58004969822;12352.320622365767;12366.938165309206;12534.874651253462;41896.79051604722;42239.78880105611;42319.788401058104;42323.36514952278;42405.93985150396;3264.7061764441314;3299.934001319984;3330.5170750241077;3345.8996230113135;3666.6353025073286;30559.08322750321;31803.84098079518;31907;32340.191495212573;32583.185420364443;3189.728873045794;3215.099772063826;3292.6378098409155;3299.406106900757;3345.866165353383;509029;510661;511309.9999999963;511601;511862;63673.68163159154;64181;64228.67885660542;64325.67837160784;64353.71292574122;34929.65070349264;35814.3883525242;35818.82090589531;36344.09139771474;36826.63173368232;17003.979761214367;17127;17192.22634981429;17207.913960430116;17265.309387624355;11906.166568340133;12180.939095304468;12183.086268529718;12992.220466771834;13190.538331158363;19341.362606106428;20229.898850505655;20272.797272027386;20356.69464958027;20360.89819550893;6438.452731517874;7656.502327348704;7665.846683066307;7672.38620910337;7718.0738311401865;872.5898827551041;995.3629677006721;1028.3829702178632;1040.287403128859;1053.004910359718;30590.541141882888;30735.846320768254;30765.538516922265;31348;31560.526592101138;1090.569225156059;1106.0653747583278;1112.260346869339;1178.2223732336618;1192.6958625550428;13591.796123058162;15624.218789060502;16115.172534244773;16375.707400963875;17120;711090;714712;715998;716596;717190;59658.70170649119;60227.698861505414;60314;60369;60429.39570604238;1249.2941488059218;1273.8853503184944;1365.0853927868154;1381.647679841654;1395.1141025448912;26283.737162628127;30195.396092077597;31816.840915795274;32145.678543214268;32397;51355.48644513507;51873.740631296605;51980.48019519756;52031.69920752011;52071.218931716816;569758;573135;573137;573854.2614573968;575295;26988.59517107206;27771.861140694167;27821.582676259466;28623.14130576086;28694.56958145671;47744.2838357418;48304.2754358692;48381.7904552389;48528.27207591818;48887;39947.20369574102;40231.59768402279;40465.59534404736;42044.5284415044;42163.578364215966;39874;40203;40250.59749402468;41744;41783.164336712485;38431.231375372896;38683;39032.2193556133;39102.63140790059;39424.40863387109;33247.66752332543;35117.946461606196;35674.28651427009;35886.28227435489;35925.461118083775;25711.357216069748;26109.73890261149;26120.60819087753;26325.9469621213;26606.86696566505 21:57:29 INFO - PROCESS | 1659 | |2;jquery.html;328.32856807827994;354.40990750400584;356.2109926512774;369.7079307347196;409.4308910614247;15172.468963586276;15339.53981380559;16205.189740512971;20901.477463063395;21280.787192128075;20073.498162545944;20619.69070463944;21244.787552124475;21254.57490850182;21491.892540537276;4785;5941.999999999989;6057.666828324441;6199.597026193283;6201.0388389799655;6146.354632763562;6178.320384757673;6228.252609686844;6244.344343843899;6249.625022498642;5875.735591898353;6044.922265297149;6075.270967483908;6123.448889599935;6188.226471691039;6045.758169673208;6096.1770161028135;6100.938990610081;6108.541859360521;6118.082287656843;5211.088059589594;5287.524122828964;5434.565234781247;5474.233607294982;5561.165825126223;12430.011198208244;12988.155769874928;13112.606621801362;13204.867951320555;13229.470821167142;2184.6286131357547;2278.1798552521077;2405.230326295586;2429.4290841652196;2970.064429704658;10211.79576408475;10293.897061029444;10327.79344413115;11019.614313499069;16070.196490175444;1774.1395423219728;1831.0844577711143;1867.6544839204792;1879.5207222158263;1897.990510047441;116414;120124.79875201311;130980;131039;133897;9543.711598934195;11376.829347559793;11613.187076904704;11695.239809412362;11703.180777345675;13343.266120363473;13452.19286842773;14649;14683.412663493555;14719.779203311744;7541.019667443307;8212.917870821215;8726.650933962697;8774.473531587997;8878.689245876492;8697.260732837653;8712.172343627471;8747.737567872973;8872.290216782641;8879.733607991642;4479.283314669702;4566.109608626352;4588.77056147198;4593.908121837545;4656.4877863434995;1609.9275532601062;1648.9422870199485;1877.2772482594025;1900.5248687828043;1917.118125662183;837.660747397305;908.52756566585;914.5838643417229;975.5024937282037;980.9215262778961;20957;21058.684119738216;21136.731796092285;21394.251201208193;21429.640195912067;850.2220468271586;903.2954295649404;936.424099179;937.3579098317674;1008.1229330482527;10660.733481663021;11088.94655007773;11135.05352045069;11231.15766317513;11291.604793832177;613517;621294.3611691657;626476;627262;628881;113581;119753;122276.5544689119;136211.31894340663;138170.6182938158;847.7160151349367;949.5916755794937;983.3902980152351;984.4487087231173;984.5126662302063;16384.098874562012;16850.9889406636;18812.24751009944;18880.52798680044;18949.650782865923;55928.48321825446;56862;58510.414895850496;58585;58833.41166588279;78983.60508197422;82758.58620707098;84366;86443.13556864351;86551;8000;8137.226963438464;8202.343812495106;8441.788955276168;8489.660413583388;11683.707907302385;12480.940644793507;12512.812307815571;12934.094613376974;13020.348982550646;10994.450277485934;11000.559977600806;11030.558777649125;11282.605108821152;11360.091192704398;10676;10778.784424311312;10877.891221087688;10906.072983796466;10983.505742241778;10768.676939691823;10854.45727713627;10887.23789334739;10958.726031848948;11268.887311126784;7775.6112194388925;8013.559254241072;8021.759347219593;8030.5181689098845;8069.59652017385;8770.298376130022;10961.616343427942;10998.285111467729;11038.951299626522;11083.944580277048 21:57:29 INFO - PROCESS | 1659 | |3;mootools.html;1173.765246950609;1394.8186735724355;1531.4563330017843;1716.1590820497959;1901.6957286834102;7906.209379062091;8410.243078122967;8471.364647651428;8815.338849586275;8821.603027863746;8496.745097647081;8788.604512796923;8790.91209087909;8798.944126704788;8810.986736525301;2327.1389585853217;2378.0368950575044;2380.214529205367;2380.95238095238;2381.583222935988;2335.2293743064747;2372.0511795281855;2376.3346263046374;2377.8335516513853;2378.7978021868075;2339.801116905065;2350.6003979323473;2355.187460326185;2372.063035101134;2374.6794182785275;2324.4886125052462;2356.8350215484925;2357.068957761683;2357.669926210332;2368.7749663781915;2325.6627788970673;2335.2760644200184;2349.0016742884204;2349.2130136404326;2359.433735903388;8752.649894004233;8855.601497932608;8869.645214191425;8879.378443508956;8884.933807943024;5279.551238144724;5450.4549545045575;5458.8908221835345;5495.917561236584;5503.972480137573;3602.225521512861;3623.4564815277654;3649.069487280753;3694.11341278094;3694.833732482045;1098.5715570927346;1099.115212254135;1100.2518287564453;1121.44488478203;1124.0670243697712;11612.535498580046;11629.825552616718;11750;11756.823647645293;11757.823632645517;3628.63713628635;4644.7213167210075;4684.203685373494;4866.075445665312;4888.9755551222015;10153.847692284622;10154.746131346776;10155.949220253851;10166.085052345177;10183.981601839756;5429.104197807396;5431.158170483582;5433.538149257279;5440.863978400493;5441.401445840955;4332.978335108304;4465.441819772528;4515.1195516873895;4603.677742558056;4960.652754307164;3321.3689399014593;4062.7765472899273;4074.796260186979;4107.630313271819;4135.152293779768;1261.1802328486374;1279.2196759976407;1290.5999140266547;1298.8181654568368;1310.6330227536305;820.7688467299051;863.8661007543841;897.3314880414133;922.9769255768525;939.7885475768035;5622.775088996476;5725.255716756878;6033.215681961317;6128.632282063001;6236.251649802053;445.4076078815168;454.470541818784;457.04249597094037;977.8533220017055;1010.7062959411818;3626.9455958160647;3912.4522566840665;3931.66580840626;3965.4646622705563;4025.0138716014762;10782.46087695612;10854.86023967488;10982.615608453825;11006.95433933791;11020.834687479693;10554.630587929385;10666.253362264568;10961.451927403597;10987.890121098846;11008.889911100947;6811.4550835933005;8204.917950820534;8409.873851892227;8419.158084191531;8432.24109830106;5976.432238937294;5999.250093738283;6052.6973651316375;6117.84705382369;6289.150964619717;9496.85754713666;9538.23694104484;9634.13292803651;9712.02879712023;10237.9488102559;8611.48331100136;9506.382085164441;10115;10490.947545262225;10533.894661053599;6852.760153394607;7058.364747172779;7242.348188663045;7653.540787552764;7677.232276772278;8272.586370681562;8311.875321870297;8379.832403351777;8425.87361189595;8438.367122465963;7487.47587668858;7511.737089201852;7549.9245007549225;7578.734744283924;7579.621018949141;7246.818829529304;7410;7419.851602968019;7461.589612571361;7581.203973582915;6948.513604047668;6977.720891164499;7059.682314295766;7062.540934839219;7073.045138906182;4889.266610008527;4897.5592196701045;4922.950770492393;5059.848204553869;5171.095058364695;5001.24981252815;5017.2724954880605;5114.846554603368;5241.659292145999;5285.788568457218 21:57:29 INFO - PROCESS | 1659 | |4;prototype.html;304.963404391473;310.917606834189;312.8513955870961;316.4051583023916;320.76263564961937;5283.365996080466;5310;5318.601104917137;5362.249285100089;5408.67547947123;4198.5801419858;4387.934180987288;5308.522232999029;5328.110479350077;5333.226682131089;3501.3172431375892;3518.5074089627474;3871.3999330103807;3903.906906066292;3947.782871942042;4096.139810639755;4120.526139493952;4124.154548317588;4132.347061175539;4161.625453709165;3349.1961929137074;3686.115332320237;3759.398496240602;4067.2272268268935;4069.633732964033;3547.5920269168987;3962.643362097425;4088.7546747195265;4096.877093687209;4105.651019663333;3572.2498275362204;3575.2670702505925;3575.9642403576154;3576.8911637392494;3587.1840605124853;5205.590338328401;5213.400458947193;5229.921551176735;5230.110881150214;5235.764390602432;3755.0762611085684;4663.417072865892;4702.882427939295;4712.69367491112;4721.976390118062;4657.346641942096;5121.257417674454;5571.879747341502;5611.859703507404;5620.634658747168;3939.72421930465;3942.1918506706056;3948.4866967294356;3953.1303113315025;3953.6046395360236;4592.576301346593;5641.407652196543;5871.442212989759;5903.645781253139;5938.703064846741;3272.49654014679;3783.621637836194;4009.1781184857036;4022.8018725113607;4089.89775255621;3245.6105267367593;3389.5932488101093;3581.6418358163974;4058.1680755445063;4066.6543343816106;4708.788104535304;4710.9764451177525;4731.33761273422;4738.763061846894;4750.192467280571;5045.48635409383;5068.23976403535;5451.591130665216;5644.8306550803545;5653.604247702704;1202.9534305154398;1394.8562179013315;1395.3372148229712;1397.9930100349434;1398.9090709103875;753.5554023126382;829.7344849648175;840.6675419460101;852.8976522817302;856.9271611913057;5003.299538064601;5133.563647089964;5205.954516607751;5210.0983141153965;5232.383808095952;4917.803287868445;5590.608657393944;5745;5766.646182132463;5856.828634273163;4084.387341898739;4483.461984561874;4908.779104940286;5052.393712754493;5292.2800089970915;2583.302508322742;2702.9594556081674;2832.745052945245;2859.5710643403654;2899.594056832045;5060.822871199491;5730.713464326767;5948.345681974979;6019.939800601938;6098;5214.97392513035;5486.396496385394;5841.50347220491;5960.284765828128;6020.157177995085;5527.55779537636;6031.638101713911;6048.818535443944;6065.969670151621;6111.84720381994;4955.603551715926;4997.600191984705;5337.292066538826;5864.794732184353;5869.383714709894;4812.302216178565;5082.567981721447;5528.650323612529;5765.962126817213;5798.391168927202;5031.597472202142;5740.942590574208;6045.274567051982;6058.4850287724275;6113.930062239001;2933.0614203455543;2990.222542139016;3429.6741809528053;3446.9310613788084;3448.7583071004046;4208.4428761358495;4218;4358.716683415568;4866.1727506323305;4942.75286235694;4494.179947044986;4640.3735495709;4734.981978874558;4765.547273009059;4782.473927868002;4163.417121603038;4299.935500967551;4452.708714472767;4803.327534145153;4840.959193773356;4518.6385089193445;5677.687727175045;5685.857853553694;5692.943070569241;5711.343195532567;5481.698506582176;5602.467765562265;5665.603407761417;5715.485396370049;5826.338928856813;4536.931946020746;5577.414371490935;5624.35319938196;5660.207570940154;5683.749575093473 21:57:29 INFO - PROCESS | 1659 | |5;yui.html;702.7645738677546;744.8547533231018;756.2815325440832;784.8979632647756;790.1545346479268;15183.468578599752;16142.919285403586;16154.434594789185;16164.757528637065;16357.427490037851;14579.854201457982;14731.779023314659;14747.188904610242;14755.704885902276;14764.187969661665;678.1794029224644;695.1310861423221;832.9541875196862;833.9666413343474;864.3819668936709;854.0136142755127;858.1761508951414;863.016161575801;864.0883867519796;868.0061329777401;901.04489241404;902.025812122909;902.9503377314245;903.1420150856679;903.6746771162376;702.3959394920364;724.7499612633633;794.376414514609;854.7350321400355;896.6951236579562;653.2748648999655;674.3660958698856;675.3449154320301;676.9695363708645;677.11298199359;15007.699846003019;15060.472883449136;15081.849181508263;15090.17004064776;15095.773563396559;13474.528391506348;13811.585652430444;13819.723605527834;13968.301584920815;14047.22740249286;11851.822222666668;12312.569060082855;12363.752724945542;12456.564020259339;12628.621141365773;4328.48058233014;4494.235979883428;4575.679702420832;4630.421197350332;4696.7651617419;120666.3966680161;120877.18684219744;121810.39094804558;123395;126932.73067269394;10435.426051567085;10890.346579205274;10948.39783811882;11020.118390528738;11052.668419947415;21319;21449.356519304445;21527.246546370803;21568;21680.67478987785;6548.738050478023;7876.369890408753;7879.803004924923;8034.919650803417;8115.472494287852;4107.856225032109;4196.916061678749;4198.475190601175;4247.66018718508;4259.318509038539;3307.68576985186;3403.3873902697255;3405.7786243894066;3406.437937740245;3406.9659303407143;624.09506215987;636.6593872278308;638.237306418825;641.2945759664332;659.7690808217181;465.5670226689144;607.738672370876;614.7049416280211;623.2520974830222;624.194788722552;8219.8356032879;8717.389782715276;8889.688860889837;9091.81816363669;9173.312001599774;582.6562328226282;599.868029033612;601.5939241012387;611.1077826373545;630.3098107572201;4124.505059392892;4284.293091639907;4300.89247768802;4342.305231162999;4389.604935555815;93888.53055734678;94020;135874;160156;170215;122472.38763806123;123659;125637;127632;135422;109969.90030099597;112702.30946535809;113213.43393283145;114236.42881785538;116914;7870.527768333689;7891;7893.960530197312;8334.333253339597;8393.538355390512;62724.68401858384;63796.3620363809;65421;65476;66308.33691663021;95137.524312378;100132.49933750577;101403.49298253462;103363.96636033543;104578;11117.11063114965;11303.830442543533;11333.26333788301;11486.712832178928;11735.882641173479;11895.762084758084;11946.701332466759;11970.820437693268;12544.623661290176;12623.305718185587;11047.944760276147;11200;11994.880051199725;12174.513019479122;12273.69315767113;11732;11735.295882247092;11818.82271765907;11824.940875295913;11946.98450631706;10863.348199108079;11270.661880143609;11387.829182562435;11537.653870383901;11981.400929953641;9180.219681327162;9328.440293582407;9786.1192492676;9821.165200958;9850.901490984998;9551.188149007134;9989.300748947504;10041.698749037248;10076.244281678757;10165.44090075053 21:57:29 INFO - PROCESS | 1659 | __end_tp_report 21:57:29 INFO - PROCESS | 1659 | __start_cc_report 21:57:29 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2039 21:57:29 INFO - PROCESS | 1659 | __end_cc_report 21:57:29 INFO - PROCESS | 1659 | __startTimestamp1477976249868__endTimestamp 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | ------- Summary: start ------- 21:57:29 INFO - PROCESS | 1659 | Number of tests: 6 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5761.33 Median:5876.00 stddev:632.56 (10.8%) stddev-sans-first:604.43 21:57:29 INFO - PROCESS | 1659 | Values: 3304.9 3308.8 3355.0 3378.4 3381.0 5667.3 5756.5 5782.5 5790.4 5854.2 5725.4 5780.0 5802.1 5803.6 5814.8 5221.4 5271.6 5292.6 5292.9 5335.1 5201.0 5204.7 5209.1 5332.6 5342.8 5328.6 5331.4 5331.9 5337.6 5339.8 5251.1 5303.7 5304.4 5313.0 5317.7 5200.1 5204.7 5218.1 5222.7 5315.0 5815.8 5856.5 5907.0 5920.2 5954.9 5687.2 5885.6 6142.7 6145.2 6167.9 6223.1 6257.6 6279.7 6292.6 6325.6 5388.0 5414.4 5824.9 5837.9 5851.4 6167.4 6240.5 6258.8 6286.3 6299.9 5188.4 6149.8 6220.9 6227.4 6233.3 6265.4 6280.0 6300.4 6302.1 6320.0 6120.3 6149.5 6256.1 6296.0 6346.0 6177.4 6189.6 6255.8 6263.6 6273.9 4975.4 4987.3 5003.0 5007.2 5012.3 4394.8 4410.6 4411.1 4440.0 4446.8 5597.9 5695.9 5747.0 5781.2 5804.7 6201.1 6254.8 6271.6 6286.7 6476.8 5795.6 5801.6 5814.7 5817.9 5857.3 5396.3 5454.3 5471.6 5472.3 5485.7 6289.2 6289.4 6293.1 6342.3 6353.5 6233.6 6241.2 6255.2 6255.8 6256.8 6336.2 6343.2 6382.1 6382.5 6391.5 5979.9 6039.7 6083.9 6090.4 6136.9 6159.1 6252.2 6261.9 6297.0 6348.6 5582.7 5891.9 6176.8 6178.0 6181.5 6081.1 6129.7 6144.1 6171.5 6173.8 5808.2 5869.4 5870.4 5876.0 5896.9 6135.6 6143.3 6144.0 6150.7 6153.3 5783.6 5799.3 5854.6 5862.4 5916.9 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:73075.80 Median:35396.12 stddev:162069.21 (457.9%) stddev-sans-first:162432.24 21:57:29 INFO - PROCESS | 1659 | Values: 494.8 499.2 510.3 516.8 536.0 31088.0 42239.8 42387.6 42391.4 44616.3 43988.8 44008.0 44285.6 44351.0 44387.3 8765.0 9899.0 10082.5 10089.0 10090.6 8879.6 12144.1 12442.9 12457.0 12617.5 12289.4 12359.6 12369.4 12374.3 12411.9 8892.2 12359.8 12444.1 12449.9 12466.2 8725.3 11998.6 12352.3 12366.9 12534.9 41896.8 42239.8 42319.8 42323.4 42405.9 3264.7 3299.9 3330.5 3345.9 3666.6 30559.1 31803.8 31907.0 32340.2 32583.2 3189.7 3215.1 3292.6 3299.4 3345.9 509029.0 510661.0 511310.0 511601.0 511862.0 63673.7 64181.0 64228.7 64325.7 64353.7 34929.7 35814.4 35818.8 36344.1 36826.6 17004.0 17127.0 17192.2 17207.9 17265.3 11906.2 12180.9 12183.1 12992.2 13190.5 19341.4 20229.9 20272.8 20356.7 20360.9 6438.5 7656.5 7665.8 7672.4 7718.1 872.6 995.4 1028.4 1040.3 1053.0 30590.5 30735.8 30765.5 31348.0 31560.5 1090.6 1106.1 1112.3 1178.2 1192.7 13591.8 15624.2 16115.2 16375.7 17120.0 711090.0 714712.0 715998.0 716596.0 717190.0 59658.7 60227.7 60314.0 60369.0 60429.4 1249.3 1273.9 1365.1 1381.6 1395.1 26283.7 30195.4 31816.8 32145.7 32397.0 51355.5 51873.7 51980.5 52031.7 52071.2 569758.0 573135.0 573137.0 573854.3 575295.0 26988.6 27771.9 27821.6 28623.1 28694.6 47744.3 48304.3 48381.8 48528.3 48887.0 39947.2 40231.6 40465.6 42044.5 42163.6 39874.0 40203.0 40250.6 41744.0 41783.2 38431.2 38683.0 39032.2 39102.6 39424.4 33247.7 35117.9 35674.3 35886.3 35925.5 25711.4 26109.7 26120.6 26325.9 26606.9 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:35815.03 Median:2341.71 stddev:104158.04 (4448.0%) stddev-sans-first:104416.15 21:57:29 INFO - PROCESS | 1659 | Values: 328.3 354.4 356.2 369.7 409.4 15172.5 15339.5 16205.2 20901.5 21280.8 20073.5 20619.7 21244.8 21254.6 21491.9 4785.0 5942.0 6057.7 6199.6 6201.0 6146.4 6178.3 6228.3 6244.3 6249.6 5875.7 6044.9 6075.3 6123.4 6188.2 6045.8 6096.2 6100.9 6108.5 6118.1 5211.1 5287.5 5434.6 5474.2 5561.2 12430.0 12988.2 13112.6 13204.9 13229.5 2184.6 2278.2 2405.2 2429.4 2970.1 10211.8 10293.9 10327.8 11019.6 16070.2 1774.1 1831.1 1867.7 1879.5 1898.0 116414.0 120124.8 130980.0 131039.0 133897.0 9543.7 11376.8 11613.2 11695.2 11703.2 13343.3 13452.2 14649.0 14683.4 14719.8 7541.0 8212.9 8726.7 8774.5 8878.7 8697.3 8712.2 8747.7 8872.3 8879.7 4479.3 4566.1 4588.8 4593.9 4656.5 1609.9 1648.9 1877.3 1900.5 1917.1 837.7 908.5 914.6 975.5 980.9 20957.0 21058.7 21136.7 21394.3 21429.6 850.2 903.3 936.4 937.4 1008.1 10660.7 11088.9 11135.1 11231.2 11291.6 613517.0 621294.4 626476.0 627262.0 628881.0 113581.0 119753.0 122276.6 136211.3 138170.6 847.7 949.6 983.4 984.4 984.5 16384.1 16851.0 18812.2 18880.5 18949.7 55928.5 56862.0 58510.4 58585.0 58833.4 78983.6 82758.6 84366.0 86443.1 86551.0 8000.0 8137.2 8202.3 8441.8 8489.7 11683.7 12480.9 12512.8 12934.1 13020.3 10994.5 11000.6 11030.6 11282.6 11360.1 10676.0 10778.8 10877.9 10906.1 10983.5 10768.7 10854.5 10887.2 10958.7 11268.9 7775.6 8013.6 8021.8 8030.5 8069.6 8770.3 10961.6 10998.3 11039.0 11083.9 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5719.66 Median:4877.53 stddev:3221.94 (66.1%) stddev-sans-first:3212.86 21:57:29 INFO - PROCESS | 1659 | Values: 1173.8 1394.8 1531.5 1716.2 1901.7 7906.2 8410.2 8471.4 8815.3 8821.6 8496.7 8788.6 8790.9 8798.9 8811.0 2327.1 2378.0 2380.2 2381.0 2381.6 2335.2 2372.1 2376.3 2377.8 2378.8 2339.8 2350.6 2355.2 2372.1 2374.7 2324.5 2356.8 2357.1 2357.7 2368.8 2325.7 2335.3 2349.0 2349.2 2359.4 8752.6 8855.6 8869.6 8879.4 8884.9 5279.6 5450.5 5458.9 5495.9 5504.0 3602.2 3623.5 3649.1 3694.1 3694.8 1098.6 1099.1 1100.3 1121.4 1124.1 11612.5 11629.8 11750.0 11756.8 11757.8 3628.6 4644.7 4684.2 4866.1 4889.0 10153.8 10154.7 10155.9 10166.1 10184.0 5429.1 5431.2 5433.5 5440.9 5441.4 4333.0 4465.4 4515.1 4603.7 4960.7 3321.4 4062.8 4074.8 4107.6 4135.2 1261.2 1279.2 1290.6 1298.8 1310.6 820.8 863.9 897.3 923.0 939.8 5622.8 5725.3 6033.2 6128.6 6236.3 445.4 454.5 457.0 977.9 1010.7 3626.9 3912.5 3931.7 3965.5 4025.0 10782.5 10854.9 10982.6 11007.0 11020.8 10554.6 10666.3 10961.5 10987.9 11008.9 6811.5 8204.9 8409.9 8419.2 8432.2 5976.4 5999.3 6052.7 6117.8 6289.2 9496.9 9538.2 9634.1 9712.0 10237.9 8611.5 9506.4 10115.0 10490.9 10533.9 6852.8 7058.4 7242.3 7653.5 7677.2 8272.6 8311.9 8379.8 8425.9 8438.4 7487.5 7511.7 7549.9 7578.7 7579.6 7246.8 7410.0 7419.9 7461.6 7581.2 6948.5 6977.7 7059.7 7062.5 7073.0 4889.3 4897.6 4923.0 5059.8 5171.1 5001.2 5017.3 5114.8 5241.7 5285.8 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4442.79 Median:4826.63 stddev:1392.85 (28.9%) stddev-sans-first:1361.70 21:57:29 INFO - PROCESS | 1659 | Values: 305.0 310.9 312.9 316.4 320.8 5283.4 5310.0 5318.6 5362.2 5408.7 4198.6 4387.9 5308.5 5328.1 5333.2 3501.3 3518.5 3871.4 3903.9 3947.8 4096.1 4120.5 4124.2 4132.3 4161.6 3349.2 3686.1 3759.4 4067.2 4069.6 3547.6 3962.6 4088.8 4096.9 4105.7 3572.2 3575.3 3576.0 3576.9 3587.2 5205.6 5213.4 5229.9 5230.1 5235.8 3755.1 4663.4 4702.9 4712.7 4722.0 4657.3 5121.3 5571.9 5611.9 5620.6 3939.7 3942.2 3948.5 3953.1 3953.6 4592.6 5641.4 5871.4 5903.6 5938.7 3272.5 3783.6 4009.2 4022.8 4089.9 3245.6 3389.6 3581.6 4058.2 4066.7 4708.8 4711.0 4731.3 4738.8 4750.2 5045.5 5068.2 5451.6 5644.8 5653.6 1203.0 1394.9 1395.3 1398.0 1398.9 753.6 829.7 840.7 852.9 856.9 5003.3 5133.6 5206.0 5210.1 5232.4 4917.8 5590.6 5745.0 5766.6 5856.8 4084.4 4483.5 4908.8 5052.4 5292.3 2583.3 2703.0 2832.7 2859.6 2899.6 5060.8 5730.7 5948.3 6019.9 6098.0 5215.0 5486.4 5841.5 5960.3 6020.2 5527.6 6031.6 6048.8 6066.0 6111.8 4955.6 4997.6 5337.3 5864.8 5869.4 4812.3 5082.6 5528.7 5766.0 5798.4 5031.6 5740.9 6045.3 6058.5 6113.9 2933.1 2990.2 3429.7 3446.9 3448.8 4208.4 4218.0 4358.7 4866.2 4942.8 4494.2 4640.4 4735.0 4765.5 4782.5 4163.4 4299.9 4452.7 4803.3 4841.0 4518.6 5677.7 5685.9 5692.9 5711.3 5481.7 5602.5 5665.6 5715.5 5826.3 4536.9 5577.4 5624.4 5660.2 5683.7 21:57:29 INFO - PROCESS | 1659 | 21:57:29 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:24711.95 Median:4116.18 stddev:40044.51 (972.9%) stddev-sans-first:40116.27 21:57:29 INFO - PROCESS | 1659 | Values: 702.8 744.9 756.3 784.9 790.2 15183.5 16142.9 16154.4 16164.8 16357.4 14579.9 14731.8 14747.2 14755.7 14764.2 678.2 695.1 833.0 834.0 864.4 854.0 858.2 863.0 864.1 868.0 901.0 902.0 903.0 903.1 903.7 702.4 724.7 794.4 854.7 896.7 653.3 674.4 675.3 677.0 677.1 15007.7 15060.5 15081.8 15090.2 15095.8 13474.5 13811.6 13819.7 13968.3 14047.2 11851.8 12312.6 12363.8 12456.6 12628.6 4328.5 4494.2 4575.7 4630.4 4696.8 120666.4 120877.2 121810.4 123395.0 126932.7 10435.4 10890.3 10948.4 11020.1 11052.7 21319.0 21449.4 21527.2 21568.0 21680.7 6548.7 7876.4 7879.8 8034.9 8115.5 4107.9 4196.9 4198.5 4247.7 4259.3 3307.7 3403.4 3405.8 3406.4 3407.0 624.1 636.7 638.2 641.3 659.8 465.6 607.7 614.7 623.3 624.2 8219.8 8717.4 8889.7 9091.8 9173.3 582.7 599.9 601.6 611.1 630.3 4124.5 4284.3 4300.9 4342.3 4389.6 93888.5 94020.0 135874.0 160156.0 170215.0 122472.4 123659.0 125637.0 127632.0 135422.0 109969.9 112702.3 113213.4 114236.4 116914.0 7870.5 7891.0 7894.0 8334.3 8393.5 62724.7 63796.4 65421.0 65476.0 66308.3 95137.5 100132.5 101403.5 103364.0 104578.0 11117.1 11303.8 11333.3 11486.7 11735.9 11895.8 11946.7 11970.8 12544.6 12623.3 11047.9 11200.0 11994.9 12174.5 12273.7 11732.0 11735.3 11818.8 11824.9 11947.0 10863.3 11270.7 11387.8 11537.7 11981.4 9180.2 9328.4 9786.1 9821.2 9850.9 9551.2 9989.3 10041.7 10076.2 10165.4 21:57:29 INFO - PROCESS | 1659 | -------- Summary: end -------- 21:57:29 INFO - PROCESS | 1659 | 21:57:30 INFO - TEST-INFO | 1659: exit 0 21:57:30 INFO - TEST-OK | dromaeo_css | took 1118059ms 21:57:30 INFO - TEST-START | kraken 21:57:30 INFO - operating with platform_type : mac_ 21:57:30 INFO - Initialising browser for kraken test... 21:57:30 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpFhEQQj/profile http://localhost:49273/getInfo.html) 21:57:32 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 21:57:32 INFO - PROCESS | 1665 | colorDepth:24 21:57:32 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 21:57:32 INFO - PROCESS | 1665 | __metrics 21:57:32 INFO - PROCESS | 1665 | 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" 21:57:32 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:33 INFO - TEST-INFO | 1665: exit 0 21:57:33 INFO - Browser initialized. 21:57:33 INFO - Running cycle 1/1 for kraken test... 21:57:33 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpFhEQQj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:45 INFO - PROCESS | 1666 | RSS: Main: 219906048 21:57:45 INFO - PROCESS | 1666 | 21:57:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 21:57:49 INFO - PROCESS | 1666 | RSS: Main: 270213120 21:57:49 INFO - PROCESS | 1666 | 21:57:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 21:57:52 INFO - PROCESS | 1666 | RSS: Main: 281513984 21:57:52 INFO - PROCESS | 1666 | 21:57:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 21:57:56 INFO - PROCESS | 1666 | RSS: Main: 377118720 21:57:56 INFO - PROCESS | 1666 | 21:57:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 21:57:58 INFO - PROCESS | 1666 | RSS: Main: 280760320 21:57:58 INFO - PROCESS | 1666 | 21:58:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:01 INFO - PROCESS | 1666 | RSS: Main: 281722880 21:58:01 INFO - PROCESS | 1666 | 21:58:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:04 INFO - PROCESS | 1666 | RSS: Main: 318861312 21:58:04 INFO - PROCESS | 1666 | 21:58:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:08 INFO - PROCESS | 1666 | RSS: Main: 318750720 21:58:08 INFO - PROCESS | 1666 | 21:58:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 21:58:11 INFO - PROCESS | 1666 | RSS: Main: 316108800 21:58:11 INFO - PROCESS | 1666 | 21:58:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:13 INFO - PROCESS | 1666 | RSS: Main: 291864576 21:58:13 INFO - PROCESS | 1666 | 21:58:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:16 INFO - PROCESS | 1666 | RSS: Main: 296546304 21:58:16 INFO - PROCESS | 1666 | 21:58:18 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:19 INFO - PROCESS | 1666 | RSS: Main: 298303488 21:58:19 INFO - PROCESS | 1666 | 21:58:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:22 INFO - PROCESS | 1666 | RSS: Main: 315109376 21:58:22 INFO - PROCESS | 1666 | 21:58:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:26 INFO - PROCESS | 1666 | RSS: Main: 308211712 21:58:26 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 21:58:28 INFO - PROCESS | 1666 | RSS: Main: 352157696 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | __start_tp_report 21:58:28 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 21:58:28 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 21:58:28 INFO - PROCESS | 1666 | |i|pagename|runs| 21:58:28 INFO - PROCESS | 1666 | |0;ai-astar;114;114;114;114;115;114;114;114;113;113 21:58:28 INFO - PROCESS | 1666 | |1;audio-beat-detection;143;110;110;141;104;109;110;107;137;109 21:58:28 INFO - PROCESS | 1666 | |2;audio-dft;185;190;232;185;182;182;182;181;183;182 21:58:28 INFO - PROCESS | 1666 | |3;audio-fft;81;58;59;88;59;62;59;59;83;58 21:58:28 INFO - PROCESS | 1666 | |4;audio-oscillator;88;73;93;68;66;68;91;66;68;90 21:58:28 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;87;83;85;83;86;84;86;84;86;84 21:58:28 INFO - PROCESS | 1666 | |6;imaging-darkroom;92;93;93;92;92;93;93;93;93;92 21:58:28 INFO - PROCESS | 1666 | |7;imaging-desaturate;132;144;102;85;87;86;86;86;87;85 21:58:28 INFO - PROCESS | 1666 | |8;json-parse-financial;57;56;54;54;56;58;59;58;57;57 21:58:28 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;74;81;75;72;70;71;71;71;73 21:58:28 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;83;83;83;82;84;80;83;82;79;86 21:58:28 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;135;139;135;139;140;141;142;151;199;158 21:58:28 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;176;204;163;199;224;179;163;163;160;164 21:58:28 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;66;67;67;69;80;86;88;69;64;66 21:58:28 INFO - PROCESS | 1666 | __end_tp_report 21:58:28 INFO - PROCESS | 1666 | __start_cc_report 21:58:28 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1983 21:58:28 INFO - PROCESS | 1666 | __end_cc_report 21:58:28 INFO - PROCESS | 1666 | __startTimestamp1477976308416__endTimestamp 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | ------- Summary: start ------- 21:58:28 INFO - PROCESS | 1666 | Number of tests: 14 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:58:28 INFO - PROCESS | 1666 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 113.0 113.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:118.00 Median:110.00 stddev:15.58 (14.2%) stddev-sans-first:13.65 21:58:28 INFO - PROCESS | 1666 | Values: 143.0 110.0 110.0 141.0 104.0 109.0 110.0 107.0 137.0 109.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:188.40 Median:184.00 stddev:15.54 (8.4%) stddev-sans-first:16.44 21:58:28 INFO - PROCESS | 1666 | Values: 185.0 190.0 232.0 185.0 182.0 182.0 182.0 181.0 183.0 182.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.60 Median:60.50 stddev:12.18 (20.1%) stddev-sans-first:11.75 21:58:28 INFO - PROCESS | 1666 | Values: 81.0 58.0 59.0 88.0 59.0 62.0 59.0 59.0 83.0 58.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:80.50 stddev:11.75 (14.6%) stddev-sans-first:11.78 21:58:28 INFO - PROCESS | 1666 | Values: 88.0 73.0 93.0 68.0 66.0 68.0 91.0 66.0 68.0 90.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:85.50 stddev:1.40 (1.6%) stddev-sans-first:1.24 21:58:28 INFO - PROCESS | 1666 | Values: 87.0 83.0 85.0 83.0 86.0 84.0 86.0 84.0 86.0 84.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 21:58:28 INFO - PROCESS | 1666 | Values: 92.0 93.0 93.0 92.0 92.0 93.0 93.0 93.0 93.0 92.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:86.00 stddev:21.86 (25.4%) stddev-sans-first:19.42 21:58:28 INFO - PROCESS | 1666 | Values: 132.0 144.0 102.0 85.0 87.0 86.0 86.0 86.0 87.0 85.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.65 (2.9%) stddev-sans-first:1.74 21:58:28 INFO - PROCESS | 1666 | Values: 57.0 56.0 54.0 54.0 56.0 58.0 59.0 58.0 57.0 57.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.50 stddev:3.72 (5.1%) stddev-sans-first:3.37 21:58:28 INFO - PROCESS | 1666 | Values: 67.0 74.0 81.0 75.0 72.0 70.0 71.0 71.0 71.0 73.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:2.07 21:58:28 INFO - PROCESS | 1666 | Values: 83.0 83.0 83.0 82.0 84.0 80.0 83.0 82.0 79.0 86.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:141.50 stddev:19.32 (13.7%) stddev-sans-first:19.92 21:58:28 INFO - PROCESS | 1666 | Values: 135.0 139.0 135.0 139.0 140.0 141.0 142.0 151.0 199.0 158.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:177.50 stddev:22.14 (12.5%) stddev-sans-first:23.44 21:58:28 INFO - PROCESS | 1666 | Values: 176.0 204.0 163.0 199.0 224.0 179.0 163.0 163.0 160.0 164.0 21:58:28 INFO - PROCESS | 1666 | 21:58:28 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:69.00 stddev:8.94 (13.0%) stddev-sans-first:9.20 21:58:28 INFO - PROCESS | 1666 | Values: 66.0 67.0 67.0 69.0 80.0 86.0 88.0 69.0 64.0 66.0 21:58:28 INFO - PROCESS | 1666 | -------- Summary: end -------- 21:58:28 INFO - PROCESS | 1666 | 21:58:29 INFO - TEST-INFO | 1666: exit 0 21:58:29 INFO - TEST-OK | kraken | took 58656ms 21:58:29 INFO - SUITE-END | took 1176s 21:58:29 INFO - Completed test suite (00:19:37) 21:58:29 INFO - javascript benchmark 21:58:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.9339013219737, 3308.818015009175, 3354.966450335496, 3378.3918894598964, 3381.0364046246823, 5667.291588551431, 5756.481916627513, 5782.450667186621, 5790.36306006339, 5854.238948936643, 5725.370209276986, 5780.0, 5802.100674395476, 5803.593748437611, 5814.825555233349, 5221.373435187783, 5271.551918086967, 5292.550133238679, 5292.947070529303, 5335.093034184179, 5201.0, 5204.739763011834, 5209.088409528336, 5332.600054995872, 5342.786288548454, 5328.600354973373, 5331.360236771573, 5331.866703332428, 5337.626366154371, 5339.786408543654, 5251.054810134175, 5303.7082960437165, 5304.443033481487, 5313.043652142613, 5317.680939143625, 5200.115980283361, 5204.661696989683, 5218.139007063868, 5222.686638801646, 5314.97342513285, 5815.767369305223, 5856.531477481792, 5907.02534081876, 5920.171176035358, 5954.851128721816, 5687.232223649796, 5885.558583106242, 6142.744345496893, 6145.170401995718, 6167.87664246717, 6223.097650840603, 6257.5619706620555, 6279.654618995954, 6292.590981586228, 6325.557210995232, 5387.973060134675, 5414.431484694129, 5824.88350232993, 5837.88324233513, 5851.356350801409, 6167.352427995085, 6240.469560087353, 6258.843528911813, 6286.277078135981, 6299.905501417483, 5188.351456067991, 6149.754009839646, 6220.906686399708, 6227.408396202353, 6233.3143354231, 6265.373462653789, 6279.968600157062, 6300.401461861115, 6302.086197501337, 6320.0, 6120.326764055951, 6149.5080393568405, 6256.061590761331, 6295.96852015737, 6346.0, 6177.444030037318, 6189.597676151126, 6255.812325630239, 6263.6241825490615, 6273.905891411632, 4975.427825800007, 4987.276844857548, 5003.0, 5007.223880298559, 5012.348394708664, 4394.846180383671, 4410.647148228134, 4411.117776444724, 4439.955600443955, 4446.82212711488, 5597.944020559742, 5695.886082278331, 5746.9712651436475, 5781.248437703071, 5804.709764511757, 6201.10084037812, 6254.843628909313, 6271.592346497463, 6286.748530058838, 6476.805695829133, 5795.565332600072, 5801.622894511843, 5814.738336774855, 5817.854553636193, 5857.326407463196, 5396.271503347077, 5454.345478542521, 5471.5896307777075, 5472.288602481652, 5485.698286594195, 6289.182406287154, 6289.40250676185, 6293.056041593798, 6342.302346741947, 6353.459955903615, 6233.563650544418, 6241.21984751906, 6255.218097737783, 6255.843603909757, 6256.812295631138, 6336.239651241881, 6343.207099112611, 6382.106505089384, 6382.521310901608, 6391.456726178327, 5979.910301345396, 6039.667818270037, 6083.908741368971, 6090.421409966046, 6136.88672321611, 6159.137720719193, 6252.249730032243, 6261.874762504815, 6296.992481202986, 6348.619082855043, 5582.720863956704, 5891.852703682443, 6176.81469555914, 6177.96911015442, 6181.505479561534, 6081.118237855575, 6129.693515324127, 6144.1398204250545, 6171.537134714825, 6173.753049878134, 5808.186853840381, 5869.383714709894, 5870.442307980735, 5876.0, 5896.882062358814, 6135.631862088289, 6143.32423433413, 6144.047672610753, 6150.692465376803, 6153.2616086068165, 5783.595148339576, 5799.2750906136735, 5854.619449735754, 5862.384449632727, 5916.881662366814], "value": 5720.803344734979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.7680276112479, 499.2162305180868, 510.3416592595552, 516.7571241516488, 535.9946400535994, 31088.0, 42239.78880105599, 42387.576124238825, 42391.36412953808, 44616.330755038616, 43988.78005609968, 44008.0, 44285.557144428545, 44351.0, 44387.334189987174, 8764.956175219148, 9899.010098990097, 10082.495875206247, 10089.041541053588, 10090.646827361044, 8879.600417981206, 12144.149909506337, 12442.875571244262, 12457.0, 12617.495300187982, 12289.446974886107, 12359.567415140427, 12369.443375048144, 12374.319412432313, 12411.875881241162, 8892.244159246407, 12359.752804943895, 12444.128910976235, 12449.937750311281, 12466.189697669713, 8725.258353039999, 11998.58004969822, 12352.320622365767, 12366.938165309206, 12534.874651253462, 41896.79051604722, 42239.78880105611, 42319.788401058104, 42323.36514952278, 42405.93985150396, 3264.7061764441314, 3299.934001319984, 3330.5170750241077, 3345.8996230113135, 3666.6353025073286, 30559.08322750321, 31803.84098079518, 31907.0, 32340.191495212573, 32583.185420364443, 3189.728873045794, 3215.099772063826, 3292.6378098409155, 3299.406106900757, 3345.866165353383, 509029.0, 510661.0, 511309.9999999963, 511601.0, 511862.0, 63673.68163159154, 64181.0, 64228.67885660542, 64325.67837160784, 64353.71292574122, 34929.65070349264, 35814.3883525242, 35818.82090589531, 36344.09139771474, 36826.63173368232, 17003.979761214367, 17127.0, 17192.22634981429, 17207.913960430116, 17265.309387624355, 11906.166568340133, 12180.939095304468, 12183.086268529718, 12992.220466771834, 13190.538331158363, 19341.362606106428, 20229.898850505655, 20272.797272027386, 20356.69464958027, 20360.89819550893, 6438.452731517874, 7656.502327348704, 7665.846683066307, 7672.38620910337, 7718.0738311401865, 872.5898827551041, 995.3629677006721, 1028.3829702178632, 1040.287403128859, 1053.004910359718, 30590.541141882888, 30735.846320768254, 30765.538516922265, 31348.0, 31560.526592101138, 1090.569225156059, 1106.0653747583278, 1112.260346869339, 1178.2223732336618, 1192.6958625550428, 13591.796123058162, 15624.218789060502, 16115.172534244773, 16375.707400963875, 17120.0, 711090.0, 714712.0, 715998.0, 716596.0, 717190.0, 59658.70170649119, 60227.698861505414, 60314.0, 60369.0, 60429.39570604238, 1249.2941488059218, 1273.8853503184944, 1365.0853927868154, 1381.647679841654, 1395.1141025448912, 26283.737162628127, 30195.396092077597, 31816.840915795274, 32145.678543214268, 32397.0, 51355.48644513507, 51873.740631296605, 51980.48019519756, 52031.69920752011, 52071.218931716816, 569758.0, 573135.0, 573137.0, 573854.2614573968, 575295.0, 26988.59517107206, 27771.861140694167, 27821.582676259466, 28623.14130576086, 28694.56958145671, 47744.2838357418, 48304.2754358692, 48381.7904552389, 48528.27207591818, 48887.0, 39947.20369574102, 40231.59768402279, 40465.59534404736, 42044.5284415044, 42163.578364215966, 39874.0, 40203.0, 40250.59749402468, 41744.0, 41783.164336712485, 38431.231375372896, 38683.0, 39032.2193556133, 39102.63140790059, 39424.40863387109, 33247.66752332543, 35117.946461606196, 35674.28651427009, 35886.28227435489, 35925.461118083775, 25711.357216069748, 26109.73890261149, 26120.60819087753, 26325.9469621213, 26606.86696566505], "value": 20689.212211361166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.32856807827994, 354.40990750400584, 356.2109926512774, 369.7079307347196, 409.4308910614247, 15172.468963586276, 15339.53981380559, 16205.189740512971, 20901.477463063395, 21280.787192128075, 20073.498162545944, 20619.69070463944, 21244.787552124475, 21254.57490850182, 21491.892540537276, 4785.0, 5941.999999999989, 6057.666828324441, 6199.597026193283, 6201.0388389799655, 6146.354632763562, 6178.320384757673, 6228.252609686844, 6244.344343843899, 6249.625022498642, 5875.735591898353, 6044.922265297149, 6075.270967483908, 6123.448889599935, 6188.226471691039, 6045.758169673208, 6096.1770161028135, 6100.938990610081, 6108.541859360521, 6118.082287656843, 5211.088059589594, 5287.524122828964, 5434.565234781247, 5474.233607294982, 5561.165825126223, 12430.011198208244, 12988.155769874928, 13112.606621801362, 13204.867951320555, 13229.470821167142, 2184.6286131357547, 2278.1798552521077, 2405.230326295586, 2429.4290841652196, 2970.064429704658, 10211.79576408475, 10293.897061029444, 10327.79344413115, 11019.614313499069, 16070.196490175444, 1774.1395423219728, 1831.0844577711143, 1867.6544839204792, 1879.5207222158263, 1897.990510047441, 116414.0, 120124.79875201311, 130980.0, 131039.0, 133897.0, 9543.711598934195, 11376.829347559793, 11613.187076904704, 11695.239809412362, 11703.180777345675, 13343.266120363473, 13452.19286842773, 14649.0, 14683.412663493555, 14719.779203311744, 7541.019667443307, 8212.917870821215, 8726.650933962697, 8774.473531587997, 8878.689245876492, 8697.260732837653, 8712.172343627471, 8747.737567872973, 8872.290216782641, 8879.733607991642, 4479.283314669702, 4566.109608626352, 4588.77056147198, 4593.908121837545, 4656.4877863434995, 1609.9275532601062, 1648.9422870199485, 1877.2772482594025, 1900.5248687828043, 1917.118125662183, 837.660747397305, 908.52756566585, 914.5838643417229, 975.5024937282037, 980.9215262778961, 20957.0, 21058.684119738216, 21136.731796092285, 21394.251201208193, 21429.640195912067, 850.2220468271586, 903.2954295649404, 936.424099179, 937.3579098317674, 1008.1229330482527, 10660.733481663021, 11088.94655007773, 11135.05352045069, 11231.15766317513, 11291.604793832177, 613517.0, 621294.3611691657, 626476.0, 627262.0, 628881.0, 113581.0, 119753.0, 122276.5544689119, 136211.31894340663, 138170.6182938158, 847.7160151349367, 949.5916755794937, 983.3902980152351, 984.4487087231173, 984.5126662302063, 16384.098874562012, 16850.9889406636, 18812.24751009944, 18880.52798680044, 18949.650782865923, 55928.48321825446, 56862.0, 58510.414895850496, 58585.0, 58833.41166588279, 78983.60508197422, 82758.58620707098, 84366.0, 86443.13556864351, 86551.0, 8000.0, 8137.226963438464, 8202.343812495106, 8441.788955276168, 8489.660413583388, 11683.707907302385, 12480.940644793507, 12512.812307815571, 12934.094613376974, 13020.348982550646, 10994.450277485934, 11000.559977600806, 11030.558777649125, 11282.605108821152, 11360.091192704398, 10676.0, 10778.784424311312, 10877.891221087688, 10906.072983796466, 10983.505742241778, 10768.676939691823, 10854.45727713627, 10887.23789334739, 10958.726031848948, 11268.887311126784, 7775.6112194388925, 8013.559254241072, 8021.759347219593, 8030.5181689098845, 8069.59652017385, 8770.298376130022, 10961.616343427942, 10998.285111467729, 11038.951299626522, 11083.944580277048], "value": 9434.59673783772, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1173.765246950609, 1394.8186735724355, 1531.4563330017843, 1716.1590820497959, 1901.6957286834102, 7906.209379062091, 8410.243078122967, 8471.364647651428, 8815.338849586275, 8821.603027863746, 8496.745097647081, 8788.604512796923, 8790.91209087909, 8798.944126704788, 8810.986736525301, 2327.1389585853217, 2378.0368950575044, 2380.214529205367, 2380.95238095238, 2381.583222935988, 2335.2293743064747, 2372.0511795281855, 2376.3346263046374, 2377.8335516513853, 2378.7978021868075, 2339.801116905065, 2350.6003979323473, 2355.187460326185, 2372.063035101134, 2374.6794182785275, 2324.4886125052462, 2356.8350215484925, 2357.068957761683, 2357.669926210332, 2368.7749663781915, 2325.6627788970673, 2335.2760644200184, 2349.0016742884204, 2349.2130136404326, 2359.433735903388, 8752.649894004233, 8855.601497932608, 8869.645214191425, 8879.378443508956, 8884.933807943024, 5279.551238144724, 5450.4549545045575, 5458.8908221835345, 5495.917561236584, 5503.972480137573, 3602.225521512861, 3623.4564815277654, 3649.069487280753, 3694.11341278094, 3694.833732482045, 1098.5715570927346, 1099.115212254135, 1100.2518287564453, 1121.44488478203, 1124.0670243697712, 11612.535498580046, 11629.825552616718, 11750.0, 11756.823647645293, 11757.823632645517, 3628.63713628635, 4644.7213167210075, 4684.203685373494, 4866.075445665312, 4888.9755551222015, 10153.847692284622, 10154.746131346776, 10155.949220253851, 10166.085052345177, 10183.981601839756, 5429.104197807396, 5431.158170483582, 5433.538149257279, 5440.863978400493, 5441.401445840955, 4332.978335108304, 4465.441819772528, 4515.1195516873895, 4603.677742558056, 4960.652754307164, 3321.3689399014593, 4062.7765472899273, 4074.796260186979, 4107.630313271819, 4135.152293779768, 1261.1802328486374, 1279.2196759976407, 1290.5999140266547, 1298.8181654568368, 1310.6330227536305, 820.7688467299051, 863.8661007543841, 897.3314880414133, 922.9769255768525, 939.7885475768035, 5622.775088996476, 5725.255716756878, 6033.215681961317, 6128.632282063001, 6236.251649802053, 445.4076078815168, 454.470541818784, 457.04249597094037, 977.8533220017055, 1010.7062959411818, 3626.9455958160647, 3912.4522566840665, 3931.66580840626, 3965.4646622705563, 4025.0138716014762, 10782.46087695612, 10854.86023967488, 10982.615608453825, 11006.95433933791, 11020.834687479693, 10554.630587929385, 10666.253362264568, 10961.451927403597, 10987.890121098846, 11008.889911100947, 6811.4550835933005, 8204.917950820534, 8409.873851892227, 8419.158084191531, 8432.24109830106, 5976.432238937294, 5999.250093738283, 6052.6973651316375, 6117.84705382369, 6289.150964619717, 9496.85754713666, 9538.23694104484, 9634.13292803651, 9712.02879712023, 10237.9488102559, 8611.48331100136, 9506.382085164441, 10115.0, 10490.947545262225, 10533.894661053599, 6852.760153394607, 7058.364747172779, 7242.348188663045, 7653.540787552764, 7677.232276772278, 8272.586370681562, 8311.875321870297, 8379.832403351777, 8425.87361189595, 8438.367122465963, 7487.47587668858, 7511.737089201852, 7549.9245007549225, 7578.734744283924, 7579.621018949141, 7246.818829529304, 7410.0, 7419.851602968019, 7461.589612571361, 7581.203973582915, 6948.513604047668, 6977.720891164499, 7059.682314295766, 7062.540934839219, 7073.045138906182, 4889.266610008527, 4897.5592196701045, 4922.950770492393, 5059.848204553869, 5171.095058364695, 5001.24981252815, 5017.2724954880605, 5114.846554603368, 5241.659292145999, 5285.788568457218], "value": 4559.0495786817, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.963404391473, 310.917606834189, 312.8513955870961, 316.4051583023916, 320.76263564961937, 5283.365996080466, 5310.0, 5318.601104917137, 5362.249285100089, 5408.67547947123, 4198.5801419858, 4387.934180987288, 5308.522232999029, 5328.110479350077, 5333.226682131089, 3501.3172431375892, 3518.5074089627474, 3871.3999330103807, 3903.906906066292, 3947.782871942042, 4096.139810639755, 4120.526139493952, 4124.154548317588, 4132.347061175539, 4161.625453709165, 3349.1961929137074, 3686.115332320237, 3759.398496240602, 4067.2272268268935, 4069.633732964033, 3547.5920269168987, 3962.643362097425, 4088.7546747195265, 4096.877093687209, 4105.651019663333, 3572.2498275362204, 3575.2670702505925, 3575.9642403576154, 3576.8911637392494, 3587.1840605124853, 5205.590338328401, 5213.400458947193, 5229.921551176735, 5230.110881150214, 5235.764390602432, 3755.0762611085684, 4663.417072865892, 4702.882427939295, 4712.69367491112, 4721.976390118062, 4657.346641942096, 5121.257417674454, 5571.879747341502, 5611.859703507404, 5620.634658747168, 3939.72421930465, 3942.1918506706056, 3948.4866967294356, 3953.1303113315025, 3953.6046395360236, 4592.576301346593, 5641.407652196543, 5871.442212989759, 5903.645781253139, 5938.703064846741, 3272.49654014679, 3783.621637836194, 4009.1781184857036, 4022.8018725113607, 4089.89775255621, 3245.6105267367593, 3389.5932488101093, 3581.6418358163974, 4058.1680755445063, 4066.6543343816106, 4708.788104535304, 4710.9764451177525, 4731.33761273422, 4738.763061846894, 4750.192467280571, 5045.48635409383, 5068.23976403535, 5451.591130665216, 5644.8306550803545, 5653.604247702704, 1202.9534305154398, 1394.8562179013315, 1395.3372148229712, 1397.9930100349434, 1398.9090709103875, 753.5554023126382, 829.7344849648175, 840.6675419460101, 852.8976522817302, 856.9271611913057, 5003.299538064601, 5133.563647089964, 5205.954516607751, 5210.0983141153965, 5232.383808095952, 4917.803287868445, 5590.608657393944, 5745.0, 5766.646182132463, 5856.828634273163, 4084.387341898739, 4483.461984561874, 4908.779104940286, 5052.393712754493, 5292.2800089970915, 2583.302508322742, 2702.9594556081674, 2832.745052945245, 2859.5710643403654, 2899.594056832045, 5060.822871199491, 5730.713464326767, 5948.345681974979, 6019.939800601938, 6098.0, 5214.97392513035, 5486.396496385394, 5841.50347220491, 5960.284765828128, 6020.157177995085, 5527.55779537636, 6031.638101713911, 6048.818535443944, 6065.969670151621, 6111.84720381994, 4955.603551715926, 4997.600191984705, 5337.292066538826, 5864.794732184353, 5869.383714709894, 4812.302216178565, 5082.567981721447, 5528.650323612529, 5765.962126817213, 5798.391168927202, 5031.597472202142, 5740.942590574208, 6045.274567051982, 6058.4850287724275, 6113.930062239001, 2933.0614203455543, 2990.222542139016, 3429.6741809528053, 3446.9310613788084, 3448.7583071004046, 4208.4428761358495, 4218.0, 4358.716683415568, 4866.1727506323305, 4942.75286235694, 4494.179947044986, 4640.3735495709, 4734.981978874558, 4765.547273009059, 4782.473927868002, 4163.417121603038, 4299.935500967551, 4452.708714472767, 4803.327534145153, 4840.959193773356, 4518.6385089193445, 5677.687727175045, 5685.857853553694, 5692.943070569241, 5711.343195532567, 5481.698506582176, 5602.467765562265, 5665.603407761417, 5715.485396370049, 5826.338928856813, 4536.931946020746, 5577.414371490935, 5624.35319938196, 5660.207570940154, 5683.749575093473], "value": 4005.5355451736114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.7645738677546, 744.8547533231018, 756.2815325440832, 784.8979632647756, 790.1545346479268, 15183.468578599752, 16142.919285403586, 16154.434594789185, 16164.757528637065, 16357.427490037851, 14579.854201457982, 14731.779023314659, 14747.188904610242, 14755.704885902276, 14764.187969661665, 678.1794029224644, 695.1310861423221, 832.9541875196862, 833.9666413343474, 864.3819668936709, 854.0136142755127, 858.1761508951414, 863.016161575801, 864.0883867519796, 868.0061329777401, 901.04489241404, 902.025812122909, 902.9503377314245, 903.1420150856679, 903.6746771162376, 702.3959394920364, 724.7499612633633, 794.376414514609, 854.7350321400355, 896.6951236579562, 653.2748648999655, 674.3660958698856, 675.3449154320301, 676.9695363708645, 677.11298199359, 15007.699846003019, 15060.472883449136, 15081.849181508263, 15090.17004064776, 15095.773563396559, 13474.528391506348, 13811.585652430444, 13819.723605527834, 13968.301584920815, 14047.22740249286, 11851.822222666668, 12312.569060082855, 12363.752724945542, 12456.564020259339, 12628.621141365773, 4328.48058233014, 4494.235979883428, 4575.679702420832, 4630.421197350332, 4696.7651617419, 120666.3966680161, 120877.18684219744, 121810.39094804558, 123395.0, 126932.73067269394, 10435.426051567085, 10890.346579205274, 10948.39783811882, 11020.118390528738, 11052.668419947415, 21319.0, 21449.356519304445, 21527.246546370803, 21568.0, 21680.67478987785, 6548.738050478023, 7876.369890408753, 7879.803004924923, 8034.919650803417, 8115.472494287852, 4107.856225032109, 4196.916061678749, 4198.475190601175, 4247.66018718508, 4259.318509038539, 3307.68576985186, 3403.3873902697255, 3405.7786243894066, 3406.437937740245, 3406.9659303407143, 624.09506215987, 636.6593872278308, 638.237306418825, 641.2945759664332, 659.7690808217181, 465.5670226689144, 607.738672370876, 614.7049416280211, 623.2520974830222, 624.194788722552, 8219.8356032879, 8717.389782715276, 8889.688860889837, 9091.81816363669, 9173.312001599774, 582.6562328226282, 599.868029033612, 601.5939241012387, 611.1077826373545, 630.3098107572201, 4124.505059392892, 4284.293091639907, 4300.89247768802, 4342.305231162999, 4389.604935555815, 93888.53055734678, 94020.0, 135874.0, 160156.0, 170215.0, 122472.38763806123, 123659.0, 125637.0, 127632.0, 135422.0, 109969.90030099597, 112702.30946535809, 113213.43393283145, 114236.42881785538, 116914.0, 7870.527768333689, 7891.0, 7893.960530197312, 8334.333253339597, 8393.538355390512, 62724.68401858384, 63796.3620363809, 65421.0, 65476.0, 66308.33691663021, 95137.524312378, 100132.49933750577, 101403.49298253462, 103363.96636033543, 104578.0, 11117.11063114965, 11303.830442543533, 11333.26333788301, 11486.712832178928, 11735.882641173479, 11895.762084758084, 11946.701332466759, 11970.820437693268, 12544.623661290176, 12623.305718185587, 11047.944760276147, 11200.0, 11994.880051199725, 12174.513019479122, 12273.69315767113, 11732.0, 11735.295882247092, 11818.82271765907, 11824.940875295913, 11946.98450631706, 10863.348199108079, 11270.661880143609, 11387.829182562435, 11537.653870383901, 11981.400929953641, 9180.219681327162, 9328.440293582407, 9786.1192492676, 9821.165200958, 9850.901490984998, 9551.188149007134, 9989.300748947504, 10041.698749037248, 10076.244281678757, 10165.44090075053], "value": 7539.094719986953, "unit": "score"}], "name": "dromaeo_css", "value": 7319.326216658875, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 110.0, 141.0, 104.0, 109.0, 110.0, 107.0, 137.0, 109.0], "value": 118.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 190.0, 232.0, 185.0, 182.0, 182.0, 182.0, 181.0, 183.0, 182.0], "value": 188.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 88.0, 59.0, 62.0, 59.0, 59.0, 83.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 73.0, 93.0, 68.0, 66.0, 68.0, 91.0, 66.0, 68.0, 90.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 83.0, 86.0, 84.0, 86.0, 84.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 144.0, 102.0, 85.0, 87.0, 86.0, 86.0, 86.0, 87.0, 85.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 54.0, 56.0, 58.0, 59.0, 58.0, 57.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 81.0, 75.0, 72.0, 70.0, 71.0, 71.0, 71.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 84.0, 80.0, 83.0, 82.0, 79.0, 86.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 135.0, 139.0, 140.0, 141.0, 142.0, 151.0, 199.0, 158.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 204.0, 163.0, 199.0, 224.0, 179.0, 163.0, 163.0, 160.0, 164.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 69.0, 80.0, 86.0, 88.0, 69.0, 64.0, 66.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1450.6000000000001, "alertThreshold": 2.0}]} 21:58:29 INFO - Return code: 0 21:58:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:29 INFO - # TBPL SUCCESS # 21:58:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:58:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:58:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:58:29 INFO - 2016-10-31 21:58:29.731 screenresolution[1670:11161] starting screenresolution argv=screenresolution get 21:58:29 INFO - 2016-10-31 21:58:29.734 screenresolution[1670:11161] Display 0: 1600x1200x32@60 21:58:29 INFO - 2016-10-31 21:58:29.740 screenresolution[1671:11164] starting screenresolution argv=screenresolution list 21:58:29 INFO - Available Modes on Display 0 21:58:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:58:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:58:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:58:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:58:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:58:29 INFO - Intel Iris: 21:58:29 INFO - Chipset Model: Intel Iris 21:58:29 INFO - Type: GPU 21:58:29 INFO - Bus: Built-In 21:58:29 INFO - VRAM (Dynamic, Max): 1536 MB 21:58:29 INFO - Vendor: Intel (0x8086) 21:58:29 INFO - Device ID: 0x0a2e 21:58:29 INFO - Revision ID: 0x0009 21:58:29 INFO - Displays: 21:58:29 INFO - Display: 21:58:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:58:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:58:29 INFO - Display Serial Number: 1600x1200 60 21:58:29 INFO - Main Display: Yes 21:58:29 INFO - Mirror: Off 21:58:29 INFO - Online: Yes 21:58:29 INFO - Rotation: Supported 21:58:29 INFO - Return code: 0 21:58:29 INFO - Running post-action listener: _resource_record_post_action 21:58:29 INFO - [mozharness: 2016-11-01 04:58:29.984386Z] Finished run-tests step (success) 21:58:29 INFO - Running post-run listener: _resource_record_post_run 21:58:30 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 32791552; Write bytes: 662680064; Read time: 311; Write time: 1906 21:58:30 INFO - TinderboxPrint: CPU usage
53.4% 21:58:30 INFO - TinderboxPrint: I/O read bytes / time
32,791,552 / 311 21:58:30 INFO - TinderboxPrint: I/O write bytes / time
662,680,064 / 1,906 21:58:30 INFO - TinderboxPrint: CPU idle
2,255.4 (46.6%) 21:58:30 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 21:58:30 INFO - TinderboxPrint: CPU user
1,616.4 (33.4%) 21:58:30 INFO - TinderboxPrint: Swap in / out
392,949,760 / 0 21:58:30 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356514304; Write bytes: 355587584; Read time: 27736; Write time: 658 21:58:30 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 31861760; Write bytes: 296938496; Read time: 297; Write time: 1215 21:58:30 INFO - Running post-run listener: _upload_blobber_files 21:58:30 INFO - Blob upload gear active. 21:58:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58:30 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 21:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:58:30 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:58:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:31 INFO - (blobuploader) - INFO - Done attempting. 21:58:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:58:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:33 INFO - (blobuploader) - INFO - Done attempting. 21:58:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:35 INFO - (blobuploader) - INFO - Done attempting. 21:58:35 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:35 INFO - Return code: 0 21:58:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1e89ef58cd1b23a84ac42a017108c4a24d32aab50ccf50711bd9e5862db76e8f2060d33c4f7b4e86bdfd24d43df6d6585fa6bd95709efe797c5614d531ea124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca02ff945796c9f0666ecf6c089c7d455226ca1181959bb89608a90aad19475af77da438127cce352e5609c19435bbc2e990b1a01d5e0805352328db3b714bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fa5c9c718369213fa7095298647fbb65818f6279c66361b627baacdebe9ca3bd8f0ef0b33c8f86979d5af36625db982d5f14de7c6fa9b6c1b40dc908949103"} 21:58:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:35 INFO - Contents: 21:58:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1e89ef58cd1b23a84ac42a017108c4a24d32aab50ccf50711bd9e5862db76e8f2060d33c4f7b4e86bdfd24d43df6d6585fa6bd95709efe797c5614d531ea124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca02ff945796c9f0666ecf6c089c7d455226ca1181959bb89608a90aad19475af77da438127cce352e5609c19435bbc2e990b1a01d5e0805352328db3b714bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fa5c9c718369213fa7095298647fbb65818f6279c66361b627baacdebe9ca3bd8f0ef0b33c8f86979d5af36625db982d5f14de7c6fa9b6c1b40dc908949103"} 21:58:35 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:35 INFO - Copying logs to upload dir... 21:58:35 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.279022 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-31 21:58:35.615950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:58:35.619533) ========= 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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1e89ef58cd1b23a84ac42a017108c4a24d32aab50ccf50711bd9e5862db76e8f2060d33c4f7b4e86bdfd24d43df6d6585fa6bd95709efe797c5614d531ea124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca02ff945796c9f0666ecf6c089c7d455226ca1181959bb89608a90aad19475af77da438127cce352e5609c19435bbc2e990b1a01d5e0805352328db3b714bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fa5c9c718369213fa7095298647fbb65818f6279c66361b627baacdebe9ca3bd8f0ef0b33c8f86979d5af36625db982d5f14de7c6fa9b6c1b40dc908949103"} build_url:https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011089 build_url: 'https://queue.taskcluster.net/v1/task/Mbx5zH8yTDqwgexicPupVg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1e89ef58cd1b23a84ac42a017108c4a24d32aab50ccf50711bd9e5862db76e8f2060d33c4f7b4e86bdfd24d43df6d6585fa6bd95709efe797c5614d531ea124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca02ff945796c9f0666ecf6c089c7d455226ca1181959bb89608a90aad19475af77da438127cce352e5609c19435bbc2e990b1a01d5e0805352328db3b714bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38fa5c9c718369213fa7095298647fbb65818f6279c66361b627baacdebe9ca3bd8f0ef0b33c8f86979d5af36625db982d5f14de7c6fa9b6c1b40dc908949103"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:58:35.657304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:58:35.657698) ========= 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.fbUwYHkIcw/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.pWcfCdMlIT/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005061 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:58:35.711566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:58:35.712153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:58:35.712810) ========= ========= Total master_lag: 0.22 =========