builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0101 starttime: 1478311245.71 results: success (0) buildid: 20161104164820 builduid: 4594785487c147469deae647d17cff89 revision: dbcc5abc7d34396c89279c20ad93845dcfc5f1d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.711148) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.711841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.712188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.738376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.738764) ========= 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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-11-04 19:00:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-11-04 19:00:45 (19.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.879718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.880107) ========= 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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.026896 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:45.928955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-04 19:00:45.929350) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dbcc5abc7d34396c89279c20ad93845dcfc5f1d0 --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 dbcc5abc7d34396c89279c20ad93845dcfc5f1d0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ftIoPAlG5S/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.FVrZvhfZdm/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-11-04 19:00:46,014 truncating revision to first 12 chars 2016-11-04 19:00:46,014 Setting DEBUG logging. 2016-11-04 19:00:46,014 attempt 1/10 2016-11-04 19:00:46,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dbcc5abc7d34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 19:00:47,758 unpacking tar archive at: mozilla-aurora-dbcc5abc7d34/testing/mozharness/ program finished with exit code 0 elapsedTime=2.026488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-04 19:00:47.979737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:47.980077) ========= script_repo_revision: dbcc5abc7d34396c89279c20ad93845dcfc5f1d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:47.980459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:47.980723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 19:00:48.000232) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-04 19:00:48.000622) ========= /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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:00:48 INFO - MultiFileLogger online at 20161104 19:00:48 in /builds/slave/test 19:00:48 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 19:00:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:00:48 INFO - {'append_to_log': False, 19:00:48 INFO - 'base_work_dir': '/builds/slave/test', 19:00:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:00:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:00:48 INFO - 'branch': 'Mozilla-Aurora', 19:00:48 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:48 INFO - 'config_files': ('talos/mac_config.py',), 19:00:48 INFO - 'default_actions': ('clobber', 19:00:48 INFO - 'read-buildbot-config', 19:00:48 INFO - 'download-and-extract', 19:00:48 INFO - 'populate-webroot', 19:00:48 INFO - 'create-virtualenv', 19:00:48 INFO - 'install', 19:00:48 INFO - 'run-tests'), 19:00:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:48 INFO - 'download_minidump_stackwalk': True, 19:00:48 INFO - 'download_symbols': 'ondemand', 19:00:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:48 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:48 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:48 INFO - 'installer_path': 'installer.exe', 19:00:48 INFO - 'log_level': 'info', 19:00:48 INFO - 'log_name': 'talos', 19:00:48 INFO - 'log_to_console': True, 19:00:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:00:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:00:48 INFO - 'opt_config_files': (), 19:00:48 INFO - 'pip_index': False, 19:00:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:00:48 INFO - 'cmd': ('bash', 19:00:48 INFO - '-c', 19:00:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:00:48 INFO - 'enabled': True, 19:00:48 INFO - 'halt_on_failure': False, 19:00:48 INFO - 'name': 'check_screen_resolution'},), 19:00:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:00:48 INFO - 'cmd': ('bash', 19:00:48 INFO - '-c', 19:00:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:00:48 INFO - 'enabled': True, 19:00:48 INFO - 'halt_on_failure': False, 19:00:48 INFO - 'name': 'check_screen_resolution'},), 19:00:48 INFO - 'run_cmd_checks_enabled': True, 19:00:48 INFO - 'sps_profile': False, 19:00:48 INFO - 'sps_profile_interval': 0, 19:00:48 INFO - 'suite': 'dromaeojs', 19:00:48 INFO - 'system_bits': '32', 19:00:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:48 INFO - 'title': 't-yosemite-r7-0101', 19:00:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:48 INFO - 'use_talos_json': True, 19:00:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:00:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:48 INFO - 'work_dir': 'build'} 19:00:48 INFO - [mozharness: 2016-11-05 02:00:48.219241Z] Running clobber step. 19:00:48 INFO - Running pre-action listener: _resource_record_pre_action 19:00:48 INFO - Running main action method: clobber 19:00:48 INFO - rmtree: /builds/slave/test/build 19:00:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:00:50 INFO - Running post-action listener: _resource_record_post_action 19:00:50 INFO - [mozharness: 2016-11-05 02:00:50.882708Z] Finished clobber step (success) 19:00:50 INFO - [mozharness: 2016-11-05 02:00:50.882953Z] Running read-buildbot-config step. 19:00:50 INFO - Running pre-action listener: _resource_record_pre_action 19:00:50 INFO - Running main action method: read_buildbot_config 19:00:50 INFO - Using buildbot properties: 19:00:50 INFO - { 19:00:50 INFO - "project": "", 19:00:50 INFO - "product": "firefox", 19:00:50 INFO - "script_repo_revision": "production", 19:00:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 19:00:50 INFO - "repository": "", 19:00:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 19:00:50 INFO - "buildid": "20161104164820", 19:00:50 INFO - "pgo_build": "False", 19:00:50 INFO - "basedir": "/builds/slave/test", 19:00:50 INFO - "buildnumber": 14, 19:00:50 INFO - "slavename": "t-yosemite-r7-0101", 19:00:50 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:00:50 INFO - "platform": "yosemite_r7", 19:00:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:00:50 INFO - "branch": "mozilla-aurora", 19:00:50 INFO - "repo_path": "releases/mozilla-aurora", 19:00:50 INFO - "revision": "dbcc5abc7d34396c89279c20ad93845dcfc5f1d0", 19:00:50 INFO - "stage_platform": "macosx64", 19:00:50 INFO - "builduid": "4594785487c147469deae647d17cff89", 19:00:50 INFO - "slavebuilddir": "test" 19:00:50 INFO - } 19:00:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:00:50 INFO - Running post-action listener: _resource_record_post_action 19:00:50 INFO - [mozharness: 2016-11-05 02:00:50.888714Z] Finished read-buildbot-config step (success) 19:00:50 INFO - [mozharness: 2016-11-05 02:00:50.888940Z] Running download-and-extract step. 19:00:50 INFO - Running pre-action listener: _resource_record_pre_action 19:00:50 INFO - Running main action method: download_and_extract 19:00:50 INFO - mkdir: /builds/slave/test/build/tests 19:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:50 INFO - trying https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:00:50 INFO - Downloading https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/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 19:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/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 19:00:51 INFO - Downloaded 1199 bytes. 19:00:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:00:51 INFO - Using the following test package requirements: 19:00:51 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:00:51 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:00:51 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:00:51 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'jsshell-mac.zip'], 19:00:51 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:00:51 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:00:51 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:00:51 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:00:51 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:00:51 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:00:51 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:00:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:00:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:00:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:00:51 INFO - Fetch https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:00:52 INFO - Expected file size: 16421519 19:00:59 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 19:00:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:00:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:00:59 INFO - Fetch https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:00:59 INFO - Expected file size: 16421519 19:01:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 19:01:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:01:06 INFO - Fetch https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:01:06 INFO - Expected file size: 14414089 19:01:07 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')]} 19:01:07 INFO - trying https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:01:07 INFO - Downloading https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 19:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/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 19:01:10 INFO - Downloaded 115462083 bytes. 19:01:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:01:10 INFO - mkdir: /builds/slave/test/properties 19:01:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:01:10 INFO - Writing to file /builds/slave/test/properties/build_url 19:01:10 INFO - Contents: 19:01:10 INFO - build_url:https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:01:11 INFO - Running post-action listener: _resource_record_post_action 19:01:11 INFO - Running post-action listener: set_extra_try_arguments 19:01:11 INFO - [mozharness: 2016-11-05 02:01:11.145680Z] Finished download-and-extract step (success) 19:01:11 INFO - [mozharness: 2016-11-05 02:01:11.145836Z] Running populate-webroot step. 19:01:11 INFO - Running pre-action listener: _resource_record_pre_action 19:01:11 INFO - Running main action method: populate_webroot 19:01:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:01:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:01:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:01:11 INFO - '--tppagecycles', 19:01:11 INFO - '7'], 19:01:11 INFO - 'tests': ['tsvgm']}}, 19:01:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:01:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:01:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:01:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:01:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['damp', 'tps']}, 19:01:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'tests': ['damp', 'tps']}, 19:01:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['dromaeo_dom']}, 19:01:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:01:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['basic_compositor_video']}, 19:01:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:01:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['a11yr', 19:01:11 INFO - 'ts_paint', 19:01:11 INFO - 'tpaint', 19:01:11 INFO - 'sessionrestore', 19:01:11 INFO - 'sessionrestore_no_auto_restore', 19:01:11 INFO - 'tabpaint']}, 19:01:11 INFO - 'other-e10s': {'tests': ['a11yr', 19:01:11 INFO - 'ts_paint', 19:01:11 INFO - 'tpaint', 19:01:11 INFO - 'sessionrestore', 19:01:11 INFO - 'sessionrestore_no_auto_restore', 19:01:11 INFO - 'tabpaint']}, 19:01:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:01:11 INFO - 'ts_paint', 19:01:11 INFO - 'tpaint', 19:01:11 INFO - 'sessionrestore', 19:01:11 INFO - 'sessionrestore_no_auto_restore', 19:01:11 INFO - 'tabpaint']}, 19:01:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:01:11 INFO - 'ts_paint', 19:01:11 INFO - 'tpaint', 19:01:11 INFO - 'sessionrestore', 19:01:11 INFO - 'sessionrestore_no_auto_restore', 19:01:11 INFO - 'tabpaint']}, 19:01:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['a11yr', 19:01:11 INFO - 'ts_paint', 19:01:11 INFO - 'tpaint', 19:01:11 INFO - 'sessionrestore', 19:01:11 INFO - 'sessionrestore_no_auto_restore', 19:01:11 INFO - 'tabpaint']}, 19:01:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['a11yr', 19:01:11 INFO - 'ts_paint', 19:01:11 INFO - 'tpaint', 19:01:11 INFO - 'sessionrestore', 19:01:11 INFO - 'sessionrestore_no_auto_restore', 19:01:11 INFO - 'tabpaint']}, 19:01:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['tsvgx', 19:01:11 INFO - 'tsvgr_opacity', 19:01:11 INFO - 'tart', 19:01:11 INFO - 'tscrollx', 19:01:11 INFO - 'cart']}, 19:01:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:01:11 INFO - 'tsvgr_opacity', 19:01:11 INFO - 'tart', 19:01:11 INFO - 'tscrollx', 19:01:11 INFO - 'cart']}, 19:01:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'talos_options': ['--disable-e10s'], 19:01:11 INFO - 'tests': ['tp5o']}, 19:01:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'tests': ['tp5o']}, 19:01:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'talos_options': ['--disable-e10s', 19:01:11 INFO - '--xperf_path', 19:01:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:11 INFO - 'tests': ['tp5n']}, 19:01:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:11 INFO - 'talos_options': ['--xperf_path', 19:01:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:11 INFO - 'tests': ['tp5n']}}, 19:01:11 INFO - 'talos.zip': {'path': '', 19:01:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:01:11 INFO - Running post-action listener: _resource_record_post_action 19:01:11 INFO - [mozharness: 2016-11-05 02:01:11.164443Z] Finished populate-webroot step (success) 19:01:11 INFO - [mozharness: 2016-11-05 02:01:11.164581Z] Running create-virtualenv step. 19:01:11 INFO - Running pre-action listener: _resource_record_pre_action 19:01:11 INFO - Running main action method: create_virtualenv 19:01:11 INFO - Creating virtualenv /builds/slave/test/build/venv 19:01:11 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 19:01:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:01:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:01:11 INFO - Using real prefix '/tools/python27' 19:01:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:01:12 INFO - Installing distribute.............................................................................................................................................................................................done. 19:01:14 INFO - Installing pip.................done. 19:01:14 INFO - Return code: 0 19:01:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:01:14 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')]} 19:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:14 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')]} 19:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:14 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:14 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 19:01:14 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 19:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:14 INFO - 'HOME': '/Users/cltbld', 19:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:14 INFO - 'LOGNAME': 'cltbld', 19:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:14 INFO - 'MOZ_NO_REMOTE': '1', 19:01:14 INFO - 'NO_EM_RESTART': '1', 19:01:14 INFO - 'PAGER': '/bin/cat', 19:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:14 INFO - 'PWD': '/builds/slave/test', 19:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:14 INFO - 'SHELL': '/bin/bash', 19:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:14 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:14 INFO - 'USER': 'cltbld', 19:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:14 INFO - 'XPC_FLAGS': '0x0', 19:01:14 INFO - 'XPC_SERVICE_NAME': '0', 19:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:15 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 19:01:15 INFO - Cleaning up... 19:01:15 INFO - Return code: 0 19:01:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:15 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:15 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 19:01:15 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 19:01:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:15 INFO - 'HOME': '/Users/cltbld', 19:01:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:15 INFO - 'LOGNAME': 'cltbld', 19:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:15 INFO - 'MOZ_NO_REMOTE': '1', 19:01:15 INFO - 'NO_EM_RESTART': '1', 19:01:15 INFO - 'PAGER': '/bin/cat', 19:01:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:15 INFO - 'PWD': '/builds/slave/test', 19:01:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:15 INFO - 'SHELL': '/bin/bash', 19:01:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:15 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:15 INFO - 'USER': 'cltbld', 19:01:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:15 INFO - 'XPC_FLAGS': '0x0', 19:01:15 INFO - 'XPC_SERVICE_NAME': '0', 19:01:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:15 INFO - Downloading/unpacking psutil>=3.1.1 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:01:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:18 INFO - Installing collected packages: psutil 19:01:18 INFO - Running setup.py install for psutil 19:01:18 INFO - building 'psutil._psutil_osx' extension 19:01:18 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 19:01:19 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 19:01:19 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 19:01:19 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 19:01:19 INFO - building 'psutil._psutil_posix' extension 19:01:19 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 19:01:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:01:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:01:19 INFO - ^ 19:01:19 INFO - 1 warning generated. 19:01:19 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 19:01:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:19 INFO - Successfully installed psutil 19:01:19 INFO - Cleaning up... 19:01:20 INFO - Return code: 0 19:01:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:01:20 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')]} 19:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:20 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')]} 19:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:20 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:20 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 19:01:20 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 19:01:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:20 INFO - 'HOME': '/Users/cltbld', 19:01:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:20 INFO - 'LOGNAME': 'cltbld', 19:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:20 INFO - 'MOZ_NO_REMOTE': '1', 19:01:20 INFO - 'NO_EM_RESTART': '1', 19:01:20 INFO - 'PAGER': '/bin/cat', 19:01:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:20 INFO - 'PWD': '/builds/slave/test', 19:01:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:20 INFO - 'SHELL': '/bin/bash', 19:01:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:20 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:20 INFO - 'USER': 'cltbld', 19:01:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:20 INFO - 'XPC_FLAGS': '0x0', 19:01:20 INFO - 'XPC_SERVICE_NAME': '0', 19:01:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:01:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:01:22 INFO - Installing collected packages: mozsystemmonitor 19:01:22 INFO - Running setup.py install for mozsystemmonitor 19:01:23 INFO - Successfully installed mozsystemmonitor 19:01:23 INFO - Cleaning up... 19:01:23 INFO - Return code: 0 19:01:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:23 INFO - 'HOME': '/Users/cltbld', 19:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:23 INFO - 'LOGNAME': 'cltbld', 19:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:23 INFO - 'MOZ_NO_REMOTE': '1', 19:01:23 INFO - 'NO_EM_RESTART': '1', 19:01:23 INFO - 'PAGER': '/bin/cat', 19:01:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:23 INFO - 'PWD': '/builds/slave/test', 19:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:23 INFO - 'SHELL': '/bin/bash', 19:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:23 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:23 INFO - 'USER': 'cltbld', 19:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:23 INFO - 'XPC_FLAGS': '0x0', 19:01:23 INFO - 'XPC_SERVICE_NAME': '0', 19:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:23 INFO - Downloading/unpacking jsonschema==2.5.1 19:01:23 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 19:01:23 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 19:01:23 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 19:01:23 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 19:01:23 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 19:01:23 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 19:01:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:01:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:01:25 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 19:01:25 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 19:01:25 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 19:01:25 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 19:01:25 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 19:01:25 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 19:01:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:01:26 INFO - warning: no files found matching '*.txt' 19:01:26 INFO - no previously-included directories found matching 'build' 19:01:26 INFO - no previously-included directories found matching 'dist' 19:01:26 INFO - no previously-included directories found matching '.git*' 19:01:26 INFO - Installing collected packages: jsonschema, functools32 19:01:26 INFO - Running setup.py install for functools32 19:01:26 INFO - warning: no files found matching '*.txt' 19:01:26 INFO - no previously-included directories found matching 'build' 19:01:26 INFO - no previously-included directories found matching 'dist' 19:01:26 INFO - no previously-included directories found matching '.git*' 19:01:26 INFO - Successfully installed jsonschema functools32 19:01:26 INFO - Cleaning up... 19:01:26 INFO - Return code: 0 19:01:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:26 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:26 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 19:01:26 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 19:01:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:26 INFO - 'HOME': '/Users/cltbld', 19:01:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:26 INFO - 'LOGNAME': 'cltbld', 19:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:26 INFO - 'MOZ_NO_REMOTE': '1', 19:01:26 INFO - 'NO_EM_RESTART': '1', 19:01:26 INFO - 'PAGER': '/bin/cat', 19:01:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:26 INFO - 'PWD': '/builds/slave/test', 19:01:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:26 INFO - 'SHELL': '/bin/bash', 19:01:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:26 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:26 INFO - 'USER': 'cltbld', 19:01:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:26 INFO - 'XPC_FLAGS': '0x0', 19:01:26 INFO - 'XPC_SERVICE_NAME': '0', 19:01:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:01:26 INFO - Cleaning up... 19:01:27 INFO - Return code: 0 19:01:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:01:27 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')]} 19:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:27 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')]} 19:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:27 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:27 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 19:01:27 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 19:01:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:27 INFO - 'HOME': '/Users/cltbld', 19:01:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:27 INFO - 'LOGNAME': 'cltbld', 19:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:27 INFO - 'MOZ_NO_REMOTE': '1', 19:01:27 INFO - 'NO_EM_RESTART': '1', 19:01:27 INFO - 'PAGER': '/bin/cat', 19:01:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:27 INFO - 'PWD': '/builds/slave/test', 19:01:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:27 INFO - 'SHELL': '/bin/bash', 19:01:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:27 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:27 INFO - 'USER': 'cltbld', 19:01:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:27 INFO - 'XPC_FLAGS': '0x0', 19:01:27 INFO - 'XPC_SERVICE_NAME': '0', 19:01:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:27 INFO - Downloading/unpacking blobuploader==1.2.4 19:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:29 INFO - Downloading blobuploader-1.2.4.tar.gz 19:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:01:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:01:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:01:30 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 19:01:30 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 19:01:30 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 19:01:30 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 19:01:30 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 19:01:30 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 19:01:30 INFO - Downloading docopt-0.6.1.tar.gz 19:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:01:30 INFO - Installing collected packages: blobuploader, requests, docopt 19:01:30 INFO - Running setup.py install for blobuploader 19:01:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:01:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:01:31 INFO - Running setup.py install for requests 19:01:31 INFO - Running setup.py install for docopt 19:01:31 INFO - Successfully installed blobuploader requests docopt 19:01:31 INFO - Cleaning up... 19:01:31 INFO - Return code: 0 19:01:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:31 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:31 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 19:01:31 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 19:01:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:31 INFO - 'HOME': '/Users/cltbld', 19:01:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:31 INFO - 'LOGNAME': 'cltbld', 19:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:31 INFO - 'MOZ_NO_REMOTE': '1', 19:01:31 INFO - 'NO_EM_RESTART': '1', 19:01:31 INFO - 'PAGER': '/bin/cat', 19:01:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:31 INFO - 'PWD': '/builds/slave/test', 19:01:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:31 INFO - 'SHELL': '/bin/bash', 19:01:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:31 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:31 INFO - 'USER': 'cltbld', 19:01:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:31 INFO - 'XPC_FLAGS': '0x0', 19:01:31 INFO - 'XPC_SERVICE_NAME': '0', 19:01:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-dJ6i1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-XH2_7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ik06Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Piy6Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-wcR4Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-cjo1c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-uA3haP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-UtH6XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-YSz4aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-aKEkO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-AOB_wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-o6IxzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-tH2Tip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-8B_e6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-jcztAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-uJy899-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-s8EgLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:01:33 INFO - Running setup.py install for manifestparser 19:01:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:01:34 INFO - Running setup.py install for mozcrash 19:01:34 INFO - Running setup.py install for mozdebug 19:01:34 INFO - Running setup.py install for mozdevice 19:01:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:01:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:01:34 INFO - Running setup.py install for mozfile 19:01:34 INFO - Running setup.py install for mozhttpd 19:01:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:01:34 INFO - Running setup.py install for mozinfo 19:01:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:01:34 INFO - Running setup.py install for mozInstall 19:01:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Running setup.py install for mozleak 19:01:35 INFO - Running setup.py install for mozlog 19:01:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Running setup.py install for moznetwork 19:01:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Running setup.py install for mozprocess 19:01:35 INFO - Running setup.py install for mozprofile 19:01:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:01:35 INFO - Running setup.py install for mozrunner 19:01:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:01:36 INFO - Running setup.py install for mozscreenshot 19:01:36 INFO - Running setup.py install for moztest 19:01:36 INFO - Running setup.py install for mozversion 19:01:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:01:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:01:36 INFO - Cleaning up... 19:01:36 INFO - Return code: 0 19:01:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:36 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')]} 19:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:36 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')]} 19:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:36 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:36 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 19:01:36 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 19:01:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:36 INFO - 'HOME': '/Users/cltbld', 19:01:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:36 INFO - 'LOGNAME': 'cltbld', 19:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:36 INFO - 'MOZ_NO_REMOTE': '1', 19:01:36 INFO - 'NO_EM_RESTART': '1', 19:01:36 INFO - 'PAGER': '/bin/cat', 19:01:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:36 INFO - 'PWD': '/builds/slave/test', 19:01:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:36 INFO - 'SHELL': '/bin/bash', 19:01:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:36 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:36 INFO - 'USER': 'cltbld', 19:01:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:36 INFO - 'XPC_FLAGS': '0x0', 19:01:36 INFO - 'XPC_SERVICE_NAME': '0', 19:01:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:36 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-bxFNL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:36 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)) 19:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:36 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-30AYTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-bncC9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-QrD2Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-OfzL5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Wk5mUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Nl3zxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-yMUY0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-bXn_mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Zx4kNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-YNjCid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:37 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)) 19:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-roSmks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:38 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)) 19:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Wr5uWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:38 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)) 19:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-9kRZan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:38 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)) 19:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-FQ0hku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:38 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)) 19:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eUtUZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:38 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)) 19:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-T4YSfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:38 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)) 19:01:38 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)) 19:01:38 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)) 19:01:38 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)) 19:01:38 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)) 19:01:38 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)) 19:01:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:41 INFO - Downloading blessings-1.6.tar.gz 19:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:01:41 INFO - Installing collected packages: blessings 19:01:41 INFO - Running setup.py install for blessings 19:01:41 INFO - Successfully installed blessings 19:01:41 INFO - Cleaning up... 19:01:41 INFO - Return code: 0 19:01:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:41 INFO - Reading from file tmpfile_stdout 19:01:41 INFO - Current package versions: 19:01:41 INFO - blessings == 1.6 19:01:41 INFO - blobuploader == 1.2.4 19:01:41 INFO - docopt == 0.6.1 19:01:41 INFO - functools32 == 3.2.3-2 19:01:41 INFO - jsonschema == 2.5.1 19:01:41 INFO - manifestparser == 1.1 19:01:41 INFO - mozInstall == 1.12 19:01:41 INFO - mozcrash == 0.17 19:01:41 INFO - mozdebug == 0.1 19:01:41 INFO - mozdevice == 0.48 19:01:41 INFO - mozfile == 1.2 19:01:41 INFO - mozhttpd == 0.7 19:01:41 INFO - mozinfo == 0.9 19:01:41 INFO - mozleak == 0.1 19:01:41 INFO - mozlog == 3.4 19:01:41 INFO - moznetwork == 0.27 19:01:41 INFO - mozprocess == 0.23 19:01:41 INFO - mozprofile == 0.28 19:01:41 INFO - mozrunner == 6.12 19:01:41 INFO - mozscreenshot == 0.1 19:01:41 INFO - mozsystemmonitor == 0.3 19:01:41 INFO - moztest == 0.7 19:01:41 INFO - mozversion == 1.4 19:01:41 INFO - psutil == 3.1.1 19:01:41 INFO - requests == 1.2.3 19:01:41 INFO - wsgiref == 0.1.2 19:01:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:42 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 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:42 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 19:01:42 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 19:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:42 INFO - 'HOME': '/Users/cltbld', 19:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:42 INFO - 'LOGNAME': 'cltbld', 19:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:42 INFO - 'MOZ_NO_REMOTE': '1', 19:01:42 INFO - 'NO_EM_RESTART': '1', 19:01:42 INFO - 'PAGER': '/bin/cat', 19:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:42 INFO - 'PWD': '/builds/slave/test', 19:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:42 INFO - 'SHELL': '/bin/bash', 19:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:42 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:42 INFO - 'USER': 'cltbld', 19:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:42 INFO - 'XPC_FLAGS': '0x0', 19:01:42 INFO - 'XPC_SERVICE_NAME': '0', 19:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 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)) 19:01:42 INFO - Cleaning up... 19:01:42 INFO - Return code: 0 19:01:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106209490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc573c8e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, '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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 19:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:01:42 INFO - 'HOME': '/Users/cltbld', 19:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:01:42 INFO - 'LOGNAME': 'cltbld', 19:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:42 INFO - 'MOZ_NO_REMOTE': '1', 19:01:42 INFO - 'NO_EM_RESTART': '1', 19:01:42 INFO - 'PAGER': '/bin/cat', 19:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:42 INFO - 'PWD': '/builds/slave/test', 19:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:01:42 INFO - 'SHELL': '/bin/bash', 19:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:01:42 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:01:42 INFO - 'USER': 'cltbld', 19:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:42 INFO - 'XPC_FLAGS': '0x0', 19:01:42 INFO - 'XPC_SERVICE_NAME': '0', 19:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:01:42 INFO - Cleaning up... 19:01:42 INFO - Return code: 0 19:01:42 INFO - Running post-action listener: _resource_record_post_action 19:01:42 INFO - Running post-action listener: _start_resource_monitoring 19:01:42 INFO - Starting resource monitoring. 19:01:42 INFO - [mozharness: 2016-11-05 02:01:42.736220Z] Finished create-virtualenv step (success) 19:01:42 INFO - [mozharness: 2016-11-05 02:01:42.737231Z] Running install step. 19:01:42 INFO - Running pre-action listener: _resource_record_pre_action 19:01:42 INFO - Running main action method: install 19:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:42 INFO - Reading from file tmpfile_stdout 19:01:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:01:43 INFO - Reading from file tmpfile_stdout 19:01:43 INFO - Output received: 19:01:43 INFO - Usage: mozinstall [options] installer 19:01:43 INFO - Options: 19:01:43 INFO - -h, --help show this help message and exit 19:01:43 INFO - -d DEST, --destination=DEST 19:01:43 INFO - Directory to install application into. [default: 19:01:43 INFO - "/builds/slave/test"] 19:01:43 INFO - --app=APP Application being installed. [default: firefox] 19:01:43 INFO - mkdir: /builds/slave/test/build/application 19:01:43 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'] 19:01:43 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 19:02:15 INFO - Reading from file tmpfile_stdout 19:02:15 INFO - Output received: 19:02:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:02:15 INFO - Running post-action listener: _resource_record_post_action 19:02:15 INFO - [mozharness: 2016-11-05 02:02:15.782809Z] Finished install step (success) 19:02:15 INFO - [mozharness: 2016-11-05 02:02:15.782945Z] Running run-tests step. 19:02:15 INFO - Running pre-action listener: _resource_record_pre_action 19:02:15 INFO - Running main action method: run_tests 19:02:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:02:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:02:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:02:15 INFO - 2016-11-04 19:02:15.797 screenresolution[1640:7539] starting screenresolution argv=screenresolution get 19:02:15 INFO - 2016-11-04 19:02:15.800 screenresolution[1640:7539] Display 0: 1600x1200x32@60 19:02:15 INFO - 2016-11-04 19:02:15.805 screenresolution[1641:7541] starting screenresolution argv=screenresolution list 19:02:15 INFO - Available Modes on Display 0 19:02:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:02:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:02:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:02:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:02:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:02:16 INFO - Intel Iris: 19:02:16 INFO - Chipset Model: Intel Iris 19:02:16 INFO - Type: GPU 19:02:16 INFO - Bus: Built-In 19:02:16 INFO - VRAM (Dynamic, Max): 1536 MB 19:02:16 INFO - Vendor: Intel (0x8086) 19:02:16 INFO - Device ID: 0x0a2e 19:02:16 INFO - Revision ID: 0x0009 19:02:16 INFO - Displays: 19:02:16 INFO - Display: 19:02:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:02:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:02:16 INFO - Display Serial Number: 1600x1200 60 19:02:16 INFO - Main Display: Yes 19:02:16 INFO - Mirror: Off 19:02:16 INFO - Online: Yes 19:02:16 INFO - Rotation: Supported 19:02:16 INFO - Return code: 0 19:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:02:16 INFO - Python 2.7.3 19:02:16 INFO - Return code: 0 19:02:16 INFO - grabbing minidump binary from tooltool 19:02:16 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')]} 19:02:16 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 0x10601dd30>, '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 0x105e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106015b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:02:16 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 19:02:16 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 19:02:16 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 19:02:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:02:16 INFO - Return code: 0 19:02:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:02:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:02:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:02:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:02:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:02:16 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/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 19:02:16 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/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --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 19:02:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ftIoPAlG5S/Render', 19:02:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:16 INFO - 'HOME': '/Users/cltbld', 19:02:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:16 INFO - 'LOGNAME': 'cltbld', 19:02:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:02:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:16 INFO - 'MOZ_NO_REMOTE': '1', 19:02:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:02:16 INFO - 'NO_EM_RESTART': '1', 19:02:16 INFO - 'PAGER': '/bin/cat', 19:02:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:16 INFO - 'PWD': '/builds/slave/test', 19:02:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:02:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:16 INFO - 'SHELL': '/bin/bash', 19:02:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVrZvhfZdm/Listeners', 19:02:16 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 19:02:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:16 INFO - 'USER': 'cltbld', 19:02:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:16 INFO - 'XPC_FLAGS': '0x0', 19:02:16 INFO - 'XPC_SERVICE_NAME': '0', 19:02:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:16 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/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 19:02:16 INFO - mozversion application_buildid: 20161104164820 19:02:16 INFO - mozversion application_changeset: dbcc5abc7d34396c89279c20ad93845dcfc5f1d0 19:02:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:02:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:02:16 INFO - mozversion application_name: Firefox 19:02:16 INFO - mozversion application_remotingname: firefox-dev 19:02:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:02:16 INFO - mozversion application_vendor: Mozilla 19:02:16 INFO - mozversion application_version: 51.0a2 19:02:16 INFO - mozversion platform_buildid: 20161104164820 19:02:16 INFO - mozversion platform_changeset: dbcc5abc7d34396c89279c20ad93845dcfc5f1d0 19:02:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:02:16 INFO - mozversion platform_version: 51.0a2 19:02:16 INFO - using testdate: 1478311336 19:02:16 INFO - actual date: 1478311336 19:02:16 INFO - starting webserver on 'localhost:49274' 19:02:16 INFO - SUITE-START | Running 2 tests 19:02:16 INFO - TEST-START | dromaeo_css 19:02:16 INFO - operating with platform_type : mac_ 19:02:16 INFO - Initialising browser for dromaeo_css test... 19:02:16 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp3jsndU/profile http://localhost:49274/getInfo.html) 19:02:18 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 19:02:18 INFO - PROCESS | 1651 | colorDepth:24 19:02:18 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 19:02:18 INFO - PROCESS | 1651 | __metrics 19:02:18 INFO - PROCESS | 1651 | 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" 19:02:18 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:19 INFO - TEST-INFO | 1651: exit 0 19:02:19 INFO - Browser initialized. 19:02:19 INFO - Running cycle 1/1 for dromaeo_css test... 19:02:19 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp3jsndU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:31 INFO - PROCESS | 1653 | RSS: Main: 219693056 19:02:31 INFO - PROCESS | 1653 | 19:03:22 INFO - PROCESS | 1653 | 1478311402897 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] 19:05:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 19:05:36 INFO - PROCESS | 1653 | RSS: Main: 359882752 19:05:36 INFO - PROCESS | 1653 | 19:08:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 19:08:40 INFO - PROCESS | 1653 | RSS: Main: 351154176 19:08:40 INFO - PROCESS | 1653 | 19:11:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 19:11:43 INFO - PROCESS | 1653 | RSS: Main: 321802240 19:11:43 INFO - PROCESS | 1653 | 19:14:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 19:14:46 INFO - PROCESS | 1653 | RSS: Main: 317784064 19:14:46 INFO - PROCESS | 1653 | 19:17:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 19:17:50 INFO - PROCESS | 1653 | RSS: Main: 312438784 19:17:50 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 19:20:53 INFO - PROCESS | 1653 | RSS: Main: 439025664 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | __start_tp_report 19:20:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 19:20:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 19:20:53 INFO - PROCESS | 1653 | |i|pagename|runs| 19:20:53 INFO - PROCESS | 1653 | |0;dojo.html;3269.8228637690436;3296.9779368395793;3304.0913748719113;3324.5345651608795;3339.8310591293034;5638.492535671789;5690.374058853523;5760.855978600537;5775.0182468980265;5791.7972870949525;5644.181593668915;5676.148577713345;5689.51639110675;5690.57320700947;5696.601237913337;5154.458781827911;5164.380274367081;5169.250458683488;5181.637285390006;5202.089634313998;5180.6373553851245;5187.325647665798;5191.143461328877;5271.42014378418;5326.360836699601;5205.505476979681;5205.557527610139;5212;5270.156774916014;5304.416514183436;5244.973775131138;5249.685018898878;5253.816116435944;5258.789648414059;5301.231321458406;4240.639545638624;5171.456997015334;5252.606054545886;5254.185601231815;5301.867453313698;5519.475649813261;5570.498655121018;5578.832635020955;5587.469190426903;5717.171010203498;6128.322667212046;6194.628322300677;6228;6231.283402408736;6237.064440333941;6199.535034872402;6284.088807122942;6312.936870631281;6320.968395158041;6343.14367560378;5637.774489020475;5685.289338832646;5708.001099807517;5768.3654797972185;5769.826905192851;5255.894882102413;6224.37756224374;6277.027060805583;6290.433860952445;6311.431971122529;6123.09992524296;6134.478569321568;6147.415995480422;6157.230346206724;6162.26052873649;6158.476529494954;6269.404406581368;6275.905861411991;6285.371462853678;6296.244450665949;6055.878882422415;6097.725602347905;6111.419415155553;6140.662263575457;6198.473129784019;6203.16257305258;6273.435390814758;6290.685465726695;6293.213348331458;6294.968525157345;4926.187179115477;4954.702717836942;4957.281194226817;4968.627352948543;4991.301217829507;4339.284018137035;4386.342048692722;4431.601155895921;4439.578240067253;4448.221561226773;5663.8867222656145;5705.457981491834;5751.971240143856;5760;5805.158252053513;6283.37166283368;6305.306416294204;6313.715882785285;6316.62100273985;6317.526185536103;5722.885542289131;5761.193432919395;5765.798197063083;5803.245578074823;5814.883702325929;5289.761960711778;5316.680999140064;5336.46635336471;5351.491608297206;5355.036093503207;6230.127782110599;6239.594426362272;6270.968645156745;6271.498280137669;6294.43350098475;6249.968750156402;6267.435930766071;6270.74917003333;6275.215598050244;6296.905546416899;6222.875542489215;6237.532185086227;6269.467095296768;6271.153394291895;6285.685715714105;6038.547108966933;6079.817605471843;6105.010960388573;6114.57197996136;6150.907736383869;6127.662978536223;6189.102580125947;6280.905786413299;6292.339304373158;6294.496440284858;5853.765849365977;5932.080527518242;6018.21763170785;6049.527832011766;6053.788117415869;6012.609180403259;6076.361981991828;6097.695115244309;6110.26676798787;6111.297200821962;5998.1002849572915;6059.521857312536;6076.797320467302;6081.695915204311;6115.480184184395;6119.571629986036;6173.32093469709;6173.783917562864;6181;6196.1015652731;5781.537477001746;5837.883242335045;6019.819405417845;6069.2716873975405;6077.878442431215 19:20:53 INFO - PROCESS | 1653 | |1;ext.html;493.7185804091667;498.53679450811893;502.17392389519244;527.4172039895915;529.1190168369665;30956.380872382568;41260.79369603151;42442.78778606107;42511.574884251146;44149.55850441495;36351.63648363516;36480.45279320806;43601.34597981025;43987.78006109973;44007;8929;9132.543372831366;9161.26709863211;9266.397684150543;9301.209397201212;9016.098390160963;12066.336351500664;12337.074719396081;12414.751704965895;12584.119111662187;12405.503779848796;12469;12484.063695222849;12486.063545234098;12511.124221304512;12284.570040048555;12350.073744469111;12350.258984460961;12365.196262242971;12387.256764594153;12119.454624541917;12191.756164876742;12207.694807629792;12219.755604887941;12221.327826969513;41365.37951930724;41729;41754.95612609679;41842.58157418417;41897.95255118616;3228.4350238708134;3305.752068594865;3313.287643156733;3347.163209197701;3364.66353364664;31604.841975790205;31901;31956.721731130958;32225.87209447658;32386.190345241557;3104.394643044607;3141.1832923439842;3217.324361884007;3218.243712727507;3227.209333713232;513618;518180.40909795207;518392.40803796117;518572;520030;63315.68342158352;63664.72670546563;63696;63712;63822.68088659527;35135.4729679055;36148.819255904076;36174.0956476085;37364.25271494555;66775;17126.314947401963;17282;17294.221760020828;17304;17314.961102333902;11824.822627660593;12058.638240852788;12995.025373097056;13118.803217951738;13162.276074815976;19384.8061519383;19729.816211027384;19767.209311627375;19770.50573735668;19774;6357.872842543124;7675.15573286938;7976.641051152712;8004.879926801103;8151.062627797761;768.6080099149362;899.0964081098585;972.7227740094039;1031.1330519945843;1042.9582816687248;29602.407951841273;30384.54423183654;30552.54171187434;30757;31022.689773102433;1029.8661174047327;1056.572088304238;1111.5053801058614;1131.298594871185;1135.3415019288793;15239.314230859638;16922;17069.317227311018;17098.487045388658;17317.307307707804;682552;686763;688638;688864;689079;61405.69297153486;61697.383026170064;61743.38256617466;61799;61899;1233.3339996402021;1234.4444999750149;1262.9557965471165;1329.4283458113105;1374.8281464816898;31005;31328.843355783985;31911.68088319087;32015.039548813573;32735.672643274214;51666.741666291426;52235.47764522458;52266;52291.47708522866;52440;564859;576962;577756;578407;579417;28301.292467688472;28684.422356769745;28688.856555717088;28718.994835180667;28771.85614072;48512.787180320774;48827.75586122047;48942.77643058952;49275;49477;38735;39235.38342832896;40842.79578602207;42008.57991420169;42196;40073.799631002825;40368.587099451375;40409;41964.580354197285;42151;39140.2171956565;39886.800565996986;40160.397594036694;40186.39720404138;40229;33235.66764332326;35315.47026794651;35769.642303576635;36143.45784813283;36201.818990904874;25966.740332597186;26274;26291.474170516864;26583.601245981714;27154.72845271601 19:20:53 INFO - PROCESS | 1653 | |2;jquery.html;353.9044457996343;361.4379639660328;378.8465671403082;379.4460088271122;406.51827584312593;14814.629634259136;15102.471413500516;16032.43886463974;20379.388618341436;20448.182072717074;19412.320568780095;20157.697634535456;20197.293094741686;20425.28511502098;20559.588808223827;5155.871103222412;5727.513161381277;6012.5791194616395;6012.699365031753;6020.12708157317;5816.069428891378;5941.851453713649;6007.399260073979;6007.7596896124105;6017.518598512131;5654.37801841797;5826.708664566776;5956.136360227764;5962.79130230442;5967.880642387149;5789.16057171712;5793.681347525884;5833.154192642043;5834.533237341003;5842.883142337172;5115.2327150927285;5118.744062796883;5253.921191182136;5457.699826509541;5536.474034966672;13084.411201495956;13127.606171814861;13153.145045572102;13354.26551539665;13369.529351771298;2132.3283165802877;2141.389703934387;2277.1802151225547;2338.8012018978407;2993.266649670845;8189.631466584018;9655.565499552467;9806.215502759762;10384.480775961172;10466.162706983423;1775.8668099892432;1798.5953160538904;1838.5771272607242;1864.5804693943753;1912.6939689649728;120786;123848.76151238462;130311;131830.34084829513;135769.3211533946;11238.438078096062;11540.94229528847;11664.358460284766;11744.647660570197;11891.405429728478;14877.256137193097;14888.553343399715;14950;14994.175320357484;15026.474073407378;8397.748067557983;8639.740807775652;8656.61045252965;8778.253848422828;8828.42615230008;8632.568371581396;8635.740927772176;8660.913390866137;8798.648054077765;8825.426347287406;4470.798814053375;4559.52125026874;4571;4633.907321853544;4670.9766451167525;1868.168664944087;1907.761529808774;1940.9126589303514;1951.414575627306;1983.2562788954142;835.4945258118872;903.6490446781971;918.2562124679031;999.3104757717152;1043.9321444106108;20449.386518404473;21216.681749773765;21351.46621334448;21362.252321168686;21430.57138857214;821.5768879027306;860.1269711243093;911.589784596934;921.4517362169498;922.6540047482194;10164.390136591828;11127.777444451227;11133.888661113448;11270.774584508265;11275.774484510264;620945;622883;630684;632954;633283;57864;71169.64415177994;108098;109000;139708.90436643458;741.499487845702;879.2570278114982;910.5366250993848;941.8398872191743;962.711186644004;18815.341463048728;19123.521911952314;19176.8082319175;19397.709034364212;19409.93245371518;46795.29807052965;56528.434715652314;57477.42522574888;57959.710201448725;60224.69887650534;82279.58860205661;83087.58456207681;86486;87900.68148977643;88335.55832220797;5669.5180909621495;7912;7950.801229969297;8249.175082491704;8374.790630234293;10622;12551;12670.366481675695;12815.231086134861;13077.149985250928;10906.61826836057;10966.780664386828;11170.609028683957;11266.211365204357;11377.715557111138;10510.316829406063;10568.418736969541;10923.563057477611;11092.778144437227;11444.828327574927;9872.111509964137;10377.584896604052;11606.24559403636;11659.300441973508;11738;7898.526088434713;8030.23712747288;8340.958295208486;8477.618507167315;8547.957260213909;8717.215450609476;11187.16096292765;11321.886781132413;11329;11718 19:20:53 INFO - PROCESS | 1653 | |3;mootools.html;1337.478383430462;1530.7803684657242;1697.8896371735837;1843.566761810975;1905.7427247321616;8010.43926925114;8245.216704413086;8499.575021248937;9058.592363343649;9066.365354425192;8178.304844088245;8602.09677983812;8803.515806630632;8815.250703690179;8967.237784788285;2364.219807463533;2403.158894386968;2407.16952651335;2410.3974006498374;2410.867402292873;2026.7061276115028;2381.785639292463;2401.519696060786;2421.1767998880377;2431.878406079698;2095.5704080663427;2169.208238992764;2171.272623671072;2171.381156370435;2177.1073859717517;2146.3131797824703;2319.7332306784765;2386.033656369173;2391.4380120671626;2397.7122745270503;2380.4286971126803;2388.3312672451566;2396.808255339586;2404.0984630763464;2411.9397015074587;8895.955520222358;8966.506842123681;9004.819903601956;9058.501782401965;9067.773305667346;5160.974195129001;5333.786648534054;5352.892942141174;5355.464453554652;5357.8392648220615;3171.334019855833;3416.641252668484;3458.1354661334667;3499.492573576817;3578.4095624221973;898.5058217980085;1026.8973102689747;1047.8009178256107;1073.8335557988523;1082.8484012238293;11854;11919.046476281877;11920.761584768255;11922.10584206188;11945.820812687904;4535.183666939916;4638.83764068256;4838.927416088762;4847.297141914473;4866.659333846667;10124.341917775468;10143.7464063399;10144.594216231415;10165.339252948535;10166.898331016595;5404.567634589223;5414.160805075219;5420.105682562412;5420.4850539198715;5461.918071228934;4796.760161991887;4921.50784921505;4934.1611925972675;4945;4952.405711314594;3337.5494308268558;3826.234753049401;3841.2317536492815;3895.552011518655;3919.706022048301;897.3314880414002;1178.5109179690332;1185.6917201527492;1188.3523479703583;1204.6747378207835;783.7962129846281;860.0652017022148;892.2103938014774;900.0774206438322;902.5351943748974;5285.947140528622;5713.257276554022;5782.797602083907;5894.381089985575;5959.404059594006;467.9836205732783;487.4297072425271;489.27587170986425;490.1422510606439;623.800383877164;3798.278327117894;3961.742486738353;4003.8999025024023;4084.346504559256;4140.3375459926265;9064.456132632064;11025.062869656009;11171.497282622302;11181.385023823768;11226.887731122748;11106;11122.55509779616;11122.61070862516;11124.944375278072;11131.554737810558;7960.562169080757;8238.876416853753;8484.109168537338;8489.066202717697;8504.107068757816;5044.394672639307;5890.793822216202;6010.939890601213;6036.577439579363;6131.019036954066;9942.552585133832;9989.300748947795;10080.04239597237;10159.492025398553;10165.644202452879;10161.339512931636;10399.376037437476;10553.366797992145;10584.153267738408;10601.787964240826;7723.884141737766;7757.92242077572;7825.139234684067;7840.176781438095;7850.489718168301;8270.214329638675;8456.619452124545;8465.78835529092;8471.703490377808;8477.02514210849;7533.962330188314;7656.310932016146;7677.9232207677205;7716.961415192888;7802.024746906637;7306.561606303426;7421.962890185515;7424.740134095281;7528;7528.623568821427;7140.892886606601;7142.357187853118;7227.168875579376;7234.674439650334;7235.2402997686595;4727.865312324949;4740.715557066587;5011.517889803943;5053.292539044463;5186.559142472932;4958.225037094562;5029.723365214948;5135.024345374367;5221.269022336952;5320.866978325418 19:20:53 INFO - PROCESS | 1653 | |4;prototype.html;260.25047862157;298.5506812247567;308.23403841453984;311.56692197844984;315.76948827356046;5396.973015134924;5445.591580631459;5478.589105817065;5487.64330318529;5541.33503979523;5000.999800039997;5037.370328708911;5361.839144825652;5400.081986062369;5421.647592906458;3198.4562624353857;3949.5063117110362;3999.3002973736047;4008.0981779099616;4150.916981660365;3898.200868821885;4057.2088442753675;4116.567760385161;4170.624643782059;4180.540140584533;3636.6181550937167;4067.430559721641;4087.2438598859308;4100.425940368336;4126.793660316987;3186.713195812388;3523.2953409317984;4084.060666046811;4096.91806163878;4127.153933443652;3480.9383138142857;3482.233908540117;3493.8427770750122;3499.982500087509;3512.209752805624;5223.947760522384;5243.973780131113;5268.262443257947;5270.92093618596;5273.973630131824;4038.495188101487;4180.226658068267;4278.850240241577;4518.73475426881;4643.399696170156;5629.352624448159;5641.887162256773;5649.435056494359;5653.8586535336535;5658;3395.5416018837636;3405.1997780521556;3560.3769340365593;3757.436384542313;3885.0287428142965;5509.834704958817;5881.2942446906645;5921.526277897758;5925.970370148165;5979.820605381846;3233.2078640732702;3548.4096609475228;3801.847926082926;3914.5889681583594;3917.843286268517;3489.2149266414854;3520.471929210588;3918.3534716771414;3964.266610677034;3975.8210880510446;4433.578810013044;4576.931346029813;4582.473015603248;4631.166390049756;4649.604783593365;5636.915446268309;5646.023891637894;5646.20953066571;5665.688387138664;5678.574106941914;1199.4782269712703;1218.8902998730157;1318.3540065367902;1343.4416077350422;1346.750851092551;671.1778071862028;771.3559178086249;818.2571123506892;834.841380137784;860.4364141487335;4605.516420775771;4913.128811070807;5378.477097501143;5422.376426710979;5447.727613619303;5787.392323806024;5798.217240672455;5838.948989181903;5859.824205273849;5893.8782038466115;4256.106217694319;4808.567228949411;5146.433892271847;5354.009508240988;5366.91949620756;2958;3043.3000409905844;3052.1759125036115;3054.823892801243;3058.638905686948;5033.458103657629;5417.295751552352;5986.431289027535;5994.580379373489;6009.549283803733;5479.643753186168;5914.526837853047;5927.436893495111;6009.338972712998;6049.334573196945;5266.999270138662;5978.641281523035;5988.730507127189;5993.790217342459;6013.398660133952;4806;5761.341548116892;5761.654300741969;5769.451902069297;5796.275465566804;4918.6065114791445;4931.038447502702;5532.75102620375;5551.2544516425305;5720.742566584597;4999.725015124058;5209.114450543492;5316.415194328698;5381.381141168659;5982.4316689914385;3549.225387306347;3689.538807649044;3857.112864041342;3857.247836671822;3943.2704949584418;4971.577415919543;5664.631798933056;5756.136579513107;5778.855528611818;5788.565857560784;5655.604107712421;5661.122526008476;5661.801836935688;5670.574706897081;5701.543876489788;5060.658925384702;5260.763265652979;5582.776688932559;5584;5596.565494009956;4760.168429044592;5274.077036518517;5357;5508.531774799027;5544.390117087198;5256.78972841082;5296.947030529799;5492.642978206563;5496.450354964471;5502.779888804563;4621.514740952151;5010.599152067753;5464.28964234647;5475.863103422446;5503.614746967673 19:20:53 INFO - PROCESS | 1653 | |5;yui.html;698.5773606967788;699.8705239530688;736.9705211791529;765.09336436323;796.4186144114796;13973.720525589495;15158.62103447413;15166.469173578927;15183.240837958114;15190.392384304641;13699.657508562292;13860.37628306726;13862;13890.166590004606;13944.651383715387;658.2594581096266;677.7695583501633;682.6279677575708;684.0457561701423;817.2930415190847;663.7643636509042;684.4216636941801;689.4312192441231;854.1074577066948;855.5380094748829;898.7753061734567;906.5104843384564;910.6129894794685;911.1935936696005;913.6619450803212;906.062225596511;906.6328137104483;907.0022974727813;907.63694522191;908.2325435007408;516.2488579117376;534.9946500535023;667.306001758171;669.036587314266;670.9798706038827;11404.771904561945;14311.212883291415;14361.281935903164;14679.339429725687;14699.55901322962;13743;13999.230042347666;14198.148111113367;14298.428062877472;14482.624150705666;11191.2725672831;11338.319700817978;11459.828102578467;11547.364894930775;11638.301701897828;3461.8788342407893;3505.5092287079574;3578.141246100917;3587.9282414351565;3680.9447858282147;113808;114113;115598;115847;118225.81774182233;9688.031196880396;10473.895261047444;10620.628278010232;10953.780924381468;10989.890101099047;22169.556608867733;22202.777972220072;22328.665070023962;22362.993665285103;22397.55204895893;7311.3785328247695;7465.7013719450615;7507.1742108368035;7551.244875512405;7558.773236802905;4154.231467178582;4226.704130710882;4282.079352939133;4298.247806633826;4432.556744325541;3398.7790793598338;3501.1772233525103;3502.124468882779;3523.3129539739502;3759.4172903200047;717.2791344698649;721.4156533208013;722.2705067881373;723.4429489293215;729.2816575672958;539.5144370066893;560.5347561524006;579.9739011744482;672.2873753820966;677.915260592426;8840.778980525409;9520.190783783317;9578.281628877861;9626.855597166048;9699.757506062264;592.0645380299117;595.9433853783884;600.9308929473167;642.9648266291267;658.2167221007082;4387.714798538085;5044.672096313728;5054.774946415767;5122.667026643257;5331.653442526223;145517.27241363726;147346;149065;154680;177998;133315.3334233342;134046;135428.64571354358;136800;140445.29777351048;124281;125163.37418313032;125980;129568.3521582386;130298;9685.515724213901;10237.74405639865;10240.539175737258;10276.486175691036;10281.9485902573;63837.680811595645;64723.35276647362;65136.674316628116;65616.67191664202;66763;61980.07029894465;74809;92559.53720231356;93626.5956010674;96824.51587742016;12037.518499259932;12507.1870328432;12851.871481285441;12982.93508532489;13248.602541923758;14083.929580352033;14255.61136204741;14973.925130374279;15246.923765381101;15761.763573546177;13620.93189534046;14063.296835158406;14186.574402767934;14308.642283942985;14533.200673963034;13488.12327198729;13698.589132126663;14081.647958801112;14313.284335783377;14429;13313.866861331262;13731.725365492834;13811.378487968266;13828.93085534566;13886.513972010931;10842.837357439486;10873.238873279111;11053.834192486958;11421.543138274375;12029.338386388832;9976.401415915068;11406.942965285452;11538.653840384803;11794.115441341763;11845.881541184477 19:20:53 INFO - PROCESS | 1653 | __end_tp_report 19:20:53 INFO - PROCESS | 1653 | __start_cc_report 19:20:53 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1389 19:20:53 INFO - PROCESS | 1653 | __end_cc_report 19:20:53 INFO - PROCESS | 1653 | __startTimestamp1478312453393__endTimestamp 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | ------- Summary: start ------- 19:20:53 INFO - PROCESS | 1653 | Number of tests: 6 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5734.45 Median:6018.22 stddev:652.20 (10.8%) stddev-sans-first:624.88 19:20:53 INFO - PROCESS | 1653 | Values: 3269.8 3297.0 3304.1 3324.5 3339.8 5638.5 5690.4 5760.9 5775.0 5791.8 5644.2 5676.1 5689.5 5690.6 5696.6 5154.5 5164.4 5169.3 5181.6 5202.1 5180.6 5187.3 5191.1 5271.4 5326.4 5205.5 5205.6 5212.0 5270.2 5304.4 5245.0 5249.7 5253.8 5258.8 5301.2 4240.6 5171.5 5252.6 5254.2 5301.9 5519.5 5570.5 5578.8 5587.5 5717.2 6128.3 6194.6 6228.0 6231.3 6237.1 6199.5 6284.1 6312.9 6321.0 6343.1 5637.8 5685.3 5708.0 5768.4 5769.8 5255.9 6224.4 6277.0 6290.4 6311.4 6123.1 6134.5 6147.4 6157.2 6162.3 6158.5 6269.4 6275.9 6285.4 6296.2 6055.9 6097.7 6111.4 6140.7 6198.5 6203.2 6273.4 6290.7 6293.2 6295.0 4926.2 4954.7 4957.3 4968.6 4991.3 4339.3 4386.3 4431.6 4439.6 4448.2 5663.9 5705.5 5752.0 5760.0 5805.2 6283.4 6305.3 6313.7 6316.6 6317.5 5722.9 5761.2 5765.8 5803.2 5814.9 5289.8 5316.7 5336.5 5351.5 5355.0 6230.1 6239.6 6271.0 6271.5 6294.4 6250.0 6267.4 6270.7 6275.2 6296.9 6222.9 6237.5 6269.5 6271.2 6285.7 6038.5 6079.8 6105.0 6114.6 6150.9 6127.7 6189.1 6280.9 6292.3 6294.5 5853.8 5932.1 6018.2 6049.5 6053.8 6012.6 6076.4 6097.7 6110.3 6111.3 5998.1 6059.5 6076.8 6081.7 6115.5 6119.6 6173.3 6173.8 6181.0 6196.1 5781.5 5837.9 6019.8 6069.3 6077.9 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:72791.17 Median:35956.55 stddev:159722.17 (444.2%) stddev-sans-first:160077.99 19:20:53 INFO - PROCESS | 1653 | Values: 493.7 498.5 502.2 527.4 529.1 30956.4 41260.8 42442.8 42511.6 44149.6 36351.6 36480.5 43601.3 43987.8 44007.0 8929.0 9132.5 9161.3 9266.4 9301.2 9016.1 12066.3 12337.1 12414.8 12584.1 12405.5 12469.0 12484.1 12486.1 12511.1 12284.6 12350.1 12350.3 12365.2 12387.3 12119.5 12191.8 12207.7 12219.8 12221.3 41365.4 41729.0 41755.0 41842.6 41898.0 3228.4 3305.8 3313.3 3347.2 3364.7 31604.8 31901.0 31956.7 32225.9 32386.2 3104.4 3141.2 3217.3 3218.2 3227.2 513618.0 518180.4 518392.4 518572.0 520030.0 63315.7 63664.7 63696.0 63712.0 63822.7 35135.5 36148.8 36174.1 37364.3 66775.0 17126.3 17282.0 17294.2 17304.0 17315.0 11824.8 12058.6 12995.0 13118.8 13162.3 19384.8 19729.8 19767.2 19770.5 19774.0 6357.9 7675.2 7976.6 8004.9 8151.1 768.6 899.1 972.7 1031.1 1043.0 29602.4 30384.5 30552.5 30757.0 31022.7 1029.9 1056.6 1111.5 1131.3 1135.3 15239.3 16922.0 17069.3 17098.5 17317.3 682552.0 686763.0 688638.0 688864.0 689079.0 61405.7 61697.4 61743.4 61799.0 61899.0 1233.3 1234.4 1263.0 1329.4 1374.8 31005.0 31328.8 31911.7 32015.0 32735.7 51666.7 52235.5 52266.0 52291.5 52440.0 564859.0 576962.0 577756.0 578407.0 579417.0 28301.3 28684.4 28688.9 28719.0 28771.9 48512.8 48827.8 48942.8 49275.0 49477.0 38735.0 39235.4 40842.8 42008.6 42196.0 40073.8 40368.6 40409.0 41964.6 42151.0 39140.2 39886.8 40160.4 40186.4 40229.0 33235.7 35315.5 35769.6 36143.5 36201.8 25966.7 26274.0 26291.5 26583.6 27154.7 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35157.76 Median:370.14 stddev:104482.46 (28227.6%) stddev-sans-first:104742.88 19:20:53 INFO - PROCESS | 1653 | Values: 353.9 361.4 378.8 379.4 406.5 14814.6 15102.5 16032.4 20379.4 20448.2 19412.3 20157.7 20197.3 20425.3 20559.6 5155.9 5727.5 6012.6 6012.7 6020.1 5816.1 5941.9 6007.4 6007.8 6017.5 5654.4 5826.7 5956.1 5962.8 5967.9 5789.2 5793.7 5833.2 5834.5 5842.9 5115.2 5118.7 5253.9 5457.7 5536.5 13084.4 13127.6 13153.1 13354.3 13369.5 2132.3 2141.4 2277.2 2338.8 2993.3 8189.6 9655.6 9806.2 10384.5 10466.2 1775.9 1798.6 1838.6 1864.6 1912.7 120786.0 123848.8 130311.0 131830.3 135769.3 11238.4 11540.9 11664.4 11744.6 11891.4 14877.3 14888.6 14950.0 14994.2 15026.5 8397.7 8639.7 8656.6 8778.3 8828.4 8632.6 8635.7 8660.9 8798.6 8825.4 4470.8 4559.5 4571.0 4633.9 4671.0 1868.2 1907.8 1940.9 1951.4 1983.3 835.5 903.6 918.3 999.3 1043.9 20449.4 21216.7 21351.5 21362.3 21430.6 821.6 860.1 911.6 921.5 922.7 10164.4 11127.8 11133.9 11270.8 11275.8 620945.0 622883.0 630684.0 632954.0 633283.0 57864.0 71169.6 108098.0 109000.0 139708.9 741.5 879.3 910.5 941.8 962.7 18815.3 19123.5 19176.8 19397.7 19409.9 46795.3 56528.4 57477.4 57959.7 60224.7 82279.6 83087.6 86486.0 87900.7 88335.6 5669.5 7912.0 7950.8 8249.2 8374.8 10622.0 12551.0 12670.4 12815.2 13077.1 10906.6 10966.8 11170.6 11266.2 11377.7 10510.3 10568.4 10923.6 11092.8 11444.8 9872.1 10377.6 11606.2 11659.3 11738.0 7898.5 8030.2 8341.0 8477.6 8548.0 8717.2 11187.2 11321.9 11329.0 11718.0 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5766.35 Median:489.71 stddev:3313.50 (676.6%) stddev-sans-first:3306.07 19:20:53 INFO - PROCESS | 1653 | Values: 1337.5 1530.8 1697.9 1843.6 1905.7 8010.4 8245.2 8499.6 9058.6 9066.4 8178.3 8602.1 8803.5 8815.3 8967.2 2364.2 2403.2 2407.2 2410.4 2410.9 2026.7 2381.8 2401.5 2421.2 2431.9 2095.6 2169.2 2171.3 2171.4 2177.1 2146.3 2319.7 2386.0 2391.4 2397.7 2380.4 2388.3 2396.8 2404.1 2411.9 8896.0 8966.5 9004.8 9058.5 9067.8 5161.0 5333.8 5352.9 5355.5 5357.8 3171.3 3416.6 3458.1 3499.5 3578.4 898.5 1026.9 1047.8 1073.8 1082.8 11854.0 11919.0 11920.8 11922.1 11945.8 4535.2 4638.8 4838.9 4847.3 4866.7 10124.3 10143.7 10144.6 10165.3 10166.9 5404.6 5414.2 5420.1 5420.5 5461.9 4796.8 4921.5 4934.2 4945.0 4952.4 3337.5 3826.2 3841.2 3895.6 3919.7 897.3 1178.5 1185.7 1188.4 1204.7 783.8 860.1 892.2 900.1 902.5 5285.9 5713.3 5782.8 5894.4 5959.4 468.0 487.4 489.3 490.1 623.8 3798.3 3961.7 4003.9 4084.3 4140.3 9064.5 11025.1 11171.5 11181.4 11226.9 11106.0 11122.6 11122.6 11124.9 11131.6 7960.6 8238.9 8484.1 8489.1 8504.1 5044.4 5890.8 6010.9 6036.6 6131.0 9942.6 9989.3 10080.0 10159.5 10165.6 10161.3 10399.4 10553.4 10584.2 10601.8 7723.9 7757.9 7825.1 7840.2 7850.5 8270.2 8456.6 8465.8 8471.7 8477.0 7534.0 7656.3 7677.9 7717.0 7802.0 7306.6 7422.0 7424.7 7528.0 7528.6 7140.9 7142.4 7227.2 7234.7 7235.2 4727.9 4740.7 5011.5 5053.3 5186.6 4958.2 5029.7 5135.0 5221.3 5320.9 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4549.52 Median:5258.78 stddev:1424.80 (27.1%) stddev-sans-first:1391.95 19:20:53 INFO - PROCESS | 1653 | Values: 260.3 298.6 308.2 311.6 315.8 5397.0 5445.6 5478.6 5487.6 5541.3 5001.0 5037.4 5361.8 5400.1 5421.6 3198.5 3949.5 3999.3 4008.1 4150.9 3898.2 4057.2 4116.6 4170.6 4180.5 3636.6 4067.4 4087.2 4100.4 4126.8 3186.7 3523.3 4084.1 4096.9 4127.2 3480.9 3482.2 3493.8 3500.0 3512.2 5223.9 5244.0 5268.3 5270.9 5274.0 4038.5 4180.2 4278.9 4518.7 4643.4 5629.4 5641.9 5649.4 5653.9 5658.0 3395.5 3405.2 3560.4 3757.4 3885.0 5509.8 5881.3 5921.5 5926.0 5979.8 3233.2 3548.4 3801.8 3914.6 3917.8 3489.2 3520.5 3918.4 3964.3 3975.8 4433.6 4576.9 4582.5 4631.2 4649.6 5636.9 5646.0 5646.2 5665.7 5678.6 1199.5 1218.9 1318.4 1343.4 1346.8 671.2 771.4 818.3 834.8 860.4 4605.5 4913.1 5378.5 5422.4 5447.7 5787.4 5798.2 5838.9 5859.8 5893.9 4256.1 4808.6 5146.4 5354.0 5366.9 2958.0 3043.3 3052.2 3054.8 3058.6 5033.5 5417.3 5986.4 5994.6 6009.5 5479.6 5914.5 5927.4 6009.3 6049.3 5267.0 5978.6 5988.7 5993.8 6013.4 4806.0 5761.3 5761.7 5769.5 5796.3 4918.6 4931.0 5532.8 5551.3 5720.7 4999.7 5209.1 5316.4 5381.4 5982.4 3549.2 3689.5 3857.1 3857.2 3943.3 4971.6 5664.6 5756.1 5778.9 5788.6 5655.6 5661.1 5661.8 5670.6 5701.5 5060.7 5260.8 5582.8 5584.0 5596.6 4760.2 5274.1 5357.0 5508.5 5544.4 5256.8 5296.9 5492.6 5496.5 5502.8 4621.5 5010.6 5464.3 5475.9 5503.6 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25716.39 Median:22380.27 stddev:41920.70 (187.3%) stddev-sans-first:41996.21 19:20:53 INFO - PROCESS | 1653 | Values: 698.6 699.9 737.0 765.1 796.4 13973.7 15158.6 15166.5 15183.2 15190.4 13699.7 13860.4 13862.0 13890.2 13944.7 658.3 677.8 682.6 684.0 817.3 663.8 684.4 689.4 854.1 855.5 898.8 906.5 910.6 911.2 913.7 906.1 906.6 907.0 907.6 908.2 516.2 535.0 667.3 669.0 671.0 11404.8 14311.2 14361.3 14679.3 14699.6 13743.0 13999.2 14198.1 14298.4 14482.6 11191.3 11338.3 11459.8 11547.4 11638.3 3461.9 3505.5 3578.1 3587.9 3680.9 113808.0 114113.0 115598.0 115847.0 118225.8 9688.0 10473.9 10620.6 10953.8 10989.9 22169.6 22202.8 22328.7 22363.0 22397.6 7311.4 7465.7 7507.2 7551.2 7558.8 4154.2 4226.7 4282.1 4298.2 4432.6 3398.8 3501.2 3502.1 3523.3 3759.4 717.3 721.4 722.3 723.4 729.3 539.5 560.5 580.0 672.3 677.9 8840.8 9520.2 9578.3 9626.9 9699.8 592.1 595.9 600.9 643.0 658.2 4387.7 5044.7 5054.8 5122.7 5331.7 145517.3 147346.0 149065.0 154680.0 177998.0 133315.3 134046.0 135428.6 136800.0 140445.3 124281.0 125163.4 125980.0 129568.4 130298.0 9685.5 10237.7 10240.5 10276.5 10281.9 63837.7 64723.4 65136.7 65616.7 66763.0 61980.1 74809.0 92559.5 93626.6 96824.5 12037.5 12507.2 12851.9 12982.9 13248.6 14083.9 14255.6 14973.9 15246.9 15761.8 13620.9 14063.3 14186.6 14308.6 14533.2 13488.1 13698.6 14081.6 14313.3 14429.0 13313.9 13731.7 13811.4 13828.9 13886.5 10842.8 10873.2 11053.8 11421.5 12029.3 9976.4 11406.9 11538.7 11794.1 11845.9 19:20:53 INFO - PROCESS | 1653 | -------- Summary: end -------- 19:20:53 INFO - PROCESS | 1653 | 19:20:53 INFO - TEST-INFO | 1653: exit 0 19:20:53 INFO - TEST-OK | dromaeo_css | took 1117609ms 19:20:53 INFO - TEST-START | kraken 19:20:53 INFO - operating with platform_type : mac_ 19:20:53 INFO - Initialising browser for kraken test... 19:20:54 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmph8NesR/profile http://localhost:49274/getInfo.html) 19:20:56 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 19:20:56 INFO - PROCESS | 1663 | colorDepth:24 19:20:56 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 19:20:56 INFO - PROCESS | 1663 | __metrics 19:20:56 INFO - PROCESS | 1663 | 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" 19:20:56 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:20:57 INFO - TEST-INFO | 1663: exit 0 19:20:57 INFO - Browser initialized. 19:20:57 INFO - Running cycle 1/1 for kraken test... 19:20:57 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmph8NesR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:09 INFO - PROCESS | 1664 | RSS: Main: 220000256 19:21:09 INFO - PROCESS | 1664 | 19:21:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 19:21:12 INFO - PROCESS | 1664 | RSS: Main: 269799424 19:21:12 INFO - PROCESS | 1664 | 19:21:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 19:21:15 INFO - PROCESS | 1664 | RSS: Main: 280989696 19:21:15 INFO - PROCESS | 1664 | 19:21:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 19:21:19 INFO - PROCESS | 1664 | RSS: Main: 378359808 19:21:19 INFO - PROCESS | 1664 | 19:21:21 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 19:21:22 INFO - PROCESS | 1664 | RSS: Main: 279674880 19:21:22 INFO - PROCESS | 1664 | 19:21:24 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:21:24 INFO - PROCESS | 1664 | RSS: Main: 280477696 19:21:24 INFO - PROCESS | 1664 | 19:21:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 19:21:28 INFO - PROCESS | 1664 | RSS: Main: 318803968 19:21:28 INFO - PROCESS | 1664 | 19:21:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 19:21:31 INFO - PROCESS | 1664 | RSS: Main: 319012864 19:21:31 INFO - PROCESS | 1664 | 19:21:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 19:21:35 INFO - PROCESS | 1664 | RSS: Main: 319369216 19:21:35 INFO - PROCESS | 1664 | 19:21:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:21:37 INFO - PROCESS | 1664 | RSS: Main: 295714816 19:21:37 INFO - PROCESS | 1664 | 19:21:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:21:40 INFO - PROCESS | 1664 | RSS: Main: 298561536 19:21:40 INFO - PROCESS | 1664 | 19:21:42 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:21:42 INFO - PROCESS | 1664 | RSS: Main: 300306432 19:21:42 INFO - PROCESS | 1664 | 19:21:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:21:46 INFO - PROCESS | 1664 | RSS: Main: 310689792 19:21:46 INFO - PROCESS | 1664 | 19:21:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:21:49 INFO - PROCESS | 1664 | RSS: Main: 310501376 19:21:49 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 19:21:51 INFO - PROCESS | 1664 | RSS: Main: 354652160 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | __start_tp_report 19:21:51 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 19:21:51 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 19:21:51 INFO - PROCESS | 1664 | |i|pagename|runs| 19:21:51 INFO - PROCESS | 1664 | |0;ai-astar;113;114;114;113;112;115;112;113;113;114 19:21:51 INFO - PROCESS | 1664 | |1;audio-beat-detection;143;109;109;141;110;129;135;137;146;109 19:21:51 INFO - PROCESS | 1664 | |2;audio-dft;184;183;180;182;184;181;183;183;185;185 19:21:51 INFO - PROCESS | 1664 | |3;audio-fft;81;59;58;92;59;59;62;59;84;57 19:21:51 INFO - PROCESS | 1664 | |4;audio-oscillator;80;69;96;69;66;91;115;68;69;89 19:21:51 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;87;85;87;84;88;84;88;85;87;84 19:21:51 INFO - PROCESS | 1664 | |6;imaging-darkroom;94;94;94;96;94;94;93;104;147;148 19:21:51 INFO - PROCESS | 1664 | |7;imaging-desaturate;86;85;87;83;99;138;125;84;89;127 19:21:51 INFO - PROCESS | 1664 | |8;json-parse-financial;55;54;53;53;56;57;58;56;57;57 19:21:51 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;67;73;71;75;74;69;69;70;72;70 19:21:51 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;82;83;84;83;83;78;79;85;85;86 19:21:51 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;140;145;146;147;136;142;139;139;167;138 19:21:51 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;163;167;164;162;162;166;163;160;155;204 19:21:51 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;66;66;67;68;66;67;66;67;67;66 19:21:51 INFO - PROCESS | 1664 | __end_tp_report 19:21:51 INFO - PROCESS | 1664 | __start_cc_report 19:21:51 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1958 19:21:51 INFO - PROCESS | 1664 | __end_cc_report 19:21:51 INFO - PROCESS | 1664 | __startTimestamp1478312511956__endTimestamp 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | ------- Summary: start ------- 19:21:51 INFO - PROCESS | 1664 | Number of tests: 14 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 19:21:51 INFO - PROCESS | 1664 | Values: 113.0 114.0 114.0 113.0 112.0 115.0 112.0 113.0 113.0 114.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:136.00 stddev:15.78 (11.6%) stddev-sans-first:15.61 19:21:51 INFO - PROCESS | 1664 | Values: 143.0 109.0 109.0 141.0 110.0 129.0 135.0 137.0 146.0 109.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:1.63 (0.9%) stddev-sans-first:1.69 19:21:51 INFO - PROCESS | 1664 | Values: 184.0 183.0 180.0 182.0 184.0 181.0 183.0 183.0 185.0 185.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:67.00 Median:60.50 stddev:13.22 (21.8%) stddev-sans-first:13.01 19:21:51 INFO - PROCESS | 1664 | Values: 81.0 59.0 58.0 92.0 59.0 59.0 62.0 59.0 84.0 57.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:74.50 stddev:16.23 (21.8%) stddev-sans-first:17.21 19:21:51 INFO - PROCESS | 1664 | Values: 80.0 69.0 96.0 69.0 66.0 91.0 115.0 68.0 69.0 89.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.66 (1.9%) stddev-sans-first:1.72 19:21:51 INFO - PROCESS | 1664 | Values: 87.0 85.0 87.0 84.0 88.0 84.0 88.0 85.0 87.0 84.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:94.00 stddev:22.21 (23.6%) stddev-sans-first:23.14 19:21:51 INFO - PROCESS | 1664 | Values: 94.0 94.0 94.0 96.0 94.0 94.0 93.0 104.0 147.0 148.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:100.30 Median:85.50 stddev:21.22 (24.8%) stddev-sans-first:21.87 19:21:51 INFO - PROCESS | 1664 | Values: 86.0 85.0 87.0 83.0 99.0 138.0 125.0 84.0 89.0 127.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:1.78 (3.1%) stddev-sans-first:1.87 19:21:51 INFO - PROCESS | 1664 | Values: 55.0 54.0 53.0 53.0 56.0 57.0 58.0 56.0 57.0 57.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:2.49 (3.5%) stddev-sans-first:2.19 19:21:51 INFO - PROCESS | 1664 | Values: 67.0 73.0 71.0 75.0 74.0 69.0 69.0 70.0 72.0 70.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:2.57 (3.1%) stddev-sans-first:2.71 19:21:51 INFO - PROCESS | 1664 | Values: 82.0 83.0 84.0 83.0 83.0 78.0 79.0 85.0 85.0 86.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:143.50 stddev:8.90 (6.2%) stddev-sans-first:9.33 19:21:51 INFO - PROCESS | 1664 | Values: 140.0 145.0 146.0 147.0 136.0 142.0 139.0 139.0 167.0 138.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:163.50 stddev:13.55 (8.3%) stddev-sans-first:14.31 19:21:51 INFO - PROCESS | 1664 | Values: 163.0 167.0 164.0 162.0 162.0 166.0 163.0 160.0 155.0 204.0 19:21:51 INFO - PROCESS | 1664 | 19:21:51 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 19:21:51 INFO - PROCESS | 1664 | Values: 66.0 66.0 67.0 68.0 66.0 67.0 66.0 67.0 67.0 66.0 19:21:51 INFO - PROCESS | 1664 | -------- Summary: end -------- 19:21:51 INFO - PROCESS | 1664 | 19:21:52 INFO - TEST-INFO | 1664: exit 0 19:21:52 INFO - TEST-OK | kraken | took 58832ms 19:21:52 INFO - SUITE-END | took 1176s 19:21:53 INFO - Completed test suite (00:19:36) 19:21:53 INFO - javascript benchmark 19:21:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.8228637690436, 3296.9779368395793, 3304.0913748719113, 3324.5345651608795, 3339.8310591293034, 5638.492535671789, 5690.374058853523, 5760.855978600537, 5775.0182468980265, 5791.7972870949525, 5644.181593668915, 5676.148577713345, 5689.51639110675, 5690.57320700947, 5696.601237913337, 5154.458781827911, 5164.380274367081, 5169.250458683488, 5181.637285390006, 5202.089634313998, 5180.6373553851245, 5187.325647665798, 5191.143461328877, 5271.42014378418, 5326.360836699601, 5205.505476979681, 5205.557527610139, 5212.0, 5270.156774916014, 5304.416514183436, 5244.973775131138, 5249.685018898878, 5253.816116435944, 5258.789648414059, 5301.231321458406, 4240.639545638624, 5171.456997015334, 5252.606054545886, 5254.185601231815, 5301.867453313698, 5519.475649813261, 5570.498655121018, 5578.832635020955, 5587.469190426903, 5717.171010203498, 6128.322667212046, 6194.628322300677, 6228.0, 6231.283402408736, 6237.064440333941, 6199.535034872402, 6284.088807122942, 6312.936870631281, 6320.968395158041, 6343.14367560378, 5637.774489020475, 5685.289338832646, 5708.001099807517, 5768.3654797972185, 5769.826905192851, 5255.894882102413, 6224.37756224374, 6277.027060805583, 6290.433860952445, 6311.431971122529, 6123.09992524296, 6134.478569321568, 6147.415995480422, 6157.230346206724, 6162.26052873649, 6158.476529494954, 6269.404406581368, 6275.905861411991, 6285.371462853678, 6296.244450665949, 6055.878882422415, 6097.725602347905, 6111.419415155553, 6140.662263575457, 6198.473129784019, 6203.16257305258, 6273.435390814758, 6290.685465726695, 6293.213348331458, 6294.968525157345, 4926.187179115477, 4954.702717836942, 4957.281194226817, 4968.627352948543, 4991.301217829507, 4339.284018137035, 4386.342048692722, 4431.601155895921, 4439.578240067253, 4448.221561226773, 5663.8867222656145, 5705.457981491834, 5751.971240143856, 5760.0, 5805.158252053513, 6283.37166283368, 6305.306416294204, 6313.715882785285, 6316.62100273985, 6317.526185536103, 5722.885542289131, 5761.193432919395, 5765.798197063083, 5803.245578074823, 5814.883702325929, 5289.761960711778, 5316.680999140064, 5336.46635336471, 5351.491608297206, 5355.036093503207, 6230.127782110599, 6239.594426362272, 6270.968645156745, 6271.498280137669, 6294.43350098475, 6249.968750156402, 6267.435930766071, 6270.74917003333, 6275.215598050244, 6296.905546416899, 6222.875542489215, 6237.532185086227, 6269.467095296768, 6271.153394291895, 6285.685715714105, 6038.547108966933, 6079.817605471843, 6105.010960388573, 6114.57197996136, 6150.907736383869, 6127.662978536223, 6189.102580125947, 6280.905786413299, 6292.339304373158, 6294.496440284858, 5853.765849365977, 5932.080527518242, 6018.21763170785, 6049.527832011766, 6053.788117415869, 6012.609180403259, 6076.361981991828, 6097.695115244309, 6110.26676798787, 6111.297200821962, 5998.1002849572915, 6059.521857312536, 6076.797320467302, 6081.695915204311, 6115.480184184395, 6119.571629986036, 6173.32093469709, 6173.783917562864, 6181.0, 6196.1015652731, 5781.537477001746, 5837.883242335045, 6019.819405417845, 6069.2716873975405, 6077.878442431215], "value": 5691.441931615478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.7185804091667, 498.53679450811893, 502.17392389519244, 527.4172039895915, 529.1190168369665, 30956.380872382568, 41260.79369603151, 42442.78778606107, 42511.574884251146, 44149.55850441495, 36351.63648363516, 36480.45279320806, 43601.34597981025, 43987.78006109973, 44007.0, 8929.0, 9132.543372831366, 9161.26709863211, 9266.397684150543, 9301.209397201212, 9016.098390160963, 12066.336351500664, 12337.074719396081, 12414.751704965895, 12584.119111662187, 12405.503779848796, 12469.0, 12484.063695222849, 12486.063545234098, 12511.124221304512, 12284.570040048555, 12350.073744469111, 12350.258984460961, 12365.196262242971, 12387.256764594153, 12119.454624541917, 12191.756164876742, 12207.694807629792, 12219.755604887941, 12221.327826969513, 41365.37951930724, 41729.0, 41754.95612609679, 41842.58157418417, 41897.95255118616, 3228.4350238708134, 3305.752068594865, 3313.287643156733, 3347.163209197701, 3364.66353364664, 31604.841975790205, 31901.0, 31956.721731130958, 32225.87209447658, 32386.190345241557, 3104.394643044607, 3141.1832923439842, 3217.324361884007, 3218.243712727507, 3227.209333713232, 513618.0, 518180.40909795207, 518392.40803796117, 518572.0, 520030.0, 63315.68342158352, 63664.72670546563, 63696.0, 63712.0, 63822.68088659527, 35135.4729679055, 36148.819255904076, 36174.0956476085, 37364.25271494555, 66775.0, 17126.314947401963, 17282.0, 17294.221760020828, 17304.0, 17314.961102333902, 11824.822627660593, 12058.638240852788, 12995.025373097056, 13118.803217951738, 13162.276074815976, 19384.8061519383, 19729.816211027384, 19767.209311627375, 19770.50573735668, 19774.0, 6357.872842543124, 7675.15573286938, 7976.641051152712, 8004.879926801103, 8151.062627797761, 768.6080099149362, 899.0964081098585, 972.7227740094039, 1031.1330519945843, 1042.9582816687248, 29602.407951841273, 30384.54423183654, 30552.54171187434, 30757.0, 31022.689773102433, 1029.8661174047327, 1056.572088304238, 1111.5053801058614, 1131.298594871185, 1135.3415019288793, 15239.314230859638, 16922.0, 17069.317227311018, 17098.487045388658, 17317.307307707804, 682552.0, 686763.0, 688638.0, 688864.0, 689079.0, 61405.69297153486, 61697.383026170064, 61743.38256617466, 61799.0, 61899.0, 1233.3339996402021, 1234.4444999750149, 1262.9557965471165, 1329.4283458113105, 1374.8281464816898, 31005.0, 31328.843355783985, 31911.68088319087, 32015.039548813573, 32735.672643274214, 51666.741666291426, 52235.47764522458, 52266.0, 52291.47708522866, 52440.0, 564859.0, 576962.0, 577756.0, 578407.0, 579417.0, 28301.292467688472, 28684.422356769745, 28688.856555717088, 28718.994835180667, 28771.85614072, 48512.787180320774, 48827.75586122047, 48942.77643058952, 49275.0, 49477.0, 38735.0, 39235.38342832896, 40842.79578602207, 42008.57991420169, 42196.0, 40073.799631002825, 40368.587099451375, 40409.0, 41964.580354197285, 42151.0, 39140.2171956565, 39886.800565996986, 40160.397594036694, 40186.39720404138, 40229.0, 33235.66764332326, 35315.47026794651, 35769.642303576635, 36143.45784813283, 36201.818990904874, 25966.740332597186, 26274.0, 26291.474170516864, 26583.601245981714, 27154.72845271601], "value": 20753.24146389713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9044457996343, 361.4379639660328, 378.8465671403082, 379.4460088271122, 406.51827584312593, 14814.629634259136, 15102.471413500516, 16032.43886463974, 20379.388618341436, 20448.182072717074, 19412.320568780095, 20157.697634535456, 20197.293094741686, 20425.28511502098, 20559.588808223827, 5155.871103222412, 5727.513161381277, 6012.5791194616395, 6012.699365031753, 6020.12708157317, 5816.069428891378, 5941.851453713649, 6007.399260073979, 6007.7596896124105, 6017.518598512131, 5654.37801841797, 5826.708664566776, 5956.136360227764, 5962.79130230442, 5967.880642387149, 5789.16057171712, 5793.681347525884, 5833.154192642043, 5834.533237341003, 5842.883142337172, 5115.2327150927285, 5118.744062796883, 5253.921191182136, 5457.699826509541, 5536.474034966672, 13084.411201495956, 13127.606171814861, 13153.145045572102, 13354.26551539665, 13369.529351771298, 2132.3283165802877, 2141.389703934387, 2277.1802151225547, 2338.8012018978407, 2993.266649670845, 8189.631466584018, 9655.565499552467, 9806.215502759762, 10384.480775961172, 10466.162706983423, 1775.8668099892432, 1798.5953160538904, 1838.5771272607242, 1864.5804693943753, 1912.6939689649728, 120786.0, 123848.76151238462, 130311.0, 131830.34084829513, 135769.3211533946, 11238.438078096062, 11540.94229528847, 11664.358460284766, 11744.647660570197, 11891.405429728478, 14877.256137193097, 14888.553343399715, 14950.0, 14994.175320357484, 15026.474073407378, 8397.748067557983, 8639.740807775652, 8656.61045252965, 8778.253848422828, 8828.42615230008, 8632.568371581396, 8635.740927772176, 8660.913390866137, 8798.648054077765, 8825.426347287406, 4470.798814053375, 4559.52125026874, 4571.0, 4633.907321853544, 4670.9766451167525, 1868.168664944087, 1907.761529808774, 1940.9126589303514, 1951.414575627306, 1983.2562788954142, 835.4945258118872, 903.6490446781971, 918.2562124679031, 999.3104757717152, 1043.9321444106108, 20449.386518404473, 21216.681749773765, 21351.46621334448, 21362.252321168686, 21430.57138857214, 821.5768879027306, 860.1269711243093, 911.589784596934, 921.4517362169498, 922.6540047482194, 10164.390136591828, 11127.777444451227, 11133.888661113448, 11270.774584508265, 11275.774484510264, 620945.0, 622883.0, 630684.0, 632954.0, 633283.0, 57864.0, 71169.64415177994, 108098.0, 109000.0, 139708.90436643458, 741.499487845702, 879.2570278114982, 910.5366250993848, 941.8398872191743, 962.711186644004, 18815.341463048728, 19123.521911952314, 19176.8082319175, 19397.709034364212, 19409.93245371518, 46795.29807052965, 56528.434715652314, 57477.42522574888, 57959.710201448725, 60224.69887650534, 82279.58860205661, 83087.58456207681, 86486.0, 87900.68148977643, 88335.55832220797, 5669.5180909621495, 7912.0, 7950.801229969297, 8249.175082491704, 8374.790630234293, 10622.0, 12551.0, 12670.366481675695, 12815.231086134861, 13077.149985250928, 10906.61826836057, 10966.780664386828, 11170.609028683957, 11266.211365204357, 11377.715557111138, 10510.316829406063, 10568.418736969541, 10923.563057477611, 11092.778144437227, 11444.828327574927, 9872.111509964137, 10377.584896604052, 11606.24559403636, 11659.300441973508, 11738.0, 7898.526088434713, 8030.23712747288, 8340.958295208486, 8477.618507167315, 8547.957260213909, 8717.215450609476, 11187.16096292765, 11321.886781132413, 11329.0, 11718.0], "value": 9306.486644194689, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.478383430462, 1530.7803684657242, 1697.8896371735837, 1843.566761810975, 1905.7427247321616, 8010.43926925114, 8245.216704413086, 8499.575021248937, 9058.592363343649, 9066.365354425192, 8178.304844088245, 8602.09677983812, 8803.515806630632, 8815.250703690179, 8967.237784788285, 2364.219807463533, 2403.158894386968, 2407.16952651335, 2410.3974006498374, 2410.867402292873, 2026.7061276115028, 2381.785639292463, 2401.519696060786, 2421.1767998880377, 2431.878406079698, 2095.5704080663427, 2169.208238992764, 2171.272623671072, 2171.381156370435, 2177.1073859717517, 2146.3131797824703, 2319.7332306784765, 2386.033656369173, 2391.4380120671626, 2397.7122745270503, 2380.4286971126803, 2388.3312672451566, 2396.808255339586, 2404.0984630763464, 2411.9397015074587, 8895.955520222358, 8966.506842123681, 9004.819903601956, 9058.501782401965, 9067.773305667346, 5160.974195129001, 5333.786648534054, 5352.892942141174, 5355.464453554652, 5357.8392648220615, 3171.334019855833, 3416.641252668484, 3458.1354661334667, 3499.492573576817, 3578.4095624221973, 898.5058217980085, 1026.8973102689747, 1047.8009178256107, 1073.8335557988523, 1082.8484012238293, 11854.0, 11919.046476281877, 11920.761584768255, 11922.10584206188, 11945.820812687904, 4535.183666939916, 4638.83764068256, 4838.927416088762, 4847.297141914473, 4866.659333846667, 10124.341917775468, 10143.7464063399, 10144.594216231415, 10165.339252948535, 10166.898331016595, 5404.567634589223, 5414.160805075219, 5420.105682562412, 5420.4850539198715, 5461.918071228934, 4796.760161991887, 4921.50784921505, 4934.1611925972675, 4945.0, 4952.405711314594, 3337.5494308268558, 3826.234753049401, 3841.2317536492815, 3895.552011518655, 3919.706022048301, 897.3314880414002, 1178.5109179690332, 1185.6917201527492, 1188.3523479703583, 1204.6747378207835, 783.7962129846281, 860.0652017022148, 892.2103938014774, 900.0774206438322, 902.5351943748974, 5285.947140528622, 5713.257276554022, 5782.797602083907, 5894.381089985575, 5959.404059594006, 467.9836205732783, 487.4297072425271, 489.27587170986425, 490.1422510606439, 623.800383877164, 3798.278327117894, 3961.742486738353, 4003.8999025024023, 4084.346504559256, 4140.3375459926265, 9064.456132632064, 11025.062869656009, 11171.497282622302, 11181.385023823768, 11226.887731122748, 11106.0, 11122.55509779616, 11122.61070862516, 11124.944375278072, 11131.554737810558, 7960.562169080757, 8238.876416853753, 8484.109168537338, 8489.066202717697, 8504.107068757816, 5044.394672639307, 5890.793822216202, 6010.939890601213, 6036.577439579363, 6131.019036954066, 9942.552585133832, 9989.300748947795, 10080.04239597237, 10159.492025398553, 10165.644202452879, 10161.339512931636, 10399.376037437476, 10553.366797992145, 10584.153267738408, 10601.787964240826, 7723.884141737766, 7757.92242077572, 7825.139234684067, 7840.176781438095, 7850.489718168301, 8270.214329638675, 8456.619452124545, 8465.78835529092, 8471.703490377808, 8477.02514210849, 7533.962330188314, 7656.310932016146, 7677.9232207677205, 7716.961415192888, 7802.024746906637, 7306.561606303426, 7421.962890185515, 7424.740134095281, 7528.0, 7528.623568821427, 7140.892886606601, 7142.357187853118, 7227.168875579376, 7234.674439650334, 7235.2402997686595, 4727.865312324949, 4740.715557066587, 5011.517889803943, 5053.292539044463, 5186.559142472932, 4958.225037094562, 5029.723365214948, 5135.024345374367, 5221.269022336952, 5320.866978325418], "value": 4521.337115793188, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.25047862157, 298.5506812247567, 308.23403841453984, 311.56692197844984, 315.76948827356046, 5396.973015134924, 5445.591580631459, 5478.589105817065, 5487.64330318529, 5541.33503979523, 5000.999800039997, 5037.370328708911, 5361.839144825652, 5400.081986062369, 5421.647592906458, 3198.4562624353857, 3949.5063117110362, 3999.3002973736047, 4008.0981779099616, 4150.916981660365, 3898.200868821885, 4057.2088442753675, 4116.567760385161, 4170.624643782059, 4180.540140584533, 3636.6181550937167, 4067.430559721641, 4087.2438598859308, 4100.425940368336, 4126.793660316987, 3186.713195812388, 3523.2953409317984, 4084.060666046811, 4096.91806163878, 4127.153933443652, 3480.9383138142857, 3482.233908540117, 3493.8427770750122, 3499.982500087509, 3512.209752805624, 5223.947760522384, 5243.973780131113, 5268.262443257947, 5270.92093618596, 5273.973630131824, 4038.495188101487, 4180.226658068267, 4278.850240241577, 4518.73475426881, 4643.399696170156, 5629.352624448159, 5641.887162256773, 5649.435056494359, 5653.8586535336535, 5658.0, 3395.5416018837636, 3405.1997780521556, 3560.3769340365593, 3757.436384542313, 3885.0287428142965, 5509.834704958817, 5881.2942446906645, 5921.526277897758, 5925.970370148165, 5979.820605381846, 3233.2078640732702, 3548.4096609475228, 3801.847926082926, 3914.5889681583594, 3917.843286268517, 3489.2149266414854, 3520.471929210588, 3918.3534716771414, 3964.266610677034, 3975.8210880510446, 4433.578810013044, 4576.931346029813, 4582.473015603248, 4631.166390049756, 4649.604783593365, 5636.915446268309, 5646.023891637894, 5646.20953066571, 5665.688387138664, 5678.574106941914, 1199.4782269712703, 1218.8902998730157, 1318.3540065367902, 1343.4416077350422, 1346.750851092551, 671.1778071862028, 771.3559178086249, 818.2571123506892, 834.841380137784, 860.4364141487335, 4605.516420775771, 4913.128811070807, 5378.477097501143, 5422.376426710979, 5447.727613619303, 5787.392323806024, 5798.217240672455, 5838.948989181903, 5859.824205273849, 5893.8782038466115, 4256.106217694319, 4808.567228949411, 5146.433892271847, 5354.009508240988, 5366.91949620756, 2958.0, 3043.3000409905844, 3052.1759125036115, 3054.823892801243, 3058.638905686948, 5033.458103657629, 5417.295751552352, 5986.431289027535, 5994.580379373489, 6009.549283803733, 5479.643753186168, 5914.526837853047, 5927.436893495111, 6009.338972712998, 6049.334573196945, 5266.999270138662, 5978.641281523035, 5988.730507127189, 5993.790217342459, 6013.398660133952, 4806.0, 5761.341548116892, 5761.654300741969, 5769.451902069297, 5796.275465566804, 4918.6065114791445, 4931.038447502702, 5532.75102620375, 5551.2544516425305, 5720.742566584597, 4999.725015124058, 5209.114450543492, 5316.415194328698, 5381.381141168659, 5982.4316689914385, 3549.225387306347, 3689.538807649044, 3857.112864041342, 3857.247836671822, 3943.2704949584418, 4971.577415919543, 5664.631798933056, 5756.136579513107, 5778.855528611818, 5788.565857560784, 5655.604107712421, 5661.122526008476, 5661.801836935688, 5670.574706897081, 5701.543876489788, 5060.658925384702, 5260.763265652979, 5582.776688932559, 5584.0, 5596.565494009956, 4760.168429044592, 5274.077036518517, 5357.0, 5508.531774799027, 5544.390117087198, 5256.78972841082, 5296.947030529799, 5492.642978206563, 5496.450354964471, 5502.779888804563, 4621.514740952151, 5010.599152067753, 5464.28964234647, 5475.863103422446, 5503.614746967673], "value": 4082.3810296042243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.5773606967788, 699.8705239530688, 736.9705211791529, 765.09336436323, 796.4186144114796, 13973.720525589495, 15158.62103447413, 15166.469173578927, 15183.240837958114, 15190.392384304641, 13699.657508562292, 13860.37628306726, 13862.0, 13890.166590004606, 13944.651383715387, 658.2594581096266, 677.7695583501633, 682.6279677575708, 684.0457561701423, 817.2930415190847, 663.7643636509042, 684.4216636941801, 689.4312192441231, 854.1074577066948, 855.5380094748829, 898.7753061734567, 906.5104843384564, 910.6129894794685, 911.1935936696005, 913.6619450803212, 906.062225596511, 906.6328137104483, 907.0022974727813, 907.63694522191, 908.2325435007408, 516.2488579117376, 534.9946500535023, 667.306001758171, 669.036587314266, 670.9798706038827, 11404.771904561945, 14311.212883291415, 14361.281935903164, 14679.339429725687, 14699.55901322962, 13743.0, 13999.230042347666, 14198.148111113367, 14298.428062877472, 14482.624150705666, 11191.2725672831, 11338.319700817978, 11459.828102578467, 11547.364894930775, 11638.301701897828, 3461.8788342407893, 3505.5092287079574, 3578.141246100917, 3587.9282414351565, 3680.9447858282147, 113808.0, 114113.0, 115598.0, 115847.0, 118225.81774182233, 9688.031196880396, 10473.895261047444, 10620.628278010232, 10953.780924381468, 10989.890101099047, 22169.556608867733, 22202.777972220072, 22328.665070023962, 22362.993665285103, 22397.55204895893, 7311.3785328247695, 7465.7013719450615, 7507.1742108368035, 7551.244875512405, 7558.773236802905, 4154.231467178582, 4226.704130710882, 4282.079352939133, 4298.247806633826, 4432.556744325541, 3398.7790793598338, 3501.1772233525103, 3502.124468882779, 3523.3129539739502, 3759.4172903200047, 717.2791344698649, 721.4156533208013, 722.2705067881373, 723.4429489293215, 729.2816575672958, 539.5144370066893, 560.5347561524006, 579.9739011744482, 672.2873753820966, 677.915260592426, 8840.778980525409, 9520.190783783317, 9578.281628877861, 9626.855597166048, 9699.757506062264, 592.0645380299117, 595.9433853783884, 600.9308929473167, 642.9648266291267, 658.2167221007082, 4387.714798538085, 5044.672096313728, 5054.774946415767, 5122.667026643257, 5331.653442526223, 145517.27241363726, 147346.0, 149065.0, 154680.0, 177998.0, 133315.3334233342, 134046.0, 135428.64571354358, 136800.0, 140445.29777351048, 124281.0, 125163.37418313032, 125980.0, 129568.3521582386, 130298.0, 9685.515724213901, 10237.74405639865, 10240.539175737258, 10276.486175691036, 10281.9485902573, 63837.680811595645, 64723.35276647362, 65136.674316628116, 65616.67191664202, 66763.0, 61980.07029894465, 74809.0, 92559.53720231356, 93626.5956010674, 96824.51587742016, 12037.518499259932, 12507.1870328432, 12851.871481285441, 12982.93508532489, 13248.602541923758, 14083.929580352033, 14255.61136204741, 14973.925130374279, 15246.923765381101, 15761.763573546177, 13620.93189534046, 14063.296835158406, 14186.574402767934, 14308.642283942985, 14533.200673963034, 13488.12327198729, 13698.589132126663, 14081.647958801112, 14313.284335783377, 14429.0, 13313.866861331262, 13731.725365492834, 13811.378487968266, 13828.93085534566, 13886.513972010931, 10842.837357439486, 10873.238873279111, 11053.834192486958, 11421.543138274375, 12029.338386388832, 9976.401415915068, 11406.942965285452, 11538.653840384803, 11794.115441341763, 11845.881541184477], "value": 7791.48156250619, "unit": "score"}], "name": "dromaeo_css", "value": 7353.436795313996, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 112.0, 115.0, 112.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 109.0, 141.0, 110.0, 129.0, 135.0, 137.0, 146.0, 109.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 180.0, 182.0, 184.0, 181.0, 183.0, 183.0, 185.0, 185.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 92.0, 59.0, 59.0, 62.0, 59.0, 84.0, 57.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 69.0, 96.0, 69.0, 66.0, 91.0, 115.0, 68.0, 69.0, 89.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 88.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 93.0, 104.0, 147.0, 148.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 83.0, 99.0, 138.0, 125.0, 84.0, 89.0, 127.0], "value": 100.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 56.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 71.0, 75.0, 74.0, 69.0, 69.0, 70.0, 72.0, 70.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 83.0, 83.0, 78.0, 79.0, 85.0, 85.0, 86.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 145.0, 146.0, 147.0, 136.0, 142.0, 139.0, 139.0, 167.0, 138.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 164.0, 162.0, 162.0, 166.0, 163.0, 160.0, 155.0, 204.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1449.8, "alertThreshold": 2.0}]} 19:21:53 INFO - Return code: 0 19:21:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:21:53 INFO - # TBPL SUCCESS # 19:21:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:21:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:21:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:21:53 INFO - 2016-11-04 19:21:53.293 screenresolution[1668:9915] starting screenresolution argv=screenresolution get 19:21:53 INFO - 2016-11-04 19:21:53.296 screenresolution[1668:9915] Display 0: 1600x1200x32@60 19:21:53 INFO - 2016-11-04 19:21:53.302 screenresolution[1669:9918] starting screenresolution argv=screenresolution list 19:21:53 INFO - Available Modes on Display 0 19:21:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:21:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:21:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:21:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:21:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:21:53 INFO - Intel Iris: 19:21:53 INFO - Chipset Model: Intel Iris 19:21:53 INFO - Type: GPU 19:21:53 INFO - Bus: Built-In 19:21:53 INFO - VRAM (Dynamic, Max): 1536 MB 19:21:53 INFO - Vendor: Intel (0x8086) 19:21:53 INFO - Device ID: 0x0a2e 19:21:53 INFO - Revision ID: 0x0009 19:21:53 INFO - Displays: 19:21:53 INFO - Display: 19:21:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:21:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:21:53 INFO - Display Serial Number: 1600x1200 60 19:21:53 INFO - Main Display: Yes 19:21:53 INFO - Mirror: Off 19:21:53 INFO - Online: Yes 19:21:53 INFO - Rotation: Supported 19:21:53 INFO - Return code: 0 19:21:53 INFO - Running post-action listener: _resource_record_post_action 19:21:53 INFO - [mozharness: 2016-11-05 02:21:53.538825Z] Finished run-tests step (success) 19:21:53 INFO - Running post-run listener: _resource_record_post_run 19:21:53 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37413888; Write bytes: 663607296; Read time: 389; Write time: 1869 19:21:53 INFO - TinderboxPrint: CPU usage
53.4% 19:21:53 INFO - TinderboxPrint: I/O read bytes / time
37,413,888 / 389 19:21:53 INFO - TinderboxPrint: I/O write bytes / time
663,607,296 / 1,869 19:21:53 INFO - TinderboxPrint: CPU idle
2,256.2 (46.6%) 19:21:53 INFO - TinderboxPrint: CPU system
962.3 (19.9%) 19:21:53 INFO - TinderboxPrint: CPU user
1,623.3 (33.5%) 19:21:53 INFO - TinderboxPrint: Swap in / out
401,145,856 / 0 19:21:53 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 364571136; Write bytes: 367056896; Read time: 28779; Write time: 786 19:21:53 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34534400; Write bytes: 294998016; Read time: 361; Write time: 1077 19:21:54 INFO - Running post-run listener: _upload_blobber_files 19:21:54 INFO - Blob upload gear active. 19:21:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:21:54 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 19:21:54 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'] 19:21:54 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 19:21:54 INFO - (blobuploader) - INFO - Open directory for files ... 19:21:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:21:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:55 INFO - (blobuploader) - INFO - Done attempting. 19:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:55 INFO - (blobuploader) - INFO - Done attempting. 19:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:21:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:58 INFO - (blobuploader) - INFO - Done attempting. 19:21:58 INFO - (blobuploader) - INFO - Iteration through files over. 19:21:58 INFO - Return code: 0 19:21:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:21:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:21:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19745474c9cfacf27085a4ee01509854f2eede79b8dcd4d8151cccdfa4bc2be5a63ec446cfcab42bd8ed0e5e5fe7f300b3d98633180e546b62c570834b8c03c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8d674d675a31d80d66d4b0ecd97c9752417e0c5672b4476c69808433cbc8c1afc096c8af1a14007a136ee62f3decd672d885ae81d59e9bd1605ba3544e39ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/552f0b44886a3080fff28d610f50e0287aed64869e2e017ea12344ea5c21d7dac1491232a905b16f99280a60b1c0dc1c5c5ef58f5a46aaba728fb1d3a053015b"} 19:21:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:21:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:21:58 INFO - Contents: 19:21:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19745474c9cfacf27085a4ee01509854f2eede79b8dcd4d8151cccdfa4bc2be5a63ec446cfcab42bd8ed0e5e5fe7f300b3d98633180e546b62c570834b8c03c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8d674d675a31d80d66d4b0ecd97c9752417e0c5672b4476c69808433cbc8c1afc096c8af1a14007a136ee62f3decd672d885ae81d59e9bd1605ba3544e39ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/552f0b44886a3080fff28d610f50e0287aed64869e2e017ea12344ea5c21d7dac1491232a905b16f99280a60b1c0dc1c5c5ef58f5a46aaba728fb1d3a053015b"} 19:21:58 INFO - Running post-run listener: copy_logs_to_upload_dir 19:21:58 INFO - Copying logs to upload dir... 19:21:58 INFO - mkdir: /builds/slave/test/build/upload/logs 19:21:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.344273 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-04 19:21:58.381164) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 19:21:58.384470) ========= 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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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/19745474c9cfacf27085a4ee01509854f2eede79b8dcd4d8151cccdfa4bc2be5a63ec446cfcab42bd8ed0e5e5fe7f300b3d98633180e546b62c570834b8c03c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8d674d675a31d80d66d4b0ecd97c9752417e0c5672b4476c69808433cbc8c1afc096c8af1a14007a136ee62f3decd672d885ae81d59e9bd1605ba3544e39ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/552f0b44886a3080fff28d610f50e0287aed64869e2e017ea12344ea5c21d7dac1491232a905b16f99280a60b1c0dc1c5c5ef58f5a46aaba728fb1d3a053015b"} build_url:https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/HJlU6D-vRqKRAvjGCOcKqQ/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/19745474c9cfacf27085a4ee01509854f2eede79b8dcd4d8151cccdfa4bc2be5a63ec446cfcab42bd8ed0e5e5fe7f300b3d98633180e546b62c570834b8c03c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8d674d675a31d80d66d4b0ecd97c9752417e0c5672b4476c69808433cbc8c1afc096c8af1a14007a136ee62f3decd672d885ae81d59e9bd1605ba3544e39ee3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/552f0b44886a3080fff28d610f50e0287aed64869e2e017ea12344ea5c21d7dac1491232a905b16f99280a60b1c0dc1c5c5ef58f5a46aaba728fb1d3a053015b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 19:21:58.417552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 19:21:58.417913) ========= 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.ftIoPAlG5S/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.FVrZvhfZdm/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.005050 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 19:21:58.466958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 19:21:58.467297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 19:21:58.467684) ========= ========= Total master_lag: 0.17 =========