builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1475102802.44 results: success (0) buildid: 20160928133220 builduid: 15f6f86c9d2148c396559f5438162e7e revision: 277a0cbc72e6934a44648db21cd8ae3c909aa663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.439896) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.440354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.440652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.502893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.503270) ========= 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.scIXnPNzJy/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.tivcxlghN3/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-28 15:46:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.0M=0s 2016-09-28 15:46:42 (25.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.647702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.648029) ========= 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.scIXnPNzJy/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.tivcxlghN3/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.035990 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:42.704282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 15:46:42.704629) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 277a0cbc72e6934a44648db21cd8ae3c909aa663 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 277a0cbc72e6934a44648db21cd8ae3c909aa663 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.scIXnPNzJy/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.tivcxlghN3/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-28 15:46:42,780 truncating revision to first 12 chars 2016-09-28 15:46:42,780 Setting DEBUG logging. 2016-09-28 15:46:42,780 attempt 1/10 2016-09-28 15:46:42,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/277a0cbc72e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 15:46:43,739 unpacking tar archive at: mozilla-aurora-277a0cbc72e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.228538 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 15:46:43.954100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:43.954415) ========= script_repo_revision: 277a0cbc72e6934a44648db21cd8ae3c909aa663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:43.954799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:43.955069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 15:46:43.972961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-28 15:46:43.973443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.scIXnPNzJy/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.tivcxlghN3/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:46:44 INFO - MultiFileLogger online at 20160928 15:46:44 in /builds/slave/test 15:46:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:46:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:46:44 INFO - {'append_to_log': False, 15:46:44 INFO - 'base_work_dir': '/builds/slave/test', 15:46:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:46:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:46:44 INFO - 'branch': 'Mozilla-Aurora', 15:46:44 INFO - 'buildbot_json_path': 'buildprops.json', 15:46:44 INFO - 'config_files': ('talos/mac_config.py',), 15:46:44 INFO - 'default_actions': ('clobber', 15:46:44 INFO - 'read-buildbot-config', 15:46:44 INFO - 'download-and-extract', 15:46:44 INFO - 'populate-webroot', 15:46:44 INFO - 'create-virtualenv', 15:46:44 INFO - 'install', 15:46:44 INFO - 'run-tests'), 15:46:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:46:44 INFO - 'download_minidump_stackwalk': True, 15:46:44 INFO - 'download_symbols': 'ondemand', 15:46:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:46:44 INFO - 'tooltool.py': '/tools/tooltool.py', 15:46:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:46:44 INFO - '/tools/misc-python/virtualenv.py')}, 15:46:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:46:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:46:44 INFO - 'installer_path': 'installer.exe', 15:46:44 INFO - 'log_level': 'info', 15:46:44 INFO - 'log_name': 'talos', 15:46:44 INFO - 'log_to_console': True, 15:46:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:46:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:46:44 INFO - 'opt_config_files': (), 15:46:44 INFO - 'pip_index': False, 15:46:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:46:44 INFO - 'cmd': ('bash', 15:46:44 INFO - '-c', 15:46:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:46:44 INFO - 'enabled': True, 15:46:44 INFO - 'halt_on_failure': False, 15:46:44 INFO - 'name': 'check_screen_resolution'},), 15:46:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:46:44 INFO - 'cmd': ('bash', 15:46:44 INFO - '-c', 15:46:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:46:44 INFO - 'enabled': True, 15:46:44 INFO - 'halt_on_failure': False, 15:46:44 INFO - 'name': 'check_screen_resolution'},), 15:46:44 INFO - 'run_cmd_checks_enabled': True, 15:46:44 INFO - 'sps_profile': False, 15:46:44 INFO - 'sps_profile_interval': 0, 15:46:44 INFO - 'suite': 'dromaeojs', 15:46:44 INFO - 'system_bits': '32', 15:46:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:46:44 INFO - 'title': 't-yosemite-r7-0051', 15:46:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:46:44 INFO - 'use_talos_json': True, 15:46:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:46:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:46:44 INFO - 'work_dir': 'build'} 15:46:44 INFO - [mozharness: 2016-09-28 22:46:44.173270Z] Running clobber step. 15:46:44 INFO - Running pre-action listener: _resource_record_pre_action 15:46:44 INFO - Running main action method: clobber 15:46:44 INFO - rmtree: /builds/slave/test/build 15:46:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:46:46 INFO - Running post-action listener: _resource_record_post_action 15:46:46 INFO - [mozharness: 2016-09-28 22:46:46.331388Z] Finished clobber step (success) 15:46:46 INFO - [mozharness: 2016-09-28 22:46:46.331533Z] Running read-buildbot-config step. 15:46:46 INFO - Running pre-action listener: _resource_record_pre_action 15:46:46 INFO - Running main action method: read_buildbot_config 15:46:46 INFO - Using buildbot properties: 15:46:46 INFO - { 15:46:46 INFO - "project": "", 15:46:46 INFO - "product": "firefox", 15:46:46 INFO - "script_repo_revision": "production", 15:46:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:46:46 INFO - "repository": "", 15:46:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:46:46 INFO - "buildid": "20160928133220", 15:46:46 INFO - "pgo_build": "False", 15:46:46 INFO - "basedir": "/builds/slave/test", 15:46:46 INFO - "buildnumber": 21, 15:46:46 INFO - "slavename": "t-yosemite-r7-0051", 15:46:46 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:46:46 INFO - "platform": "yosemite_r7", 15:46:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:46:46 INFO - "branch": "mozilla-aurora", 15:46:46 INFO - "repo_path": "releases/mozilla-aurora", 15:46:46 INFO - "revision": "277a0cbc72e6934a44648db21cd8ae3c909aa663", 15:46:46 INFO - "stage_platform": "macosx64", 15:46:46 INFO - "builduid": "15f6f86c9d2148c396559f5438162e7e", 15:46:46 INFO - "slavebuilddir": "test" 15:46:46 INFO - } 15:46:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 15:46:46 INFO - Running post-action listener: _resource_record_post_action 15:46:46 INFO - [mozharness: 2016-09-28 22:46:46.334996Z] Finished read-buildbot-config step (success) 15:46:46 INFO - [mozharness: 2016-09-28 22:46:46.335111Z] Running download-and-extract step. 15:46:46 INFO - Running pre-action listener: _resource_record_pre_action 15:46:46 INFO - Running main action method: download_and_extract 15:46:46 INFO - mkdir: /builds/slave/test/build/tests 15:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:46:46 INFO - trying https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 15:46:46 INFO - Downloading https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 15:46:47 INFO - Downloaded 1199 bytes. 15:46:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:46:47 INFO - Using the following test package requirements: 15:46:47 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:46:47 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 15:46:47 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 15:46:47 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'jsshell-mac.zip'], 15:46:47 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 15:46:47 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:46:47 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 15:46:47 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 15:46:47 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 15:46:47 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:46:47 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 15:46:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:46:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:46:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:46:47 INFO - Fetch https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:46:48 INFO - Expected file size: 16432435 15:46:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:46:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:46:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:46:55 INFO - Fetch https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:46:55 INFO - Expected file size: 16432435 15:47:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 15:47:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:47:02 INFO - Fetch https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 15:47:02 INFO - Expected file size: 14414059 15:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:03 INFO - trying https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:47:03 INFO - Downloading https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 15:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 15:47:06 INFO - Downloaded 115272456 bytes. 15:47:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:47:06 INFO - mkdir: /builds/slave/test/properties 15:47:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:06 INFO - Contents: 15:47:06 INFO - build_url:https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:47:07 INFO - Running post-action listener: _resource_record_post_action 15:47:07 INFO - Running post-action listener: set_extra_try_arguments 15:47:07 INFO - [mozharness: 2016-09-28 22:47:07.325069Z] Finished download-and-extract step (success) 15:47:07 INFO - [mozharness: 2016-09-28 22:47:07.325188Z] Running populate-webroot step. 15:47:07 INFO - Running pre-action listener: _resource_record_pre_action 15:47:07 INFO - Running main action method: populate_webroot 15:47:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:07 INFO - '--tppagecycles', 15:47:07 INFO - '7'], 15:47:07 INFO - 'tests': ['tsvgm']}}, 15:47:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:47:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:47:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:47:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['damp', 'tps']}, 15:47:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'tests': ['damp', 'tps']}, 15:47:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['dromaeo_dom']}, 15:47:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['basic_compositor_video']}, 15:47:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:47:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['a11yr', 15:47:07 INFO - 'ts_paint', 15:47:07 INFO - 'tpaint', 15:47:07 INFO - 'sessionrestore', 15:47:07 INFO - 'sessionrestore_no_auto_restore', 15:47:07 INFO - 'tabpaint']}, 15:47:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:47:07 INFO - 'ts_paint', 15:47:07 INFO - 'tpaint', 15:47:07 INFO - 'sessionrestore', 15:47:07 INFO - 'sessionrestore_no_auto_restore', 15:47:07 INFO - 'tabpaint']}, 15:47:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:47:07 INFO - 'ts_paint', 15:47:07 INFO - 'tpaint', 15:47:07 INFO - 'sessionrestore', 15:47:07 INFO - 'sessionrestore_no_auto_restore', 15:47:07 INFO - 'tabpaint']}, 15:47:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:47:07 INFO - 'ts_paint', 15:47:07 INFO - 'tpaint', 15:47:07 INFO - 'sessionrestore', 15:47:07 INFO - 'sessionrestore_no_auto_restore', 15:47:07 INFO - 'tabpaint']}, 15:47:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['a11yr', 15:47:07 INFO - 'ts_paint', 15:47:07 INFO - 'tpaint', 15:47:07 INFO - 'sessionrestore', 15:47:07 INFO - 'sessionrestore_no_auto_restore', 15:47:07 INFO - 'tabpaint']}, 15:47:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['a11yr', 15:47:07 INFO - 'ts_paint', 15:47:07 INFO - 'tpaint', 15:47:07 INFO - 'sessionrestore', 15:47:07 INFO - 'sessionrestore_no_auto_restore', 15:47:07 INFO - 'tabpaint']}, 15:47:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['tsvgx', 15:47:07 INFO - 'tsvgr_opacity', 15:47:07 INFO - 'tart', 15:47:07 INFO - 'tscrollx', 15:47:07 INFO - 'cart']}, 15:47:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:47:07 INFO - 'tsvgr_opacity', 15:47:07 INFO - 'tart', 15:47:07 INFO - 'tscrollx', 15:47:07 INFO - 'cart']}, 15:47:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'talos_options': ['--disable-e10s'], 15:47:07 INFO - 'tests': ['tp5o']}, 15:47:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'tests': ['tp5o']}, 15:47:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'talos_options': ['--disable-e10s', 15:47:07 INFO - '--xperf_path', 15:47:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:07 INFO - 'tests': ['tp5n']}, 15:47:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:07 INFO - 'talos_options': ['--xperf_path', 15:47:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:07 INFO - 'tests': ['tp5n']}}, 15:47:07 INFO - 'talos.zip': {'path': '', 15:47:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:07 INFO - Running post-action listener: _resource_record_post_action 15:47:07 INFO - [mozharness: 2016-09-28 22:47:07.343776Z] Finished populate-webroot step (success) 15:47:07 INFO - [mozharness: 2016-09-28 22:47:07.343866Z] Running create-virtualenv step. 15:47:07 INFO - Running pre-action listener: _resource_record_pre_action 15:47:07 INFO - Running main action method: create_virtualenv 15:47:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:47:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:47:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:07 INFO - Using real prefix '/tools/python27' 15:47:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:08 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:11 INFO - Installing pip.................done. 15:47:11 INFO - Return code: 0 15:47:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:11 INFO - 'HOME': '/Users/cltbld', 15:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:11 INFO - 'LOGNAME': 'cltbld', 15:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:11 INFO - 'MOZ_NO_REMOTE': '1', 15:47:11 INFO - 'NO_EM_RESTART': '1', 15:47:11 INFO - 'PAGER': '/bin/cat', 15:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:11 INFO - 'PWD': '/builds/slave/test', 15:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:11 INFO - 'SHELL': '/bin/bash', 15:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:11 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:11 INFO - 'USER': 'cltbld', 15:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:11 INFO - 'XPC_FLAGS': '0x0', 15:47:11 INFO - 'XPC_SERVICE_NAME': '0', 15:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:47:11 INFO - Cleaning up... 15:47:11 INFO - Return code: 0 15:47:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:11 INFO - 'HOME': '/Users/cltbld', 15:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:11 INFO - 'LOGNAME': 'cltbld', 15:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:11 INFO - 'MOZ_NO_REMOTE': '1', 15:47:11 INFO - 'NO_EM_RESTART': '1', 15:47:11 INFO - 'PAGER': '/bin/cat', 15:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:11 INFO - 'PWD': '/builds/slave/test', 15:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:11 INFO - 'SHELL': '/bin/bash', 15:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:11 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:11 INFO - 'USER': 'cltbld', 15:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:11 INFO - 'XPC_FLAGS': '0x0', 15:47:11 INFO - 'XPC_SERVICE_NAME': '0', 15:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:11 INFO - Downloading/unpacking psutil>=3.1.1 15:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:14 INFO - Installing collected packages: psutil 15:47:14 INFO - Running setup.py install for psutil 15:47:15 INFO - building 'psutil._psutil_osx' extension 15:47:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:47:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:47:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:47:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:47:15 INFO - building 'psutil._psutil_posix' extension 15:47:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:47:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:47:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:47:15 INFO - ^ 15:47:15 INFO - 1 warning generated. 15:47:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:16 INFO - Successfully installed psutil 15:47:16 INFO - Cleaning up... 15:47:16 INFO - Return code: 0 15:47:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:47:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:16 INFO - 'HOME': '/Users/cltbld', 15:47:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:16 INFO - 'LOGNAME': 'cltbld', 15:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:16 INFO - 'MOZ_NO_REMOTE': '1', 15:47:16 INFO - 'NO_EM_RESTART': '1', 15:47:16 INFO - 'PAGER': '/bin/cat', 15:47:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:16 INFO - 'PWD': '/builds/slave/test', 15:47:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:16 INFO - 'SHELL': '/bin/bash', 15:47:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:16 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:16 INFO - 'USER': 'cltbld', 15:47:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:16 INFO - 'XPC_FLAGS': '0x0', 15:47:16 INFO - 'XPC_SERVICE_NAME': '0', 15:47:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:47:18 INFO - Installing collected packages: mozsystemmonitor 15:47:18 INFO - Running setup.py install for mozsystemmonitor 15:47:19 INFO - Successfully installed mozsystemmonitor 15:47:19 INFO - Cleaning up... 15:47:19 INFO - Return code: 0 15:47:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:19 INFO - 'HOME': '/Users/cltbld', 15:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:19 INFO - 'LOGNAME': 'cltbld', 15:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:19 INFO - 'MOZ_NO_REMOTE': '1', 15:47:19 INFO - 'NO_EM_RESTART': '1', 15:47:19 INFO - 'PAGER': '/bin/cat', 15:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:19 INFO - 'PWD': '/builds/slave/test', 15:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:19 INFO - 'SHELL': '/bin/bash', 15:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:19 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:19 INFO - 'USER': 'cltbld', 15:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:19 INFO - 'XPC_FLAGS': '0x0', 15:47:19 INFO - 'XPC_SERVICE_NAME': '0', 15:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:19 INFO - Downloading/unpacking jsonschema==2.5.1 15:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:22 INFO - warning: no files found matching '*.txt' 15:47:22 INFO - no previously-included directories found matching 'build' 15:47:22 INFO - no previously-included directories found matching 'dist' 15:47:22 INFO - no previously-included directories found matching '.git*' 15:47:22 INFO - Installing collected packages: jsonschema, functools32 15:47:22 INFO - Running setup.py install for functools32 15:47:22 INFO - warning: no files found matching '*.txt' 15:47:22 INFO - no previously-included directories found matching 'build' 15:47:22 INFO - no previously-included directories found matching 'dist' 15:47:22 INFO - no previously-included directories found matching '.git*' 15:47:22 INFO - Successfully installed jsonschema functools32 15:47:22 INFO - Cleaning up... 15:47:22 INFO - Return code: 0 15:47:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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', '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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:47: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 functools32==3.2.3-2 15:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:22 INFO - 'HOME': '/Users/cltbld', 15:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:22 INFO - 'LOGNAME': 'cltbld', 15:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:22 INFO - 'MOZ_NO_REMOTE': '1', 15:47:22 INFO - 'NO_EM_RESTART': '1', 15:47:22 INFO - 'PAGER': '/bin/cat', 15:47:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:22 INFO - 'PWD': '/builds/slave/test', 15:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:22 INFO - 'SHELL': '/bin/bash', 15:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:22 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:22 INFO - 'USER': 'cltbld', 15:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:22 INFO - 'XPC_FLAGS': '0x0', 15:47:22 INFO - 'XPC_SERVICE_NAME': '0', 15:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:47:22 INFO - Cleaning up... 15:47:22 INFO - Return code: 0 15:47:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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', '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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:47: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 blobuploader==1.2.4 15:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:22 INFO - 'HOME': '/Users/cltbld', 15:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:22 INFO - 'LOGNAME': 'cltbld', 15:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:22 INFO - 'MOZ_NO_REMOTE': '1', 15:47:22 INFO - 'NO_EM_RESTART': '1', 15:47:22 INFO - 'PAGER': '/bin/cat', 15:47:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:22 INFO - 'PWD': '/builds/slave/test', 15:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:22 INFO - 'SHELL': '/bin/bash', 15:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:22 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:22 INFO - 'USER': 'cltbld', 15:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:22 INFO - 'XPC_FLAGS': '0x0', 15:47:22 INFO - 'XPC_SERVICE_NAME': '0', 15:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:26 INFO - Downloading docopt-0.6.1.tar.gz 15:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:26 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:26 INFO - Running setup.py install for blobuploader 15:47:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:26 INFO - Running setup.py install for requests 15:47:27 INFO - Running setup.py install for docopt 15:47:27 INFO - Successfully installed blobuploader requests docopt 15:47:27 INFO - Cleaning up... 15:47:27 INFO - Return code: 0 15:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:27 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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:27 INFO - 'HOME': '/Users/cltbld', 15:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:27 INFO - 'LOGNAME': 'cltbld', 15:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:27 INFO - 'MOZ_NO_REMOTE': '1', 15:47:27 INFO - 'NO_EM_RESTART': '1', 15:47:27 INFO - 'PAGER': '/bin/cat', 15:47:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:27 INFO - 'PWD': '/builds/slave/test', 15:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:27 INFO - 'SHELL': '/bin/bash', 15:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:27 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:27 INFO - 'USER': 'cltbld', 15:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:27 INFO - 'XPC_FLAGS': '0x0', 15:47:27 INFO - 'XPC_SERVICE_NAME': '0', 15:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ZMdlgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-EKdR8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-A9_Ei0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-tsgzvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-0bM9N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Yjc9FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-aceccj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-895iAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-_xH7my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-IJdOL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2J3ESV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-dVi5iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-b6LfmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-uorDda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-M4MkJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5G1v1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:29 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-yOqvJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:29 INFO - Running setup.py install for manifestparser 15:47:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:47:29 INFO - Running setup.py install for mozcrash 15:47:30 INFO - Running setup.py install for mozdebug 15:47:30 INFO - Running setup.py install for mozdevice 15:47:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Running setup.py install for mozfile 15:47:30 INFO - Running setup.py install for mozhttpd 15:47:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Running setup.py install for mozinfo 15:47:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Running setup.py install for mozInstall 15:47:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:47:30 INFO - Running setup.py install for mozleak 15:47:31 INFO - Running setup.py install for mozlog 15:47:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:47:31 INFO - Running setup.py install for moznetwork 15:47:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:47:31 INFO - Running setup.py install for mozprocess 15:47:31 INFO - Running setup.py install for mozprofile 15:47:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:47:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:47:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:47:31 INFO - Running setup.py install for mozrunner 15:47:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:47:31 INFO - Running setup.py install for mozscreenshot 15:47:32 INFO - Running setup.py install for moztest 15:47:32 INFO - Running setup.py install for mozversion 15:47:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:47:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:32 INFO - Cleaning up... 15:47:32 INFO - Return code: 0 15:47:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:32 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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:32 INFO - 'HOME': '/Users/cltbld', 15:47:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:32 INFO - 'LOGNAME': 'cltbld', 15:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:32 INFO - 'MOZ_NO_REMOTE': '1', 15:47:32 INFO - 'NO_EM_RESTART': '1', 15:47:32 INFO - 'PAGER': '/bin/cat', 15:47:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:32 INFO - 'PWD': '/builds/slave/test', 15:47:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:32 INFO - 'SHELL': '/bin/bash', 15:47:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:32 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:32 INFO - 'USER': 'cltbld', 15:47:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:32 INFO - 'XPC_FLAGS': '0x0', 15:47:32 INFO - 'XPC_SERVICE_NAME': '0', 15:47:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-HdEzwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-P89qO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-6vs9On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-yXYMa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-bun_Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-CprYzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-xR9NnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-etzV2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-vJzbxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-hdIU1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-OjjeAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-OWPVnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-fJtiic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-XjnnuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-QW_rSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-1BDIEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Yv4w0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:36 INFO - Downloading blessings-1.6.tar.gz 15:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:47:37 INFO - Installing collected packages: blessings 15:47:37 INFO - Running setup.py install for blessings 15:47:37 INFO - Successfully installed blessings 15:47:37 INFO - Cleaning up... 15:47:37 INFO - Return code: 0 15:47:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:47:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:37 INFO - Reading from file tmpfile_stdout 15:47:37 INFO - Current package versions: 15:47:37 INFO - blessings == 1.6 15:47:37 INFO - blobuploader == 1.2.4 15:47:37 INFO - docopt == 0.6.1 15:47:37 INFO - functools32 == 3.2.3-2 15:47:37 INFO - jsonschema == 2.5.1 15:47:37 INFO - manifestparser == 1.1 15:47:37 INFO - mozInstall == 1.12 15:47:37 INFO - mozcrash == 0.17 15:47:37 INFO - mozdebug == 0.1 15:47:37 INFO - mozdevice == 0.48 15:47:37 INFO - mozfile == 1.2 15:47:37 INFO - mozhttpd == 0.7 15:47:37 INFO - mozinfo == 0.9 15:47:37 INFO - mozleak == 0.1 15:47:37 INFO - mozlog == 3.4 15:47:37 INFO - moznetwork == 0.27 15:47:37 INFO - mozprocess == 0.23 15:47:37 INFO - mozprofile == 0.28 15:47:37 INFO - mozrunner == 6.12 15:47:37 INFO - mozscreenshot == 0.1 15:47:37 INFO - mozsystemmonitor == 0.3 15:47:37 INFO - moztest == 0.7 15:47:37 INFO - mozversion == 1.4 15:47:37 INFO - psutil == 3.1.1 15:47:37 INFO - requests == 1.2.3 15:47:37 INFO - wsgiref == 0.1.2 15:47:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:37 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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:37 INFO - 'HOME': '/Users/cltbld', 15:47:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:37 INFO - 'LOGNAME': 'cltbld', 15:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:37 INFO - 'MOZ_NO_REMOTE': '1', 15:47:37 INFO - 'NO_EM_RESTART': '1', 15:47:37 INFO - 'PAGER': '/bin/cat', 15:47:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:37 INFO - 'PWD': '/builds/slave/test', 15:47:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:37 INFO - 'SHELL': '/bin/bash', 15:47:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:37 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:37 INFO - 'USER': 'cltbld', 15:47:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:37 INFO - 'XPC_FLAGS': '0x0', 15:47:37 INFO - 'XPC_SERVICE_NAME': '0', 15:47:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:47:37 INFO - Cleaning up... 15:47:37 INFO - Return code: 0 15:47:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:37 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 0x105f7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa381566d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, '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.scIXnPNzJy/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.tivcxlghN3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:47:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:47:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:47:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:47:37 INFO - 'HOME': '/Users/cltbld', 15:47:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:47:37 INFO - 'LOGNAME': 'cltbld', 15:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:37 INFO - 'MOZ_NO_REMOTE': '1', 15:47:37 INFO - 'NO_EM_RESTART': '1', 15:47:37 INFO - 'PAGER': '/bin/cat', 15:47:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:37 INFO - 'PWD': '/builds/slave/test', 15:47:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:47:37 INFO - 'SHELL': '/bin/bash', 15:47:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:47:37 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:47:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:47:37 INFO - 'USER': 'cltbld', 15:47:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:47:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:37 INFO - 'XPC_FLAGS': '0x0', 15:47:37 INFO - 'XPC_SERVICE_NAME': '0', 15:47:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:47:38 INFO - Cleaning up... 15:47:38 INFO - Return code: 0 15:47:38 INFO - Running post-action listener: _resource_record_post_action 15:47:38 INFO - Running post-action listener: _start_resource_monitoring 15:47:38 INFO - Starting resource monitoring. 15:47:38 INFO - [mozharness: 2016-09-28 22:47:38.279506Z] Finished create-virtualenv step (success) 15:47:38 INFO - [mozharness: 2016-09-28 22:47:38.280445Z] Running install step. 15:47:38 INFO - Running pre-action listener: _resource_record_pre_action 15:47:38 INFO - Running main action method: install 15:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:38 INFO - Reading from file tmpfile_stdout 15:47:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:47:38 INFO - Reading from file tmpfile_stdout 15:47:38 INFO - Output received: 15:47:38 INFO - Usage: mozinstall [options] installer 15:47:38 INFO - Options: 15:47:38 INFO - -h, --help show this help message and exit 15:47:38 INFO - -d DEST, --destination=DEST 15:47:38 INFO - Directory to install application into. [default: 15:47:38 INFO - "/builds/slave/test"] 15:47:38 INFO - --app=APP Application being installed. [default: firefox] 15:47:38 INFO - mkdir: /builds/slave/test/build/application 15:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:48:11 INFO - Reading from file tmpfile_stdout 15:48:11 INFO - Output received: 15:48:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:48:11 INFO - Running post-action listener: _resource_record_post_action 15:48:11 INFO - [mozharness: 2016-09-28 22:48:11.107392Z] Finished install step (success) 15:48:11 INFO - [mozharness: 2016-09-28 22:48:11.107526Z] Running run-tests step. 15:48:11 INFO - Running pre-action listener: _resource_record_pre_action 15:48:11 INFO - Running main action method: run_tests 15:48:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:48:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:48:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:48:11 INFO - 2016-09-28 15:48:11.122 screenresolution[1639:7582] starting screenresolution argv=screenresolution get 15:48:11 INFO - 2016-09-28 15:48:11.124 screenresolution[1639:7582] Display 0: 1600x1200x32@60 15:48:11 INFO - 2016-09-28 15:48:11.130 screenresolution[1640:7585] starting screenresolution argv=screenresolution list 15:48:11 INFO - Available Modes on Display 0 15:48:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:48:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:48:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:48:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:48:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:48:11 INFO - Intel Iris: 15:48:11 INFO - Chipset Model: Intel Iris 15:48:11 INFO - Type: GPU 15:48:11 INFO - Bus: Built-In 15:48:11 INFO - VRAM (Dynamic, Max): 1536 MB 15:48:11 INFO - Vendor: Intel (0x8086) 15:48:11 INFO - Device ID: 0x0a2e 15:48:11 INFO - Revision ID: 0x0009 15:48:11 INFO - Displays: 15:48:11 INFO - Display: 15:48:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:48:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:48:11 INFO - Display Serial Number: 1600x1200 60 15:48:11 INFO - Main Display: Yes 15:48:11 INFO - Mirror: Off 15:48:11 INFO - Online: Yes 15:48:11 INFO - Rotation: Supported 15:48:11 INFO - Return code: 0 15:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:11 INFO - Python 2.7.3 15:48:11 INFO - Return code: 0 15:48:11 INFO - grabbing minidump binary from tooltool 15:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:11 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 0x105d8ed30>, '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 0x105bf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d86b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:48:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:48:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:48:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:11 INFO - Return code: 0 15:48:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:48:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:48:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.scIXnPNzJy/Render', 15:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:11 INFO - 'HOME': '/Users/cltbld', 15:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:11 INFO - 'LOGNAME': 'cltbld', 15:48:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:11 INFO - 'MOZ_NO_REMOTE': '1', 15:48:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:11 INFO - 'NO_EM_RESTART': '1', 15:48:11 INFO - 'PAGER': '/bin/cat', 15:48:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:11 INFO - 'PWD': '/builds/slave/test', 15:48:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:11 INFO - 'SHELL': '/bin/bash', 15:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tivcxlghN3/Listeners', 15:48:11 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:11 INFO - 'USER': 'cltbld', 15:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:11 INFO - 'XPC_FLAGS': '0x0', 15:48:11 INFO - 'XPC_SERVICE_NAME': '0', 15:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:48:11 INFO - mozversion application_buildid: 20160928133220 15:48:11 INFO - mozversion application_changeset: 277a0cbc72e6934a44648db21cd8ae3c909aa663 15:48:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:48:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:11 INFO - mozversion application_name: Firefox 15:48:11 INFO - mozversion application_remotingname: firefox-dev 15:48:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:48:11 INFO - mozversion application_vendor: Mozilla 15:48:11 INFO - mozversion application_version: 51.0a2 15:48:11 INFO - mozversion platform_buildid: 20160928133220 15:48:11 INFO - mozversion platform_changeset: 277a0cbc72e6934a44648db21cd8ae3c909aa663 15:48:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:48:11 INFO - mozversion platform_version: 51.0a2 15:48:11 INFO - using testdate: 1475102891 15:48:11 INFO - actual date: 1475102891 15:48:11 INFO - starting webserver on 'localhost:49278' 15:48:11 INFO - SUITE-START | Running 2 tests 15:48:11 INFO - TEST-START | dromaeo_css 15:48:11 INFO - operating with platform_type : mac_ 15:48:11 INFO - Initialising browser for dromaeo_css test... 15:48:11 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpC3kyVR/profile http://localhost:49278/getInfo.html) 15:48:14 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 15:48:14 INFO - PROCESS | 1650 | colorDepth:24 15:48:14 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 15:48:14 INFO - PROCESS | 1650 | __metrics 15:48:14 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:48:14 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:14 INFO - TEST-INFO | 1650: exit 0 15:48:14 INFO - Browser initialized. 15:48:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:14 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpC3kyVR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:26 INFO - PROCESS | 1652 | RSS: Main: 219095040 15:48:26 INFO - PROCESS | 1652 | 15:49:17 INFO - PROCESS | 1652 | 1475102957853 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:51:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 15:51:31 INFO - PROCESS | 1652 | RSS: Main: 374972416 15:51:31 INFO - PROCESS | 1652 | 15:54:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 15:54:34 INFO - PROCESS | 1652 | RSS: Main: 346390528 15:54:34 INFO - PROCESS | 1652 | 15:57:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 15:57:37 INFO - PROCESS | 1652 | RSS: Main: 340688896 15:57:37 INFO - PROCESS | 1652 | 16:00:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 16:00:40 INFO - PROCESS | 1652 | RSS: Main: 315838464 16:00:40 INFO - PROCESS | 1652 | 16:03:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 16:03:44 INFO - PROCESS | 1652 | RSS: Main: 314007552 16:03:44 INFO - PROCESS | 1652 | 16:06:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 16:06:48 INFO - PROCESS | 1652 | RSS: Main: 455057408 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | __start_tp_report 16:06:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 16:06:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 16:06:48 INFO - PROCESS | 1652 | |i|pagename|runs| 16:06:48 INFO - PROCESS | 1652 | |0;dojo.html;3356.8657253709844;3357.5467311912894;3389.627141014488;3395.830208489578;3430.6740859618344;4271.9960809209815;5613.943860561393;5709.286339207599;5791.768329266834;5811.73847176877;5743.712814359286;5820.156077368779;5833.241678581789;5844.883102337951;5894.174815525819;5235.267062611238;5262.842114736564;5267.157254839227;5296;5305.920411193835;5201.817936372227;5203.011427828719;5213.504717051874;5362.27609272749;5399.163129714901;5232.189010703347;5233.73831308435;5266.236395722618;5313.628046036779;5316.787328506855;5286.973565132169;5293.788248470057;5300.443453437372;5313.495217954288;5374.27447294618;5179.093658609729;5295.364556253236;5311.468853114697;5343.946560534423;5353.839384818461;5637.830865074055;5705.087186050212;5719.19931209631;5763.942360576382;5888.205092312569;6153.107799369066;6218.906716399258;6244.188255526798;6245.531585131133;6309.116723658692;5282.841514754564;6326.304106548276;6334.162108403779;6351.87296254077;6355.428011478943;5879.559033072451;5899.73451194693;5908.05471124618;5920.0231961726695;5925.259342582177;6213.068039794067;6260.655663938436;6269.310375858652;6298.464630506367;6330.366963303725;6222.28443728977;6237;6242.906356404657;6244.687765611701;6272.529560282997;6295.276043254993;6330.493560515148;6332.778352757631;6336.809895703136;6358.554901156967;6073.757049717962;6151.200343955257;6168.629882207082;6175.104609831549;6240.594361366497;6311.779087731908;6332.746690132435;6334.651594162366;6340.714667839959;6358.968205159037;4912.1158191525865;4958.52893975079;4965.9751701241985;4983.6760610560195;4987.750612469362;4411.073674528385;4420.115976804652;4480.596746292849;4483.865484035419;4495.348174514743;4873.853784386474;5755.280589926259;5803.622764520377;5868.559858010581;5906.379830117861;6324.6521441321165;6335.429811316912;6344.206974128234;6362.586431881913;6375.330590287953;5605.579581531401;5849.912251316234;5859.53123750099;5863.355030946593;5903.026000709835;4815.807367705253;5368.979893820162;5385.165299378603;5416.187571864252;5425.945740542623;5444.6460980037755;6284.37156284377;6305.730576053194;6313.863504569222;6369.713362898773;6337.588056776295;6347.714352854225;6358.109864619049;6360.236771587254;6378.2346118466085;6216.937830621636;6273.247210334606;6290.49676025926;6293.37066293367;6312.400321969406;6301.338359472189;6312.368763123651;6319.368063193644;6323.114763932961;6326.778562750282;6158.230221222348;6350.079238510298;6354.078658594571;6372.55392122547;6378;6048.183495228088;6084.817455476343;6112.541559382975;6202.7208775606105;6212.596181248205;5198;6093.086037094471;6116.480099191618;6124.991279909952;6138.878900475427;6068.514518838394;6069.969650151721;6070.089486576872;6098.725557349841;6116.785912493041;6113.51091912637;6204.931408410598;6229;6231.314555398993;6233.906491402723;5805.10020946754;5874.353821079763;5886.05823068307;5945.762169513171;6054.91387234725 16:06:48 INFO - PROCESS | 1652 | |1;ext.html;506.3417557175672;508.9211172268298;523.1498814426557;531.3835950297653;547.9807557942224;30769.384612307742;42445.78777106114;43621.78189109058;43627.34558981614;46303.768481157545;45004.54995450044;45288.32067518982;45400.54599454004;45427.31859022109;45578.54421455784;8769.693060742875;9827.01729827017;9941.652042178524;10009.049140331694;10013.148882345009;8763.079876612928;11780.94109529451;12048.7590248195;12080.879191208063;12357.443915023845;12286;12344.876551234462;12355;12379;12383.257004579755;12221.450034748457;12321.075919306044;12403.75192496154;12423.62729118128;12447.128700990888;12092.39538023104;12174.147809653328;12195.14633975622;12195.939020304842;12206.267623942504;42099.1580168398;42368;42425.727228183205;42446.57553424488;42452.363214551806;3645.143391303042;3647.9270414591824;3875.9031024224337;4054.39184122384;4056.918861622751;30382.54426183609;30773.538396924065;32171.51742723861;33127;33207;3141.8743250269963;3408.3353746019534;3421.7775844570024;3445.758796884219;3486.6164721880573;304353;396801;398113;406405;408919.99999999703;59276.40723592795;59474.70262648659;59568.80862382728;59600.70199649061;59609.403905961255;68283;68465.65767171132;68509.65745171341;68737;68868.6556567214;17122.743158852627;17378.913105434392;17406.56483587895;17425.651486970444;17433.21550530229;12150.57472988441;12210.328431936152;13384;13482.123661961941;13514.797278040838;18326.633467330845;18725.344612938756;18738.25046998132;19230.134643940775;19254.71117933232;6065.090236464565;6323.20959880015;6345.270293916166;6447.451966582893;6454.77408290717;771.9807004824925;968.1359163530602;984.1142971325864;998.7103739915489;1066.7599790047177;30024.399512010074;30059.94790182377;30412;30847.383052339275;30949;938.7465384346189;945.2013048973606;977.8093271812071;993.2964965084769;1064.3986147826454;15022.173780441963;15621.921890390475;15723.292451839467;15858.52424427269;16159;671623;697073;702556;703477;710053;61357.69321153365;61426;61474;61661;62088.379116209166;1370.2121280263889;1377.9586612401645;1406.810080639121;1407.5847624950663;1409.0559325252311;29538.704612953596;30042.69957300399;30058.24854378658;30376.31730979932;30948.53577196389;52202.47797522128;52808;52909.47090529045;52979.94040119099;53054.67363315948;623478;626453;626828;628463;628585;41750.16499669929;42180.10189541539;42659.14681706411;42756.78621606872;42824.57175428206;39675.73294949172;41653.79173104115;47815.521844781106;51978;52100.739496303795;39803;40515.79742101271;40759.388609170295;41038.38442423426;42345.364819528346;40703;40878;41515.58484415117;41674.166516670106;41999.58000419957;38826;39340.2131957365;39660.81017569477;39678.008049798984;39688.206235875696;33995.83002084974;35608;36296;36311.273774523834;36428.27143457169;22979.770202297765;25944;26483.07309244167;27074.458510830067;27100.457990840467 16:06:48 INFO - PROCESS | 1652 | |2;jquery.html;350.58980992239077;356.6540455757917;373.40069188951713;382.902359898226;399.86804354563;14697.632559186026;15228.390864365427;20046.532349883666;21201.363959081213;21564.460888477795;20505.589888202227;20963.16147354104;20986.68519972198;21073.47316317093;21410.03654835532;5871.677057761822;6221.191245138126;6222.346653601352;6226.782062627809;6233.470155036827;4252.574742525753;4444.422225110731;4458.375827384169;6080.2399700037495;6823.795286141423;6890.827729306758;6890.896636550456;6894.482913781461;6898.0687607172895;6903.413209877166;6593.604383736967;6734.865302693943;6809.216940051908;6809.285025072346;6814.352636499525;5190.377154741455;5453.127499600045;5888.735006924699;5891.911621325684;5900.704964751745;12661.810072848915;12945.676358091028;12955.222686638832;12968.80546791799;19539;1808.8914665120135;1890.7069404242227;2185.595664802017;2193.2981445937307;2200.3179014505395;9335.859962100574;9722.125008749246;9890.901090989142;10101.69694909154;10297.639582614647;1550.6588550518868;1807.3764551229804;1876.6152938647544;1878.8121187881238;1903.2577294855018;110039.89960100377;117117.41441292824;119008.61982760296;127911;132697;11420.600278990196;11617.361045142598;11649.825252621218;11694.356810375511;11859.46632401544;12585.874141258653;13384.464621415034;13467;14260.786088208684;14307.57077287683;8579.871301930476;8692.434991725517;8718.956405217934;8832;8846.380753347332;8745.300375969908;8746.912530874737;8770.693025744069;8915.37592368541;8924.286057115416;4407.0084231048395;4434.889127771831;4464.687471877002;4492.124035813051;4581.610563102174;1858.851291896645;1882.3223639489772;1890.9432717018512;1905.4569447707338;1910.770707515107;837.4556538250064;880.1022956584249;924.6024209589941;930.4556834251903;1029.361795686679;20606.381808545768;21358.893205534183;21365.25221617236;21446.57106857854;21645;765.8008917681332;907.2061945797427;918.6095909238547;928.4893308680199;978.7210644966151;7316.963415182997;9604.94345621981;10981.670549883516;11149.609763658233;11183.384913829655;524876;530438;534933;652936;667265;145214;148325;149744;154437;157090;998.7553049502773;1010.2069875147973;1023.5445226874118;1046.0794500839213;1046.576136664652;18152.90923545374;18724.438266852016;19234.326798561982;19263.51841203981;19287.710684339465;44731.552684472736;57634.84730305454;58515.70742146432;58575.414245857;59718.70140649443;68855.31144688689;86191.13808861832;86812;87942.56028719815;90720;7338.779836604697;7753.612319384121;7884.72403465876;8292.212239837207;8323.04285007232;12039;12446.688832779253;12499.93750031244;12670.429830657458;12822.307315463484;10735.94632026835;10912.127029837753;11087.667369978913;11128.332300062022;11136.49885755159;10829.187810914056;10936.945315273373;10943.179261555575;10985.890141098806;11311.886881131084;10897.073748731447;11209.43952802373;11283.435828208721;11317;11402.48688808989;7772.68909243624;7873.212678732081;8076.111627721063;8200.876986845084;11945.283283003047;10023.649172278936;10633.985623003133;10904.781904362027;11310.60412885545;11534.961853433231 16:06:48 INFO - PROCESS | 1652 | |3;mootools.html;1386.085183778705;1556.6419723463603;1557.7819105325252;1762.5505496098492;1886.4057821786137;7865.292123708865;8467.703630372938;8883.60023798929;9085.182333589975;9182.311326650512;7659.693612255517;8902.910970890289;8925.821483570324;8966.641334346634;8972.371933964625;2382.7498112698177;2410.5781488239577;2411.2766170148884;2411.3850968003135;2414.7223069347074;2359.775821296974;2393.772591603795;2404.843685160459;2406.0015093736165;2409.0604664180983;2371.7509661485556;2391.9162829300976;2398.8440751351195;2406.1578447543307;2408.843425177358;2335.3811240021237;2364.609839376501;2372.15788395119;2373.727021392545;2380.9999999999914;2327.2087490253393;2336.3691803213037;2371.537550177716;2372.0986025310444;2377.5363804058215;8911.465312081296;9026.593803278869;9028.638854445815;9036.32227582934;9039.502827344493;5264.6051546134195;5311;5491.752871120809;5492.642978206404;5504.972475137639;3558.626344233844;3613.1870329175986;3717.6282371762877;3720.274546463441;3722.348588996942;1115.827046807746;1116.4864162485267;1123.4719681749564;1146.7821113988316;1147.8450409194736;11833.408329583486;11929.045676345871;12004.939975300067;12019.699507512294;12026.098042646836;4487.842925497592;4519.841805536857;4669.976650116728;4680.67235293533;4695.248760198352;9288.582013809395;9288.767780805534;9301.162895339452;9302.813943721223;9317.301202409846;5324;5343.412224655285;5350.304460420199;5357.357117145967;5357.8392648220615;4344.739315641072;4500.459944806644;4627.9768601156775;4668.439787225555;5005.299258103868;3993.740406873544;4076.7961601919787;4146.709730318909;4152.314868046738;4191.685623578243;1299;1316.5063101336998;1325.3969443903002;1331.9001074919227;1334.1328136711215;871.8169184471332;880.3133555826465;919.9034101419388;924.2005665099774;933.4166146158651;5730.799422020209;5815.273090863642;5888.116782482576;5927.2590926134235;5966.731497082642;429.91186806704553;446.2480719986768;450.6710101625832;453.7322979442145;456.7670488051118;3873;3964.960350396517;3977.6420122189143;3992.3811809169624;4036.2936486114813;10538.89461105379;10978.945105274423;10984.615538456115;10988.945055274673;10990.450477476094;10571.995660412249;10779.946100269606;10988.395638239974;11012.17408694351;11029.44852757359;8263.462874913232;8379.70671026511;8397.748067558105;8460.74617761456;8473.237408633253;4985.177445721415;4995.450500445021;5719.685417302088;5939.584229104094;5998.610090344114;10247.487625618838;10302.793944120926;10312.175025998053;10338.689839304832;10349.430781306799;9327.86008209891;9656.275779316438;9812.460314682476;10237.641682541076;10252.846207307046;7414.592197428978;7571.583562904093;7651;7663.846723065396;7759.650815713194;8311.127331630092;8464.238218560358;8552.486850788973;8683.435576687496;8695;7589;7680.731174409092;7707.036620422447;7733.883991740241;7823.139454659869;6101.267847858107;6642;7550.112471882029;7572.924270757222;7622.58075805836;6912.79261622132;7077.610731409616;7183.461240406886;7184.784456466105;7185.389241914496;5155.9742201288755;5176.661053620319;5236.554892834151;5245.186996015624;5327.041132596015;4428.335749637451;5234.214867769865;5300.681959082467;5325.2810870531985;5330.493603107699 16:06:48 INFO - PROCESS | 1652 | |4;prototype.html;299.44303595312715;306.8726478511418;308.4401810713554;315.5408880079483;316.5663041632963;4764.309175169603;5366.597505187107;5501.532369748566;5509.724513774306;5521.404939678345;4428.734275943446;4630.490646028934;5314.893702125955;5363.973180134104;5409.810656627019;3830;3866.478025466561;3902.804859757015;4052.3516237402023;4108.644147431355;4059.7564146151176;4102.958970410287;4107;4121.814518346681;4173.269677806372;3520.9119772005647;3557.3418917500344;3861.6331448512346;4067.776272305037;4092.3656833190753;3837.597052309495;4032.1734044521095;4061.492313460832;4064.796760161995;4066.593340665939;2914.985425072882;3502.9474557881654;3504.5969713483023;3508.4035713928693;3512.5433693619666;4550.749708766017;4987.326710894019;5220.895582088375;5228.764705588258;5255.973720131413;4006.8981030216924;4292.29177185764;4512.187806194884;4587.220172570671;4622.699524530894;5562.221289019541;5589.357223919261;5618.6628802272;5635.3237611486475;5636.830895073154;3257.664357613367;3805.315043292206;3833.4441505981476;3844.826982785781;3856.82644281008;5671.262735844355;5797.391273916262;5862.736176872008;5905.970470147665;5927.4665280125;3303.339332133583;3459.238967427162;3839.6736277416176;3904.7657140571655;3909.2181563687377;3333.516640087174;3964.8215830287704;3987.601239875989;4007.979960100181;4017.397390391465;4088.325426304686;4277.486701595828;4639.350490931272;4687.484376718558;4699.271612900006;5436.673799572039;5546.417626149197;5681.289838770153;5716.885662286731;5790.971045144747;1052.6999805055675;1217.762536305412;1326.4694122351136;1329.2091205732575;1332.3072002558615;720.6865013719049;770.9421793365408;780.980475488106;783.5925318834175;806.7136166660869;5079.619028572872;5168.250603662448;5250.7374631268285;5287.312649355559;5328;5058.367704036996;5461.918071228934;5783;5813.244278243801;5836.445537673914;4955.876103097451;5158.690478571298;5278.973605132027;5291.470852914677;5313.787448502017;2508.4857604191097;2664.8947331607815;2785.415062836827;3011.804232724866;3015.743661788729;5393.029254734107;5906.734196961147;5964.642121472725;6001.909971350433;6004.609700369462;5118.59051275897;5136.614753893398;5573.442655734394;5870.324912635102;5944.85137871548;5728.364952121987;5866.8533286667325;5872.152006276952;5952.76188952437;5998.670073146019;4630.72215667061;5399.2980912481125;5741.3397459291045;5757.107648314518;5788.623739456922;5053.418856831511;5426.67439953604;5619.522340601095;5718.714064296852;5721.427857214412;5021.4225364083595;5653.219235940665;5956.851078722893;5973.49225315853;5985.371535988658;3572.946405803863;3601.2617413430708;3724.946832506245;3938.3895496198134;3972.741771784825;5618.438156184512;5637.943620563742;5698.515626171822;5706.745835395079;5713.571482138939;4929.852104436873;5102.795888164432;5518.351191428217;5553.0559804832465;5622.522085622604;4694.554017368345;4944.752762361795;5483.8080667176455;5553.888922221614;5559.805406810742;4577.473590537131;4860.3681521401995;4871.562888947698;5385.0037743017665;5533.723313834212;4685.554872287127;5166.819161329336;5210.723372773543;5413.431589683027;5714.571407144564;4523.705959112647;4634.443866735878;5498.257735205696;5536.418676039119;5565 16:06:48 INFO - PROCESS | 1652 | |5;yui.html;684.3874732114757;724.2142275630944;743.2456057102042;743.3904198557184;794.972175973841;14967.326470308835;16269.349226030945;16283.430079947204;16325.428609998653;16356.427525036626;14616;14689.706205875877;14714.337854796533;14753.557393278192;14773.261336933137;624.4473640827878;705.28413660135;708.6208878250137;828.8673812190051;855.7218903856271;853.3812985585463;872.7687162901836;874.6370256343641;876.8334016536837;877.5963056993791;927.5176908007832;928.4104593583056;928.5682157796623;930.2650905784423;930.2650905784423;705.2594775485719;731.9414446844293;884.6417201033528;918.6095909238547;921.6728061538158;690.3683129936153;692.972281108755;693.1578132568953;694.6873906741936;696.7631005458118;15122.470713525085;15161.469348572748;15174.772378414333;15178.620534486616;15206.695866082617;13512.256825874572;13667.589972300846;13739.313034348243;13829.723405531833;13971.161730296215;12089.818652720216;12378.938105309417;12480.875191248062;12509.499620015189;12579.308138052495;4448.755318457484;4584.701994370355;4676.789544470507;4704.553067458586;4741.952580474185;118034;120813;121207.39396302962;122965;123168.38415807953;10357;10759.677209683721;10841.67474975752;10846.620368287073;11088.223824332219;17905.37331193402;21023.05396257172;21219.575608487743;21230.2569410073;21234.256801011892;6279.529035322369;7798.376129909594;8048.195180481905;8062.274395304451;8185.467944583583;4482.551744825491;4487.798049087799;4575.748333841604;4639.86080417588;4706.952930470651;3404.6084700259294;3465.8440370183403;3477.982610086933;3510.4558793387064;3512.8243587820507;661.5402295404648;664.4584663499232;691.5926090406;726.3208899678817;730.5324592260957;617.4473845907977;620.4325130499627;647.3720491123603;687.4823801728119;689.2315068698465;8891.866622000674;9303.627854885728;9807.215422766161;9940.850887236697;9959.954204808535;534.2503301686928;581.2269681323829;615.2678312807744;643.7650257655922;655.6066360183947;4277.593628605277;4546.4544254689645;4625.444946606429;4810.6151507879285;4852;152323;156397;159402;159473;161580;106851;107359;107711;125522.07540283658;139364.9095263572;102329;103008.48495757623;103090.48454757828;108589;111361;9725.367851089657;9889.06053924876;10006.299559030798;10042.748931276776;10072.093511583993;50421;60613;62981.370186299384;64332.35667643264;64394.678026611444;91073;94897.525512372;96044;97214;101216;12295.877041229473;12605.558805441766;13110.410031548794;13211.207327560378;13319.267440290489;14319.14085154894;14395.640108997359;14670.77993830072;15030.398784048515;15822.129782862054;10678.98539218807;12403.379831008593;13605.591832245049;14088.436462541384;14237.35931883047;13548.593542193355;13870.72258554803;14437.639059023608;14606.561803145923;14618.634534136732;13228.801567976296;13430.462781488632;14167.504137355143;14299.857001429853;14307.427702891768;10849.427380277219;11271.943640281746;11471.311721296748;11730.413479326171;11906.704611037256;10760.246782725135;11493.520077300898;11522.942385288019;11697.415129243675;11733.76532469363 16:06:48 INFO - PROCESS | 1652 | __end_tp_report 16:06:48 INFO - PROCESS | 1652 | __start_cc_report 16:06:48 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1384 16:06:48 INFO - PROCESS | 1652 | __end_cc_report 16:06:48 INFO - PROCESS | 1652 | __startTimestamp1475104008105__endTimestamp 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | ------- Summary: start ------- 16:06:48 INFO - PROCESS | 1652 | Number of tests: 6 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5776.91 Median:6048.18 stddev:663.23 (11.0%) stddev-sans-first:637.51 16:06:48 INFO - PROCESS | 1652 | Values: 3356.9 3357.5 3389.6 3395.8 3430.7 4272.0 5613.9 5709.3 5791.8 5811.7 5743.7 5820.2 5833.2 5844.9 5894.2 5235.3 5262.8 5267.2 5296.0 5305.9 5201.8 5203.0 5213.5 5362.3 5399.2 5232.2 5233.7 5266.2 5313.6 5316.8 5287.0 5293.8 5300.4 5313.5 5374.3 5179.1 5295.4 5311.5 5343.9 5353.8 5637.8 5705.1 5719.2 5763.9 5888.2 6153.1 6218.9 6244.2 6245.5 6309.1 5282.8 6326.3 6334.2 6351.9 6355.4 5879.6 5899.7 5908.1 5920.0 5925.3 6213.1 6260.7 6269.3 6298.5 6330.4 6222.3 6237.0 6242.9 6244.7 6272.5 6295.3 6330.5 6332.8 6336.8 6358.6 6073.8 6151.2 6168.6 6175.1 6240.6 6311.8 6332.7 6334.7 6340.7 6359.0 4912.1 4958.5 4966.0 4983.7 4987.8 4411.1 4420.1 4480.6 4483.9 4495.3 4873.9 5755.3 5803.6 5868.6 5906.4 6324.7 6335.4 6344.2 6362.6 6375.3 5605.6 5849.9 5859.5 5863.4 5903.0 4815.8 5369.0 5385.2 5416.2 5425.9 5444.6 6284.4 6305.7 6313.9 6369.7 6337.6 6347.7 6358.1 6360.2 6378.2 6216.9 6273.2 6290.5 6293.4 6312.4 6301.3 6312.4 6319.4 6323.1 6326.8 6158.2 6350.1 6354.1 6372.6 6378.0 6048.2 6084.8 6112.5 6202.7 6212.6 5198.0 6093.1 6116.5 6125.0 6138.9 6068.5 6070.0 6070.1 6098.7 6116.8 6113.5 6204.9 6229.0 6231.3 6233.9 5805.1 5874.4 5886.1 5945.8 6054.9 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:71761.47 Median:218958.00 stddev:156564.97 (71.5%) stddev-sans-first:156912.77 16:06:48 INFO - PROCESS | 1652 | Values: 506.3 508.9 523.1 531.4 548.0 30769.4 42445.8 43621.8 43627.3 46303.8 45004.5 45288.3 45400.5 45427.3 45578.5 8769.7 9827.0 9941.7 10009.0 10013.1 8763.1 11780.9 12048.8 12080.9 12357.4 12286.0 12344.9 12355.0 12379.0 12383.3 12221.5 12321.1 12403.8 12423.6 12447.1 12092.4 12174.1 12195.1 12195.9 12206.3 42099.2 42368.0 42425.7 42446.6 42452.4 3645.1 3647.9 3875.9 4054.4 4056.9 30382.5 30773.5 32171.5 33127.0 33207.0 3141.9 3408.3 3421.8 3445.8 3486.6 304353.0 396801.0 398113.0 406405.0 408920.0 59276.4 59474.7 59568.8 59600.7 59609.4 68283.0 68465.7 68509.7 68737.0 68868.7 17122.7 17378.9 17406.6 17425.7 17433.2 12150.6 12210.3 13384.0 13482.1 13514.8 18326.6 18725.3 18738.3 19230.1 19254.7 6065.1 6323.2 6345.3 6447.5 6454.8 772.0 968.1 984.1 998.7 1066.8 30024.4 30059.9 30412.0 30847.4 30949.0 938.7 945.2 977.8 993.3 1064.4 15022.2 15621.9 15723.3 15858.5 16159.0 671623.0 697073.0 702556.0 703477.0 710053.0 61357.7 61426.0 61474.0 61661.0 62088.4 1370.2 1378.0 1406.8 1407.6 1409.1 29538.7 30042.7 30058.2 30376.3 30948.5 52202.5 52808.0 52909.5 52979.9 53054.7 623478.0 626453.0 626828.0 628463.0 628585.0 41750.2 42180.1 42659.1 42756.8 42824.6 39675.7 41653.8 47815.5 51978.0 52100.7 39803.0 40515.8 40759.4 41038.4 42345.4 40703.0 40878.0 41515.6 41674.2 41999.6 38826.0 39340.2 39660.8 39678.0 39688.2 33995.8 35608.0 36296.0 36311.3 36428.3 22979.8 25944.0 26483.1 27074.5 27100.5 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35234.68 Median:21505.52 stddev:98820.70 (459.5%) stddev-sans-first:99063.20 16:06:48 INFO - PROCESS | 1652 | Values: 350.6 356.7 373.4 382.9 399.9 14697.6 15228.4 20046.5 21201.4 21564.5 20505.6 20963.2 20986.7 21073.5 21410.0 5871.7 6221.2 6222.3 6226.8 6233.5 4252.6 4444.4 4458.4 6080.2 6823.8 6890.8 6890.9 6894.5 6898.1 6903.4 6593.6 6734.9 6809.2 6809.3 6814.4 5190.4 5453.1 5888.7 5891.9 5900.7 12661.8 12945.7 12955.2 12968.8 19539.0 1808.9 1890.7 2185.6 2193.3 2200.3 9335.9 9722.1 9890.9 10101.7 10297.6 1550.7 1807.4 1876.6 1878.8 1903.3 110039.9 117117.4 119008.6 127911.0 132697.0 11420.6 11617.4 11649.8 11694.4 11859.5 12585.9 13384.5 13467.0 14260.8 14307.6 8579.9 8692.4 8719.0 8832.0 8846.4 8745.3 8746.9 8770.7 8915.4 8924.3 4407.0 4434.9 4464.7 4492.1 4581.6 1858.9 1882.3 1890.9 1905.5 1910.8 837.5 880.1 924.6 930.5 1029.4 20606.4 21358.9 21365.3 21446.6 21645.0 765.8 907.2 918.6 928.5 978.7 7317.0 9604.9 10981.7 11149.6 11183.4 524876.0 530438.0 534933.0 652936.0 667265.0 145214.0 148325.0 149744.0 154437.0 157090.0 998.8 1010.2 1023.5 1046.1 1046.6 18152.9 18724.4 19234.3 19263.5 19287.7 44731.6 57634.8 58515.7 58575.4 59718.7 68855.3 86191.1 86812.0 87942.6 90720.0 7338.8 7753.6 7884.7 8292.2 8323.0 12039.0 12446.7 12499.9 12670.4 12822.3 10735.9 10912.1 11087.7 11128.3 11136.5 10829.2 10936.9 10943.2 10985.9 11311.9 10897.1 11209.4 11283.4 11317.0 11402.5 7772.7 7873.2 8076.1 8200.9 11945.3 10023.6 10634.0 10904.8 11310.6 11535.0 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5747.26 Median:4687.96 stddev:3244.24 (69.2%) stddev-sans-first:3236.78 16:06:48 INFO - PROCESS | 1652 | Values: 1386.1 1556.6 1557.8 1762.6 1886.4 7865.3 8467.7 8883.6 9085.2 9182.3 7659.7 8902.9 8925.8 8966.6 8972.4 2382.7 2410.6 2411.3 2411.4 2414.7 2359.8 2393.8 2404.8 2406.0 2409.1 2371.8 2391.9 2398.8 2406.2 2408.8 2335.4 2364.6 2372.2 2373.7 2381.0 2327.2 2336.4 2371.5 2372.1 2377.5 8911.5 9026.6 9028.6 9036.3 9039.5 5264.6 5311.0 5491.8 5492.6 5505.0 3558.6 3613.2 3717.6 3720.3 3722.3 1115.8 1116.5 1123.5 1146.8 1147.8 11833.4 11929.0 12004.9 12019.7 12026.1 4487.8 4519.8 4670.0 4680.7 4695.2 9288.6 9288.8 9301.2 9302.8 9317.3 5324.0 5343.4 5350.3 5357.4 5357.8 4344.7 4500.5 4628.0 4668.4 5005.3 3993.7 4076.8 4146.7 4152.3 4191.7 1299.0 1316.5 1325.4 1331.9 1334.1 871.8 880.3 919.9 924.2 933.4 5730.8 5815.3 5888.1 5927.3 5966.7 429.9 446.2 450.7 453.7 456.8 3873.0 3965.0 3977.6 3992.4 4036.3 10538.9 10978.9 10984.6 10988.9 10990.5 10572.0 10779.9 10988.4 11012.2 11029.4 8263.5 8379.7 8397.7 8460.7 8473.2 4985.2 4995.5 5719.7 5939.6 5998.6 10247.5 10302.8 10312.2 10338.7 10349.4 9327.9 9656.3 9812.5 10237.6 10252.8 7414.6 7571.6 7651.0 7663.8 7759.7 8311.1 8464.2 8552.5 8683.4 8695.0 7589.0 7680.7 7707.0 7733.9 7823.1 6101.3 6642.0 7550.1 7572.9 7622.6 6912.8 7077.6 7183.5 7184.8 7185.4 5156.0 5176.7 5236.6 5245.2 5327.0 4428.3 5234.2 5300.7 5325.3 5330.5 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4513.51 Median:5110.69 stddev:1414.99 (27.7%) stddev-sans-first:1383.15 16:06:48 INFO - PROCESS | 1652 | Values: 299.4 306.9 308.4 315.5 316.6 4764.3 5366.6 5501.5 5509.7 5521.4 4428.7 4630.5 5314.9 5364.0 5409.8 3830.0 3866.5 3902.8 4052.4 4108.6 4059.8 4103.0 4107.0 4121.8 4173.3 3520.9 3557.3 3861.6 4067.8 4092.4 3837.6 4032.2 4061.5 4064.8 4066.6 2915.0 3502.9 3504.6 3508.4 3512.5 4550.7 4987.3 5220.9 5228.8 5256.0 4006.9 4292.3 4512.2 4587.2 4622.7 5562.2 5589.4 5618.7 5635.3 5636.8 3257.7 3805.3 3833.4 3844.8 3856.8 5671.3 5797.4 5862.7 5906.0 5927.5 3303.3 3459.2 3839.7 3904.8 3909.2 3333.5 3964.8 3987.6 4008.0 4017.4 4088.3 4277.5 4639.4 4687.5 4699.3 5436.7 5546.4 5681.3 5716.9 5791.0 1052.7 1217.8 1326.5 1329.2 1332.3 720.7 770.9 781.0 783.6 806.7 5079.6 5168.3 5250.7 5287.3 5328.0 5058.4 5461.9 5783.0 5813.2 5836.4 4955.9 5158.7 5279.0 5291.5 5313.8 2508.5 2664.9 2785.4 3011.8 3015.7 5393.0 5906.7 5964.6 6001.9 6004.6 5118.6 5136.6 5573.4 5870.3 5944.9 5728.4 5866.9 5872.2 5952.8 5998.7 4630.7 5399.3 5741.3 5757.1 5788.6 5053.4 5426.7 5619.5 5718.7 5721.4 5021.4 5653.2 5956.9 5973.5 5985.4 3572.9 3601.3 3724.9 3938.4 3972.7 5618.4 5637.9 5698.5 5706.7 5713.6 4929.9 5102.8 5518.4 5553.1 5622.5 4694.6 4944.8 5483.8 5553.9 5559.8 4577.5 4860.4 4871.6 5385.0 5533.7 4685.6 5166.8 5210.7 5413.4 5714.6 4523.7 4634.4 5498.3 5536.4 5565.0 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25142.76 Median:21121.31 stddev:40272.31 (190.7%) stddev-sans-first:40343.41 16:06:48 INFO - PROCESS | 1652 | Values: 684.4 724.2 743.2 743.4 795.0 14967.3 16269.3 16283.4 16325.4 16356.4 14616.0 14689.7 14714.3 14753.6 14773.3 624.4 705.3 708.6 828.9 855.7 853.4 872.8 874.6 876.8 877.6 927.5 928.4 928.6 930.3 930.3 705.3 731.9 884.6 918.6 921.7 690.4 693.0 693.2 694.7 696.8 15122.5 15161.5 15174.8 15178.6 15206.7 13512.3 13667.6 13739.3 13829.7 13971.2 12089.8 12378.9 12480.9 12509.5 12579.3 4448.8 4584.7 4676.8 4704.6 4742.0 118034.0 120813.0 121207.4 122965.0 123168.4 10357.0 10759.7 10841.7 10846.6 11088.2 17905.4 21023.1 21219.6 21230.3 21234.3 6279.5 7798.4 8048.2 8062.3 8185.5 4482.6 4487.8 4575.7 4639.9 4707.0 3404.6 3465.8 3478.0 3510.5 3512.8 661.5 664.5 691.6 726.3 730.5 617.4 620.4 647.4 687.5 689.2 8891.9 9303.6 9807.2 9940.9 9960.0 534.3 581.2 615.3 643.8 655.6 4277.6 4546.5 4625.4 4810.6 4852.0 152323.0 156397.0 159402.0 159473.0 161580.0 106851.0 107359.0 107711.0 125522.1 139364.9 102329.0 103008.5 103090.5 108589.0 111361.0 9725.4 9889.1 10006.3 10042.7 10072.1 50421.0 60613.0 62981.4 64332.4 64394.7 91073.0 94897.5 96044.0 97214.0 101216.0 12295.9 12605.6 13110.4 13211.2 13319.3 14319.1 14395.6 14670.8 15030.4 15822.1 10679.0 12403.4 13605.6 14088.4 14237.4 13548.6 13870.7 14437.6 14606.6 14618.6 13228.8 13430.5 14167.5 14299.9 14307.4 10849.4 11271.9 11471.3 11730.4 11906.7 10760.2 11493.5 11522.9 11697.4 11733.8 16:06:48 INFO - PROCESS | 1652 | -------- Summary: end -------- 16:06:48 INFO - PROCESS | 1652 | 16:06:48 INFO - TEST-INFO | 1652: exit 0 16:06:48 INFO - TEST-OK | dromaeo_css | took 1117011ms 16:06:48 INFO - TEST-START | kraken 16:06:48 INFO - operating with platform_type : mac_ 16:06:48 INFO - Initialising browser for kraken test... 16:06:48 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmph5QLgv/profile http://localhost:49278/getInfo.html) 16:06:51 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 16:06:51 INFO - PROCESS | 1661 | colorDepth:24 16:06:51 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 16:06:51 INFO - PROCESS | 1661 | __metrics 16:06:51 INFO - PROCESS | 1661 | 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" 16:06:51 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:52 INFO - TEST-INFO | 1661: exit 0 16:06:52 INFO - Browser initialized. 16:06:52 INFO - Running cycle 1/1 for kraken test... 16:06:52 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmph5QLgv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:04 INFO - PROCESS | 1662 | RSS: Main: 219451392 16:07:04 INFO - PROCESS | 1662 | 16:07:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:08 INFO - PROCESS | 1662 | RSS: Main: 271261696 16:07:08 INFO - PROCESS | 1662 | 16:07:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 16:07:11 INFO - PROCESS | 1662 | RSS: Main: 281448448 16:07:11 INFO - PROCESS | 1662 | 16:07:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 16:07:14 INFO - PROCESS | 1662 | RSS: Main: 375398400 16:07:14 INFO - PROCESS | 1662 | 16:07:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 16:07:17 INFO - PROCESS | 1662 | RSS: Main: 280207360 16:07:17 INFO - PROCESS | 1662 | 16:07:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:20 INFO - PROCESS | 1662 | RSS: Main: 280809472 16:07:20 INFO - PROCESS | 1662 | 16:07:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:23 INFO - PROCESS | 1662 | RSS: Main: 319016960 16:07:23 INFO - PROCESS | 1662 | 16:07:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:27 INFO - PROCESS | 1662 | RSS: Main: 319242240 16:07:27 INFO - PROCESS | 1662 | 16:07:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 16:07:30 INFO - PROCESS | 1662 | RSS: Main: 317673472 16:07:30 INFO - PROCESS | 1662 | 16:07:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:32 INFO - PROCESS | 1662 | RSS: Main: 289837056 16:07:32 INFO - PROCESS | 1662 | 16:07:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:35 INFO - PROCESS | 1662 | RSS: Main: 295440384 16:07:35 INFO - PROCESS | 1662 | 16:07:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:38 INFO - PROCESS | 1662 | RSS: Main: 296583168 16:07:38 INFO - PROCESS | 1662 | 16:07:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:41 INFO - PROCESS | 1662 | RSS: Main: 311934976 16:07:41 INFO - PROCESS | 1662 | 16:07:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:44 INFO - PROCESS | 1662 | RSS: Main: 308367360 16:07:44 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 16:07:46 INFO - PROCESS | 1662 | RSS: Main: 351563776 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | __start_tp_report 16:07:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 16:07:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 16:07:46 INFO - PROCESS | 1662 | |i|pagename|runs| 16:07:46 INFO - PROCESS | 1662 | |0;ai-astar;114;115;115;113;115;118;153;165;115;115 16:07:46 INFO - PROCESS | 1662 | |1;audio-beat-detection;144;108;109;145;139;139;110;107;137;110 16:07:46 INFO - PROCESS | 1662 | |2;audio-dft;184;182;184;185;181;182;181;184;183;185 16:07:46 INFO - PROCESS | 1662 | |3;audio-fft;80;59;58;85;64;65;69;81;107;80 16:07:46 INFO - PROCESS | 1662 | |4;audio-oscillator;89;69;92;69;67;69;93;67;68;89 16:07:46 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;88;87;88;81;88;85;89;86;88;86 16:07:46 INFO - PROCESS | 1662 | |6;imaging-darkroom;94;93;95;94;94;94;94;94;94;93 16:07:46 INFO - PROCESS | 1662 | |7;imaging-desaturate;85;85;87;84;84;84;86;86;86;85 16:07:46 INFO - PROCESS | 1662 | |8;json-parse-financial;58;52;50;52;53;56;58;57;56;56 16:07:46 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;71;71;79;73;72;69;75;70;69 16:07:46 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;82;84;94;101;101;80;83;84;81;88 16:07:46 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;137;136;138;137;136;138;141;142;179;135 16:07:46 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;181;162;161;163;162;164;162;162;161;163 16:07:46 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;65;66;67;66;66;66;66;65;66 16:07:46 INFO - PROCESS | 1662 | __end_tp_report 16:07:46 INFO - PROCESS | 1662 | __start_cc_report 16:07:46 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1992 16:07:46 INFO - PROCESS | 1662 | __end_cc_report 16:07:46 INFO - PROCESS | 1662 | __startTimestamp1475104066782__endTimestamp 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | ------- Summary: start ------- 16:07:46 INFO - PROCESS | 1662 | Number of tests: 14 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:123.80 Median:115.00 stddev:18.81 (16.4%) stddev-sans-first:19.61 16:07:46 INFO - PROCESS | 1662 | Values: 114.0 115.0 115.0 113.0 115.0 118.0 153.0 165.0 115.0 115.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:138.00 stddev:17.05 (12.4%) stddev-sans-first:16.61 16:07:46 INFO - PROCESS | 1662 | Values: 144.0 108.0 109.0 145.0 139.0 139.0 110.0 107.0 137.0 110.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:1.52 (0.8%) stddev-sans-first:1.58 16:07:46 INFO - PROCESS | 1662 | Values: 184.0 182.0 184.0 185.0 181.0 182.0 181.0 184.0 183.0 185.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.50 stddev:14.95 (20.1%) stddev-sans-first:15.74 16:07:46 INFO - PROCESS | 1662 | Values: 80.0 59.0 58.0 85.0 64.0 65.0 69.0 81.0 107.0 80.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.00 stddev:11.75 (14.9%) stddev-sans-first:11.66 16:07:46 INFO - PROCESS | 1662 | Values: 89.0 69.0 92.0 69.0 67.0 69.0 93.0 67.0 68.0 89.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:2.32 (2.6%) stddev-sans-first:2.40 16:07:46 INFO - PROCESS | 1662 | Values: 88.0 87.0 88.0 81.0 88.0 85.0 89.0 86.0 88.0 86.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:07:46 INFO - PROCESS | 1662 | Values: 94.0 93.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.03 (1.2%) stddev-sans-first:1.09 16:07:46 INFO - PROCESS | 1662 | Values: 85.0 85.0 87.0 84.0 84.0 84.0 86.0 86.0 86.0 85.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.00 stddev:2.82 (5.0%) stddev-sans-first:2.74 16:07:46 INFO - PROCESS | 1662 | Values: 58.0 52.0 50.0 52.0 53.0 56.0 58.0 57.0 56.0 56.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.97 (5.6%) stddev-sans-first:3.22 16:07:46 INFO - PROCESS | 1662 | Values: 64.0 71.0 71.0 79.0 73.0 72.0 69.0 75.0 70.0 69.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:83.50 stddev:8.02 (9.6%) stddev-sans-first:8.23 16:07:46 INFO - PROCESS | 1662 | Values: 82.0 84.0 94.0 101.0 101.0 80.0 83.0 84.0 81.0 88.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:138.00 stddev:13.22 (9.6%) stddev-sans-first:13.90 16:07:46 INFO - PROCESS | 1662 | Values: 137.0 136.0 138.0 137.0 136.0 138.0 141.0 142.0 179.0 135.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:162.50 stddev:6.01 (3.7%) stddev-sans-first:0.97 16:07:46 INFO - PROCESS | 1662 | Values: 181.0 162.0 161.0 163.0 162.0 164.0 162.0 162.0 161.0 163.0 16:07:46 INFO - PROCESS | 1662 | 16:07:46 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:07:46 INFO - PROCESS | 1662 | Values: 66.0 65.0 66.0 67.0 66.0 66.0 66.0 66.0 65.0 66.0 16:07:46 INFO - PROCESS | 1662 | -------- Summary: end -------- 16:07:46 INFO - PROCESS | 1662 | 16:07:47 INFO - TEST-INFO | 1662: exit 0 16:07:47 INFO - TEST-OK | kraken | took 58874ms 16:07:47 INFO - SUITE-END | took 1175s 16:07:47 INFO - Completed test suite (00:19:36) 16:07:47 INFO - javascript benchmark 16:07:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.8657253709844, 3357.5467311912894, 3389.627141014488, 3395.830208489578, 3430.6740859618344, 4271.9960809209815, 5613.943860561393, 5709.286339207599, 5791.768329266834, 5811.73847176877, 5743.712814359286, 5820.156077368779, 5833.241678581789, 5844.883102337951, 5894.174815525819, 5235.267062611238, 5262.842114736564, 5267.157254839227, 5296.0, 5305.920411193835, 5201.817936372227, 5203.011427828719, 5213.504717051874, 5362.27609272749, 5399.163129714901, 5232.189010703347, 5233.73831308435, 5266.236395722618, 5313.628046036779, 5316.787328506855, 5286.973565132169, 5293.788248470057, 5300.443453437372, 5313.495217954288, 5374.27447294618, 5179.093658609729, 5295.364556253236, 5311.468853114697, 5343.946560534423, 5353.839384818461, 5637.830865074055, 5705.087186050212, 5719.19931209631, 5763.942360576382, 5888.205092312569, 6153.107799369066, 6218.906716399258, 6244.188255526798, 6245.531585131133, 6309.116723658692, 5282.841514754564, 6326.304106548276, 6334.162108403779, 6351.87296254077, 6355.428011478943, 5879.559033072451, 5899.73451194693, 5908.05471124618, 5920.0231961726695, 5925.259342582177, 6213.068039794067, 6260.655663938436, 6269.310375858652, 6298.464630506367, 6330.366963303725, 6222.28443728977, 6237.0, 6242.906356404657, 6244.687765611701, 6272.529560282997, 6295.276043254993, 6330.493560515148, 6332.778352757631, 6336.809895703136, 6358.554901156967, 6073.757049717962, 6151.200343955257, 6168.629882207082, 6175.104609831549, 6240.594361366497, 6311.779087731908, 6332.746690132435, 6334.651594162366, 6340.714667839959, 6358.968205159037, 4912.1158191525865, 4958.52893975079, 4965.9751701241985, 4983.6760610560195, 4987.750612469362, 4411.073674528385, 4420.115976804652, 4480.596746292849, 4483.865484035419, 4495.348174514743, 4873.853784386474, 5755.280589926259, 5803.622764520377, 5868.559858010581, 5906.379830117861, 6324.6521441321165, 6335.429811316912, 6344.206974128234, 6362.586431881913, 6375.330590287953, 5605.579581531401, 5849.912251316234, 5859.53123750099, 5863.355030946593, 5903.026000709835, 4815.807367705253, 5368.979893820162, 5385.165299378603, 5416.187571864252, 5425.945740542623, 5444.6460980037755, 6284.37156284377, 6305.730576053194, 6313.863504569222, 6369.713362898773, 6337.588056776295, 6347.714352854225, 6358.109864619049, 6360.236771587254, 6378.2346118466085, 6216.937830621636, 6273.247210334606, 6290.49676025926, 6293.37066293367, 6312.400321969406, 6301.338359472189, 6312.368763123651, 6319.368063193644, 6323.114763932961, 6326.778562750282, 6158.230221222348, 6350.079238510298, 6354.078658594571, 6372.55392122547, 6378.0, 6048.183495228088, 6084.817455476343, 6112.541559382975, 6202.7208775606105, 6212.596181248205, 5198.0, 6093.086037094471, 6116.480099191618, 6124.991279909952, 6138.878900475427, 6068.514518838394, 6069.969650151721, 6070.089486576872, 6098.725557349841, 6116.785912493041, 6113.51091912637, 6204.931408410598, 6229.0, 6231.314555398993, 6233.906491402723, 5805.10020946754, 5874.353821079763, 5886.05823068307, 5945.762169513171, 6054.91387234725], "value": 5735.170397983145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.3417557175672, 508.9211172268298, 523.1498814426557, 531.3835950297653, 547.9807557942224, 30769.384612307742, 42445.78777106114, 43621.78189109058, 43627.34558981614, 46303.768481157545, 45004.54995450044, 45288.32067518982, 45400.54599454004, 45427.31859022109, 45578.54421455784, 8769.693060742875, 9827.01729827017, 9941.652042178524, 10009.049140331694, 10013.148882345009, 8763.079876612928, 11780.94109529451, 12048.7590248195, 12080.879191208063, 12357.443915023845, 12286.0, 12344.876551234462, 12355.0, 12379.0, 12383.257004579755, 12221.450034748457, 12321.075919306044, 12403.75192496154, 12423.62729118128, 12447.128700990888, 12092.39538023104, 12174.147809653328, 12195.14633975622, 12195.939020304842, 12206.267623942504, 42099.1580168398, 42368.0, 42425.727228183205, 42446.57553424488, 42452.363214551806, 3645.143391303042, 3647.9270414591824, 3875.9031024224337, 4054.39184122384, 4056.918861622751, 30382.54426183609, 30773.538396924065, 32171.51742723861, 33127.0, 33207.0, 3141.8743250269963, 3408.3353746019534, 3421.7775844570024, 3445.758796884219, 3486.6164721880573, 304353.0, 396801.0, 398113.0, 406405.0, 408919.99999999703, 59276.40723592795, 59474.70262648659, 59568.80862382728, 59600.70199649061, 59609.403905961255, 68283.0, 68465.65767171132, 68509.65745171341, 68737.0, 68868.6556567214, 17122.743158852627, 17378.913105434392, 17406.56483587895, 17425.651486970444, 17433.21550530229, 12150.57472988441, 12210.328431936152, 13384.0, 13482.123661961941, 13514.797278040838, 18326.633467330845, 18725.344612938756, 18738.25046998132, 19230.134643940775, 19254.71117933232, 6065.090236464565, 6323.20959880015, 6345.270293916166, 6447.451966582893, 6454.77408290717, 771.9807004824925, 968.1359163530602, 984.1142971325864, 998.7103739915489, 1066.7599790047177, 30024.399512010074, 30059.94790182377, 30412.0, 30847.383052339275, 30949.0, 938.7465384346189, 945.2013048973606, 977.8093271812071, 993.2964965084769, 1064.3986147826454, 15022.173780441963, 15621.921890390475, 15723.292451839467, 15858.52424427269, 16159.0, 671623.0, 697073.0, 702556.0, 703477.0, 710053.0, 61357.69321153365, 61426.0, 61474.0, 61661.0, 62088.379116209166, 1370.2121280263889, 1377.9586612401645, 1406.810080639121, 1407.5847624950663, 1409.0559325252311, 29538.704612953596, 30042.69957300399, 30058.24854378658, 30376.31730979932, 30948.53577196389, 52202.47797522128, 52808.0, 52909.47090529045, 52979.94040119099, 53054.67363315948, 623478.0, 626453.0, 626828.0, 628463.0, 628585.0, 41750.16499669929, 42180.10189541539, 42659.14681706411, 42756.78621606872, 42824.57175428206, 39675.73294949172, 41653.79173104115, 47815.521844781106, 51978.0, 52100.739496303795, 39803.0, 40515.79742101271, 40759.388609170295, 41038.38442423426, 42345.364819528346, 40703.0, 40878.0, 41515.58484415117, 41674.166516670106, 41999.58000419957, 38826.0, 39340.2131957365, 39660.81017569477, 39678.008049798984, 39688.206235875696, 33995.83002084974, 35608.0, 36296.0, 36311.273774523834, 36428.27143457169, 22979.770202297765, 25944.0, 26483.07309244167, 27074.458510830067, 27100.457990840467], "value": 21125.756483183683, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.58980992239077, 356.6540455757917, 373.40069188951713, 382.902359898226, 399.86804354563, 14697.632559186026, 15228.390864365427, 20046.532349883666, 21201.363959081213, 21564.460888477795, 20505.589888202227, 20963.16147354104, 20986.68519972198, 21073.47316317093, 21410.03654835532, 5871.677057761822, 6221.191245138126, 6222.346653601352, 6226.782062627809, 6233.470155036827, 4252.574742525753, 4444.422225110731, 4458.375827384169, 6080.2399700037495, 6823.795286141423, 6890.827729306758, 6890.896636550456, 6894.482913781461, 6898.0687607172895, 6903.413209877166, 6593.604383736967, 6734.865302693943, 6809.216940051908, 6809.285025072346, 6814.352636499525, 5190.377154741455, 5453.127499600045, 5888.735006924699, 5891.911621325684, 5900.704964751745, 12661.810072848915, 12945.676358091028, 12955.222686638832, 12968.80546791799, 19539.0, 1808.8914665120135, 1890.7069404242227, 2185.595664802017, 2193.2981445937307, 2200.3179014505395, 9335.859962100574, 9722.125008749246, 9890.901090989142, 10101.69694909154, 10297.639582614647, 1550.6588550518868, 1807.3764551229804, 1876.6152938647544, 1878.8121187881238, 1903.2577294855018, 110039.89960100377, 117117.41441292824, 119008.61982760296, 127911.0, 132697.0, 11420.600278990196, 11617.361045142598, 11649.825252621218, 11694.356810375511, 11859.46632401544, 12585.874141258653, 13384.464621415034, 13467.0, 14260.786088208684, 14307.57077287683, 8579.871301930476, 8692.434991725517, 8718.956405217934, 8832.0, 8846.380753347332, 8745.300375969908, 8746.912530874737, 8770.693025744069, 8915.37592368541, 8924.286057115416, 4407.0084231048395, 4434.889127771831, 4464.687471877002, 4492.124035813051, 4581.610563102174, 1858.851291896645, 1882.3223639489772, 1890.9432717018512, 1905.4569447707338, 1910.770707515107, 837.4556538250064, 880.1022956584249, 924.6024209589941, 930.4556834251903, 1029.361795686679, 20606.381808545768, 21358.893205534183, 21365.25221617236, 21446.57106857854, 21645.0, 765.8008917681332, 907.2061945797427, 918.6095909238547, 928.4893308680199, 978.7210644966151, 7316.963415182997, 9604.94345621981, 10981.670549883516, 11149.609763658233, 11183.384913829655, 524876.0, 530438.0, 534933.0, 652936.0, 667265.0, 145214.0, 148325.0, 149744.0, 154437.0, 157090.0, 998.7553049502773, 1010.2069875147973, 1023.5445226874118, 1046.0794500839213, 1046.576136664652, 18152.90923545374, 18724.438266852016, 19234.326798561982, 19263.51841203981, 19287.710684339465, 44731.552684472736, 57634.84730305454, 58515.70742146432, 58575.414245857, 59718.70140649443, 68855.31144688689, 86191.13808861832, 86812.0, 87942.56028719815, 90720.0, 7338.779836604697, 7753.612319384121, 7884.72403465876, 8292.212239837207, 8323.04285007232, 12039.0, 12446.688832779253, 12499.93750031244, 12670.429830657458, 12822.307315463484, 10735.94632026835, 10912.127029837753, 11087.667369978913, 11128.332300062022, 11136.49885755159, 10829.187810914056, 10936.945315273373, 10943.179261555575, 10985.890141098806, 11311.886881131084, 10897.073748731447, 11209.43952802373, 11283.435828208721, 11317.0, 11402.48688808989, 7772.68909243624, 7873.212678732081, 8076.111627721063, 8200.876986845084, 11945.283283003047, 10023.649172278936, 10633.985623003133, 10904.781904362027, 11310.60412885545, 11534.961853433231], "value": 9480.330039468945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.085183778705, 1556.6419723463603, 1557.7819105325252, 1762.5505496098492, 1886.4057821786137, 7865.292123708865, 8467.703630372938, 8883.60023798929, 9085.182333589975, 9182.311326650512, 7659.693612255517, 8902.910970890289, 8925.821483570324, 8966.641334346634, 8972.371933964625, 2382.7498112698177, 2410.5781488239577, 2411.2766170148884, 2411.3850968003135, 2414.7223069347074, 2359.775821296974, 2393.772591603795, 2404.843685160459, 2406.0015093736165, 2409.0604664180983, 2371.7509661485556, 2391.9162829300976, 2398.8440751351195, 2406.1578447543307, 2408.843425177358, 2335.3811240021237, 2364.609839376501, 2372.15788395119, 2373.727021392545, 2380.9999999999914, 2327.2087490253393, 2336.3691803213037, 2371.537550177716, 2372.0986025310444, 2377.5363804058215, 8911.465312081296, 9026.593803278869, 9028.638854445815, 9036.32227582934, 9039.502827344493, 5264.6051546134195, 5311.0, 5491.752871120809, 5492.642978206404, 5504.972475137639, 3558.626344233844, 3613.1870329175986, 3717.6282371762877, 3720.274546463441, 3722.348588996942, 1115.827046807746, 1116.4864162485267, 1123.4719681749564, 1146.7821113988316, 1147.8450409194736, 11833.408329583486, 11929.045676345871, 12004.939975300067, 12019.699507512294, 12026.098042646836, 4487.842925497592, 4519.841805536857, 4669.976650116728, 4680.67235293533, 4695.248760198352, 9288.582013809395, 9288.767780805534, 9301.162895339452, 9302.813943721223, 9317.301202409846, 5324.0, 5343.412224655285, 5350.304460420199, 5357.357117145967, 5357.8392648220615, 4344.739315641072, 4500.459944806644, 4627.9768601156775, 4668.439787225555, 5005.299258103868, 3993.740406873544, 4076.7961601919787, 4146.709730318909, 4152.314868046738, 4191.685623578243, 1299.0, 1316.5063101336998, 1325.3969443903002, 1331.9001074919227, 1334.1328136711215, 871.8169184471332, 880.3133555826465, 919.9034101419388, 924.2005665099774, 933.4166146158651, 5730.799422020209, 5815.273090863642, 5888.116782482576, 5927.2590926134235, 5966.731497082642, 429.91186806704553, 446.2480719986768, 450.6710101625832, 453.7322979442145, 456.7670488051118, 3873.0, 3964.960350396517, 3977.6420122189143, 3992.3811809169624, 4036.2936486114813, 10538.89461105379, 10978.945105274423, 10984.615538456115, 10988.945055274673, 10990.450477476094, 10571.995660412249, 10779.946100269606, 10988.395638239974, 11012.17408694351, 11029.44852757359, 8263.462874913232, 8379.70671026511, 8397.748067558105, 8460.74617761456, 8473.237408633253, 4985.177445721415, 4995.450500445021, 5719.685417302088, 5939.584229104094, 5998.610090344114, 10247.487625618838, 10302.793944120926, 10312.175025998053, 10338.689839304832, 10349.430781306799, 9327.86008209891, 9656.275779316438, 9812.460314682476, 10237.641682541076, 10252.846207307046, 7414.592197428978, 7571.583562904093, 7651.0, 7663.846723065396, 7759.650815713194, 8311.127331630092, 8464.238218560358, 8552.486850788973, 8683.435576687496, 8695.0, 7589.0, 7680.731174409092, 7707.036620422447, 7733.883991740241, 7823.139454659869, 6101.267847858107, 6642.0, 7550.112471882029, 7572.924270757222, 7622.58075805836, 6912.79261622132, 7077.610731409616, 7183.461240406886, 7184.784456466105, 7185.389241914496, 5155.9742201288755, 5176.661053620319, 5236.554892834151, 5245.186996015624, 5327.041132596015, 4428.335749637451, 5234.214867769865, 5300.681959082467, 5325.2810870531985, 5330.493603107699], "value": 4546.200674949537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.44303595312715, 306.8726478511418, 308.4401810713554, 315.5408880079483, 316.5663041632963, 4764.309175169603, 5366.597505187107, 5501.532369748566, 5509.724513774306, 5521.404939678345, 4428.734275943446, 4630.490646028934, 5314.893702125955, 5363.973180134104, 5409.810656627019, 3830.0, 3866.478025466561, 3902.804859757015, 4052.3516237402023, 4108.644147431355, 4059.7564146151176, 4102.958970410287, 4107.0, 4121.814518346681, 4173.269677806372, 3520.9119772005647, 3557.3418917500344, 3861.6331448512346, 4067.776272305037, 4092.3656833190753, 3837.597052309495, 4032.1734044521095, 4061.492313460832, 4064.796760161995, 4066.593340665939, 2914.985425072882, 3502.9474557881654, 3504.5969713483023, 3508.4035713928693, 3512.5433693619666, 4550.749708766017, 4987.326710894019, 5220.895582088375, 5228.764705588258, 5255.973720131413, 4006.8981030216924, 4292.29177185764, 4512.187806194884, 4587.220172570671, 4622.699524530894, 5562.221289019541, 5589.357223919261, 5618.6628802272, 5635.3237611486475, 5636.830895073154, 3257.664357613367, 3805.315043292206, 3833.4441505981476, 3844.826982785781, 3856.82644281008, 5671.262735844355, 5797.391273916262, 5862.736176872008, 5905.970470147665, 5927.4665280125, 3303.339332133583, 3459.238967427162, 3839.6736277416176, 3904.7657140571655, 3909.2181563687377, 3333.516640087174, 3964.8215830287704, 3987.601239875989, 4007.979960100181, 4017.397390391465, 4088.325426304686, 4277.486701595828, 4639.350490931272, 4687.484376718558, 4699.271612900006, 5436.673799572039, 5546.417626149197, 5681.289838770153, 5716.885662286731, 5790.971045144747, 1052.6999805055675, 1217.762536305412, 1326.4694122351136, 1329.2091205732575, 1332.3072002558615, 720.6865013719049, 770.9421793365408, 780.980475488106, 783.5925318834175, 806.7136166660869, 5079.619028572872, 5168.250603662448, 5250.7374631268285, 5287.312649355559, 5328.0, 5058.367704036996, 5461.918071228934, 5783.0, 5813.244278243801, 5836.445537673914, 4955.876103097451, 5158.690478571298, 5278.973605132027, 5291.470852914677, 5313.787448502017, 2508.4857604191097, 2664.8947331607815, 2785.415062836827, 3011.804232724866, 3015.743661788729, 5393.029254734107, 5906.734196961147, 5964.642121472725, 6001.909971350433, 6004.609700369462, 5118.59051275897, 5136.614753893398, 5573.442655734394, 5870.324912635102, 5944.85137871548, 5728.364952121987, 5866.8533286667325, 5872.152006276952, 5952.76188952437, 5998.670073146019, 4630.72215667061, 5399.2980912481125, 5741.3397459291045, 5757.107648314518, 5788.623739456922, 5053.418856831511, 5426.67439953604, 5619.522340601095, 5718.714064296852, 5721.427857214412, 5021.4225364083595, 5653.219235940665, 5956.851078722893, 5973.49225315853, 5985.371535988658, 3572.946405803863, 3601.2617413430708, 3724.946832506245, 3938.3895496198134, 3972.741771784825, 5618.438156184512, 5637.943620563742, 5698.515626171822, 5706.745835395079, 5713.571482138939, 4929.852104436873, 5102.795888164432, 5518.351191428217, 5553.0559804832465, 5622.522085622604, 4694.554017368345, 4944.752762361795, 5483.8080667176455, 5553.888922221614, 5559.805406810742, 4577.473590537131, 4860.3681521401995, 4871.562888947698, 5385.0037743017665, 5533.723313834212, 4685.554872287127, 5166.819161329336, 5210.723372773543, 5413.431589683027, 5714.571407144564, 4523.705959112647, 4634.443866735878, 5498.257735205696, 5536.418676039119, 5565.0], "value": 4051.616662798945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.3874732114757, 724.2142275630944, 743.2456057102042, 743.3904198557184, 794.972175973841, 14967.326470308835, 16269.349226030945, 16283.430079947204, 16325.428609998653, 16356.427525036626, 14616.0, 14689.706205875877, 14714.337854796533, 14753.557393278192, 14773.261336933137, 624.4473640827878, 705.28413660135, 708.6208878250137, 828.8673812190051, 855.7218903856271, 853.3812985585463, 872.7687162901836, 874.6370256343641, 876.8334016536837, 877.5963056993791, 927.5176908007832, 928.4104593583056, 928.5682157796623, 930.2650905784423, 930.2650905784423, 705.2594775485719, 731.9414446844293, 884.6417201033528, 918.6095909238547, 921.6728061538158, 690.3683129936153, 692.972281108755, 693.1578132568953, 694.6873906741936, 696.7631005458118, 15122.470713525085, 15161.469348572748, 15174.772378414333, 15178.620534486616, 15206.695866082617, 13512.256825874572, 13667.589972300846, 13739.313034348243, 13829.723405531833, 13971.161730296215, 12089.818652720216, 12378.938105309417, 12480.875191248062, 12509.499620015189, 12579.308138052495, 4448.755318457484, 4584.701994370355, 4676.789544470507, 4704.553067458586, 4741.952580474185, 118034.0, 120813.0, 121207.39396302962, 122965.0, 123168.38415807953, 10357.0, 10759.677209683721, 10841.67474975752, 10846.620368287073, 11088.223824332219, 17905.37331193402, 21023.05396257172, 21219.575608487743, 21230.2569410073, 21234.256801011892, 6279.529035322369, 7798.376129909594, 8048.195180481905, 8062.274395304451, 8185.467944583583, 4482.551744825491, 4487.798049087799, 4575.748333841604, 4639.86080417588, 4706.952930470651, 3404.6084700259294, 3465.8440370183403, 3477.982610086933, 3510.4558793387064, 3512.8243587820507, 661.5402295404648, 664.4584663499232, 691.5926090406, 726.3208899678817, 730.5324592260957, 617.4473845907977, 620.4325130499627, 647.3720491123603, 687.4823801728119, 689.2315068698465, 8891.866622000674, 9303.627854885728, 9807.215422766161, 9940.850887236697, 9959.954204808535, 534.2503301686928, 581.2269681323829, 615.2678312807744, 643.7650257655922, 655.6066360183947, 4277.593628605277, 4546.4544254689645, 4625.444946606429, 4810.6151507879285, 4852.0, 152323.0, 156397.0, 159402.0, 159473.0, 161580.0, 106851.0, 107359.0, 107711.0, 125522.07540283658, 139364.9095263572, 102329.0, 103008.48495757623, 103090.48454757828, 108589.0, 111361.0, 9725.367851089657, 9889.06053924876, 10006.299559030798, 10042.748931276776, 10072.093511583993, 50421.0, 60613.0, 62981.370186299384, 64332.35667643264, 64394.678026611444, 91073.0, 94897.525512372, 96044.0, 97214.0, 101216.0, 12295.877041229473, 12605.558805441766, 13110.410031548794, 13211.207327560378, 13319.267440290489, 14319.14085154894, 14395.640108997359, 14670.77993830072, 15030.398784048515, 15822.129782862054, 10678.98539218807, 12403.379831008593, 13605.591832245049, 14088.436462541384, 14237.35931883047, 13548.593542193355, 13870.72258554803, 14437.639059023608, 14606.561803145923, 14618.634534136732, 13228.801567976296, 13430.462781488632, 14167.504137355143, 14299.857001429853, 14307.427702891768, 10849.427380277219, 11271.943640281746, 11471.311721296748, 11730.413479326171, 11906.704611037256, 10760.246782725135, 11493.520077300898, 11522.942385288019, 11697.415129243675, 11733.76532469363], "value": 7907.125584668156, "unit": "score"}], "name": "dromaeo_css", "value": 7423.1411995130165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 113.0, 115.0, 118.0, 153.0, 165.0, 115.0, 115.0], "value": 123.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 109.0, 145.0, 139.0, 139.0, 110.0, 107.0, 137.0, 110.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 185.0, 181.0, 182.0, 181.0, 184.0, 183.0, 185.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 85.0, 64.0, 65.0, 69.0, 81.0, 107.0, 80.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 92.0, 69.0, 67.0, 69.0, 93.0, 67.0, 68.0, 89.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 81.0, 88.0, 85.0, 89.0, 86.0, 88.0, 86.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 84.0, 84.0, 84.0, 86.0, 86.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 50.0, 52.0, 53.0, 56.0, 58.0, 57.0, 56.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 71.0, 79.0, 73.0, 72.0, 69.0, 75.0, 70.0, 69.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 94.0, 101.0, 101.0, 80.0, 83.0, 84.0, 81.0, 88.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 138.0, 137.0, 136.0, 138.0, 141.0, 142.0, 179.0, 135.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 162.0, 161.0, 163.0, 162.0, 164.0, 162.0, 162.0, 161.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1435.2, "alertThreshold": 2.0}]} 16:07:48 INFO - Return code: 0 16:07:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:07:48 INFO - # TBPL SUCCESS # 16:07:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:07:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:07:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:07:48 INFO - 2016-09-28 16:07:48.087 screenresolution[1666:10109] starting screenresolution argv=screenresolution get 16:07:48 INFO - 2016-09-28 16:07:48.090 screenresolution[1666:10109] Display 0: 1600x1200x32@60 16:07:48 INFO - 2016-09-28 16:07:48.096 screenresolution[1667:10112] starting screenresolution argv=screenresolution list 16:07:48 INFO - Available Modes on Display 0 16:07:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:07:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:07:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:07:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:07:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:07:48 INFO - Intel Iris: 16:07:48 INFO - Chipset Model: Intel Iris 16:07:48 INFO - Type: GPU 16:07:48 INFO - Bus: Built-In 16:07:48 INFO - VRAM (Dynamic, Max): 1536 MB 16:07:48 INFO - Vendor: Intel (0x8086) 16:07:48 INFO - Device ID: 0x0a2e 16:07:48 INFO - Revision ID: 0x0009 16:07:48 INFO - Displays: 16:07:48 INFO - Display: 16:07:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:07:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:07:48 INFO - Display Serial Number: 1600x1200 60 16:07:48 INFO - Main Display: Yes 16:07:48 INFO - Mirror: Off 16:07:48 INFO - Online: Yes 16:07:48 INFO - Rotation: Supported 16:07:48 INFO - Return code: 0 16:07:48 INFO - Running post-action listener: _resource_record_post_action 16:07:48 INFO - [mozharness: 2016-09-28 23:07:48.331584Z] Finished run-tests step (success) 16:07:48 INFO - Running post-run listener: _resource_record_post_run 16:07:48 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38495232; Write bytes: 662563328; Read time: 380; Write time: 2034 16:07:48 INFO - TinderboxPrint: CPU usage
53.6% 16:07:48 INFO - TinderboxPrint: I/O read bytes / time
38,495,232 / 380 16:07:48 INFO - TinderboxPrint: I/O write bytes / time
662,563,328 / 2,034 16:07:48 INFO - TinderboxPrint: CPU idle
2,244.8 (46.4%) 16:07:48 INFO - TinderboxPrint: CPU system
974.4 (20.1%) 16:07:48 INFO - TinderboxPrint: CPU user
1,618.4 (33.5%) 16:07:48 INFO - TinderboxPrint: Swap in / out
401,428,480 / 0 16:07:48 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354396672; Write bytes: 354793472; Read time: 27802; Write time: 880 16:07:48 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37520384; Write bytes: 297587200; Read time: 365; Write time: 1120 16:07:48 INFO - Running post-run listener: _upload_blobber_files 16:07:48 INFO - Blob upload gear active. 16:07:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:07:48 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 16:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:07:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:50 INFO - (blobuploader) - INFO - Done attempting. 16:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:50 INFO - (blobuploader) - INFO - Done attempting. 16:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:07:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:07:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:53 INFO - (blobuploader) - INFO - Done attempting. 16:07:53 INFO - (blobuploader) - INFO - Iteration through files over. 16:07:53 INFO - Return code: 0 16:07:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:07:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:07:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e774edc6ce02167122e25f6384315dabd6a10da22f45961105bb7995f0ee5c71d74af8ec51256cbb12da343306e0484406d3d5553bf93e74f360c71a67e4ff56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a1f2c76b7a930ee3ef83e15fd4f80cfd3d7a555e6d672a799014b87887d2529156de73f5cb281a8b7ab1910c362c3ec60aa144bc41fc3c360bcaa71bf09e23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba01c3199cc368d56d49e6e51c527c682dbfb8025c3dc9045a64c3f6e446fe573a222edb95816618ec864c285dd8f15c11d3ce2944916409562cb8c9cb0429d8"} 16:07:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:07:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:07:53 INFO - Contents: 16:07:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e774edc6ce02167122e25f6384315dabd6a10da22f45961105bb7995f0ee5c71d74af8ec51256cbb12da343306e0484406d3d5553bf93e74f360c71a67e4ff56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a1f2c76b7a930ee3ef83e15fd4f80cfd3d7a555e6d672a799014b87887d2529156de73f5cb281a8b7ab1910c362c3ec60aa144bc41fc3c360bcaa71bf09e23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba01c3199cc368d56d49e6e51c527c682dbfb8025c3dc9045a64c3f6e446fe573a222edb95816618ec864c285dd8f15c11d3ce2944916409562cb8c9cb0429d8"} 16:07:53 INFO - Running post-run listener: copy_logs_to_upload_dir 16:07:53 INFO - Copying logs to upload dir... 16:07:53 INFO - mkdir: /builds/slave/test/build/upload/logs 16:07:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.338834 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-28 16:07:53.350486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 16:07:53.354221) ========= 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.scIXnPNzJy/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.tivcxlghN3/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e774edc6ce02167122e25f6384315dabd6a10da22f45961105bb7995f0ee5c71d74af8ec51256cbb12da343306e0484406d3d5553bf93e74f360c71a67e4ff56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a1f2c76b7a930ee3ef83e15fd4f80cfd3d7a555e6d672a799014b87887d2529156de73f5cb281a8b7ab1910c362c3ec60aa144bc41fc3c360bcaa71bf09e23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba01c3199cc368d56d49e6e51c527c682dbfb8025c3dc9045a64c3f6e446fe573a222edb95816618ec864c285dd8f15c11d3ce2944916409562cb8c9cb0429d8"} build_url:https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011045 build_url: 'https://queue.taskcluster.net/v1/task/KE-aiV9qShaF058CW2j7Yw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e774edc6ce02167122e25f6384315dabd6a10da22f45961105bb7995f0ee5c71d74af8ec51256cbb12da343306e0484406d3d5553bf93e74f360c71a67e4ff56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a1f2c76b7a930ee3ef83e15fd4f80cfd3d7a555e6d672a799014b87887d2529156de73f5cb281a8b7ab1910c362c3ec60aa144bc41fc3c360bcaa71bf09e23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba01c3199cc368d56d49e6e51c527c682dbfb8025c3dc9045a64c3f6e446fe573a222edb95816618ec864c285dd8f15c11d3ce2944916409562cb8c9cb0429d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 16:07:53.387505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:07:53.387953) ========= 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.scIXnPNzJy/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.tivcxlghN3/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005274 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:07:53.436721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 16:07:53.437087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 16:07:53.437400) ========= ========= Total master_lag: 0.17 =========