builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0014 starttime: 1482254147.86 results: success (0) buildid: 20161220080652 builduid: 95bf9582e6aa445ab5d66e1e8e71daba revision: 40f05c0d1f30179d1fffe01cba2e71e5bbabb155 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:47.863772) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:47.864189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:47.864462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:47.889008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:47.889389) ========= 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.Bh455YRiSk/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.I4OBojebEY/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-12-20 09:15:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.7M=0.001s 2016-12-20 09:15:48 (14.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190911 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:48.104617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:48.104926) ========= 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.Bh455YRiSk/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.I4OBojebEY/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.025956 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:48.152624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 09:15:48.152935) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 40f05c0d1f30179d1fffe01cba2e71e5bbabb155 --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-beta --rev 40f05c0d1f30179d1fffe01cba2e71e5bbabb155 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bh455YRiSk/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.I4OBojebEY/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-12-20 09:15:48,246 truncating revision to first 12 chars 2016-12-20 09:15:48,246 Setting DEBUG logging. 2016-12-20 09:15:48,246 attempt 1/10 2016-12-20 09:15:48,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/40f05c0d1f30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 09:15:48,972 unpacking tar archive at: mozilla-beta-40f05c0d1f30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.991482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 09:15:49.167741) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:49.168074) ========= script_repo_revision: 40f05c0d1f30179d1fffe01cba2e71e5bbabb155 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:49.168450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:49.168712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 09:15:49.188640) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-20 09:15:49.189053) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bh455YRiSk/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.I4OBojebEY/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:15:49 INFO - MultiFileLogger online at 20161220 09:15:49 in /builds/slave/test 09:15:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:15:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:49 INFO - {'append_to_log': False, 09:15:49 INFO - 'base_work_dir': '/builds/slave/test', 09:15:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:15:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:49 INFO - 'branch': 'Mozilla-Beta', 09:15:49 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:49 INFO - 'config_files': ('talos/mac_config.py',), 09:15:49 INFO - 'default_actions': ('clobber', 09:15:49 INFO - 'read-buildbot-config', 09:15:49 INFO - 'download-and-extract', 09:15:49 INFO - 'populate-webroot', 09:15:49 INFO - 'create-virtualenv', 09:15:49 INFO - 'install', 09:15:49 INFO - 'run-tests'), 09:15:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:49 INFO - 'download_minidump_stackwalk': True, 09:15:49 INFO - 'download_symbols': 'ondemand', 09:15:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:49 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:49 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:49 INFO - 'installer_path': 'installer.exe', 09:15:49 INFO - 'log_level': 'info', 09:15:49 INFO - 'log_name': 'talos', 09:15:49 INFO - 'log_to_console': True, 09:15:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:15:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:15:49 INFO - 'opt_config_files': (), 09:15:49 INFO - 'pip_index': False, 09:15:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:49 INFO - 'cmd': ('bash', 09:15:49 INFO - '-c', 09:15:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:49 INFO - 'enabled': True, 09:15:49 INFO - 'halt_on_failure': False, 09:15:49 INFO - 'name': 'check_screen_resolution'},), 09:15:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:49 INFO - 'cmd': ('bash', 09:15:49 INFO - '-c', 09:15:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:49 INFO - 'enabled': True, 09:15:49 INFO - 'halt_on_failure': False, 09:15:49 INFO - 'name': 'check_screen_resolution'},), 09:15:49 INFO - 'run_cmd_checks_enabled': True, 09:15:49 INFO - 'sps_profile': False, 09:15:49 INFO - 'sps_profile_interval': 0, 09:15:49 INFO - 'suite': 'dromaeojs', 09:15:49 INFO - 'system_bits': '32', 09:15:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:49 INFO - 'title': 't-yosemite-r7-0014', 09:15:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:49 INFO - 'use_talos_json': True, 09:15:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:49 INFO - 'work_dir': 'build'} 09:15:49 INFO - [mozharness: 2016-12-20 17:15:49.386717Z] Running clobber step. 09:15:49 INFO - Running pre-action listener: _resource_record_pre_action 09:15:49 INFO - Running main action method: clobber 09:15:49 INFO - rmtree: /builds/slave/test/build 09:15:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:52 INFO - Running post-action listener: _resource_record_post_action 09:15:52 INFO - [mozharness: 2016-12-20 17:15:52.370994Z] Finished clobber step (success) 09:15:52 INFO - [mozharness: 2016-12-20 17:15:52.371172Z] Running read-buildbot-config step. 09:15:52 INFO - Running pre-action listener: _resource_record_pre_action 09:15:52 INFO - Running main action method: read_buildbot_config 09:15:52 INFO - Using buildbot properties: 09:15:52 INFO - { 09:15:52 INFO - "project": "", 09:15:52 INFO - "product": "firefox", 09:15:52 INFO - "script_repo_revision": "production", 09:15:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:15:52 INFO - "repository": "", 09:15:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:15:52 INFO - "buildid": "20161220080652", 09:15:52 INFO - "pgo_build": "False", 09:15:52 INFO - "basedir": "/builds/slave/test", 09:15:52 INFO - "buildnumber": 90, 09:15:52 INFO - "slavename": "t-yosemite-r7-0014", 09:15:52 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:15:52 INFO - "platform": "yosemite_r7", 09:15:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:15:52 INFO - "branch": "mozilla-beta", 09:15:52 INFO - "repo_path": "releases/mozilla-beta", 09:15:52 INFO - "revision": "40f05c0d1f30179d1fffe01cba2e71e5bbabb155", 09:15:52 INFO - "stage_platform": "macosx64", 09:15:52 INFO - "builduid": "95bf9582e6aa445ab5d66e1e8e71daba", 09:15:52 INFO - "slavebuilddir": "test" 09:15:52 INFO - } 09:15:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:15:52 INFO - Running post-action listener: _resource_record_post_action 09:15:52 INFO - [mozharness: 2016-12-20 17:15:52.374471Z] Finished read-buildbot-config step (success) 09:15:52 INFO - [mozharness: 2016-12-20 17:15:52.374557Z] Running download-and-extract step. 09:15:52 INFO - Running pre-action listener: _resource_record_pre_action 09:15:52 INFO - Running main action method: download_and_extract 09:15:52 INFO - mkdir: /builds/slave/test/build/tests 09:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:52 INFO - trying https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:15:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 09:15:53 INFO - Downloaded 1165 bytes. 09:15:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:15:53 INFO - Using the following test package requirements: 09:15:53 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:15:53 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:15:53 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:15:53 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:15:53 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:15:53 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:15:53 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:15:53 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:15:53 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:15:53 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:15:53 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:15:53 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:15:53 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:15:53 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:15:53 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:15:53 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:15:53 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:15:53 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:15:54 INFO - Expected file size: 16232538 09:16:01 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:16:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:16:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:16:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:16:01 INFO - Expected file size: 16232538 09:16:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:16:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:16:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:16:09 INFO - Expected file size: 14414089 09:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:09 INFO - trying https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 09:16:12 INFO - Downloaded 86057353 bytes. 09:16:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:12 INFO - mkdir: /builds/slave/test/properties 09:16:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:12 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:12 INFO - Contents: 09:16:12 INFO - build_url:https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:12 INFO - Running post-action listener: _resource_record_post_action 09:16:12 INFO - Running post-action listener: set_extra_try_arguments 09:16:12 INFO - [mozharness: 2016-12-20 17:16:12.965364Z] Finished download-and-extract step (success) 09:16:12 INFO - [mozharness: 2016-12-20 17:16:12.965489Z] Running populate-webroot step. 09:16:12 INFO - Running pre-action listener: _resource_record_pre_action 09:16:12 INFO - Running main action method: populate_webroot 09:16:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:12 INFO - '--tppagecycles', 09:16:12 INFO - '7'], 09:16:12 INFO - 'tests': ['tsvgm']}}, 09:16:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['damp', 'tps']}, 09:16:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'tests': ['damp', 'tps']}, 09:16:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['dromaeo_dom']}, 09:16:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['basic_compositor_video']}, 09:16:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['a11yr', 09:16:12 INFO - 'ts_paint', 09:16:12 INFO - 'tpaint', 09:16:12 INFO - 'sessionrestore', 09:16:12 INFO - 'sessionrestore_no_auto_restore', 09:16:12 INFO - 'tabpaint']}, 09:16:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tsvgx', 09:16:12 INFO - 'tsvgr_opacity', 09:16:12 INFO - 'tart', 09:16:12 INFO - 'tscrollx', 09:16:12 INFO - 'cart']}, 09:16:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:12 INFO - 'tsvgr_opacity', 09:16:12 INFO - 'tart', 09:16:12 INFO - 'tscrollx', 09:16:12 INFO - 'cart']}, 09:16:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s'], 09:16:12 INFO - 'tests': ['tp5o']}, 09:16:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'tests': ['tp5o']}, 09:16:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--disable-e10s', 09:16:12 INFO - '--xperf_path', 09:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:12 INFO - 'tests': ['tp5n']}, 09:16:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:12 INFO - 'talos_options': ['--xperf_path', 09:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:12 INFO - 'tests': ['tp5n']}}, 09:16:12 INFO - 'talos.zip': {'path': '', 09:16:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:12 INFO - Running post-action listener: _resource_record_post_action 09:16:12 INFO - [mozharness: 2016-12-20 17:16:12.983916Z] Finished populate-webroot step (success) 09:16:12 INFO - [mozharness: 2016-12-20 17:16:12.984058Z] Running create-virtualenv step. 09:16:12 INFO - Running pre-action listener: _resource_record_pre_action 09:16:12 INFO - Running main action method: create_virtualenv 09:16:12 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:16:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:13 INFO - Using real prefix '/tools/python27' 09:16:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:16 INFO - Installing pip.................done. 09:16:16 INFO - Return code: 0 09:16:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:16 INFO - 'HOME': '/Users/cltbld', 09:16:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:16 INFO - 'LOGNAME': 'cltbld', 09:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:16 INFO - 'MOZ_NO_REMOTE': '1', 09:16:16 INFO - 'NO_EM_RESTART': '1', 09:16:16 INFO - 'PAGER': '/bin/cat', 09:16:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:16 INFO - 'PWD': '/builds/slave/test', 09:16:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:16 INFO - 'SHELL': '/bin/bash', 09:16:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:16 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:16 INFO - 'USER': 'cltbld', 09:16:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:16 INFO - 'XPC_FLAGS': '0x0', 09:16:16 INFO - 'XPC_SERVICE_NAME': '0', 09:16:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:16:16 INFO - Cleaning up... 09:16:16 INFO - Return code: 0 09:16:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:16:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:16 INFO - 'HOME': '/Users/cltbld', 09:16:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:16 INFO - 'LOGNAME': 'cltbld', 09:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:16 INFO - 'MOZ_NO_REMOTE': '1', 09:16:16 INFO - 'NO_EM_RESTART': '1', 09:16:16 INFO - 'PAGER': '/bin/cat', 09:16:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:16 INFO - 'PWD': '/builds/slave/test', 09:16:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:16 INFO - 'SHELL': '/bin/bash', 09:16:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:16 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:16 INFO - 'USER': 'cltbld', 09:16:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:16 INFO - 'XPC_FLAGS': '0x0', 09:16:16 INFO - 'XPC_SERVICE_NAME': '0', 09:16:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:17 INFO - Downloading/unpacking psutil>=3.1.1 09:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:20 INFO - Installing collected packages: psutil 09:16:20 INFO - Running setup.py install for psutil 09:16:20 INFO - building 'psutil._psutil_osx' extension 09:16:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:16:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:16:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:16:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:16:21 INFO - building 'psutil._psutil_posix' extension 09:16:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:16:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:16:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:16:21 INFO - ^ 09:16:21 INFO - 1 warning generated. 09:16:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:16:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:21 INFO - Successfully installed psutil 09:16:21 INFO - Cleaning up... 09:16:22 INFO - Return code: 0 09:16:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:22 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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:22 INFO - 'HOME': '/Users/cltbld', 09:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:22 INFO - 'LOGNAME': 'cltbld', 09:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:22 INFO - 'MOZ_NO_REMOTE': '1', 09:16:22 INFO - 'NO_EM_RESTART': '1', 09:16:22 INFO - 'PAGER': '/bin/cat', 09:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:22 INFO - 'PWD': '/builds/slave/test', 09:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:22 INFO - 'SHELL': '/bin/bash', 09:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:22 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:22 INFO - 'USER': 'cltbld', 09:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:22 INFO - 'XPC_FLAGS': '0x0', 09:16:22 INFO - 'XPC_SERVICE_NAME': '0', 09:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:24 INFO - Installing collected packages: mozsystemmonitor 09:16:24 INFO - Running setup.py install for mozsystemmonitor 09:16:25 INFO - Successfully installed mozsystemmonitor 09:16:25 INFO - Cleaning up... 09:16:25 INFO - Return code: 0 09:16:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:25 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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:25 INFO - 'HOME': '/Users/cltbld', 09:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:25 INFO - 'LOGNAME': 'cltbld', 09:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:25 INFO - 'MOZ_NO_REMOTE': '1', 09:16:25 INFO - 'NO_EM_RESTART': '1', 09:16:25 INFO - 'PAGER': '/bin/cat', 09:16:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:25 INFO - 'PWD': '/builds/slave/test', 09:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:25 INFO - 'SHELL': '/bin/bash', 09:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:25 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:25 INFO - 'USER': 'cltbld', 09:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:25 INFO - 'XPC_FLAGS': '0x0', 09:16:25 INFO - 'XPC_SERVICE_NAME': '0', 09:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:28 INFO - warning: no files found matching '*.txt' 09:16:28 INFO - no previously-included directories found matching 'build' 09:16:28 INFO - no previously-included directories found matching 'dist' 09:16:28 INFO - no previously-included directories found matching '.git*' 09:16:28 INFO - Installing collected packages: jsonschema, functools32 09:16:28 INFO - Running setup.py install for functools32 09:16:28 INFO - warning: no files found matching '*.txt' 09:16:28 INFO - no previously-included directories found matching 'build' 09:16:28 INFO - no previously-included directories found matching 'dist' 09:16:28 INFO - no previously-included directories found matching '.git*' 09:16:28 INFO - Successfully installed jsonschema functools32 09:16:28 INFO - Cleaning up... 09:16:28 INFO - Return code: 0 09:16:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:28 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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:16:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:28 INFO - 'HOME': '/Users/cltbld', 09:16:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:28 INFO - 'LOGNAME': 'cltbld', 09:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:28 INFO - 'MOZ_NO_REMOTE': '1', 09:16:28 INFO - 'NO_EM_RESTART': '1', 09:16:28 INFO - 'PAGER': '/bin/cat', 09:16:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:28 INFO - 'PWD': '/builds/slave/test', 09:16:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:28 INFO - 'SHELL': '/bin/bash', 09:16:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:28 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:28 INFO - 'USER': 'cltbld', 09:16:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:28 INFO - 'XPC_FLAGS': '0x0', 09:16:28 INFO - 'XPC_SERVICE_NAME': '0', 09:16:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:29 INFO - Cleaning up... 09:16:29 INFO - Return code: 0 09:16:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:29 INFO - 'HOME': '/Users/cltbld', 09:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:29 INFO - 'LOGNAME': 'cltbld', 09:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:29 INFO - 'MOZ_NO_REMOTE': '1', 09:16:29 INFO - 'NO_EM_RESTART': '1', 09:16:29 INFO - 'PAGER': '/bin/cat', 09:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:29 INFO - 'PWD': '/builds/slave/test', 09:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:29 INFO - 'SHELL': '/bin/bash', 09:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:29 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:29 INFO - 'USER': 'cltbld', 09:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:29 INFO - 'XPC_FLAGS': '0x0', 09:16:29 INFO - 'XPC_SERVICE_NAME': '0', 09:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:29 INFO - Downloading/unpacking blobuploader==1.2.4 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:33 INFO - Downloading docopt-0.6.1.tar.gz 09:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:33 INFO - Running setup.py install for blobuploader 09:16:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:33 INFO - Running setup.py install for requests 09:16:34 INFO - Running setup.py install for docopt 09:16:34 INFO - Successfully installed blobuploader requests docopt 09:16:34 INFO - Cleaning up... 09:16:34 INFO - Return code: 0 09:16:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:34 INFO - 'HOME': '/Users/cltbld', 09:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:34 INFO - 'LOGNAME': 'cltbld', 09:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:34 INFO - 'MOZ_NO_REMOTE': '1', 09:16:34 INFO - 'NO_EM_RESTART': '1', 09:16:34 INFO - 'PAGER': '/bin/cat', 09:16:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:34 INFO - 'PWD': '/builds/slave/test', 09:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:34 INFO - 'SHELL': '/bin/bash', 09:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:34 INFO - 'USER': 'cltbld', 09:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:34 INFO - 'XPC_FLAGS': '0x0', 09:16:34 INFO - 'XPC_SERVICE_NAME': '0', 09:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:34 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-tDan_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:34 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ldUcPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:34 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-YGh5iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:34 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ZTmVjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:34 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-UU8tpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-NCaOuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-6mddQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-b4I2VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-X6kAGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Cf6gKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-l1jyYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ivjNsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-rxI0jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:35 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-M3c9qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:36 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-6HuOAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:36 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-0godT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:36 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DZVaLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:36 INFO - Running setup.py install for manifestparser 09:16:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozcrash 09:16:36 INFO - Running setup.py install for mozdebug 09:16:36 INFO - Running setup.py install for mozdevice 09:16:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozfile 09:16:37 INFO - Running setup.py install for mozhttpd 09:16:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Running setup.py install for mozinfo 09:16:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Running setup.py install for mozInstall 09:16:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Running setup.py install for mozleak 09:16:37 INFO - Running setup.py install for mozlog 09:16:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Running setup.py install for moznetwork 09:16:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:38 INFO - Running setup.py install for mozprocess 09:16:38 INFO - Running setup.py install for mozprofile 09:16:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:38 INFO - Running setup.py install for mozrunner 09:16:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:38 INFO - Running setup.py install for mozscreenshot 09:16:38 INFO - Running setup.py install for moztest 09:16:38 INFO - Running setup.py install for mozversion 09:16:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:38 INFO - Cleaning up... 09:16:38 INFO - Return code: 0 09:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:38 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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:38 INFO - 'HOME': '/Users/cltbld', 09:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:38 INFO - 'LOGNAME': 'cltbld', 09:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:38 INFO - 'MOZ_NO_REMOTE': '1', 09:16:38 INFO - 'NO_EM_RESTART': '1', 09:16:38 INFO - 'PAGER': '/bin/cat', 09:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:38 INFO - 'PWD': '/builds/slave/test', 09:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:38 INFO - 'SHELL': '/bin/bash', 09:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:38 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:38 INFO - 'USER': 'cltbld', 09:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:38 INFO - 'XPC_FLAGS': '0x0', 09:16:38 INFO - 'XPC_SERVICE_NAME': '0', 09:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-VJVTwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-LhM0cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:39 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)) 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Giimli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-A2YfHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:39 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)) 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-OF8AT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-R1fkQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-CYPZeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:39 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Z7fuJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-7SqSvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DQPOj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Uaxkdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Oq4ABl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:40 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)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-m_TUhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-FtF2JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:40 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)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ISOzAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-kAJvBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:40 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)) 09:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-eNoRzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:16:41 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)) 09:16:41 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)) 09:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:41 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)) 09:16:41 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)) 09:16:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - Downloading blessings-1.6.tar.gz 09:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:43 INFO - Installing collected packages: blessings 09:16:43 INFO - Running setup.py install for blessings 09:16:43 INFO - Successfully installed blessings 09:16:43 INFO - Cleaning up... 09:16:44 INFO - Return code: 0 09:16:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:44 INFO - Reading from file tmpfile_stdout 09:16:44 INFO - Current package versions: 09:16:44 INFO - blessings == 1.6 09:16:44 INFO - blobuploader == 1.2.4 09:16:44 INFO - docopt == 0.6.1 09:16:44 INFO - functools32 == 3.2.3-2 09:16:44 INFO - jsonschema == 2.5.1 09:16:44 INFO - manifestparser == 1.1 09:16:44 INFO - mozInstall == 1.12 09:16:44 INFO - mozcrash == 0.17 09:16:44 INFO - mozdebug == 0.1 09:16:44 INFO - mozdevice == 0.48 09:16:44 INFO - mozfile == 1.2 09:16:44 INFO - mozhttpd == 0.7 09:16:44 INFO - mozinfo == 0.9 09:16:44 INFO - mozleak == 0.1 09:16:44 INFO - mozlog == 3.4 09:16:44 INFO - moznetwork == 0.27 09:16:44 INFO - mozprocess == 0.23 09:16:44 INFO - mozprofile == 0.28 09:16:44 INFO - mozrunner == 6.12 09:16:44 INFO - mozscreenshot == 0.1 09:16:44 INFO - mozsystemmonitor == 0.3 09:16:44 INFO - moztest == 0.7 09:16:44 INFO - mozversion == 1.4 09:16:44 INFO - psutil == 3.1.1 09:16:44 INFO - requests == 1.2.3 09:16:44 INFO - wsgiref == 0.1.2 09:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:45 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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:45 INFO - 'HOME': '/Users/cltbld', 09:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:45 INFO - 'LOGNAME': 'cltbld', 09:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:45 INFO - 'MOZ_NO_REMOTE': '1', 09:16:45 INFO - 'NO_EM_RESTART': '1', 09:16:45 INFO - 'PAGER': '/bin/cat', 09:16:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:45 INFO - 'PWD': '/builds/slave/test', 09:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:45 INFO - 'SHELL': '/bin/bash', 09:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:45 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:45 INFO - 'USER': 'cltbld', 09:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:45 INFO - 'XPC_FLAGS': '0x0', 09:16:45 INFO - 'XPC_SERVICE_NAME': '0', 09:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:45 INFO - Cleaning up... 09:16:45 INFO - Return code: 0 09:16:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:45 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 0x108770490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0a592390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, '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.Bh455YRiSk/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.I4OBojebEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:45 INFO - 'HOME': '/Users/cltbld', 09:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:45 INFO - 'LOGNAME': 'cltbld', 09:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:45 INFO - 'MOZ_NO_REMOTE': '1', 09:16:45 INFO - 'NO_EM_RESTART': '1', 09:16:45 INFO - 'PAGER': '/bin/cat', 09:16:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:45 INFO - 'PWD': '/builds/slave/test', 09:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:45 INFO - 'SHELL': '/bin/bash', 09:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:16:45 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:45 INFO - 'USER': 'cltbld', 09:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:45 INFO - 'XPC_FLAGS': '0x0', 09:16:45 INFO - 'XPC_SERVICE_NAME': '0', 09:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:45 INFO - Cleaning up... 09:16:45 INFO - Return code: 0 09:16:45 INFO - Running post-action listener: _resource_record_post_action 09:16:45 INFO - Running post-action listener: _start_resource_monitoring 09:16:45 INFO - Starting resource monitoring. 09:16:45 INFO - [mozharness: 2016-12-20 17:16:45.638131Z] Finished create-virtualenv step (success) 09:16:45 INFO - [mozharness: 2016-12-20 17:16:45.639136Z] Running install step. 09:16:45 INFO - Running pre-action listener: _resource_record_pre_action 09:16:45 INFO - Running main action method: install 09:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:45 INFO - Reading from file tmpfile_stdout 09:16:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:46 INFO - Reading from file tmpfile_stdout 09:16:46 INFO - Output received: 09:16:46 INFO - Usage: mozinstall [options] installer 09:16:46 INFO - Options: 09:16:46 INFO - -h, --help show this help message and exit 09:16:46 INFO - -d DEST, --destination=DEST 09:16:46 INFO - Directory to install application into. [default: 09:16:46 INFO - "/builds/slave/test"] 09:16:46 INFO - --app=APP Application being installed. [default: firefox] 09:16:46 INFO - mkdir: /builds/slave/test/build/application 09:16:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:17:07 INFO - Reading from file tmpfile_stdout 09:17:07 INFO - Output received: 09:17:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:17:07 INFO - Running post-action listener: _resource_record_post_action 09:17:07 INFO - [mozharness: 2016-12-20 17:17:07.817497Z] Finished install step (success) 09:17:07 INFO - [mozharness: 2016-12-20 17:17:07.817636Z] Running run-tests step. 09:17:07 INFO - Running pre-action listener: _resource_record_pre_action 09:17:07 INFO - Running main action method: run_tests 09:17:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:07 INFO - 2016-12-20 09:17:07.831 screenresolution[1628:7292] starting screenresolution argv=screenresolution get 09:17:07 INFO - 2016-12-20 09:17:07.834 screenresolution[1628:7292] Display 0: 1600x1200x32@60 09:17:07 INFO - 2016-12-20 09:17:07.840 screenresolution[1629:7294] starting screenresolution argv=screenresolution list 09:17:07 INFO - Available Modes on Display 0 09:17:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:08 INFO - Intel Iris: 09:17:08 INFO - Chipset Model: Intel Iris 09:17:08 INFO - Type: GPU 09:17:08 INFO - Bus: Built-In 09:17:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:08 INFO - Vendor: Intel (0x8086) 09:17:08 INFO - Device ID: 0x0a2e 09:17:08 INFO - Revision ID: 0x0009 09:17:08 INFO - Displays: 09:17:08 INFO - Display: 09:17:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:08 INFO - Display Serial Number: 1600x1200 60 09:17:08 INFO - Main Display: Yes 09:17:08 INFO - Mirror: Off 09:17:08 INFO - Online: Yes 09:17:08 INFO - Rotation: Supported 09:17:08 INFO - Return code: 0 09:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:08 INFO - Python 2.7.3 09:17:08 INFO - Return code: 0 09:17:08 INFO - grabbing minidump binary from tooltool 09:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:08 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 0x108584d30>, '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 0x1083eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10857cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:17:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:17:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:17:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:08 INFO - Return code: 0 09:17:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:17:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:17:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh455YRiSk/Render', 09:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:08 INFO - 'HOME': '/Users/cltbld', 09:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:08 INFO - 'LOGNAME': 'cltbld', 09:17:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:08 INFO - 'MOZ_NO_REMOTE': '1', 09:17:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:08 INFO - 'NO_EM_RESTART': '1', 09:17:08 INFO - 'PAGER': '/bin/cat', 09:17:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:08 INFO - 'PWD': '/builds/slave/test', 09:17:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:08 INFO - 'SHELL': '/bin/bash', 09:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4OBojebEY/Listeners', 09:17:08 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:08 INFO - 'USER': 'cltbld', 09:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:08 INFO - 'XPC_FLAGS': '0x0', 09:17:08 INFO - 'XPC_SERVICE_NAME': '0', 09:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:17:08 INFO - mozversion application_buildid: 20161220080652 09:17:08 INFO - mozversion application_changeset: 40f05c0d1f30179d1fffe01cba2e71e5bbabb155 09:17:08 INFO - mozversion application_display_name: Firefox 09:17:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:08 INFO - mozversion application_name: Firefox 09:17:08 INFO - mozversion application_remotingname: firefox 09:17:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:17:08 INFO - mozversion application_vendor: Mozilla 09:17:08 INFO - mozversion application_version: 51.0 09:17:08 INFO - mozversion platform_buildid: 20161220080652 09:17:08 INFO - mozversion platform_changeset: 40f05c0d1f30179d1fffe01cba2e71e5bbabb155 09:17:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:17:08 INFO - mozversion platform_version: 51.0 09:17:08 INFO - using testdate: 1482254228 09:17:08 INFO - actual date: 1482254228 09:17:08 INFO - starting webserver on 'localhost:49240' 09:17:08 INFO - SUITE-START | Running 2 tests 09:17:08 INFO - TEST-START | dromaeo_css 09:17:08 INFO - operating with platform_type : mac_ 09:17:08 INFO - Initialising browser for dromaeo_css test... 09:17:08 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpCyyO5n/profile http://localhost:49240/getInfo.html) 09:17:11 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 09:17:11 INFO - PROCESS | 1639 | colorDepth:24 09:17:11 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 09:17:11 INFO - PROCESS | 1639 | __metrics 09:17:11 INFO - PROCESS | 1639 | 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" 09:17:11 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:17:11 INFO - TEST-INFO | 1639: exit 0 09:17:11 INFO - Browser initialized. 09:17:11 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:11 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpCyyO5n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:23 INFO - PROCESS | 1642 | RSS: Main: 168488960 09:17:23 INFO - PROCESS | 1642 | 09:18:18 INFO - PROCESS | 1642 | 1482254298741 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] 09:20:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 09:20:27 INFO - PROCESS | 1642 | RSS: Main: 301912064 09:20:27 INFO - PROCESS | 1642 | 09:23:30 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 09:23:30 INFO - PROCESS | 1642 | RSS: Main: 301981696 09:23:30 INFO - PROCESS | 1642 | 09:26:32 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 09:26:33 INFO - PROCESS | 1642 | RSS: Main: 276795392 09:26:33 INFO - PROCESS | 1642 | 09:29:35 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 09:29:36 INFO - PROCESS | 1642 | RSS: Main: 267624448 09:29:36 INFO - PROCESS | 1642 | 09:32:39 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 09:32:40 INFO - PROCESS | 1642 | RSS: Main: 263565312 09:32:40 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 09:35:43 INFO - PROCESS | 1642 | RSS: Main: 328843264 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | __start_tp_report 09:35:43 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 09:35:43 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 09:35:43 INFO - PROCESS | 1642 | |i|pagename|runs| 09:35:43 INFO - PROCESS | 1642 | |0;dojo.html;3469.9826500867493;3487.1107867493783;3519.1729943463265;3529.8058606776617;3579.9642003579975;5866.442687944644;5914.053751399777;5956.195913551669;5960.105984102387;5981.910271345933;5648.293963254593;5853.414658534144;5945;5945.643261404319;5970.253718285215;5273.182656688219;5312.548433383167;5345.251664766916;5374.059539580578;5454.290942177511;5279.815206467774;5284.577233821305;5308.23030660554;5420.34955805302;5445.700486473243;5392.056390131731;5401.216823560581;5402.864928376783;5410.594205434589;5416.729163541807;5305.734713264341;5390.946090539083;5394.325709286359;5396.082665946798;5415.025295446818;5206.661566998133;5288.550473209782;5290.867728306823;5381.838544843622;5411.458854114557;6031.728572214261;6049.062395328731;6061.939380606182;6069.726862291208;6083.48290395317;6159.38406159385;6216.2851272103835;6220.595661282002;6353.618782873043;6367.554271201017;6232.532560058014;6268.968655156695;6273.811785646392;6284.277308109535;6305.59013664115;5945.405459454107;5946.613470124385;5961;5971.9701401493585;5990.9101363479585;6207.068939658997;6224.315325314212;6284.560080794392;6355.968220158869;6408.519361047846;6188.071789231652;6242.469390101802;6253.280872699698;6267.1539342188225;6277.340879207709;6299.559030867887;6317.46301564363;6326.557141000086;6327;6348.079528468346;5044.8234311798915;6141.048137538689;6207.379262073757;6315.084312774622;6319.652419116901;6195.132681424604;6225.470834978987;6259.2488901332135;6269.780557680459;6314.305426403092;4220.894477638084;4953.331300274417;5000.649954503223;5010.3737032870895;5013.974930125399;4477.932831007537;4484.529124441952;4486.461624605003;4502.527234640315;4537.977310113428;5862.472377485961;5935.109733539917;5990.520758339409;6005.099235114681;6013.188219590387;6254.593451425642;6281.309056003836;6281.623102613858;6301.6534090625455;6303.464205542488;6056.57603967718;6068.817935461943;6092.603980741238;6093.542984276197;6094.512439004869;5346;5479.150731636602;5479.698616576047;5545.916811247835;5581.6371935824045;5462.371827239759;6295.874082518324;6342.5243106767175;6354.6187228764575;6430.260520040255;6268.623882567061;6277.246730392382;6277.905831412624;6279.120923070683;6284.340144284784;6339.651319177489;6356.936430635635;6373;6428.517861160338;6438.905386084283;6169.907451388322;6206.255249369924;6221.564490485623;6253.062040693932;6275.184226050585;6299.212598425197;6300.149479820166;6302.590331628429;6312.305646378986;6316.526260530387;6169.074638804036;6261.186045814015;6266.592671476339;6269.843253918689;6296.464800492009;6134.35589263121;6154;6158.952977993841;6164.6917654118015;6287.402696743802;6127.019676851683;6165.32181460048;6174.783882564088;6178.104174894705;6184;6030.638161710312;6261.937380626136;6280.214973128359;6280.874382512233;6282.528810339151;5987.072003839412;6032.668203248863;6039.758409663565;6084.421979911901;6122.969385153046 09:35:43 INFO - PROCESS | 1642 | |1;ext.html;496.4092729651714;526.552430434131;530.4006472685865;559.6586082489681;567.562976508089;32625.18437039072;39404.80297598508;41344.793276033575;42611.78694106529;45892.08215835681;45466;45841.77079114608;45945.77027114868;45986.54013459865;46090;7844.333231675315;10119.190464762838;10323.328983616078;10329.793404131913;10343.534540945639;9445;12804;12894.032947528925;12894.161879477851;12905.41925613345;12704.110712250145;12784.872151278507;12800.551980680679;12802.487900484017;12824.23054616726;12719.427625756864;12765.489380424771;12778.233306001623;12805.935970320183;12822.294773787531;12598.874011259863;12683.556075537312;12699.428525716365;12699.619011429671;12699.936500317532;32495.51256731151;43040.56959430397;43083.707488775384;43310.35034474485;43335.13329733419;3396.694297513211;3524.4360902255517;3628.8548458061646;3916.353801622729;4378.868633940987;31817.52273715896;31969.84015079933;32029.359412811613;32323.676763232303;32629.673703262903;3312.96687033129;3368.225308179108;3440.1571614954246;3450.4996775467416;3468.809215493147;523108;524658;524851;528572;528685;35236.64763352385;65296.02055969164;65716;65764.67117664381;65835.68328633497;36024.27951441009;36820.81589592088;37155.6995505156;37253.81373093117;37415;13395;16051.518454446385;16053.357865685475;16066.598335041484;16086.43697470583;10541.57833686644;12641.051921105769;13315.66710832237;13434.596962091153;13558.932205339108;8128;8175.754727358189;8210;8226.588670566567;8293.585320733939;3386.0519054664733;3411.3518431497937;3416.4021296273054;3418.9145271367915;3440.7935523868146;985.7486340983004;1018.3177271228295;1077.2028698763015;1085.8316960871077;1086.342762628614;31430.528542071886;31547.36905261882;31697.52453713196;32391;32398.35203295921;1136.2727854173336;1137.4597066393396;1162.105179012156;1184.1296646964474;1195.3545085653823;16368.427105051504;16684;16750.581235468966;16792.580185495215;17156.914215428842;684527;691943;691953;692282;692347;62416;62817.37182628115;62885.685571572765;62896.68551657212;62995;1303.9804402933964;1329.654289884637;1330.7205486847677;1418.3475601223552;1429.892758043151;28198.295042624097;30753.384932301677;31751;32659.673403265664;33776;54037.568309426955;54525;54632;54634.726826365615;54649;514664;516435;516742;517340;517786;24969.87515062413;25387.238382848544;28406.857965710038;28495.572566411935;28496.287592810346;40637.79681101694;49852.75073624609;50061;50470;51202.74398628132;41123.58876411198;41927;42174.78912605417;42188.94527636834;43130.56869431266;34757.65242347544;34926.476102858986;41825.79087104545;42743;43116.78441607772;40002;41348.1730365397;41532.3770143442;41749.165016700106;41874.95312617087;35300.47049294211;36346.27307453889;36540.26919461649;37044.44433333556;37162.62837371592;23098.884505577364;26886;27088.864555677097;27214.863925680245;27577 09:35:43 INFO - PROCESS | 1642 | |2;jquery.html;391.0790089339605;391.5027914548525;392.66034879828936;399.8280739282109;421.12406195114164;15524.922375388136;20465.97670116494;21059.2629257976;21907.890460547715;21932.45168870779;14501.854981450182;16474.505764827074;16816.83183168168;20839.583208335862;21029.474263143427;5343.412224655294;5659.971700141494;5682.886342273152;5692.658440493563;5697.03150464422;4972.552470277675;5504.311961004874;5690.231818704484;5729.0833466645345;5741.770329186827;5701.543876489892;5709.286339207599;5716.114002329646;5719.19931209631;5723.427657234285;5671.943280567183;5721.456461636138;5728.513076388491;5952.9702351488395;6239.937600624026;5241.73791310433;6169.259688837324;6178.10417489466;6186.474149697281;6188.350223226541;13765.862341376558;13926.651833704238;20983.79016209849;26965.595516067275;27022.86488567564;2306.5041016181603;2328.8020518255967;2371.1700904683394;2564.846109233452;2596.31197732601;9913.306068575203;10164.288499805016;10488.58045678172;10587.364758114538;10661.733456663567;1869.2616416515536;1922.798106198843;1947.065408603864;1952.4435535872208;1971.497268196615;122555.3872230642;123532;126974;127703.36148319292;128455;9527.90472095284;10052.888893332336;10198.643047493451;10515.106215971575;10612.09797167234;12673.30296833683;12712.872871271169;12725.363731813557;12732.29972351511;12745.872541274653;7989.201079891965;8310.501369917823;8390;8418.705345312885;8606.956965215133;7742.7677169685;8387.20321569462;8783.956080219557;8970.86543701845;9003.909960900308;4559.316102584638;4622.491525932145;4628.768561571908;4637.095766325601;4680.251159814414;1931.2082046361206;1986.5629561496448;1995.6407846587463;1998.320571005865;2002.389271272276;880.7974165941741;954.8615450759601;992.265723364705;1002.7944271424341;1049.317943336837;20929.47676308074;20978;21466.819324936965;21541.892290538446;21625.89187054086;929.1405449958761;957.0620791624248;963.9228861691048;988.1551273660916;1057.6351158850184;10268.783237238576;10903.672889813319;10916.345019298868;10951.850055744191;11036.172287078502;558804.4119558834;561117;568918;582480;586303;75914.62042689751;80585.19414805777;125745;131197;140132;451.1585892310817;465.3113392179593;466.8039423442095;466.83427383279127;467.6025378428309;10807.729806754895;11330.660080197607;18974.146163422956;19745;19981.100850461473;53316;53510.66223344292;54217.72891135677;55522.444775551725;56122.71938640444;73275;76305.23694762982;78246.82629760672;80447;81577;8227.794305142419;8261.802038704234;8299.29455996247;8513.914860851311;8537.060923298557;10880;13046.282454465096;13129.803052954405;13435.395407206895;13525.053246272666;10169.828086914873;11026;11219.158563107963;11224.270422422516;11461.025812805672;10572.41851698164;10653.627123050655;10741.677749667522;10744.19418543628;11667;11540.480678369326;11573.247738896946;11605.419729013684;11688.532458701557;11851.170418070653;8154.959225203836;8267.958660206661;8365.16348365183;8366.414350995372;8429.957850210954;8524.488530688179;11136.49885755159;11215.55137794479;11415;11544.480498377425 09:35:43 INFO - PROCESS | 1642 | |3;mootools.html;1335.2789493673417;1497.266339493648;1516.8938174327795;1700.685373205957;1872.335320961058;8110.837783244331;8619.138086191379;8836.469811811296;9164.770880727985;9171.220446262076;9004.68483603074;9097.408668436547;9109.544522773867;9120.908790912106;9122.27021838253;2421.3946513371657;2452.043702955849;2453.668754718108;2457.6682147909983;2464.2730394533655;2091.1635345861623;2389.486260454002;2421.4793819328843;2431.732509423971;2433.8174636902213;2390.916317928873;2409.409694624819;2425.369403954967;2425.6846609940685;2429.79346755526;2372.6203807390907;2398.8440751351195;2406.626972819207;2408.2895545814026;2419.068658566447;2362.397588614909;2384.7257565379855;2392.569337519246;2395.101836811196;2395.9760402395927;8465;9034.909650903539;9079.092090790935;9146.54267286633;9153.450792952444;5407.648502847303;5638.295213098363;5643.351014633328;5647.548196144298;5652.63257888236;3262.3312220994876;3648.525691660094;3685.5024571682748;3702.2780557791243;3768.4724138620613;1128.7798879218556;1129.949152288149;1130.66645339625;1144.5765066925208;1154.9133814963911;12190.57332993341;12218.694532636666;12261.509539618404;12276.877231227752;12287.139900206988;4508.504064552896;4626.606738427204;4773.809047638056;4813;4821.4696383397795;9427.19868811145;9437.386569872937;9440.150386465113;9444;9453.196478299284;5396.244525766396;5399.676019438846;5405.162199859028;5406.918616276682;5409.56723462122;4417.867463976086;4580.633549316047;4714.198586240347;4727.030958653468;5099.770510327045;3888.5528164260904;3908.5895980922164;4002.1595464952684;4005.1989602079702;4012.4181993611346;1025.6512785652915;1180.734334774686;1191.4221602522769;1198.9940050299867;1207.2816674078908;830.6137645994642;845.8350621628723;888.4314039015036;924.6671198368582;953.4422362917633;5893.233879595711;6040.728167232485;6103.38966103395;6135.11040899076;6368.904466433008;893.6916763716507;947.8672985781996;990.6186118344489;991.0733464210986;997.2919227348518;3669.4862719218795;3835.846566137379;3985.5416627088257;3999.6200360965663;4054.5742697016976;10134.594616215269;11194.048505877092;11307.773844523064;11334.94332528332;11343.489542970587;11269.66191014271;11272.887271127347;11281.435928203557;11282.661520154408;11302.547898084149;8293.502389856629;8384.329253659693;8422;8435.325173986066;8443.95778021106;5541.916871246854;5667.809759950456;5986.850328741816;6073.30157031947;6127.264728232641;10093.293469457361;10199.847002294822;10404;10483.895161048596;10488.423136727553;9639.469829159183;9951.054649808257;10592.576296948344;10758.193135515025;10779.461026948778;7280.417566594554;7631.771046868603;7725.072991241087;7857.764267071997;7868.881966770388;8725.694600688945;8776.91223087761;8819.779505512413;8829.514376709343;8845.557722113997;7637.2362763725405;7776.7278145264645;7834.412419068479;7848.686052557834;7906.841863162819;7569.810754731176;7589.43079269046;7604.277593628596;7619.314261716472;7705.499142555716;6254.437100660963;7200.963995179991;7230.6384680764695;7289.744858929912;7291.781246562611;4932.383452068491;5045.974770126126;5140.074786538459;5201.583873290203;5202.24567437727;5109.233614957786;5137.537621614073;5177.663451875616;5179.611529135254;5282.8943421132135 09:35:43 INFO - PROCESS | 1642 | |4;prototype.html;264.87550851099985;314.30852125324293;320.038284953714;326.26101879243504;327.2326394604651;4464.8214071437105;5279.498447647472;5387.13805791073;5388.245645609618;5463.344398672155;4998.850034498962;5061.519155680205;5305.708186049766;5314.335708036496;5439.456054394558;3381.7125544328637;4124.32964649316;4137.317342638461;4158.251514727355;4182.644475219595;3431.811250381228;4134.7312424692445;4144.223370341878;4164.229617520768;4168.91662166758;3255.8209298488573;3850.4609354690365;4093.2836753568154;4116.34138537834;4146.481689788777;3650.68969137621;3782.9432558511644;4050.5949405059555;4066.512018557777;4093.5906409358977;3512.981235441719;3524.788512689247;3537.6285490023433;3543.007957771828;3574.3208790329754;4295.689814606544;5041.59667226621;5082.636573993111;5253.4221235664045;5285.524302812727;4259.531451540328;4301.666483390159;4632.86101416958;4669.855885308088;4695.943412732108;5004.874878128039;5071.670341427833;5337.70642614656;5604.516386890512;5630.4528147267365;3348.296857659894;3677.613850545681;3860.36304009838;3885.5418677377156;3922.7450215735885;5300.4941814124;5878.882422351529;5889.645381562264;5918.496927761145;5952.9702351488395;3916.9608303917166;3917.2948869203815;3923.431102490123;3945.901352466154;3952.940705889414;3674.026383008505;3811.4282857571034;4015.578364271768;4023.2154729827403;4053.5338436079637;4334.349847522897;4664.787155339636;4664.906701865943;4673.95326046742;4675.532446755297;4788.904221915543;5381.92361527696;5665.66006039639;5669.262995810601;5723.771049157987;1281.705207802192;1338.819259399988;1363.9454421823016;1365.515242089064;1368.4594585138814;853.1681610429781;883.9646414143491;884.5934963408212;887.8623813308948;896.3904544909394;4942;4959.380077490314;5097.827499675095;5285.2600635911;5404.594655400861;5826.067829147316;5830.504407125357;5843.2695913010875;5850.385709500526;5905.025670764362;4524.457065152203;5088.338515992971;5321.521063104339;5427.158790387496;5440.238366628675;2600.726923673025;2644.5239856825956;2989.372231831296;2997.8501074946166;3040.4223197592387;5717.571182161355;5965.940340596625;6023.162935304774;6035.818925432156;6044.516438684895;5068.847934561895;5862.127557496796;6020;6050.364711705208;6068.362821903725;5111.46329635383;5295.814646487354;6017.488513476316;6046.039843902251;6073.75704971805;4860.781264843161;5638.351589567253;5821.243238379153;5841.32824725162;5891.558133140117;5376.462353764592;5795.565332599987;5823.942430224166;5826.329972053268;5826.592138550431;4961.404631444249;5730.398308177748;5958.463738263577;6047.550741949517;6065.54508411862;4022.577629348876;4084.693647976473;4095;4095.160492099053;4119.732217405859;5844.532437405082;5861.912071318849;5862.062070068769;5869.442402971711;5871.383504732113;4452.37666726665;4810.374651295309;5500.4224556420995;5621.213030175697;5735.61971781706;4751.738654374042;5646.971765141148;5656.8969051034655;5670.149477578396;5672.602917795714;4421.712588681726;5017.269042180442;5347.9304139171545;5469.835904922858;5604.467575580314;5114.974425127851;5347.037533243898;5552.7778888843995;5681.176229446624;5687.971560142339;5320.5477534408465;5524.75138618755;5570.777168913198;5579.386267510652;5592.133219351007 09:35:43 INFO - PROCESS | 1642 | |5;yui.html;706.7597017014217;740.7814694665074;793.1711361627101;807.5437377881497;857.2670366836351;16192.514224573251;17258.964462132248;17265.913670431662;17287.22207500664;17314.82685173148;15393.307301171446;15453.22733863305;15480.916335856495;15481.5355539334;15498.225088745547;717.1000394504889;731.1591669579999;732.9926700733005;867.8177582707639;869.8651708985118;888.5690440136528;892.3396686452011;901.8106197698492;901.8737376767258;904.416651259937;953.4184147669915;954.3271993244746;954.6086104697075;955.4935883981501;956.1920177450044;949.5489642419865;951.9381240219363;952.3857112162685;952.6951375559823;953.7853982853871;705.5837056136853;705.7071315404102;706.7067167125637;707.7487491940338;708.0406049802494;16047.277872495766;16144;16156.515304540882;16163.595910102342;16239.59401014984;11497.712557186138;13509.59471215865;13928.37322320498;13970.371333290026;14011.019228653999;13401.86598134016;13647.590572282748;13781.379837907318;14197.57407277773;14272.857271427256;3944.3097457944746;4082.9183416331803;4736.431628204603;4793.18515852306;4799.496052914428;101052.49473752585;101867.98132018659;106200.46899765452;107828;109109;11187.552497899993;11208.383538905438;11457.54169833214;11465.254758440675;11478.713032174095;22555.774442255366;22573.32280031602;22601.886990565272;22613.208537701103;22669.979850906748;7762.301392874669;7826.256505631955;7845.215478452109;7884.881726774103;7886.645100970355;4230.894227644333;4359.324304732771;4545.909081818411;4651.3023046543285;4672.719636821802;3670.1925576373687;3779.60314167014;3831.310364134427;3842.2315536892734;3851.364524853424;673.1417442760421;696.3837004251274;700.8843540815708;706.9328413800681;715.0811207598211;593.403629352498;593.8099808061465;603.3272900715758;673.9831504212336;718.1203026292854;9234.122758337948;9474.857877131848;9749.31754777173;9763.414195148314;9965.152961998312;622.9906551401733;681.3050688297908;697.6267696782197;706.2654838967519;711.310029271616;4430.379746835446;4761.761911904391;4823.1800593899125;4832.226843704991;4840.975795121072;170216;172674;174764.25235747735;175671;176091;137214;145682.27158864136;147949.26025369804;152899.47100529075;154599;88276;128593;130499;131071;131534.34232828775;8898.154675305836;9036.367454278137;9201.079892011014;9201.401908875901;9272.165505104573;59870.401295986485;66624.33375666375;68347.97478037734;69774;69809.3019069823;103493.48253258686;103686;109007;110033;114077.42961285141;12308.199967002116;13236.735265294832;13691.794623080463;13741.656458588615;14134.929325353307;15163.772543411636;15347.846521534642;15426.382944682537;15506.844931550992;16131.516054518383;14503;14702.779458308349;14843.703125937636;15054.096754194783;15566.9221653891;14737;14774.556763297118;14864.851351486346;15268.923655381652;15352.155631440379;11699.2980421175;13839;14077.788833167306;14683.632909177357;15254.08475491474;11531.290146815323;11805.704857378634;11872.347020913932;12226.816597751218;12393.566225182076;9895.010498950047;11890.583829565923;12099.455524501594;12137.089718271342;12192.695182620506 09:35:43 INFO - PROCESS | 1642 | __end_tp_report 09:35:43 INFO - PROCESS | 1642 | __start_cc_report 09:35:43 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1217 09:35:43 INFO - PROCESS | 1642 | __end_cc_report 09:35:43 INFO - PROCESS | 1642 | __startTimestamp1482255343541__endTimestamp 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | ------- Summary: start ------- 09:35:43 INFO - PROCESS | 1642 | Number of tests: 6 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5854.92 Median:6122.97 stddev:631.62 (10.3%) stddev-sans-first:605.21 09:35:43 INFO - PROCESS | 1642 | Values: 3470.0 3487.1 3519.2 3529.8 3580.0 5866.4 5914.1 5956.2 5960.1 5981.9 5648.3 5853.4 5945.0 5945.6 5970.3 5273.2 5312.5 5345.3 5374.1 5454.3 5279.8 5284.6 5308.2 5420.3 5445.7 5392.1 5401.2 5402.9 5410.6 5416.7 5305.7 5390.9 5394.3 5396.1 5415.0 5206.7 5288.6 5290.9 5381.8 5411.5 6031.7 6049.1 6061.9 6069.7 6083.5 6159.4 6216.3 6220.6 6353.6 6367.6 6232.5 6269.0 6273.8 6284.3 6305.6 5945.4 5946.6 5961.0 5972.0 5990.9 6207.1 6224.3 6284.6 6356.0 6408.5 6188.1 6242.5 6253.3 6267.2 6277.3 6299.6 6317.5 6326.6 6327.0 6348.1 5044.8 6141.0 6207.4 6315.1 6319.7 6195.1 6225.5 6259.2 6269.8 6314.3 4220.9 4953.3 5000.6 5010.4 5014.0 4477.9 4484.5 4486.5 4502.5 4538.0 5862.5 5935.1 5990.5 6005.1 6013.2 6254.6 6281.3 6281.6 6301.7 6303.5 6056.6 6068.8 6092.6 6093.5 6094.5 5346.0 5479.2 5479.7 5545.9 5581.6 5462.4 6295.9 6342.5 6354.6 6430.3 6268.6 6277.2 6277.9 6279.1 6284.3 6339.7 6356.9 6373.0 6428.5 6438.9 6169.9 6206.3 6221.6 6253.1 6275.2 6299.2 6300.1 6302.6 6312.3 6316.5 6169.1 6261.2 6266.6 6269.8 6296.5 6134.4 6154.0 6159.0 6164.7 6287.4 6127.0 6165.3 6174.8 6178.1 6184.0 6030.6 6261.9 6280.2 6280.9 6282.5 5987.1 6032.7 6039.8 6084.4 6123.0 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:71088.63 Median:34842.06 stddev:155955.83 (447.6%) stddev-sans-first:156303.27 09:35:43 INFO - PROCESS | 1642 | Values: 496.4 526.6 530.4 559.7 567.6 32625.2 39404.8 41344.8 42611.8 45892.1 45466.0 45841.8 45945.8 45986.5 46090.0 7844.3 10119.2 10323.3 10329.8 10343.5 9445.0 12804.0 12894.0 12894.2 12905.4 12704.1 12784.9 12800.6 12802.5 12824.2 12719.4 12765.5 12778.2 12805.9 12822.3 12598.9 12683.6 12699.4 12699.6 12699.9 32495.5 43040.6 43083.7 43310.4 43335.1 3396.7 3524.4 3628.9 3916.4 4378.9 31817.5 31969.8 32029.4 32323.7 32629.7 3313.0 3368.2 3440.2 3450.5 3468.8 523108.0 524658.0 524851.0 528572.0 528685.0 35236.6 65296.0 65716.0 65764.7 65835.7 36024.3 36820.8 37155.7 37253.8 37415.0 13395.0 16051.5 16053.4 16066.6 16086.4 10541.6 12641.1 13315.7 13434.6 13558.9 8128.0 8175.8 8210.0 8226.6 8293.6 3386.1 3411.4 3416.4 3418.9 3440.8 985.7 1018.3 1077.2 1085.8 1086.3 31430.5 31547.4 31697.5 32391.0 32398.4 1136.3 1137.5 1162.1 1184.1 1195.4 16368.4 16684.0 16750.6 16792.6 17156.9 684527.0 691943.0 691953.0 692282.0 692347.0 62416.0 62817.4 62885.7 62896.7 62995.0 1304.0 1329.7 1330.7 1418.3 1429.9 28198.3 30753.4 31751.0 32659.7 33776.0 54037.6 54525.0 54632.0 54634.7 54649.0 514664.0 516435.0 516742.0 517340.0 517786.0 24969.9 25387.2 28406.9 28495.6 28496.3 40637.8 49852.8 50061.0 50470.0 51202.7 41123.6 41927.0 42174.8 42188.9 43130.6 34757.7 34926.5 41825.8 42743.0 43116.8 40002.0 41348.2 41532.4 41749.2 41875.0 35300.5 36346.3 36540.3 37044.4 37162.6 23098.9 26886.0 27088.9 27214.9 27577.0 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:33722.71 Median:14780.95 stddev:95612.79 (646.9%) stddev-sans-first:95848.26 09:35:43 INFO - PROCESS | 1642 | Values: 391.1 391.5 392.7 399.8 421.1 15524.9 20466.0 21059.3 21907.9 21932.5 14501.9 16474.5 16816.8 20839.6 21029.5 5343.4 5660.0 5682.9 5692.7 5697.0 4972.6 5504.3 5690.2 5729.1 5741.8 5701.5 5709.3 5716.1 5719.2 5723.4 5671.9 5721.5 5728.5 5953.0 6239.9 5241.7 6169.3 6178.1 6186.5 6188.4 13765.9 13926.7 20983.8 26965.6 27022.9 2306.5 2328.8 2371.2 2564.8 2596.3 9913.3 10164.3 10488.6 10587.4 10661.7 1869.3 1922.8 1947.1 1952.4 1971.5 122555.4 123532.0 126974.0 127703.4 128455.0 9527.9 10052.9 10198.6 10515.1 10612.1 12673.3 12712.9 12725.4 12732.3 12745.9 7989.2 8310.5 8390.0 8418.7 8607.0 7742.8 8387.2 8784.0 8970.9 9003.9 4559.3 4622.5 4628.8 4637.1 4680.3 1931.2 1986.6 1995.6 1998.3 2002.4 880.8 954.9 992.3 1002.8 1049.3 20929.5 20978.0 21466.8 21541.9 21625.9 929.1 957.1 963.9 988.2 1057.6 10268.8 10903.7 10916.3 10951.9 11036.2 558804.4 561117.0 568918.0 582480.0 586303.0 75914.6 80585.2 125745.0 131197.0 140132.0 451.2 465.3 466.8 466.8 467.6 10807.7 11330.7 18974.1 19745.0 19981.1 53316.0 53510.7 54217.7 55522.4 56122.7 73275.0 76305.2 78246.8 80447.0 81577.0 8227.8 8261.8 8299.3 8513.9 8537.1 10880.0 13046.3 13129.8 13435.4 13525.1 10169.8 11026.0 11219.2 11224.3 11461.0 10572.4 10653.6 10741.7 10744.2 11667.0 11540.5 11573.2 11605.4 11688.5 11851.2 8155.0 8268.0 8365.2 8366.4 8430.0 8524.5 11136.5 11215.6 11415.0 11544.5 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5855.93 Median:5123.39 stddev:3318.93 (64.8%) stddev-sans-first:3310.85 09:35:43 INFO - PROCESS | 1642 | Values: 1335.3 1497.3 1516.9 1700.7 1872.3 8110.8 8619.1 8836.5 9164.8 9171.2 9004.7 9097.4 9109.5 9120.9 9122.3 2421.4 2452.0 2453.7 2457.7 2464.3 2091.2 2389.5 2421.5 2431.7 2433.8 2390.9 2409.4 2425.4 2425.7 2429.8 2372.6 2398.8 2406.6 2408.3 2419.1 2362.4 2384.7 2392.6 2395.1 2396.0 8465.0 9034.9 9079.1 9146.5 9153.5 5407.6 5638.3 5643.4 5647.5 5652.6 3262.3 3648.5 3685.5 3702.3 3768.5 1128.8 1129.9 1130.7 1144.6 1154.9 12190.6 12218.7 12261.5 12276.9 12287.1 4508.5 4626.6 4773.8 4813.0 4821.5 9427.2 9437.4 9440.2 9444.0 9453.2 5396.2 5399.7 5405.2 5406.9 5409.6 4417.9 4580.6 4714.2 4727.0 5099.8 3888.6 3908.6 4002.2 4005.2 4012.4 1025.7 1180.7 1191.4 1199.0 1207.3 830.6 845.8 888.4 924.7 953.4 5893.2 6040.7 6103.4 6135.1 6368.9 893.7 947.9 990.6 991.1 997.3 3669.5 3835.8 3985.5 3999.6 4054.6 10134.6 11194.0 11307.8 11334.9 11343.5 11269.7 11272.9 11281.4 11282.7 11302.5 8293.5 8384.3 8422.0 8435.3 8444.0 5541.9 5667.8 5986.9 6073.3 6127.3 10093.3 10199.8 10404.0 10483.9 10488.4 9639.5 9951.1 10592.6 10758.2 10779.5 7280.4 7631.8 7725.1 7857.8 7868.9 8725.7 8776.9 8819.8 8829.5 8845.6 7637.2 7776.7 7834.4 7848.7 7906.8 7569.8 7589.4 7604.3 7619.3 7705.5 6254.4 7201.0 7230.6 7289.7 7291.8 4932.4 5046.0 5140.1 5201.6 5202.2 5109.2 5137.5 5177.7 5179.6 5282.9 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4582.51 Median:5093.08 stddev:1414.89 (27.8%) stddev-sans-first:1381.25 09:35:43 INFO - PROCESS | 1642 | Values: 264.9 314.3 320.0 326.3 327.2 4464.8 5279.5 5387.1 5388.2 5463.3 4998.9 5061.5 5305.7 5314.3 5439.5 3381.7 4124.3 4137.3 4158.3 4182.6 3431.8 4134.7 4144.2 4164.2 4168.9 3255.8 3850.5 4093.3 4116.3 4146.5 3650.7 3782.9 4050.6 4066.5 4093.6 3513.0 3524.8 3537.6 3543.0 3574.3 4295.7 5041.6 5082.6 5253.4 5285.5 4259.5 4301.7 4632.9 4669.9 4695.9 5004.9 5071.7 5337.7 5604.5 5630.5 3348.3 3677.6 3860.4 3885.5 3922.7 5300.5 5878.9 5889.6 5918.5 5953.0 3917.0 3917.3 3923.4 3945.9 3952.9 3674.0 3811.4 4015.6 4023.2 4053.5 4334.3 4664.8 4664.9 4674.0 4675.5 4788.9 5381.9 5665.7 5669.3 5723.8 1281.7 1338.8 1363.9 1365.5 1368.5 853.2 884.0 884.6 887.9 896.4 4942.0 4959.4 5097.8 5285.3 5404.6 5826.1 5830.5 5843.3 5850.4 5905.0 4524.5 5088.3 5321.5 5427.2 5440.2 2600.7 2644.5 2989.4 2997.9 3040.4 5717.6 5965.9 6023.2 6035.8 6044.5 5068.8 5862.1 6020.0 6050.4 6068.4 5111.5 5295.8 6017.5 6046.0 6073.8 4860.8 5638.4 5821.2 5841.3 5891.6 5376.5 5795.6 5823.9 5826.3 5826.6 4961.4 5730.4 5958.5 6047.6 6065.5 4022.6 4084.7 4095.0 4095.2 4119.7 5844.5 5861.9 5862.1 5869.4 5871.4 4452.4 4810.4 5500.4 5621.2 5735.6 4751.7 5647.0 5656.9 5670.1 5672.6 4421.7 5017.3 5347.9 5469.8 5604.5 5115.0 5347.0 5552.8 5681.2 5688.0 5320.5 5524.8 5570.8 5579.4 5592.1 09:35:43 INFO - PROCESS | 1642 | 09:35:43 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:27254.64 Median:22607.55 stddev:44608.44 (197.3%) stddev-sans-first:44689.04 09:35:43 INFO - PROCESS | 1642 | Values: 706.8 740.8 793.2 807.5 857.3 16192.5 17259.0 17265.9 17287.2 17314.8 15393.3 15453.2 15480.9 15481.5 15498.2 717.1 731.2 733.0 867.8 869.9 888.6 892.3 901.8 901.9 904.4 953.4 954.3 954.6 955.5 956.2 949.5 951.9 952.4 952.7 953.8 705.6 705.7 706.7 707.7 708.0 16047.3 16144.0 16156.5 16163.6 16239.6 11497.7 13509.6 13928.4 13970.4 14011.0 13401.9 13647.6 13781.4 14197.6 14272.9 3944.3 4082.9 4736.4 4793.2 4799.5 101052.5 101868.0 106200.5 107828.0 109109.0 11187.6 11208.4 11457.5 11465.3 11478.7 22555.8 22573.3 22601.9 22613.2 22670.0 7762.3 7826.3 7845.2 7884.9 7886.6 4230.9 4359.3 4545.9 4651.3 4672.7 3670.2 3779.6 3831.3 3842.2 3851.4 673.1 696.4 700.9 706.9 715.1 593.4 593.8 603.3 674.0 718.1 9234.1 9474.9 9749.3 9763.4 9965.2 623.0 681.3 697.6 706.3 711.3 4430.4 4761.8 4823.2 4832.2 4841.0 170216.0 172674.0 174764.3 175671.0 176091.0 137214.0 145682.3 147949.3 152899.5 154599.0 88276.0 128593.0 130499.0 131071.0 131534.3 8898.2 9036.4 9201.1 9201.4 9272.2 59870.4 66624.3 68348.0 69774.0 69809.3 103493.5 103686.0 109007.0 110033.0 114077.4 12308.2 13236.7 13691.8 13741.7 14134.9 15163.8 15347.8 15426.4 15506.8 16131.5 14503.0 14702.8 14843.7 15054.1 15566.9 14737.0 14774.6 14864.9 15268.9 15352.2 11699.3 13839.0 14077.8 14683.6 15254.1 11531.3 11805.7 11872.3 12226.8 12393.6 9895.0 11890.6 12099.5 12137.1 12192.7 09:35:43 INFO - PROCESS | 1642 | -------- Summary: end -------- 09:35:43 INFO - PROCESS | 1642 | 09:35:44 INFO - TEST-INFO | 1642: exit 0 09:35:44 INFO - TEST-OK | dromaeo_css | took 1115719ms 09:35:44 INFO - TEST-START | kraken 09:35:44 INFO - operating with platform_type : mac_ 09:35:44 INFO - Initialising browser for kraken test... 09:35:44 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpgA0SFq/profile http://localhost:49240/getInfo.html) 09:35:46 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 09:35:46 INFO - PROCESS | 1653 | colorDepth:24 09:35:46 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 09:35:46 INFO - PROCESS | 1653 | __metrics 09:35:46 INFO - PROCESS | 1653 | 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" 09:35:46 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:47 INFO - TEST-INFO | 1653: exit 0 09:35:47 INFO - Browser initialized. 09:35:47 INFO - Running cycle 1/1 for kraken test... 09:35:47 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpgA0SFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:59 INFO - PROCESS | 1655 | RSS: Main: 168820736 09:35:59 INFO - PROCESS | 1655 | 09:36:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:03 INFO - PROCESS | 1655 | RSS: Main: 218427392 09:36:03 INFO - PROCESS | 1655 | 09:36:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 09:36:06 INFO - PROCESS | 1655 | RSS: Main: 233459712 09:36:06 INFO - PROCESS | 1655 | 09:36:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 09:36:09 INFO - PROCESS | 1655 | RSS: Main: 328994816 09:36:09 INFO - PROCESS | 1655 | 09:36:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 09:36:12 INFO - PROCESS | 1655 | RSS: Main: 228306944 09:36:12 INFO - PROCESS | 1655 | 09:36:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:15 INFO - PROCESS | 1655 | RSS: Main: 230100992 09:36:15 INFO - PROCESS | 1655 | 09:36:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:18 INFO - PROCESS | 1655 | RSS: Main: 268066816 09:36:18 INFO - PROCESS | 1655 | 09:36:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:21 INFO - PROCESS | 1655 | RSS: Main: 267972608 09:36:21 INFO - PROCESS | 1655 | 09:36:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 09:36:25 INFO - PROCESS | 1655 | RSS: Main: 265347072 09:36:25 INFO - PROCESS | 1655 | 09:36:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:27 INFO - PROCESS | 1655 | RSS: Main: 239984640 09:36:27 INFO - PROCESS | 1655 | 09:36:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:29 INFO - PROCESS | 1655 | RSS: Main: 246702080 09:36:29 INFO - PROCESS | 1655 | 09:36:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:32 INFO - PROCESS | 1655 | RSS: Main: 252899328 09:36:32 INFO - PROCESS | 1655 | 09:36:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:36 INFO - PROCESS | 1655 | RSS: Main: 267378688 09:36:36 INFO - PROCESS | 1655 | 09:36:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:39 INFO - PROCESS | 1655 | RSS: Main: 261468160 09:36:39 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 09:36:41 INFO - PROCESS | 1655 | RSS: Main: 305512448 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | __start_tp_report 09:36:41 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 09:36:41 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 09:36:41 INFO - PROCESS | 1655 | |i|pagename|runs| 09:36:41 INFO - PROCESS | 1655 | |0;ai-astar;113;112;113;113;113;112;112;112;111;113 09:36:41 INFO - PROCESS | 1655 | |1;audio-beat-detection;148;109;112;143;109;108;111;122;173;107 09:36:41 INFO - PROCESS | 1655 | |2;audio-dft;183;182;181;182;182;183;182;180;186;183 09:36:41 INFO - PROCESS | 1655 | |3;audio-fft;79;57;58;90;62;58;61;58;82;57 09:36:41 INFO - PROCESS | 1655 | |4;audio-oscillator;84;69;94;69;68;69;92;67;67;89 09:36:41 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;83;87;86;87;84;88;86;87;84 09:36:41 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;95;94;96;95;96;94;95;93;95 09:36:41 INFO - PROCESS | 1655 | |7;imaging-desaturate;85;84;85;86;85;84;83;85;84;84 09:36:41 INFO - PROCESS | 1655 | |8;json-parse-financial;56;52;52;51;54;57;57;56;56;56 09:36:41 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;63;71;73;72;72;66;66;68;69;68 09:36:41 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;85;83;71;79;97;98;98;87;81;88 09:36:41 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;133;137;141;132;141;149;154;148;196;153 09:36:41 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;163;160;159;162;161;160;160;162;162;156 09:36:41 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;67;67;66;65;66;65;64;66;56 09:36:41 INFO - PROCESS | 1655 | __end_tp_report 09:36:41 INFO - PROCESS | 1655 | __start_cc_report 09:36:41 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1847 09:36:41 INFO - PROCESS | 1655 | __end_cc_report 09:36:41 INFO - PROCESS | 1655 | __startTimestamp1482255401341__endTimestamp 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | ------- Summary: start ------- 09:36:41 INFO - PROCESS | 1655 | Number of tests: 14 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 09:36:41 INFO - PROCESS | 1655 | Values: 113.0 112.0 113.0 113.0 113.0 112.0 112.0 112.0 111.0 113.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:117.00 stddev:22.73 (19.4%) stddev-sans-first:22.42 09:36:41 INFO - PROCESS | 1655 | Values: 148.0 109.0 112.0 143.0 109.0 108.0 111.0 122.0 173.0 107.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:182.40 Median:182.50 stddev:1.58 (0.9%) stddev-sans-first:1.66 09:36:41 INFO - PROCESS | 1655 | Values: 183.0 182.0 181.0 182.0 182.0 183.0 182.0 180.0 186.0 183.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:66.20 Median:61.50 stddev:12.45 (20.2%) stddev-sans-first:12.32 09:36:41 INFO - PROCESS | 1655 | Values: 79.0 57.0 58.0 90.0 62.0 58.0 61.0 58.0 82.0 57.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:76.50 stddev:11.45 (15.0%) stddev-sans-first:11.84 09:36:41 INFO - PROCESS | 1655 | Values: 84.0 69.0 94.0 69.0 68.0 69.0 92.0 67.0 67.0 89.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.91 (2.2%) stddev-sans-first:1.72 09:36:41 INFO - PROCESS | 1655 | Values: 89.0 83.0 87.0 86.0 87.0 84.0 88.0 86.0 87.0 84.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 09:36:41 INFO - PROCESS | 1655 | Values: 95.0 95.0 94.0 96.0 95.0 96.0 94.0 95.0 93.0 95.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 09:36:41 INFO - PROCESS | 1655 | Values: 85.0 84.0 85.0 86.0 85.0 84.0 83.0 85.0 84.0 84.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:56.00 stddev:2.26 (4.0%) stddev-sans-first:2.35 09:36:41 INFO - PROCESS | 1655 | Values: 56.0 52.0 52.0 51.0 54.0 57.0 57.0 56.0 56.0 56.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:70.00 stddev:3.22 (4.6%) stddev-sans-first:2.65 09:36:41 INFO - PROCESS | 1655 | Values: 63.0 71.0 73.0 72.0 72.0 66.0 66.0 68.0 69.0 68.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:8.93 (10.2%) stddev-sans-first:9.45 09:36:41 INFO - PROCESS | 1655 | Values: 85.0 83.0 71.0 79.0 97.0 98.0 98.0 87.0 81.0 88.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:148.50 stddev:18.45 (12.4%) stddev-sans-first:18.71 09:36:41 INFO - PROCESS | 1655 | Values: 133.0 137.0 141.0 132.0 141.0 149.0 154.0 148.0 196.0 153.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:2.01 (1.2%) stddev-sans-first:1.92 09:36:41 INFO - PROCESS | 1655 | Values: 163.0 160.0 159.0 162.0 161.0 160.0 160.0 162.0 162.0 156.0 09:36:41 INFO - PROCESS | 1655 | 09:36:41 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:66.00 stddev:3.22 (4.9%) stddev-sans-first:3.39 09:36:41 INFO - PROCESS | 1655 | Values: 66.0 67.0 67.0 66.0 65.0 66.0 65.0 64.0 66.0 56.0 09:36:41 INFO - PROCESS | 1655 | -------- Summary: end -------- 09:36:41 INFO - PROCESS | 1655 | 09:36:42 INFO - TEST-INFO | 1655: exit 0 09:36:42 INFO - TEST-OK | kraken | took 58105ms 09:36:42 INFO - SUITE-END | took 1173s 09:36:42 INFO - Completed test suite (00:19:34) 09:36:42 INFO - javascript benchmark 09:36:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3469.9826500867493, 3487.1107867493783, 3519.1729943463265, 3529.8058606776617, 3579.9642003579975, 5866.442687944644, 5914.053751399777, 5956.195913551669, 5960.105984102387, 5981.910271345933, 5648.293963254593, 5853.414658534144, 5945.0, 5945.643261404319, 5970.253718285215, 5273.182656688219, 5312.548433383167, 5345.251664766916, 5374.059539580578, 5454.290942177511, 5279.815206467774, 5284.577233821305, 5308.23030660554, 5420.34955805302, 5445.700486473243, 5392.056390131731, 5401.216823560581, 5402.864928376783, 5410.594205434589, 5416.729163541807, 5305.734713264341, 5390.946090539083, 5394.325709286359, 5396.082665946798, 5415.025295446818, 5206.661566998133, 5288.550473209782, 5290.867728306823, 5381.838544843622, 5411.458854114557, 6031.728572214261, 6049.062395328731, 6061.939380606182, 6069.726862291208, 6083.48290395317, 6159.38406159385, 6216.2851272103835, 6220.595661282002, 6353.618782873043, 6367.554271201017, 6232.532560058014, 6268.968655156695, 6273.811785646392, 6284.277308109535, 6305.59013664115, 5945.405459454107, 5946.613470124385, 5961.0, 5971.9701401493585, 5990.9101363479585, 6207.068939658997, 6224.315325314212, 6284.560080794392, 6355.968220158869, 6408.519361047846, 6188.071789231652, 6242.469390101802, 6253.280872699698, 6267.1539342188225, 6277.340879207709, 6299.559030867887, 6317.46301564363, 6326.557141000086, 6327.0, 6348.079528468346, 5044.8234311798915, 6141.048137538689, 6207.379262073757, 6315.084312774622, 6319.652419116901, 6195.132681424604, 6225.470834978987, 6259.2488901332135, 6269.780557680459, 6314.305426403092, 4220.894477638084, 4953.331300274417, 5000.649954503223, 5010.3737032870895, 5013.974930125399, 4477.932831007537, 4484.529124441952, 4486.461624605003, 4502.527234640315, 4537.977310113428, 5862.472377485961, 5935.109733539917, 5990.520758339409, 6005.099235114681, 6013.188219590387, 6254.593451425642, 6281.309056003836, 6281.623102613858, 6301.6534090625455, 6303.464205542488, 6056.57603967718, 6068.817935461943, 6092.603980741238, 6093.542984276197, 6094.512439004869, 5346.0, 5479.150731636602, 5479.698616576047, 5545.916811247835, 5581.6371935824045, 5462.371827239759, 6295.874082518324, 6342.5243106767175, 6354.6187228764575, 6430.260520040255, 6268.623882567061, 6277.246730392382, 6277.905831412624, 6279.120923070683, 6284.340144284784, 6339.651319177489, 6356.936430635635, 6373.0, 6428.517861160338, 6438.905386084283, 6169.907451388322, 6206.255249369924, 6221.564490485623, 6253.062040693932, 6275.184226050585, 6299.212598425197, 6300.149479820166, 6302.590331628429, 6312.305646378986, 6316.526260530387, 6169.074638804036, 6261.186045814015, 6266.592671476339, 6269.843253918689, 6296.464800492009, 6134.35589263121, 6154.0, 6158.952977993841, 6164.6917654118015, 6287.402696743802, 6127.019676851683, 6165.32181460048, 6174.783882564088, 6178.104174894705, 6184.0, 6030.638161710312, 6261.937380626136, 6280.214973128359, 6280.874382512233, 6282.528810339151, 5987.072003839412, 6032.668203248863, 6039.758409663565, 6084.421979911901, 6122.969385153046], "value": 5816.026549248981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.4092729651714, 526.552430434131, 530.4006472685865, 559.6586082489681, 567.562976508089, 32625.18437039072, 39404.80297598508, 41344.793276033575, 42611.78694106529, 45892.08215835681, 45466.0, 45841.77079114608, 45945.77027114868, 45986.54013459865, 46090.0, 7844.333231675315, 10119.190464762838, 10323.328983616078, 10329.793404131913, 10343.534540945639, 9445.0, 12804.0, 12894.032947528925, 12894.161879477851, 12905.41925613345, 12704.110712250145, 12784.872151278507, 12800.551980680679, 12802.487900484017, 12824.23054616726, 12719.427625756864, 12765.489380424771, 12778.233306001623, 12805.935970320183, 12822.294773787531, 12598.874011259863, 12683.556075537312, 12699.428525716365, 12699.619011429671, 12699.936500317532, 32495.51256731151, 43040.56959430397, 43083.707488775384, 43310.35034474485, 43335.13329733419, 3396.694297513211, 3524.4360902255517, 3628.8548458061646, 3916.353801622729, 4378.868633940987, 31817.52273715896, 31969.84015079933, 32029.359412811613, 32323.676763232303, 32629.673703262903, 3312.96687033129, 3368.225308179108, 3440.1571614954246, 3450.4996775467416, 3468.809215493147, 523108.0, 524658.0, 524851.0, 528572.0, 528685.0, 35236.64763352385, 65296.02055969164, 65716.0, 65764.67117664381, 65835.68328633497, 36024.27951441009, 36820.81589592088, 37155.6995505156, 37253.81373093117, 37415.0, 13395.0, 16051.518454446385, 16053.357865685475, 16066.598335041484, 16086.43697470583, 10541.57833686644, 12641.051921105769, 13315.66710832237, 13434.596962091153, 13558.932205339108, 8128.0, 8175.754727358189, 8210.0, 8226.588670566567, 8293.585320733939, 3386.0519054664733, 3411.3518431497937, 3416.4021296273054, 3418.9145271367915, 3440.7935523868146, 985.7486340983004, 1018.3177271228295, 1077.2028698763015, 1085.8316960871077, 1086.342762628614, 31430.528542071886, 31547.36905261882, 31697.52453713196, 32391.0, 32398.35203295921, 1136.2727854173336, 1137.4597066393396, 1162.105179012156, 1184.1296646964474, 1195.3545085653823, 16368.427105051504, 16684.0, 16750.581235468966, 16792.580185495215, 17156.914215428842, 684527.0, 691943.0, 691953.0, 692282.0, 692347.0, 62416.0, 62817.37182628115, 62885.685571572765, 62896.68551657212, 62995.0, 1303.9804402933964, 1329.654289884637, 1330.7205486847677, 1418.3475601223552, 1429.892758043151, 28198.295042624097, 30753.384932301677, 31751.0, 32659.673403265664, 33776.0, 54037.568309426955, 54525.0, 54632.0, 54634.726826365615, 54649.0, 514664.0, 516435.0, 516742.0, 517340.0, 517786.0, 24969.87515062413, 25387.238382848544, 28406.857965710038, 28495.572566411935, 28496.287592810346, 40637.79681101694, 49852.75073624609, 50061.0, 50470.0, 51202.74398628132, 41123.58876411198, 41927.0, 42174.78912605417, 42188.94527636834, 43130.56869431266, 34757.65242347544, 34926.476102858986, 41825.79087104545, 42743.0, 43116.78441607772, 40002.0, 41348.1730365397, 41532.3770143442, 41749.165016700106, 41874.95312617087, 35300.47049294211, 36346.27307453889, 36540.26919461649, 37044.44433333556, 37162.62837371592, 23098.884505577364, 26886.0, 27088.864555677097, 27214.863925680245, 27577.0], "value": 20079.481262213714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.0790089339605, 391.5027914548525, 392.66034879828936, 399.8280739282109, 421.12406195114164, 15524.922375388136, 20465.97670116494, 21059.2629257976, 21907.890460547715, 21932.45168870779, 14501.854981450182, 16474.505764827074, 16816.83183168168, 20839.583208335862, 21029.474263143427, 5343.412224655294, 5659.971700141494, 5682.886342273152, 5692.658440493563, 5697.03150464422, 4972.552470277675, 5504.311961004874, 5690.231818704484, 5729.0833466645345, 5741.770329186827, 5701.543876489892, 5709.286339207599, 5716.114002329646, 5719.19931209631, 5723.427657234285, 5671.943280567183, 5721.456461636138, 5728.513076388491, 5952.9702351488395, 6239.937600624026, 5241.73791310433, 6169.259688837324, 6178.10417489466, 6186.474149697281, 6188.350223226541, 13765.862341376558, 13926.651833704238, 20983.79016209849, 26965.595516067275, 27022.86488567564, 2306.5041016181603, 2328.8020518255967, 2371.1700904683394, 2564.846109233452, 2596.31197732601, 9913.306068575203, 10164.288499805016, 10488.58045678172, 10587.364758114538, 10661.733456663567, 1869.2616416515536, 1922.798106198843, 1947.065408603864, 1952.4435535872208, 1971.497268196615, 122555.3872230642, 123532.0, 126974.0, 127703.36148319292, 128455.0, 9527.90472095284, 10052.888893332336, 10198.643047493451, 10515.106215971575, 10612.09797167234, 12673.30296833683, 12712.872871271169, 12725.363731813557, 12732.29972351511, 12745.872541274653, 7989.201079891965, 8310.501369917823, 8390.0, 8418.705345312885, 8606.956965215133, 7742.7677169685, 8387.20321569462, 8783.956080219557, 8970.86543701845, 9003.909960900308, 4559.316102584638, 4622.491525932145, 4628.768561571908, 4637.095766325601, 4680.251159814414, 1931.2082046361206, 1986.5629561496448, 1995.6407846587463, 1998.320571005865, 2002.389271272276, 880.7974165941741, 954.8615450759601, 992.265723364705, 1002.7944271424341, 1049.317943336837, 20929.47676308074, 20978.0, 21466.819324936965, 21541.892290538446, 21625.89187054086, 929.1405449958761, 957.0620791624248, 963.9228861691048, 988.1551273660916, 1057.6351158850184, 10268.783237238576, 10903.672889813319, 10916.345019298868, 10951.850055744191, 11036.172287078502, 558804.4119558834, 561117.0, 568918.0, 582480.0, 586303.0, 75914.62042689751, 80585.19414805777, 125745.0, 131197.0, 140132.0, 451.1585892310817, 465.3113392179593, 466.8039423442095, 466.83427383279127, 467.6025378428309, 10807.729806754895, 11330.660080197607, 18974.146163422956, 19745.0, 19981.100850461473, 53316.0, 53510.66223344292, 54217.72891135677, 55522.444775551725, 56122.71938640444, 73275.0, 76305.23694762982, 78246.82629760672, 80447.0, 81577.0, 8227.794305142419, 8261.802038704234, 8299.29455996247, 8513.914860851311, 8537.060923298557, 10880.0, 13046.282454465096, 13129.803052954405, 13435.395407206895, 13525.053246272666, 10169.828086914873, 11026.0, 11219.158563107963, 11224.270422422516, 11461.025812805672, 10572.41851698164, 10653.627123050655, 10741.677749667522, 10744.19418543628, 11667.0, 11540.480678369326, 11573.247738896946, 11605.419729013684, 11688.532458701557, 11851.170418070653, 8154.959225203836, 8267.958660206661, 8365.16348365183, 8366.414350995372, 8429.957850210954, 8524.488530688179, 11136.49885755159, 11215.55137794479, 11415.0, 11544.480498377425], "value": 9238.36203542786, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.2789493673417, 1497.266339493648, 1516.8938174327795, 1700.685373205957, 1872.335320961058, 8110.837783244331, 8619.138086191379, 8836.469811811296, 9164.770880727985, 9171.220446262076, 9004.68483603074, 9097.408668436547, 9109.544522773867, 9120.908790912106, 9122.27021838253, 2421.3946513371657, 2452.043702955849, 2453.668754718108, 2457.6682147909983, 2464.2730394533655, 2091.1635345861623, 2389.486260454002, 2421.4793819328843, 2431.732509423971, 2433.8174636902213, 2390.916317928873, 2409.409694624819, 2425.369403954967, 2425.6846609940685, 2429.79346755526, 2372.6203807390907, 2398.8440751351195, 2406.626972819207, 2408.2895545814026, 2419.068658566447, 2362.397588614909, 2384.7257565379855, 2392.569337519246, 2395.101836811196, 2395.9760402395927, 8465.0, 9034.909650903539, 9079.092090790935, 9146.54267286633, 9153.450792952444, 5407.648502847303, 5638.295213098363, 5643.351014633328, 5647.548196144298, 5652.63257888236, 3262.3312220994876, 3648.525691660094, 3685.5024571682748, 3702.2780557791243, 3768.4724138620613, 1128.7798879218556, 1129.949152288149, 1130.66645339625, 1144.5765066925208, 1154.9133814963911, 12190.57332993341, 12218.694532636666, 12261.509539618404, 12276.877231227752, 12287.139900206988, 4508.504064552896, 4626.606738427204, 4773.809047638056, 4813.0, 4821.4696383397795, 9427.19868811145, 9437.386569872937, 9440.150386465113, 9444.0, 9453.196478299284, 5396.244525766396, 5399.676019438846, 5405.162199859028, 5406.918616276682, 5409.56723462122, 4417.867463976086, 4580.633549316047, 4714.198586240347, 4727.030958653468, 5099.770510327045, 3888.5528164260904, 3908.5895980922164, 4002.1595464952684, 4005.1989602079702, 4012.4181993611346, 1025.6512785652915, 1180.734334774686, 1191.4221602522769, 1198.9940050299867, 1207.2816674078908, 830.6137645994642, 845.8350621628723, 888.4314039015036, 924.6671198368582, 953.4422362917633, 5893.233879595711, 6040.728167232485, 6103.38966103395, 6135.11040899076, 6368.904466433008, 893.6916763716507, 947.8672985781996, 990.6186118344489, 991.0733464210986, 997.2919227348518, 3669.4862719218795, 3835.846566137379, 3985.5416627088257, 3999.6200360965663, 4054.5742697016976, 10134.594616215269, 11194.048505877092, 11307.773844523064, 11334.94332528332, 11343.489542970587, 11269.66191014271, 11272.887271127347, 11281.435928203557, 11282.661520154408, 11302.547898084149, 8293.502389856629, 8384.329253659693, 8422.0, 8435.325173986066, 8443.95778021106, 5541.916871246854, 5667.809759950456, 5986.850328741816, 6073.30157031947, 6127.264728232641, 10093.293469457361, 10199.847002294822, 10404.0, 10483.895161048596, 10488.423136727553, 9639.469829159183, 9951.054649808257, 10592.576296948344, 10758.193135515025, 10779.461026948778, 7280.417566594554, 7631.771046868603, 7725.072991241087, 7857.764267071997, 7868.881966770388, 8725.694600688945, 8776.91223087761, 8819.779505512413, 8829.514376709343, 8845.557722113997, 7637.2362763725405, 7776.7278145264645, 7834.412419068479, 7848.686052557834, 7906.841863162819, 7569.810754731176, 7589.43079269046, 7604.277593628596, 7619.314261716472, 7705.499142555716, 6254.437100660963, 7200.963995179991, 7230.6384680764695, 7289.744858929912, 7291.781246562611, 4932.383452068491, 5045.974770126126, 5140.074786538459, 5201.583873290203, 5202.24567437727, 5109.233614957786, 5137.537621614073, 5177.663451875616, 5179.611529135254, 5282.8943421132135], "value": 4679.731306653438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.87550851099985, 314.30852125324293, 320.038284953714, 326.26101879243504, 327.2326394604651, 4464.8214071437105, 5279.498447647472, 5387.13805791073, 5388.245645609618, 5463.344398672155, 4998.850034498962, 5061.519155680205, 5305.708186049766, 5314.335708036496, 5439.456054394558, 3381.7125544328637, 4124.32964649316, 4137.317342638461, 4158.251514727355, 4182.644475219595, 3431.811250381228, 4134.7312424692445, 4144.223370341878, 4164.229617520768, 4168.91662166758, 3255.8209298488573, 3850.4609354690365, 4093.2836753568154, 4116.34138537834, 4146.481689788777, 3650.68969137621, 3782.9432558511644, 4050.5949405059555, 4066.512018557777, 4093.5906409358977, 3512.981235441719, 3524.788512689247, 3537.6285490023433, 3543.007957771828, 3574.3208790329754, 4295.689814606544, 5041.59667226621, 5082.636573993111, 5253.4221235664045, 5285.524302812727, 4259.531451540328, 4301.666483390159, 4632.86101416958, 4669.855885308088, 4695.943412732108, 5004.874878128039, 5071.670341427833, 5337.70642614656, 5604.516386890512, 5630.4528147267365, 3348.296857659894, 3677.613850545681, 3860.36304009838, 3885.5418677377156, 3922.7450215735885, 5300.4941814124, 5878.882422351529, 5889.645381562264, 5918.496927761145, 5952.9702351488395, 3916.9608303917166, 3917.2948869203815, 3923.431102490123, 3945.901352466154, 3952.940705889414, 3674.026383008505, 3811.4282857571034, 4015.578364271768, 4023.2154729827403, 4053.5338436079637, 4334.349847522897, 4664.787155339636, 4664.906701865943, 4673.95326046742, 4675.532446755297, 4788.904221915543, 5381.92361527696, 5665.66006039639, 5669.262995810601, 5723.771049157987, 1281.705207802192, 1338.819259399988, 1363.9454421823016, 1365.515242089064, 1368.4594585138814, 853.1681610429781, 883.9646414143491, 884.5934963408212, 887.8623813308948, 896.3904544909394, 4942.0, 4959.380077490314, 5097.827499675095, 5285.2600635911, 5404.594655400861, 5826.067829147316, 5830.504407125357, 5843.2695913010875, 5850.385709500526, 5905.025670764362, 4524.457065152203, 5088.338515992971, 5321.521063104339, 5427.158790387496, 5440.238366628675, 2600.726923673025, 2644.5239856825956, 2989.372231831296, 2997.8501074946166, 3040.4223197592387, 5717.571182161355, 5965.940340596625, 6023.162935304774, 6035.818925432156, 6044.516438684895, 5068.847934561895, 5862.127557496796, 6020.0, 6050.364711705208, 6068.362821903725, 5111.46329635383, 5295.814646487354, 6017.488513476316, 6046.039843902251, 6073.75704971805, 4860.781264843161, 5638.351589567253, 5821.243238379153, 5841.32824725162, 5891.558133140117, 5376.462353764592, 5795.565332599987, 5823.942430224166, 5826.329972053268, 5826.592138550431, 4961.404631444249, 5730.398308177748, 5958.463738263577, 6047.550741949517, 6065.54508411862, 4022.577629348876, 4084.693647976473, 4095.0, 4095.160492099053, 4119.732217405859, 5844.532437405082, 5861.912071318849, 5862.062070068769, 5869.442402971711, 5871.383504732113, 4452.37666726665, 4810.374651295309, 5500.4224556420995, 5621.213030175697, 5735.61971781706, 4751.738654374042, 5646.971765141148, 5656.8969051034655, 5670.149477578396, 5672.602917795714, 4421.712588681726, 5017.269042180442, 5347.9304139171545, 5469.835904922858, 5604.467575580314, 5114.974425127851, 5347.037533243898, 5552.7778888843995, 5681.176229446624, 5687.971560142339, 5320.5477534408465, 5524.75138618755, 5570.777168913198, 5579.386267510652, 5592.133219351007], "value": 4131.224161105333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.7597017014217, 740.7814694665074, 793.1711361627101, 807.5437377881497, 857.2670366836351, 16192.514224573251, 17258.964462132248, 17265.913670431662, 17287.22207500664, 17314.82685173148, 15393.307301171446, 15453.22733863305, 15480.916335856495, 15481.5355539334, 15498.225088745547, 717.1000394504889, 731.1591669579999, 732.9926700733005, 867.8177582707639, 869.8651708985118, 888.5690440136528, 892.3396686452011, 901.8106197698492, 901.8737376767258, 904.416651259937, 953.4184147669915, 954.3271993244746, 954.6086104697075, 955.4935883981501, 956.1920177450044, 949.5489642419865, 951.9381240219363, 952.3857112162685, 952.6951375559823, 953.7853982853871, 705.5837056136853, 705.7071315404102, 706.7067167125637, 707.7487491940338, 708.0406049802494, 16047.277872495766, 16144.0, 16156.515304540882, 16163.595910102342, 16239.59401014984, 11497.712557186138, 13509.59471215865, 13928.37322320498, 13970.371333290026, 14011.019228653999, 13401.86598134016, 13647.590572282748, 13781.379837907318, 14197.57407277773, 14272.857271427256, 3944.3097457944746, 4082.9183416331803, 4736.431628204603, 4793.18515852306, 4799.496052914428, 101052.49473752585, 101867.98132018659, 106200.46899765452, 107828.0, 109109.0, 11187.552497899993, 11208.383538905438, 11457.54169833214, 11465.254758440675, 11478.713032174095, 22555.774442255366, 22573.32280031602, 22601.886990565272, 22613.208537701103, 22669.979850906748, 7762.301392874669, 7826.256505631955, 7845.215478452109, 7884.881726774103, 7886.645100970355, 4230.894227644333, 4359.324304732771, 4545.909081818411, 4651.3023046543285, 4672.719636821802, 3670.1925576373687, 3779.60314167014, 3831.310364134427, 3842.2315536892734, 3851.364524853424, 673.1417442760421, 696.3837004251274, 700.8843540815708, 706.9328413800681, 715.0811207598211, 593.403629352498, 593.8099808061465, 603.3272900715758, 673.9831504212336, 718.1203026292854, 9234.122758337948, 9474.857877131848, 9749.31754777173, 9763.414195148314, 9965.152961998312, 622.9906551401733, 681.3050688297908, 697.6267696782197, 706.2654838967519, 711.310029271616, 4430.379746835446, 4761.761911904391, 4823.1800593899125, 4832.226843704991, 4840.975795121072, 170216.0, 172674.0, 174764.25235747735, 175671.0, 176091.0, 137214.0, 145682.27158864136, 147949.26025369804, 152899.47100529075, 154599.0, 88276.0, 128593.0, 130499.0, 131071.0, 131534.34232828775, 8898.154675305836, 9036.367454278137, 9201.079892011014, 9201.401908875901, 9272.165505104573, 59870.401295986485, 66624.33375666375, 68347.97478037734, 69774.0, 69809.3019069823, 103493.48253258686, 103686.0, 109007.0, 110033.0, 114077.42961285141, 12308.199967002116, 13236.735265294832, 13691.794623080463, 13741.656458588615, 14134.929325353307, 15163.772543411636, 15347.846521534642, 15426.382944682537, 15506.844931550992, 16131.516054518383, 14503.0, 14702.779458308349, 14843.703125937636, 15054.096754194783, 15566.9221653891, 14737.0, 14774.556763297118, 14864.851351486346, 15268.923655381652, 15352.155631440379, 11699.2980421175, 13839.0, 14077.788833167306, 14683.632909177357, 15254.08475491474, 11531.290146815323, 11805.704857378634, 11872.347020913932, 12226.816597751218, 12393.566225182076, 9895.010498950047, 11890.583829565923, 12099.455524501594, 12137.089718271342, 12192.695182620506], "value": 8291.962178327612, "unit": "score"}], "name": "dromaeo_css", "value": 7464.416967647993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 111.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 112.0, 143.0, 109.0, 108.0, 111.0, 122.0, 173.0, 107.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 181.0, 182.0, 182.0, 183.0, 182.0, 180.0, 186.0, 183.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 90.0, 62.0, 58.0, 61.0, 58.0, 82.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 94.0, 69.0, 68.0, 69.0, 92.0, 67.0, 67.0, 89.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 87.0, 86.0, 87.0, 84.0, 88.0, 86.0, 87.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 94.0, 95.0, 93.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 86.0, 85.0, 84.0, 83.0, 85.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 52.0, 51.0, 54.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 73.0, 72.0, 72.0, 66.0, 66.0, 68.0, 69.0, 68.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 71.0, 79.0, 97.0, 98.0, 98.0, 87.0, 81.0, 88.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 141.0, 132.0, 141.0, 149.0, 154.0, 148.0, 196.0, 153.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 159.0, 162.0, 161.0, 160.0, 160.0, 162.0, 162.0, 156.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 65.0, 66.0, 65.0, 64.0, 66.0, 56.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1411.3, "alertThreshold": 2.0}]} 09:36:42 INFO - Return code: 0 09:36:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:42 INFO - # TBPL SUCCESS # 09:36:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:36:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:36:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:36:42 INFO - 2016-12-20 09:36:42.677 screenresolution[1659:9637] starting screenresolution argv=screenresolution get 09:36:42 INFO - 2016-12-20 09:36:42.680 screenresolution[1659:9637] Display 0: 1600x1200x32@60 09:36:42 INFO - 2016-12-20 09:36:42.687 screenresolution[1660:9640] starting screenresolution argv=screenresolution list 09:36:42 INFO - Available Modes on Display 0 09:36:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:36:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:36:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:36:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:36:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:36:42 INFO - Intel Iris: 09:36:42 INFO - Chipset Model: Intel Iris 09:36:42 INFO - Type: GPU 09:36:42 INFO - Bus: Built-In 09:36:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:36:42 INFO - Vendor: Intel (0x8086) 09:36:42 INFO - Device ID: 0x0a2e 09:36:42 INFO - Revision ID: 0x0009 09:36:42 INFO - Displays: 09:36:42 INFO - Display: 09:36:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:36:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:36:42 INFO - Display Serial Number: 1600x1200 60 09:36:42 INFO - Main Display: Yes 09:36:42 INFO - Mirror: Off 09:36:42 INFO - Online: Yes 09:36:42 INFO - Rotation: Supported 09:36:42 INFO - Return code: 0 09:36:42 INFO - Running post-action listener: _resource_record_post_action 09:36:42 INFO - [mozharness: 2016-12-20 17:36:42.925804Z] Finished run-tests step (success) 09:36:42 INFO - Running post-run listener: _resource_record_post_run 09:36:42 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 39306240; Write bytes: 491879936; Read time: 388; Write time: 1563 09:36:42 INFO - TinderboxPrint: CPU usage
53.2% 09:36:42 INFO - TinderboxPrint: I/O read bytes / time
39,306,240 / 388 09:36:42 INFO - TinderboxPrint: I/O write bytes / time
491,879,936 / 1,563 09:36:42 INFO - TinderboxPrint: CPU idle
2,238.8 (46.8%) 09:36:42 INFO - TinderboxPrint: CPU system
955.8 (20.0%) 09:36:42 INFO - TinderboxPrint: CPU user
1,591.2 (33.2%) 09:36:42 INFO - TinderboxPrint: Swap in / out
234,356,736 / 0 09:36:42 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194548224; Write bytes: 186867712; Read time: 17803; Write time: 339 09:36:43 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 34952192; Write bytes: 294690304; Read time: 355; Write time: 1192 09:36:43 INFO - Running post-run listener: _upload_blobber_files 09:36:43 INFO - Blob upload gear active. 09:36:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:36:43 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:43 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:36:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:44 INFO - (blobuploader) - INFO - Done attempting. 09:36:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:36:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:45 INFO - (blobuploader) - INFO - Done attempting. 09:36:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:48 INFO - (blobuploader) - INFO - Done attempting. 09:36:48 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:48 INFO - Return code: 0 09:36:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03ebc5dbebec118a424615d2fa69b5b615079c2d5ba8e8e52e61544a1be14705f860cfc89ce3c760b5f2a3e86193bb6dcb1a54139f13b538a2528be73702a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ee8ee664f640c8737dfafb87ce8fbb4788604c025946343dcb02739e59749b402766a7f9dd691048fa3186f6401a6f3739cbe7ed73d0a3bdf4c3724490aa917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb40da7fb3e0c042c16ea8261b01ffc2b90027de0d3b39cd78c416bc3b7ed07feceb08a5d49a5e5bbd9601a9c8ca8576b502363843fa852651058cb3139e538b"} 09:36:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:48 INFO - Contents: 09:36:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03ebc5dbebec118a424615d2fa69b5b615079c2d5ba8e8e52e61544a1be14705f860cfc89ce3c760b5f2a3e86193bb6dcb1a54139f13b538a2528be73702a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ee8ee664f640c8737dfafb87ce8fbb4788604c025946343dcb02739e59749b402766a7f9dd691048fa3186f6401a6f3739cbe7ed73d0a3bdf4c3724490aa917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb40da7fb3e0c042c16ea8261b01ffc2b90027de0d3b39cd78c416bc3b7ed07feceb08a5d49a5e5bbd9601a9c8ca8576b502363843fa852651058cb3139e538b"} 09:36:48 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:48 INFO - Copying logs to upload dir... 09:36:48 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.934569 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-20 09:36:48.170395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 09:36:48.173416) ========= 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.Bh455YRiSk/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.I4OBojebEY/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-Beta/sha512/03ebc5dbebec118a424615d2fa69b5b615079c2d5ba8e8e52e61544a1be14705f860cfc89ce3c760b5f2a3e86193bb6dcb1a54139f13b538a2528be73702a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ee8ee664f640c8737dfafb87ce8fbb4788604c025946343dcb02739e59749b402766a7f9dd691048fa3186f6401a6f3739cbe7ed73d0a3bdf4c3724490aa917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb40da7fb3e0c042c16ea8261b01ffc2b90027de0d3b39cd78c416bc3b7ed07feceb08a5d49a5e5bbd9601a9c8ca8576b502363843fa852651058cb3139e538b"} build_url:https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/ErEm5CvFS0GHkq1VdOWq0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03ebc5dbebec118a424615d2fa69b5b615079c2d5ba8e8e52e61544a1be14705f860cfc89ce3c760b5f2a3e86193bb6dcb1a54139f13b538a2528be73702a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ee8ee664f640c8737dfafb87ce8fbb4788604c025946343dcb02739e59749b402766a7f9dd691048fa3186f6401a6f3739cbe7ed73d0a3bdf4c3724490aa917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb40da7fb3e0c042c16ea8261b01ffc2b90027de0d3b39cd78c416bc3b7ed07feceb08a5d49a5e5bbd9601a9c8ca8576b502363843fa852651058cb3139e538b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 09:36:48.207585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:36:48.207872) ========= 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.Bh455YRiSk/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.I4OBojebEY/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005205 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:36:48.255740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 09:36:48.256047) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 09:36:48.256343) ========= ========= Total master_lag: 0.18 =========