builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0262 starttime: 1477345600.35 results: success (0) buildid: 20161024125522 builduid: 6f1a302d80cd449db6afcd800229d629 revision: d33b1329a44d70645ee3bfc7b87063de4da8c54a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.354234) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.354664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.354981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.377392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.377765) ========= 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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-24 14:46:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 31.5M=0s 2016-10-24 14:46:40 (31.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.496692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.497002) ========= 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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.019378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:40.545414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 14:46:40.548773) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d33b1329a44d70645ee3bfc7b87063de4da8c54a --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 d33b1329a44d70645ee3bfc7b87063de4da8c54a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bf1lO3G1ae/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.buF6mBcGcY/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-24 14:46:40,626 truncating revision to first 12 chars 2016-10-24 14:46:40,626 Setting DEBUG logging. 2016-10-24 14:46:40,626 attempt 1/10 2016-10-24 14:46:40,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d33b1329a44d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 14:46:41,862 unpacking tar archive at: mozilla-aurora-d33b1329a44d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.507658 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 14:46:42.079367) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:42.079705) ========= script_repo_revision: d33b1329a44d70645ee3bfc7b87063de4da8c54a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:42.080083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:42.080345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 14:46:42.103527) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-24 14:46:42.103897) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bf1lO3G1ae/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.buF6mBcGcY/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:46:42 INFO - MultiFileLogger online at 20161024 14:46:42 in /builds/slave/test 14:46:42 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 14:46:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:46:42 INFO - {'append_to_log': False, 14:46:42 INFO - 'base_work_dir': '/builds/slave/test', 14:46:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:46:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:46:42 INFO - 'branch': 'Mozilla-Aurora', 14:46:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:46:42 INFO - 'config_files': ('talos/mac_config.py',), 14:46:42 INFO - 'default_actions': ('clobber', 14:46:42 INFO - 'read-buildbot-config', 14:46:42 INFO - 'download-and-extract', 14:46:42 INFO - 'populate-webroot', 14:46:42 INFO - 'create-virtualenv', 14:46:42 INFO - 'install', 14:46:42 INFO - 'run-tests'), 14:46:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:46:42 INFO - 'download_minidump_stackwalk': True, 14:46:42 INFO - 'download_symbols': 'ondemand', 14:46:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:46:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:46:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:46:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:46:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:46:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:46:42 INFO - 'installer_path': 'installer.exe', 14:46:42 INFO - 'log_level': 'info', 14:46:42 INFO - 'log_name': 'talos', 14:46:42 INFO - 'log_to_console': True, 14:46:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:46:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:46:42 INFO - 'opt_config_files': (), 14:46:42 INFO - 'pip_index': False, 14:46:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:46:42 INFO - 'cmd': ('bash', 14:46:42 INFO - '-c', 14:46:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:46:42 INFO - 'enabled': True, 14:46:42 INFO - 'halt_on_failure': False, 14:46:42 INFO - 'name': 'check_screen_resolution'},), 14:46:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:46:42 INFO - 'cmd': ('bash', 14:46:42 INFO - '-c', 14:46:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:46:42 INFO - 'enabled': True, 14:46:42 INFO - 'halt_on_failure': False, 14:46:42 INFO - 'name': 'check_screen_resolution'},), 14:46:42 INFO - 'run_cmd_checks_enabled': True, 14:46:42 INFO - 'sps_profile': False, 14:46:42 INFO - 'sps_profile_interval': 0, 14:46:42 INFO - 'suite': 'dromaeojs', 14:46:42 INFO - 'system_bits': '32', 14:46:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:46:42 INFO - 'title': 't-yosemite-r7-0262', 14:46:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:46:42 INFO - 'use_talos_json': True, 14:46:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:46:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:46:42 INFO - 'work_dir': 'build'} 14:46:42 INFO - [mozharness: 2016-10-24 21:46:42.309691Z] Running clobber step. 14:46:42 INFO - Running pre-action listener: _resource_record_pre_action 14:46:42 INFO - Running main action method: clobber 14:46:42 INFO - rmtree: /builds/slave/test/build 14:46:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:46:42 INFO - Running post-action listener: _resource_record_post_action 14:46:42 INFO - [mozharness: 2016-10-24 21:46:42.900152Z] Finished clobber step (success) 14:46:42 INFO - [mozharness: 2016-10-24 21:46:42.900431Z] Running read-buildbot-config step. 14:46:42 INFO - Running pre-action listener: _resource_record_pre_action 14:46:42 INFO - Running main action method: read_buildbot_config 14:46:42 INFO - Using buildbot properties: 14:46:42 INFO - { 14:46:42 INFO - "project": "", 14:46:42 INFO - "product": "firefox", 14:46:42 INFO - "script_repo_revision": "production", 14:46:42 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:46:42 INFO - "repository": "", 14:46:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:46:42 INFO - "buildid": "20161024125522", 14:46:42 INFO - "pgo_build": "False", 14:46:42 INFO - "basedir": "/builds/slave/test", 14:46:42 INFO - "buildnumber": 107, 14:46:42 INFO - "slavename": "t-yosemite-r7-0262", 14:46:42 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:46:42 INFO - "platform": "yosemite_r7", 14:46:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:46:42 INFO - "branch": "mozilla-aurora", 14:46:42 INFO - "repo_path": "releases/mozilla-aurora", 14:46:42 INFO - "revision": "d33b1329a44d70645ee3bfc7b87063de4da8c54a", 14:46:42 INFO - "stage_platform": "macosx64", 14:46:42 INFO - "builduid": "6f1a302d80cd449db6afcd800229d629", 14:46:42 INFO - "slavebuilddir": "test" 14:46:42 INFO - } 14:46:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:46:42 INFO - Running post-action listener: _resource_record_post_action 14:46:42 INFO - [mozharness: 2016-10-24 21:46:42.906580Z] Finished read-buildbot-config step (success) 14:46:42 INFO - [mozharness: 2016-10-24 21:46:42.906772Z] Running download-and-extract step. 14:46:42 INFO - Running pre-action listener: _resource_record_pre_action 14:46:42 INFO - Running main action method: download_and_extract 14:46:42 INFO - mkdir: /builds/slave/test/build/tests 14:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:42 INFO - trying https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:46:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/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 14:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/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 14:46:44 INFO - Downloaded 1199 bytes. 14:46:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:46:44 INFO - Using the following test package requirements: 14:46:44 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:46:44 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:46:44 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:46:44 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'jsshell-mac.zip'], 14:46:44 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:46:44 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:46:44 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:46:44 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:46:44 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:46:44 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:46:44 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:46:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:46:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:46:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:46:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:46:44 INFO - Expected file size: 16438239 14:46:51 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 14:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:46:52 INFO - Expected file size: 16438239 14:46:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 14:46:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:46:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 14:47:00 INFO - Expected file size: 14414081 14:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:00 INFO - trying https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:47:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 14:47:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/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 14:47:03 INFO - Downloaded 115435406 bytes. 14:47:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:47:03 INFO - mkdir: /builds/slave/test/properties 14:47:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:47:03 INFO - Writing to file /builds/slave/test/properties/build_url 14:47:03 INFO - Contents: 14:47:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:47:04 INFO - Running post-action listener: _resource_record_post_action 14:47:04 INFO - Running post-action listener: set_extra_try_arguments 14:47:04 INFO - [mozharness: 2016-10-24 21:47:04.479185Z] Finished download-and-extract step (success) 14:47:04 INFO - [mozharness: 2016-10-24 21:47:04.479303Z] Running populate-webroot step. 14:47:04 INFO - Running pre-action listener: _resource_record_pre_action 14:47:04 INFO - Running main action method: populate_webroot 14:47:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:47:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:47:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:47:04 INFO - '--tppagecycles', 14:47:04 INFO - '7'], 14:47:04 INFO - 'tests': ['tsvgm']}}, 14:47:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:47:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:47:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:47:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:47:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['damp', 'tps']}, 14:47:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'tests': ['damp', 'tps']}, 14:47:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['dromaeo_dom']}, 14:47:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:47:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['basic_compositor_video']}, 14:47:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:47:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['a11yr', 14:47:04 INFO - 'ts_paint', 14:47:04 INFO - 'tpaint', 14:47:04 INFO - 'sessionrestore', 14:47:04 INFO - 'sessionrestore_no_auto_restore', 14:47:04 INFO - 'tabpaint']}, 14:47:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:47:04 INFO - 'ts_paint', 14:47:04 INFO - 'tpaint', 14:47:04 INFO - 'sessionrestore', 14:47:04 INFO - 'sessionrestore_no_auto_restore', 14:47:04 INFO - 'tabpaint']}, 14:47:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:47:04 INFO - 'ts_paint', 14:47:04 INFO - 'tpaint', 14:47:04 INFO - 'sessionrestore', 14:47:04 INFO - 'sessionrestore_no_auto_restore', 14:47:04 INFO - 'tabpaint']}, 14:47:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:47:04 INFO - 'ts_paint', 14:47:04 INFO - 'tpaint', 14:47:04 INFO - 'sessionrestore', 14:47:04 INFO - 'sessionrestore_no_auto_restore', 14:47:04 INFO - 'tabpaint']}, 14:47:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['a11yr', 14:47:04 INFO - 'ts_paint', 14:47:04 INFO - 'tpaint', 14:47:04 INFO - 'sessionrestore', 14:47:04 INFO - 'sessionrestore_no_auto_restore', 14:47:04 INFO - 'tabpaint']}, 14:47:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['a11yr', 14:47:04 INFO - 'ts_paint', 14:47:04 INFO - 'tpaint', 14:47:04 INFO - 'sessionrestore', 14:47:04 INFO - 'sessionrestore_no_auto_restore', 14:47:04 INFO - 'tabpaint']}, 14:47:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['tsvgx', 14:47:04 INFO - 'tsvgr_opacity', 14:47:04 INFO - 'tart', 14:47:04 INFO - 'tscrollx', 14:47:04 INFO - 'cart']}, 14:47:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:47:04 INFO - 'tsvgr_opacity', 14:47:04 INFO - 'tart', 14:47:04 INFO - 'tscrollx', 14:47:04 INFO - 'cart']}, 14:47:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'talos_options': ['--disable-e10s'], 14:47:04 INFO - 'tests': ['tp5o']}, 14:47:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'tests': ['tp5o']}, 14:47:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'talos_options': ['--disable-e10s', 14:47:04 INFO - '--xperf_path', 14:47:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:04 INFO - 'tests': ['tp5n']}, 14:47:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:04 INFO - 'talos_options': ['--xperf_path', 14:47:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:04 INFO - 'tests': ['tp5n']}}, 14:47:04 INFO - 'talos.zip': {'path': '', 14:47:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:47:04 INFO - Running post-action listener: _resource_record_post_action 14:47:04 INFO - [mozharness: 2016-10-24 21:47:04.497865Z] Finished populate-webroot step (success) 14:47:04 INFO - [mozharness: 2016-10-24 21:47:04.497993Z] Running create-virtualenv step. 14:47:04 INFO - Running pre-action listener: _resource_record_pre_action 14:47:04 INFO - Running main action method: create_virtualenv 14:47:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:47:04 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 14:47:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:47:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:47:04 INFO - Using real prefix '/tools/python27' 14:47:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:47:05 INFO - Installing distribute.............................................................................................................................................................................................done. 14:47:08 INFO - Installing pip.................done. 14:47:08 INFO - Return code: 0 14:47:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:08 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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:47:08 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 14:47:08 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 14:47:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:08 INFO - 'HOME': '/Users/cltbld', 14:47:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:08 INFO - 'LOGNAME': 'cltbld', 14:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:08 INFO - 'MOZ_NO_REMOTE': '1', 14:47:08 INFO - 'NO_EM_RESTART': '1', 14:47:08 INFO - 'PAGER': '/bin/cat', 14:47:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:08 INFO - 'PWD': '/builds/slave/test', 14:47:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:08 INFO - 'SHELL': '/bin/bash', 14:47:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:08 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:08 INFO - 'USER': 'cltbld', 14:47:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:08 INFO - 'XPC_FLAGS': '0x0', 14:47:08 INFO - 'XPC_SERVICE_NAME': '0', 14:47:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:08 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 14:47:08 INFO - Cleaning up... 14:47:08 INFO - Return code: 0 14:47:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:08 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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:47:08 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 14:47:08 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 14:47:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:08 INFO - 'HOME': '/Users/cltbld', 14:47:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:08 INFO - 'LOGNAME': 'cltbld', 14:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:08 INFO - 'MOZ_NO_REMOTE': '1', 14:47:08 INFO - 'NO_EM_RESTART': '1', 14:47:08 INFO - 'PAGER': '/bin/cat', 14:47:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:08 INFO - 'PWD': '/builds/slave/test', 14:47:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:08 INFO - 'SHELL': '/bin/bash', 14:47:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:08 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:08 INFO - 'USER': 'cltbld', 14:47:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:08 INFO - 'XPC_FLAGS': '0x0', 14:47:08 INFO - 'XPC_SERVICE_NAME': '0', 14:47:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:08 INFO - Downloading/unpacking psutil>=3.1.1 14:47:08 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 14:47:08 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 14:47:08 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 14:47:08 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 14:47:08 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 14:47:08 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 14:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:47:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:12 INFO - Installing collected packages: psutil 14:47:12 INFO - Running setup.py install for psutil 14:47:12 INFO - building 'psutil._psutil_osx' extension 14:47:12 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 14:47:12 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 14:47:12 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 14:47:12 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 14:47:12 INFO - building 'psutil._psutil_posix' extension 14:47:12 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 14:47:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:47:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:47:12 INFO - ^ 14:47:12 INFO - 1 warning generated. 14:47:12 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 14:47:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:12 INFO - Successfully installed psutil 14:47:12 INFO - Cleaning up... 14:47:13 INFO - Return code: 0 14:47:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:13 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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:47:13 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 14:47:13 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 14:47:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:13 INFO - 'HOME': '/Users/cltbld', 14:47:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:13 INFO - 'LOGNAME': 'cltbld', 14:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:13 INFO - 'MOZ_NO_REMOTE': '1', 14:47:13 INFO - 'NO_EM_RESTART': '1', 14:47:13 INFO - 'PAGER': '/bin/cat', 14:47:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:13 INFO - 'PWD': '/builds/slave/test', 14:47:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:13 INFO - 'SHELL': '/bin/bash', 14:47:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:13 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:13 INFO - 'USER': 'cltbld', 14:47:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:13 INFO - 'XPC_FLAGS': '0x0', 14:47:13 INFO - 'XPC_SERVICE_NAME': '0', 14:47:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:47:13 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 14:47:13 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 14:47:13 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 14:47:13 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 14:47:13 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 14:47:13 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 14:47:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:47:15 INFO - Installing collected packages: mozsystemmonitor 14:47:15 INFO - Running setup.py install for mozsystemmonitor 14:47:15 INFO - Successfully installed mozsystemmonitor 14:47:15 INFO - Cleaning up... 14:47:16 INFO - Return code: 0 14:47:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14: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')]} 14:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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', '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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14: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 jsonschema==2.5.1 14:47:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:16 INFO - 'HOME': '/Users/cltbld', 14:47:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:16 INFO - 'LOGNAME': 'cltbld', 14:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:16 INFO - 'MOZ_NO_REMOTE': '1', 14:47:16 INFO - 'NO_EM_RESTART': '1', 14:47:16 INFO - 'PAGER': '/bin/cat', 14:47:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:16 INFO - 'PWD': '/builds/slave/test', 14:47:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:16 INFO - 'SHELL': '/bin/bash', 14:47:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:16 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:16 INFO - 'USER': 'cltbld', 14:47:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:16 INFO - 'XPC_FLAGS': '0x0', 14:47:16 INFO - 'XPC_SERVICE_NAME': '0', 14:47:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:16 INFO - Downloading/unpacking jsonschema==2.5.1 14: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 14: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 14: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 14: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 14: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 14: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 14:47:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:47:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:47:18 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 14:47:18 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 14:47:18 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 14:47:18 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 14:47:18 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 14:47:18 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 14:47:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:47:19 INFO - warning: no files found matching '*.txt' 14:47:19 INFO - no previously-included directories found matching 'build' 14:47:19 INFO - no previously-included directories found matching 'dist' 14:47:19 INFO - no previously-included directories found matching '.git*' 14:47:19 INFO - Installing collected packages: jsonschema, functools32 14:47:19 INFO - Running setup.py install for functools32 14:47:19 INFO - warning: no files found matching '*.txt' 14:47:19 INFO - no previously-included directories found matching 'build' 14:47:19 INFO - no previously-included directories found matching 'dist' 14:47:19 INFO - no previously-included directories found matching '.git*' 14:47:19 INFO - Successfully installed jsonschema functools32 14:47:19 INFO - Cleaning up... 14:47:19 INFO - Return code: 0 14:47:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14: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')]} 14:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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', '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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14: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 functools32==3.2.3-2 14:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:19 INFO - 'HOME': '/Users/cltbld', 14:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:19 INFO - 'LOGNAME': 'cltbld', 14:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:19 INFO - 'MOZ_NO_REMOTE': '1', 14:47:19 INFO - 'NO_EM_RESTART': '1', 14:47:19 INFO - 'PAGER': '/bin/cat', 14:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:19 INFO - 'PWD': '/builds/slave/test', 14:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:19 INFO - 'SHELL': '/bin/bash', 14:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:19 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:19 INFO - 'USER': 'cltbld', 14:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:19 INFO - 'XPC_FLAGS': '0x0', 14:47:19 INFO - 'XPC_SERVICE_NAME': '0', 14:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:47:19 INFO - Cleaning up... 14:47:19 INFO - Return code: 0 14:47:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14: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')]} 14:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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', '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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14: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 blobuploader==1.2.4 14:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:19 INFO - 'HOME': '/Users/cltbld', 14:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:19 INFO - 'LOGNAME': 'cltbld', 14:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:19 INFO - 'MOZ_NO_REMOTE': '1', 14:47:19 INFO - 'NO_EM_RESTART': '1', 14:47:19 INFO - 'PAGER': '/bin/cat', 14:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:19 INFO - 'PWD': '/builds/slave/test', 14:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:19 INFO - 'SHELL': '/bin/bash', 14:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:19 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:19 INFO - 'USER': 'cltbld', 14:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:19 INFO - 'XPC_FLAGS': '0x0', 14:47:19 INFO - 'XPC_SERVICE_NAME': '0', 14:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:20 INFO - Downloading/unpacking blobuploader==1.2.4 14:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:23 INFO - Downloading blobuploader-1.2.4.tar.gz 14:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:47:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14: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 14: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 14: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 14: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 14: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 14: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 14:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:47:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:47:24 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 14:47:24 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 14:47:24 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 14:47:24 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 14:47:24 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 14:47:24 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 14:47:24 INFO - Downloading docopt-0.6.1.tar.gz 14:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:47:24 INFO - Installing collected packages: blobuploader, requests, docopt 14:47:24 INFO - Running setup.py install for blobuploader 14:47:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:47:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:47:24 INFO - Running setup.py install for requests 14:47:25 INFO - Running setup.py install for docopt 14:47:25 INFO - Successfully installed blobuploader requests docopt 14:47:25 INFO - Cleaning up... 14:47:25 INFO - Return code: 0 14:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:25 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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:47:25 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 14:47:25 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 14:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:25 INFO - 'HOME': '/Users/cltbld', 14:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:25 INFO - 'LOGNAME': 'cltbld', 14:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:25 INFO - 'MOZ_NO_REMOTE': '1', 14:47:25 INFO - 'NO_EM_RESTART': '1', 14:47:25 INFO - 'PAGER': '/bin/cat', 14:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:25 INFO - 'PWD': '/builds/slave/test', 14:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:25 INFO - 'SHELL': '/bin/bash', 14:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:25 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:25 INFO - 'USER': 'cltbld', 14:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:25 INFO - 'XPC_FLAGS': '0x0', 14:47:25 INFO - 'XPC_SERVICE_NAME': '0', 14:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:25 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-y3of7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-KBQk4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-h_bkvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-FCW2UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-X5Jvgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-m6CTCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-1uuaWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-i_8TAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-_8mU3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-UeJR0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-gNlOXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-X7aP_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-FZkN_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Nz6ldJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-2mnhQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-7N0lQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-tSBi30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:47:27 INFO - Running setup.py install for manifestparser 14:47:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:47:27 INFO - Running setup.py install for mozcrash 14:47:28 INFO - Running setup.py install for mozdebug 14:47:28 INFO - Running setup.py install for mozdevice 14:47:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Running setup.py install for mozfile 14:47:28 INFO - Running setup.py install for mozhttpd 14:47:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Running setup.py install for mozinfo 14:47:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Running setup.py install for mozInstall 14:47:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:47:28 INFO - Running setup.py install for mozleak 14:47:29 INFO - Running setup.py install for mozlog 14:47:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:47:29 INFO - Running setup.py install for moznetwork 14:47:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:47:29 INFO - Running setup.py install for mozprocess 14:47:29 INFO - Running setup.py install for mozprofile 14:47:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:47:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:47:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:47:29 INFO - Running setup.py install for mozrunner 14:47:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:47:29 INFO - Running setup.py install for mozscreenshot 14:47:30 INFO - Running setup.py install for moztest 14:47:30 INFO - Running setup.py install for mozversion 14:47:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:47:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:47:30 INFO - Cleaning up... 14:47:30 INFO - Return code: 0 14:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:30 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')]} 14:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:30 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')]} 14:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:30 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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:47:30 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 14:47:30 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 14:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:30 INFO - 'HOME': '/Users/cltbld', 14:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:30 INFO - 'LOGNAME': 'cltbld', 14:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:30 INFO - 'MOZ_NO_REMOTE': '1', 14:47:30 INFO - 'NO_EM_RESTART': '1', 14:47:30 INFO - 'PAGER': '/bin/cat', 14:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:30 INFO - 'PWD': '/builds/slave/test', 14:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:30 INFO - 'SHELL': '/bin/bash', 14:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:30 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:30 INFO - 'USER': 'cltbld', 14:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:30 INFO - 'XPC_FLAGS': '0x0', 14:47:30 INFO - 'XPC_SERVICE_NAME': '0', 14:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:30 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-YH4cPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:30 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)) 14:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:30 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-jC1E1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:30 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)) 14:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:30 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-rt1sYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:30 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)) 14:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:30 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-KFXNpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-mu9OyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-3O3e1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-tUaGFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-0HVycX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-FgyWVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-1fMMsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-EPbWEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-szkTsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:31 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)) 14:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-eevm60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:32 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)) 14:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-rdQwxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:32 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)) 14:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-O2jSVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:32 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)) 14:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-iMP_4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:32 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)) 14:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-8m2RwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:32 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)) 14:47:32 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)) 14:47:32 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)) 14:47:32 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)) 14:47:32 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)) 14:47:32 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)) 14:47:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:34 INFO - Downloading blessings-1.6.tar.gz 14:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:47:35 INFO - Installing collected packages: blessings 14:47:35 INFO - Running setup.py install for blessings 14:47:35 INFO - Successfully installed blessings 14:47:35 INFO - Cleaning up... 14:47:35 INFO - Return code: 0 14:47:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:35 INFO - Reading from file tmpfile_stdout 14:47:35 INFO - Current package versions: 14:47:35 INFO - blessings == 1.6 14:47:35 INFO - blobuploader == 1.2.4 14:47:35 INFO - docopt == 0.6.1 14:47:35 INFO - functools32 == 3.2.3-2 14:47:35 INFO - jsonschema == 2.5.1 14:47:35 INFO - manifestparser == 1.1 14:47:35 INFO - mozInstall == 1.12 14:47:35 INFO - mozcrash == 0.17 14:47:35 INFO - mozdebug == 0.1 14:47:35 INFO - mozdevice == 0.48 14:47:35 INFO - mozfile == 1.2 14:47:35 INFO - mozhttpd == 0.7 14:47:35 INFO - mozinfo == 0.9 14:47:35 INFO - mozleak == 0.1 14:47:35 INFO - mozlog == 3.4 14:47:35 INFO - moznetwork == 0.27 14:47:35 INFO - mozprocess == 0.23 14:47:35 INFO - mozprofile == 0.28 14:47:35 INFO - mozrunner == 6.12 14:47:35 INFO - mozscreenshot == 0.1 14:47:35 INFO - mozsystemmonitor == 0.3 14:47:35 INFO - moztest == 0.7 14:47:35 INFO - mozversion == 1.4 14:47:35 INFO - psutil == 3.1.1 14:47:35 INFO - requests == 1.2.3 14:47:35 INFO - wsgiref == 0.1.2 14:47:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:35 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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:47:35 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 14:47:35 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 14:47:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:35 INFO - 'HOME': '/Users/cltbld', 14:47:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:35 INFO - 'LOGNAME': 'cltbld', 14:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:35 INFO - 'MOZ_NO_REMOTE': '1', 14:47:35 INFO - 'NO_EM_RESTART': '1', 14:47:35 INFO - 'PAGER': '/bin/cat', 14:47:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:35 INFO - 'PWD': '/builds/slave/test', 14:47:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:35 INFO - 'SHELL': '/bin/bash', 14:47:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:35 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:35 INFO - 'USER': 'cltbld', 14:47:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:35 INFO - 'XPC_FLAGS': '0x0', 14:47:35 INFO - 'XPC_SERVICE_NAME': '0', 14:47:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 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)) 14:47:35 INFO - Cleaning up... 14:47:35 INFO - Return code: 0 14:47:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:36 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 0x10ca3f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6c3595ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, '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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 14:47:36 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 14:47:36 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 14:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:36 INFO - 'HOME': '/Users/cltbld', 14:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:36 INFO - 'LOGNAME': 'cltbld', 14:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:36 INFO - 'MOZ_NO_REMOTE': '1', 14:47:36 INFO - 'NO_EM_RESTART': '1', 14:47:36 INFO - 'PAGER': '/bin/cat', 14:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:36 INFO - 'PWD': '/builds/slave/test', 14:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:36 INFO - 'SHELL': '/bin/bash', 14:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:47:36 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:36 INFO - 'USER': 'cltbld', 14:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:36 INFO - 'XPC_FLAGS': '0x0', 14:47:36 INFO - 'XPC_SERVICE_NAME': '0', 14:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:47:36 INFO - Cleaning up... 14:47:36 INFO - Return code: 0 14:47:36 INFO - Running post-action listener: _resource_record_post_action 14:47:36 INFO - Running post-action listener: _start_resource_monitoring 14:47:36 INFO - Starting resource monitoring. 14:47:36 INFO - [mozharness: 2016-10-24 21:47:36.453177Z] Finished create-virtualenv step (success) 14:47:36 INFO - [mozharness: 2016-10-24 21:47:36.454233Z] Running install step. 14:47:36 INFO - Running pre-action listener: _resource_record_pre_action 14:47:36 INFO - Running main action method: install 14:47:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:36 INFO - Reading from file tmpfile_stdout 14:47:36 INFO - Detecting whether we're running mozinstall >=1.0... 14:47:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:47:36 INFO - Reading from file tmpfile_stdout 14:47:36 INFO - Output received: 14:47:36 INFO - Usage: mozinstall [options] installer 14:47:36 INFO - Options: 14:47:36 INFO - -h, --help show this help message and exit 14:47:36 INFO - -d DEST, --destination=DEST 14:47:36 INFO - Directory to install application into. [default: 14:47:36 INFO - "/builds/slave/test"] 14:47:36 INFO - --app=APP Application being installed. [default: firefox] 14:47:36 INFO - mkdir: /builds/slave/test/build/application 14:47:36 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'] 14:47:36 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 14:48:09 INFO - Reading from file tmpfile_stdout 14:48:09 INFO - Output received: 14:48:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:48:09 INFO - Running post-action listener: _resource_record_post_action 14:48:09 INFO - [mozharness: 2016-10-24 21:48:09.198189Z] Finished install step (success) 14:48:09 INFO - [mozharness: 2016-10-24 21:48:09.198309Z] Running run-tests step. 14:48:09 INFO - Running pre-action listener: _resource_record_pre_action 14:48:09 INFO - Running main action method: run_tests 14:48:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:48:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:48:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:48:09 INFO - 2016-10-24 14:48:09.212 screenresolution[6536:114349] starting screenresolution argv=screenresolution get 14:48:09 INFO - 2016-10-24 14:48:09.215 screenresolution[6536:114349] Display 0: 1600x1200x32@60 14:48:09 INFO - 2016-10-24 14:48:09.221 screenresolution[6537:114353] starting screenresolution argv=screenresolution list 14:48:09 INFO - Available Modes on Display 0 14:48:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:48:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:48:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:48:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:48:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:48:09 INFO - Intel Iris: 14:48:09 INFO - Chipset Model: Intel Iris 14:48:09 INFO - Type: GPU 14:48:09 INFO - Bus: Built-In 14:48:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:48:09 INFO - Vendor: Intel (0x8086) 14:48:09 INFO - Device ID: 0x0a2e 14:48:09 INFO - Revision ID: 0x0009 14:48:09 INFO - Displays: 14:48:09 INFO - Display: 14:48:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:48:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:48:09 INFO - Display Serial Number: 1600x1200 60 14:48:09 INFO - Main Display: Yes 14:48:09 INFO - Mirror: Off 14:48:09 INFO - Online: Yes 14:48:09 INFO - Rotation: Supported 14:48:09 INFO - Return code: 0 14:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:09 INFO - Python 2.7.3 14:48:09 INFO - Return code: 0 14:48:09 INFO - grabbing minidump binary from tooltool 14:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:09 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 0x10c853d30>, '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 0x10c6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:09 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 14:48:09 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 14:48:09 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 14:48:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:09 INFO - Return code: 0 14:48:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:48:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:48:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:09 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/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 14:48:09 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/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0262 --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 14:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bf1lO3G1ae/Render', 14:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:09 INFO - 'HOME': '/Users/cltbld', 14:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:09 INFO - 'LOGNAME': 'cltbld', 14:48:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:09 INFO - 'MOZ_NO_REMOTE': '1', 14:48:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:09 INFO - 'NO_EM_RESTART': '1', 14:48:09 INFO - 'PAGER': '/bin/cat', 14:48:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:09 INFO - 'PWD': '/builds/slave/test', 14:48:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:09 INFO - 'SHELL': '/bin/bash', 14:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.buF6mBcGcY/Listeners', 14:48:09 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 14:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:09 INFO - 'USER': 'cltbld', 14:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:09 INFO - 'XPC_FLAGS': '0x0', 14:48:09 INFO - 'XPC_SERVICE_NAME': '0', 14:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:09 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/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 14:48:09 INFO - mozversion application_buildid: 20161024125522 14:48:09 INFO - mozversion application_changeset: d33b1329a44d70645ee3bfc7b87063de4da8c54a 14:48:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:48:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:09 INFO - mozversion application_name: Firefox 14:48:09 INFO - mozversion application_remotingname: firefox-dev 14:48:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:48:09 INFO - mozversion application_vendor: Mozilla 14:48:09 INFO - mozversion application_version: 51.0a2 14:48:09 INFO - mozversion platform_buildid: 20161024125522 14:48:09 INFO - mozversion platform_changeset: d33b1329a44d70645ee3bfc7b87063de4da8c54a 14:48:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:48:09 INFO - mozversion platform_version: 51.0a2 14:48:09 INFO - using testdate: 1477345689 14:48:09 INFO - actual date: 1477345689 14:48:09 INFO - starting webserver on 'localhost:58342' 14:48:09 INFO - SUITE-START | Running 2 tests 14:48:09 INFO - TEST-START | dromaeo_css 14:48:09 INFO - operating with platform_type : mac_ 14:48:09 INFO - Initialising browser for dromaeo_css test... 14:48:09 INFO - TEST-INFO | started process 6547 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmp8REbVW/profile http://localhost:58342/getInfo.html) 14:48:12 INFO - PROCESS | 6547 | __metrics Screen width/height:1600/1200 14:48:12 INFO - PROCESS | 6547 | colorDepth:24 14:48:12 INFO - PROCESS | 6547 | Browser inner width/height: 1024/689 14:48:12 INFO - PROCESS | 6547 | __metrics 14:48:12 INFO - PROCESS | 6547 | 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" 14:48:12 INFO - PROCESS | 6547 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:48:12 INFO - TEST-INFO | 6547: exit 0 14:48:12 INFO - Browser initialized. 14:48:12 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:12 INFO - TEST-INFO | started process 6550 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmp8REbVW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:24 INFO - PROCESS | 6550 | RSS: Main: 219856896 14:48:24 INFO - PROCESS | 6550 | 14:49:15 INFO - PROCESS | 6550 | 1477345755931 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] 14:51:27 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58342/tests/dromaeo/cssquery-ext.html) 14:51:29 INFO - PROCESS | 6550 | RSS: Main: 357937152 14:51:29 INFO - PROCESS | 6550 | 14:54:32 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-ext.html (next: http://localhost:58342/tests/dromaeo/cssquery-jquery.html) 14:54:33 INFO - PROCESS | 6550 | RSS: Main: 350281728 14:54:33 INFO - PROCESS | 6550 | 14:57:35 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58342/tests/dromaeo/cssquery-mootools.html) 14:57:36 INFO - PROCESS | 6550 | RSS: Main: 313147392 14:57:36 INFO - PROCESS | 6550 | 15:00:38 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58342/tests/dromaeo/cssquery-prototype.html) 15:00:39 INFO - PROCESS | 6550 | RSS: Main: 318062592 15:00:39 INFO - PROCESS | 6550 | 15:03:42 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58342/tests/dromaeo/cssquery-yui.html) 15:03:43 INFO - PROCESS | 6550 | RSS: Main: 310431744 15:03:43 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58342/tests/dromaeo/cssquery-yui.html (next: http://localhost:58342/tests/dromaeo/cssquery-dojo.html) 15:06:46 INFO - PROCESS | 6550 | RSS: Main: 447758336 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | __start_tp_report 15:06:46 INFO - PROCESS | 6550 | _x_x_mozilla_page_load 15:06:46 INFO - PROCESS | 6550 | _x_x_mozilla_page_load_details 15:06:46 INFO - PROCESS | 6550 | |i|pagename|runs| 15:06:46 INFO - PROCESS | 6550 | |0;dojo.html;3236.5307030480576;3239.611246650401;3252.4633435483156;3286.1291757684203;3290.5557749703785;5607.635503692262;5703.629264097831;5731.713414329277;5735.598508104429;5744.5117165040965;5623.409541998092;5697.0599851024535;5726.226959360485;5734.713264336777;5745.396733343002;5165.173572228454;5199.558037566792;5206.140986737184;5206.271122042898;5248.842534723945;5102.69383836971;5121.641485096045;5128.820491282806;5303.124984377573;5350.063738845706;5148.948510514903;5206.739663016853;5206.869828254286;5232.529072383485;5241.606879484035;5183.352080989876;5198.636095473318;5207.869803254911;5224.895502089975;5255.894882102356;5115.283860259567;5226.242194881721;5234;5234.764435600369;5264.499872512105;5555.194496797982;5568.6658800472105;5568.832935011916;5642.322921249435;5748.109043098327;6107.46191531438;6149.046897730859;6159.1993040904845;6206.193194884636;6219.440250377443;5563.471470210324;6239.812805615838;6251.874662560737;6351.396617321347;6367.07677386781;5485.314335708036;5539.362973258127;5819.156222347736;5826.504747096545;5864.736086876101;6161.168242287234;6261.749530018839;6304.369563043659;6316.30520642729;6363.649999250086;5968.120042186697;6143.96928015357;6188.164597779332;6189.50483961282;6203.906941395882;6282.591631543935;6303.905441418382;6308.936910630927;6310.5267104967315;6322.462590679752;5873.823785286449;6040.214772079602;6056.57603967718;6099.634021958696;6187.504999600022;6225.533085018642;6243.875122497525;6250.249970003538;6254.468370188585;6268.435840774352;4890.804367825318;4945.8021679132435;4949.925751113737;4951.5048495150195;4968.850934471971;4366.126774645084;4391.385206071152;4405.581469760367;4416.138852923649;4519.480259770103;5697.430256974352;5741.052726300197;5758.3090029196765;5763.798267060716;5780.94219057804;6256.80358730056;6276.748930042839;6300.086487459293;6324.494040476751;6327.651979141191;5531.751071201725;5756.942430575725;5787.421257874179;5796.304443466726;5838.5329173666005;5299.125644268653;5319.7340132993195;5351.3043304370185;5354.143337066051;5385.973070134624;6254.874902501924;6305.054241863757;6317.778877739349;6321.273053598895;6342.492600592034;6332.715027823667;6335.683215839097;6337;6339.90490142639;6344.238691357066;6131.724072416841;6144.678894037804;6166.352532983972;6205.069239614094;6213.440790328711;6111.956402836337;6117.15760190703;6179.28938172116;6226.25284965807;6235.937640623717;6205.844853878689;6291.748330066929;6308.621482711052;6313.242410910537;6323.905141422791;5323.800549431317;5844.15259787337;6125;6128.466687918415;6160.199174107337;5844.064949608042;5940.227770389822;5984.491318237999;6027.367126451835;6098.695065246631;5873.4126587340925;5883.852903677443;5884.293884733688;5887.234659494238;5889;6005.849853753516;6027.126066720389;6028.547858910511;6082.695865206811;6090.147379366804;5728.570357223141;5752.050911599539;5852.4147585241135;5891.351951285269;5896.410358964069 15:06:46 INFO - PROCESS | 6550 | |1;ext.html;506.76182194368636;509.88527581294215;513.1942849725931;515.4072816261297;522.3627174846686;24254.75745242547;40082.59917400825;41033.79483102584;41112.38331425023;44220.336694949605;42821;43284.56715432845;43457.6962691119;43548.34677479832;43619.56380436195;8750.781230469225;9850.704478865628;10019.74950626233;10035.04667056632;10053.396796192215;8767.824643507127;12011.63965081049;12265.754684906296;12293.754124917496;12602.18085824423;12261.938690306535;12288.078394120432;12305.015598752123;12324.38378081097;12336.93831530841;12206.267623942547;12306.692332691755;12309.753804923852;12322.383880806014;12341.69145771354;10258.7435314117;11996.64010079699;12092.972097371734;12099.971502422304;12102.334371609559;40259;40271.39592906109;40327.59672403297;40459;40501;3364.2598628301735;3370.376480351143;3383.881564145243;3446.190145315849;3946.6645335146545;30838.529455778964;31187.84406077978;31474.842625786954;32052.519212211602;32446.513302300486;3105.4720697481484;3214.4856822908455;3248.2529018325918;3275.606927168755;3298.0270820108126;525842;530321.3483932595;532137;532314.9999999962;532826;33319.66680333214;33922.66077339245;63649.36350636527;64247.678761605894;64403.67798160979;35245;35536.28927421489;35625.82187089048;35677.82161089178;35687.4646880297;15118.168500732565;15258.618534536725;15264.084154950739;15266.465673701367;15272.847271527142;11620.76758464826;11880.821787673192;11906.64280071582;12950.611481655566;13067;6326.398992095744;7384.1877393486675;7385.778426647209;7673.271039251262;7860.842783144305;3198.1045307313525;3246.5454836322933;3248.0742988248708;3263.037403965788;3288.408086544445;909.9363044586815;924.713338864954;939.3565407695751;986.2356673577891;1044.4046893270915;29328.560071598942;30259.092227233217;30274.84862575673;30770.076897693107;30790.846045769627;852.2755657690913;1011.413380239474;1040.7346126737634;1111.90548803351;1118.7930232906938;15142.091474511564;15618.219089045502;15740.449084281996;15808.68382632341;15990.76013859793;696769;705459;706819;707182;707494;58221;58615.70692146512;58627;58774;58794.53013674692;1203.8495188101488;1231.778279909607;1332.513632524141;1356.7354365898752;1380.42712274405;29622.407551849272;31241.37517249688;31464.528032079994;31538.526922095727;32123.03630891077;50173.74913125411;50806.49193508018;50807.237891430916;50854.74572627113;50910.236346455575;538330;539285;541385;542607;543135;26629;26981.595276071268;27349.90600375963;27421.314467137683;28513.00204492833;47924.52075479201;48274.51725482841;48609;49008.2648760276;49652;40051.599484004786;40514.79742601268;40949.59050409458;41013.79493102516;42396.78801606096;33402.15462294137;40082;40688.98277543085;41351.79324103481;41522;38330.80834595809;39145.217095658496;39187.608123919534;39254.80372598233;40091.79954100211;33049.50425743568;34539.13652158716;35381.82309088438;35397.64602353943;35700.821495892356;25857.965681372534;25906.740932590434;26043.95824167012;26197;26496 15:06:46 INFO - PROCESS | 6550 | |2;jquery.html;348.472064821795;351.88563716792044;355.8292019830483;371.7546419363219;405.0440959335967;14409.567712968614;14796.260186990648;15766.132862692562;20077.89961050193;20360.08379622917;20192.495187620316;20583.485412864688;21346.7191968482;21397.786022139775;21623.891880540614;5889.64662120272;5921.73352199152;6138.29409617893;6188.350223226541;6207.068939659042;5980.6112602680905;6131.049687298476;6161.845953851167;6166.660833654148;6167.7841275555365;4152.8131234094535;4405.03089320349;4411.338299255105;5739.196512488255;6106.725197366107;6792.490563207754;6845;6880.346367095118;6893.20728116268;6907.965460172667;5175.275461435402;5438.483344082306;5474.589405794582;5551.167324901297;5966.880662386728;10953.507092180871;12891.80662290057;12958.15771974828;13126.01554883378;13127.737445251041;2144.667576525641;2368.5026144509675;2395.796357309631;2429.3881134579;2963.866626001835;8112.75661730149;9141.268698504104;9824.459654718987;10036.24728145392;10415.375077495375;1770.4246120011048;1784.5092599535233;1796.4071856287524;1805.2327760701648;1889.093235247089;112355;116261.99999999916;124156.37921810334;124324;124778;11487.885121148682;11724.824127638092;11726.947784137741;11753.764924701458;11894.464749086139;14233.85766142346;14685.045472044283;14686.97191196606;14696.191709456083;14706.117632942058;7252.528585641917;8664.176903194186;8684.522351270742;8768.912310876809;8844.027157012724;8165.897603823527;8680.34897382699;8691.304695624462;8698.086700896441;8861.379703420827;4083.7549747015273;4503.572160644799;4534.546545345439;4600.838970636011;4610.05493873755;1825.3063835742332;1891.2529550827346;1891.659501289781;1892.1551487300048;1899.1928430417017;805.2269820971933;870.1733353314377;883.2536506651869;888.6534251641865;926.2404828040942;20627.58744825125;21586.676199857015;21613.78386216149;21625.24311649085;21705.34883953484;900.8063266397756;903.6159632156439;932.3613324872484;954.1603389017758;1009.2481101579224;9128.45229286245;10747.301425407324;11275.436228188557;11316.6039188628;11370.976612104785;488326;561926;565136;568899;571781;104831;125171.74828251783;130431.34784326017;141127.99999999793;141417;864.6757465950269;947.5925352098664;983.2478154212033;1022.1516141602303;1024.702836177515;19262.518437039187;19741.40775776729;20201;20217.595648086663;20239.79760202379;56072.719636401554;57345.42654573401;57439.712801437396;57493.71253143708;59805.40194597998;78164;80704;85465.86335341666;86974.56512717396;86988;7951.3638908886;8018.879716804369;8049.758507244792;8282.751517454486;8316.584170791315;12387.75224495523;12664.366781661065;12779.936100319439;12838.743225135631;13228.801567976296;7781.455298129303;7930.9603451982375;8051.436399451982;8060.992375953006;8887.955560222157;6119.388061193845;7564.4704870658525;7887;7988.960055199686;8201.507909525448;7907.84184316322;8107;8206.712765053195;8211.58942052907;8225.547594882339;11950.521979120738;12522.186057906207;12689.619311420673;12697.968325067945;12959.287239201934;7946.7615971520945;7997.7600671979935;8094.473859199369;8153.369326134678;8169.754907352789 15:06:46 INFO - PROCESS | 6550 | |3;mootools.html;1310.77716788146;1346.9730605387895;1380.5789234283543;1648.2253340929767;1904.4381907337333;7147.89278160828;7811.414143939206;8317.667293308268;8741;8965.91034089659;8822.294216462684;8926.37515373924;8926.464412135276;8938.642454301837;8940.552972351372;2376.8811559422047;2392.2583998960376;2404.7955923746504;2405.230326295586;2420.104561312317;2348.729896061958;2392.1507864708037;2394.568977584034;2403.230966090852;2404.002339029301;2350.518143780521;2371.6679664846934;2385.3678775124604;2387.522495500898;2389.7012873390827;1998.8300994415492;2364.267077206063;2365.27859003004;2370.1704403458825;2373.181252467896;2312.6531020346915;2335.602947498929;2343.8945247463903;2347.6830627865193;2348.8590684558812;8770.649174033031;8797;8841.115888411172;8862;8880.111988801133;5187.403448603422;5214.296070030536;5327.174287985368;5359.1425371940695;5435.374931882845;2994.970050299491;3590.622984586607;3678.889633311005;3679.558452985632;3688.7233457490797;1097.434821067151;1101.366714139365;1101.7465982823996;1125.1505113639232;1127.8815724348908;11647.068234541217;11741.58904438349;11791.93872551466;11829.645110646694;11839.881601183964;4425.402570652985;4457.2645513489915;4622.006268652256;4640.443146822403;4643.4660014098135;9170.86243706345;9181.495017774087;9199.218066464291;9207.76980575491;9210.677626283183;4523.208438523311;5232.1628539433505;5253.894922101536;5265.341832270966;5302.2046692996355;3721.8697345593314;4092.815823287959;4391.121775644884;4539.364488971547;4909.582685471703;3742.8315725792404;3805.7145714071003;3809.276237514863;3849.7882616456363;3864.2851072551666;1156.8496095507699;1158.9652310430702;1161.0653423993597;1169.5204965963915;1171.1450641032095;733.4352548537596;808.8070096607457;907.9773005674779;914.4741773480275;939.3236869454119;5693.17448969897;5719.48524632785;5788.797392091256;5885.382034886361;5973.731182096816;433.8828516300644;448.5581702023504;453.1345130800156;463.99536004640197;466.68265579405653;3486.38988177068;3869.361555343337;3880.864169754045;4076.3681629346906;4080.959190408117;10460.372377657213;10607.469626518643;10827.458627068772;10925.781484370427;11255.774884502263;10827.83758243627;10873.456327183609;10902.890971090346;10916.508757105948;10935.125189984783;7849.332806711379;8106.554139522265;8203.179682031869;8249.546274954815;8322.250997410141;5884.558658100574;5965.224520812267;6002.87994240104;6186.288576813724;6222.688865556795;10036.548355324174;10075.193984481077;10079.596816127272;10092.596296148366;10271.383716977005;9416.152546270869;9906.752331191778;10251.897481025095;10310.896891030994;10494.632687855888;7139.643017849191;7306.232845551141;7447.590382529013;7548;7664.3485303747575;8293.170682931659;8312.293455056388;8396.076431592643;8403.20169583913;8461.788455288666;6520.152380190545;7550.093988721389;7569.091708994956;7624.847503049797;7646.9617651911385;6397.616143031433;7372.778816635509;7480.139783924918;7519.548827070394;7520.247975202436;6953.20038195614;7056.188538318159;7061.71753129869;7072.222055573986;7101.11236095488;4825.6139508838505;4849.878753031202;5014.197728363444;5046.318746969112;5164.664296820694;4198.328267477311;4959.280904268789;4969.254611808257;5050.651447077127;5066.189409694432 15:06:46 INFO - PROCESS | 6550 | |4;prototype.html;292.5801474883542;294.9675535691075;301.41976694862393;303.543167532863;307.5448336462035;4422.756748378838;4996.300517927493;5147.584414286069;5341.813036543722;5348.866278343038;4951.900961980758;5068.1384164692;5116.616253780962;5156.407013193484;5184.766685499152;4027.7777777777806;4058.2492238935893;4061.6344528992386;4063.878083657495;4075.755454672714;3339.966600334002;3625.7461977661574;4016.5983401659746;4042.282030137195;4044.1102957349335;3205.7016908152236;3466.9653303466894;3833;3866.6326698963694;4041.2725709372303;3378.7803792753516;3533.5583052118486;3971.225611005855;4055.3916912463073;4066.369712694537;3220.162757683019;3246.480563109915;3492.947605785915;3526.8714011516327;3531.4526248431534;5182.585393168575;5182.585393168575;5212.322398088262;5216.400113986864;5217.47825217479;3803.562590302123;4206.894827629303;4514.6614003949835;4563.224251877155;4582.1064892346;5564.8330550083565;5575.442455754433;5576.9163462548095;5582.637128586629;5607.915881261784;3767.3407153747985;3776.2825063237897;3784.280986612535;3786.3941769316775;3800.6697655820517;4706.705655944608;5066.771995260222;5521.757604538987;5671.659700417947;5869.941300587025;3400.25194457219;3769.3780526212868;3799.936017914988;3823.4647149399107;3841.4814000110186;3401.897943061712;3757.3612485877466;3881.7088718346236;3922.195949830278;4060.796960151981;3990.980045099756;4035.2938235808615;4049.230646177276;4293.86212653647;4568.931466027946;5612.691301978349;5624.85937851557;5630.690312032795;5630.915536266959;5640;1174.6652204121956;1268.1186575330241;1309.8821106100497;1335.4858379523953;1342.9932850335686;826.2068414322198;847.720252316734;859.5788063848669;860.6342304520554;886.2466903132415;4893.486183950634;5261.447548007481;5265.525652817218;5320.946790532123;5340.8664783379945;5458.789190377904;5712.028955077647;5719.857003574861;5730.684812335278;5741.62679425836;4969.676970996874;5282.147640274286;5285.207218917193;5409.810656627078;5425.860569280495;2849.8056496497993;2870.603046456191;2958.763298936123;3023;3049.5425686147255;4924.901501969941;5025.321581586512;5355.544778693777;5612.775488980476;5980.491658209014;5086.54221120101;5144.845654630367;5268.81559145428;5955.940440595626;5994.220751302303;5925.555583331267;5993.7712768882275;6050.364711705296;6074.483668888194;6128.233970753656;4942.382202224722;4951.48444604335;5577.581681373832;5740.311162660508;5763.7982670606325;4752.5485078917445;4880.975595122001;5630.5777066720975;5757.625754325955;5767.221425107725;5735.76305240948;5894.263217097863;6000.339962604023;6071.878562428638;6074.179985701874;3431.4681224410256;3921.450996860499;3979.900502487461;4029.8388064478268;4039.575844536399;4380.5838445347645;5085.415177254515;5794.478496935296;5813.709314534341;5861.296644402699;4223.8099285532835;5728.94014607299;5740.827775166752;5744.90311036477;5819.476247137778;5324.577317320687;5573.136163894603;5585.804496842591;5625.23109516633;5632.211490391266;5235.345581802275;5488.572971027642;5512.862178445411;5527.226188333556;5545.223668686468;5355.97322013403;5608.411116832837;5629.718514074362;5673.404292549388;5678.602497825113;5464.644798088111;5471.534919531725;5481.780728770805;5502.752376143003;5505.146702261156 15:06:46 INFO - PROCESS | 6550 | |5;yui.html;603.8369640197145;721.9278072192785;735.6211551051206;742.064998102391;779.660847531324;14825.777613335795;15820.604484887883;15992.200389980513;16026.43907463239;16030.957987730819;14256.429742810302;14393.352299146538;14824.703505929874;15074.698506029872;15086.773698394505;690.1097584116484;831.0816547714763;866.7139843851514;873.6811063961671;876.2639382918347;697.979060628182;716.0941409117471;846.9957650211741;870.3037569944051;880.35294058867;923.5474617437475;928.0811996123823;929.3773171974759;931.3108299858123;932.8460803967337;926.9490178040205;927.536231884058;929.6606738540384;930.1070971867016;931.4225180388135;526.3263023330144;546.4781134017004;659.7789740436959;677;686.7287421468542;14897.478588249467;15046.19445666516;15048.645621894082;15055.247237638183;15075.396984120622;13704.10923289983;13962.511312104027;14052.648683782885;14149.292535373294;14386.784198237036;11947.94026029873;12322.568710095104;12509.74980500394;12841.29372884491;13027.609171724864;4297.290946993742;4535.002299494106;4543.795529201194;4550.522195169526;4734.337192793012;119639;121162.39418802937;122499;123161.76838231593;123188.76811231862;10666.626668066736;11095.55617775296;11107.444627768578;11237.662870113747;11258.38078905668;21830.672539911913;21845.01697423588;21901.12395504162;22028.33914982553;22031.898405080003;7626.389888808882;7654.349380302737;7694.884576731353;7723.9227607723205;7846.372290216769;4268.893277668021;4341.826326946887;4349.282368409177;4357.694961352739;4364.323529852878;3454.654534546525;3792.089898424358;4030.858919937788;4058.898527536835;4067.8372865085066;689.3279052923359;693.0297583383303;708.3907839258234;708.397861817451;717.0534893939949;529.5684017525704;603.5322624965687;682.3585829320423;688.7313947560456;690.1511141296234;9118.908810911938;9355.812883742286;9432.386894851812;9583.568739406743;9687.757806054764;638.3584497579902;638.559394018126;646.5926466326279;670.6378555579932;685.4516386890567;4587.587117159472;4713.6464765142755;4730.905381892343;4789.299798571457;4867.196912509467;127895;151922.24038879955;160293.19853400657;160756;166005;94218;117145.65708685778;125303.37348313382;137299;138860;97982.53026204613;119187.8081219194;119562.4021879885;120101;120476;8732.34507411934;8950.53286453845;9035.367524273237;9077.77305567366;9224.953875230582;63107.36892631199;63127.6843615779;64425.03362449661;64966;67022.66488667525;91055;94468;96065;96440;104260;11704.531818727155;11903.523859045888;12351.888330050338;12557.811632825333;12634.167712129403;14018.859811401755;15343.61640958985;15349.386024558893;15831.525054248392;15850.52448426549;13484;13963.720725585634;14227.857721423068;14401.42394304216;14860.331285092412;13597.796033059314;13843.2370403633;13981.091229070078;14018.719625607227;14551.563453096423;11047.447627618747;12672.366381681064;12766.17019893704;14527.782083268548;14544.200068996306;10699.197560182862;10946.562137514411;11386.487608057823;11677.182597218452;12342.81485777696;9525.333226674065;9914.553845077133;11588.826167607323;11716.23844450108;11722.58970936013 15:06:46 INFO - PROCESS | 6550 | __end_tp_report 15:06:46 INFO - PROCESS | 6550 | __start_cc_report 15:06:46 INFO - PROCESS | 6550 | _x_x_mozilla_cycle_collect,1311 15:06:46 INFO - PROCESS | 6550 | __end_cc_report 15:06:46 INFO - PROCESS | 6550 | __startTimestamp1477346806482__endTimestamp 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | ------- Summary: start ------- 15:06:46 INFO - PROCESS | 6550 | Number of tests: 6 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | [#0] dojo.html Cycles:165 Average:5721.47 Median:5873.41 stddev:647.93 (11.0%) stddev-sans-first:619.89 15:06:46 INFO - PROCESS | 6550 | Values: 3236.5 3239.6 3252.5 3286.1 3290.6 5607.6 5703.6 5731.7 5735.6 5744.5 5623.4 5697.1 5726.2 5734.7 5745.4 5165.2 5199.6 5206.1 5206.3 5248.8 5102.7 5121.6 5128.8 5303.1 5350.1 5148.9 5206.7 5206.9 5232.5 5241.6 5183.4 5198.6 5207.9 5224.9 5255.9 5115.3 5226.2 5234.0 5234.8 5264.5 5555.2 5568.7 5568.8 5642.3 5748.1 6107.5 6149.0 6159.2 6206.2 6219.4 5563.5 6239.8 6251.9 6351.4 6367.1 5485.3 5539.4 5819.2 5826.5 5864.7 6161.2 6261.7 6304.4 6316.3 6363.6 5968.1 6144.0 6188.2 6189.5 6203.9 6282.6 6303.9 6308.9 6310.5 6322.5 5873.8 6040.2 6056.6 6099.6 6187.5 6225.5 6243.9 6250.2 6254.5 6268.4 4890.8 4945.8 4949.9 4951.5 4968.9 4366.1 4391.4 4405.6 4416.1 4519.5 5697.4 5741.1 5758.3 5763.8 5780.9 6256.8 6276.7 6300.1 6324.5 6327.7 5531.8 5756.9 5787.4 5796.3 5838.5 5299.1 5319.7 5351.3 5354.1 5386.0 6254.9 6305.1 6317.8 6321.3 6342.5 6332.7 6335.7 6337.0 6339.9 6344.2 6131.7 6144.7 6166.4 6205.1 6213.4 6112.0 6117.2 6179.3 6226.3 6235.9 6205.8 6291.7 6308.6 6313.2 6323.9 5323.8 5844.2 6125.0 6128.5 6160.2 5844.1 5940.2 5984.5 6027.4 6098.7 5873.4 5883.9 5884.3 5887.2 5889.0 6005.8 6027.1 6028.5 6082.7 6090.1 5728.6 5752.1 5852.4 5891.4 5896.4 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | [#1] ext.html Cycles:180 Average:71294.68 Median:18992.66 stddev:160066.31 (842.8%) stddev-sans-first:160427.10 15:06:46 INFO - PROCESS | 6550 | Values: 506.8 509.9 513.2 515.4 522.4 24254.8 40082.6 41033.8 41112.4 44220.3 42821.0 43284.6 43457.7 43548.3 43619.6 8750.8 9850.7 10019.7 10035.0 10053.4 8767.8 12011.6 12265.8 12293.8 12602.2 12261.9 12288.1 12305.0 12324.4 12336.9 12206.3 12306.7 12309.8 12322.4 12341.7 10258.7 11996.6 12093.0 12100.0 12102.3 40259.0 40271.4 40327.6 40459.0 40501.0 3364.3 3370.4 3383.9 3446.2 3946.7 30838.5 31187.8 31474.8 32052.5 32446.5 3105.5 3214.5 3248.3 3275.6 3298.0 525842.0 530321.3 532137.0 532315.0 532826.0 33319.7 33922.7 63649.4 64247.7 64403.7 35245.0 35536.3 35625.8 35677.8 35687.5 15118.2 15258.6 15264.1 15266.5 15272.8 11620.8 11880.8 11906.6 12950.6 13067.0 6326.4 7384.2 7385.8 7673.3 7860.8 3198.1 3246.5 3248.1 3263.0 3288.4 909.9 924.7 939.4 986.2 1044.4 29328.6 30259.1 30274.8 30770.1 30790.8 852.3 1011.4 1040.7 1111.9 1118.8 15142.1 15618.2 15740.4 15808.7 15990.8 696769.0 705459.0 706819.0 707182.0 707494.0 58221.0 58615.7 58627.0 58774.0 58794.5 1203.8 1231.8 1332.5 1356.7 1380.4 29622.4 31241.4 31464.5 31538.5 32123.0 50173.7 50806.5 50807.2 50854.7 50910.2 538330.0 539285.0 541385.0 542607.0 543135.0 26629.0 26981.6 27349.9 27421.3 28513.0 47924.5 48274.5 48609.0 49008.3 49652.0 40051.6 40514.8 40949.6 41013.8 42396.8 33402.2 40082.0 40689.0 41351.8 41522.0 38330.8 39145.2 39187.6 39254.8 40091.8 33049.5 34539.1 35381.8 35397.6 35700.8 25858.0 25906.7 26044.0 26197.0 26496.0 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | [#2] jquery.html Cycles:180 Average:33496.89 Median:4605.45 stddev:92954.06 (2018.4%) stddev-sans-first:93181.50 15:06:46 INFO - PROCESS | 6550 | Values: 348.5 351.9 355.8 371.8 405.0 14409.6 14796.3 15766.1 20077.9 20360.1 20192.5 20583.5 21346.7 21397.8 21623.9 5889.6 5921.7 6138.3 6188.4 6207.1 5980.6 6131.0 6161.8 6166.7 6167.8 4152.8 4405.0 4411.3 5739.2 6106.7 6792.5 6845.0 6880.3 6893.2 6908.0 5175.3 5438.5 5474.6 5551.2 5966.9 10953.5 12891.8 12958.2 13126.0 13127.7 2144.7 2368.5 2395.8 2429.4 2963.9 8112.8 9141.3 9824.5 10036.2 10415.4 1770.4 1784.5 1796.4 1805.2 1889.1 112355.0 116262.0 124156.4 124324.0 124778.0 11487.9 11724.8 11726.9 11753.8 11894.5 14233.9 14685.0 14687.0 14696.2 14706.1 7252.5 8664.2 8684.5 8768.9 8844.0 8165.9 8680.3 8691.3 8698.1 8861.4 4083.8 4503.6 4534.5 4600.8 4610.1 1825.3 1891.3 1891.7 1892.2 1899.2 805.2 870.2 883.3 888.7 926.2 20627.6 21586.7 21613.8 21625.2 21705.3 900.8 903.6 932.4 954.2 1009.2 9128.5 10747.3 11275.4 11316.6 11371.0 488326.0 561926.0 565136.0 568899.0 571781.0 104831.0 125171.7 130431.3 141128.0 141417.0 864.7 947.6 983.2 1022.2 1024.7 19262.5 19741.4 20201.0 20217.6 20239.8 56072.7 57345.4 57439.7 57493.7 59805.4 78164.0 80704.0 85465.9 86974.6 86988.0 7951.4 8018.9 8049.8 8282.8 8316.6 12387.8 12664.4 12779.9 12838.7 13228.8 7781.5 7931.0 8051.4 8061.0 8888.0 6119.4 7564.5 7887.0 7989.0 8201.5 7907.8 8107.0 8206.7 8211.6 8225.5 11950.5 12522.2 12689.6 12698.0 12959.3 7946.8 7997.8 8094.5 8153.4 8169.8 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | [#3] mootools.html Cycles:180 Average:5654.19 Median:2552.22 stddev:3234.21 (126.7%) stddev-sans-first:3226.81 15:06:46 INFO - PROCESS | 6550 | Values: 1310.8 1347.0 1380.6 1648.2 1904.4 7147.9 7811.4 8317.7 8741.0 8965.9 8822.3 8926.4 8926.5 8938.6 8940.6 2376.9 2392.3 2404.8 2405.2 2420.1 2348.7 2392.2 2394.6 2403.2 2404.0 2350.5 2371.7 2385.4 2387.5 2389.7 1998.8 2364.3 2365.3 2370.2 2373.2 2312.7 2335.6 2343.9 2347.7 2348.9 8770.6 8797.0 8841.1 8862.0 8880.1 5187.4 5214.3 5327.2 5359.1 5435.4 2995.0 3590.6 3678.9 3679.6 3688.7 1097.4 1101.4 1101.7 1125.2 1127.9 11647.1 11741.6 11791.9 11829.6 11839.9 4425.4 4457.3 4622.0 4640.4 4643.5 9170.9 9181.5 9199.2 9207.8 9210.7 4523.2 5232.2 5253.9 5265.3 5302.2 3721.9 4092.8 4391.1 4539.4 4909.6 3742.8 3805.7 3809.3 3849.8 3864.3 1156.8 1159.0 1161.1 1169.5 1171.1 733.4 808.8 908.0 914.5 939.3 5693.2 5719.5 5788.8 5885.4 5973.7 433.9 448.6 453.1 464.0 466.7 3486.4 3869.4 3880.9 4076.4 4081.0 10460.4 10607.5 10827.5 10925.8 11255.8 10827.8 10873.5 10902.9 10916.5 10935.1 7849.3 8106.6 8203.2 8249.5 8322.3 5884.6 5965.2 6002.9 6186.3 6222.7 10036.5 10075.2 10079.6 10092.6 10271.4 9416.2 9906.8 10251.9 10310.9 10494.6 7139.6 7306.2 7447.6 7548.0 7664.3 8293.2 8312.3 8396.1 8403.2 8461.8 6520.2 7550.1 7569.1 7624.8 7647.0 6397.6 7372.8 7480.1 7519.5 7520.2 6953.2 7056.2 7061.7 7072.2 7101.1 4825.6 4849.9 5014.2 5046.3 5164.7 4198.3 4959.3 4969.3 5050.7 5066.2 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | [#4] prototype.html Cycles:180 Average:4513.71 Median:5152.00 stddev:1414.06 (27.4%) stddev-sans-first:1382.08 15:06:46 INFO - PROCESS | 6550 | Values: 292.6 295.0 301.4 303.5 307.5 4422.8 4996.3 5147.6 5341.8 5348.9 4951.9 5068.1 5116.6 5156.4 5184.8 4027.8 4058.2 4061.6 4063.9 4075.8 3340.0 3625.7 4016.6 4042.3 4044.1 3205.7 3467.0 3833.0 3866.6 4041.3 3378.8 3533.6 3971.2 4055.4 4066.4 3220.2 3246.5 3492.9 3526.9 3531.5 5182.6 5182.6 5212.3 5216.4 5217.5 3803.6 4206.9 4514.7 4563.2 4582.1 5564.8 5575.4 5576.9 5582.6 5607.9 3767.3 3776.3 3784.3 3786.4 3800.7 4706.7 5066.8 5521.8 5671.7 5869.9 3400.3 3769.4 3799.9 3823.5 3841.5 3401.9 3757.4 3881.7 3922.2 4060.8 3991.0 4035.3 4049.2 4293.9 4568.9 5612.7 5624.9 5630.7 5630.9 5640.0 1174.7 1268.1 1309.9 1335.5 1343.0 826.2 847.7 859.6 860.6 886.2 4893.5 5261.4 5265.5 5320.9 5340.9 5458.8 5712.0 5719.9 5730.7 5741.6 4969.7 5282.1 5285.2 5409.8 5425.9 2849.8 2870.6 2958.8 3023.0 3049.5 4924.9 5025.3 5355.5 5612.8 5980.5 5086.5 5144.8 5268.8 5955.9 5994.2 5925.6 5993.8 6050.4 6074.5 6128.2 4942.4 4951.5 5577.6 5740.3 5763.8 4752.5 4881.0 5630.6 5757.6 5767.2 5735.8 5894.3 6000.3 6071.9 6074.2 3431.5 3921.5 3979.9 4029.8 4039.6 4380.6 5085.4 5794.5 5813.7 5861.3 4223.8 5728.9 5740.8 5744.9 5819.5 5324.6 5573.1 5585.8 5625.2 5632.2 5235.3 5488.6 5512.9 5527.2 5545.2 5356.0 5608.4 5629.7 5673.4 5678.6 5464.6 5471.5 5481.8 5502.8 5505.1 15:06:46 INFO - PROCESS | 6550 | 15:06:46 INFO - PROCESS | 6550 | [#5] yui.html Cycles:180 Average:25582.23 Median:4063.37 stddev:41062.85 (1010.6%) stddev-sans-first:41135.21 15:06:46 INFO - PROCESS | 6550 | Values: 603.8 721.9 735.6 742.1 779.7 14825.8 15820.6 15992.2 16026.4 16031.0 14256.4 14393.4 14824.7 15074.7 15086.8 690.1 831.1 866.7 873.7 876.3 698.0 716.1 847.0 870.3 880.4 923.5 928.1 929.4 931.3 932.8 926.9 927.5 929.7 930.1 931.4 526.3 546.5 659.8 677.0 686.7 14897.5 15046.2 15048.6 15055.2 15075.4 13704.1 13962.5 14052.6 14149.3 14386.8 11947.9 12322.6 12509.7 12841.3 13027.6 4297.3 4535.0 4543.8 4550.5 4734.3 119639.0 121162.4 122499.0 123161.8 123188.8 10666.6 11095.6 11107.4 11237.7 11258.4 21830.7 21845.0 21901.1 22028.3 22031.9 7626.4 7654.3 7694.9 7723.9 7846.4 4268.9 4341.8 4349.3 4357.7 4364.3 3454.7 3792.1 4030.9 4058.9 4067.8 689.3 693.0 708.4 708.4 717.1 529.6 603.5 682.4 688.7 690.2 9118.9 9355.8 9432.4 9583.6 9687.8 638.4 638.6 646.6 670.6 685.5 4587.6 4713.6 4730.9 4789.3 4867.2 127895.0 151922.2 160293.2 160756.0 166005.0 94218.0 117145.7 125303.4 137299.0 138860.0 97982.5 119187.8 119562.4 120101.0 120476.0 8732.3 8950.5 9035.4 9077.8 9225.0 63107.4 63127.7 64425.0 64966.0 67022.7 91055.0 94468.0 96065.0 96440.0 104260.0 11704.5 11903.5 12351.9 12557.8 12634.2 14018.9 15343.6 15349.4 15831.5 15850.5 13484.0 13963.7 14227.9 14401.4 14860.3 13597.8 13843.2 13981.1 14018.7 14551.6 11047.4 12672.4 12766.2 14527.8 14544.2 10699.2 10946.6 11386.5 11677.2 12342.8 9525.3 9914.6 11588.8 11716.2 11722.6 15:06:46 INFO - PROCESS | 6550 | -------- Summary: end -------- 15:06:46 INFO - PROCESS | 6550 | 15:06:47 INFO - TEST-INFO | 6550: exit 0 15:06:47 INFO - TEST-OK | dromaeo_css | took 1117297ms 15:06:47 INFO - TEST-START | kraken 15:06:47 INFO - operating with platform_type : mac_ 15:06:47 INFO - Initialising browser for kraken test... 15:06:47 INFO - TEST-INFO | started process 6552 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpsgsKOJ/profile http://localhost:58342/getInfo.html) 15:06:49 INFO - PROCESS | 6552 | __metrics Screen width/height:1600/1200 15:06:49 INFO - PROCESS | 6552 | colorDepth:24 15:06:49 INFO - PROCESS | 6552 | Browser inner width/height: 1024/689 15:06:49 INFO - PROCESS | 6552 | __metrics 15:06:49 INFO - PROCESS | 6552 | 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:06:49 INFO - PROCESS | 6552 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:06:50 INFO - TEST-INFO | 6552: exit 0 15:06:50 INFO - Browser initialized. 15:06:50 INFO - Running cycle 1/1 for kraken test... 15:06:50 INFO - TEST-INFO | started process 6553 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpsgsKOJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:02 INFO - PROCESS | 6553 | RSS: Main: 219922432 15:07:02 INFO - PROCESS | 6553 | 15:07:04 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-beat-detection) 15:07:05 INFO - PROCESS | 6553 | RSS: Main: 270520320 15:07:05 INFO - PROCESS | 6553 | 15:07:08 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-dft) 15:07:09 INFO - PROCESS | 6553 | RSS: Main: 281104384 15:07:09 INFO - PROCESS | 6553 | 15:07:12 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-fft) 15:07:12 INFO - PROCESS | 6553 | RSS: Main: 379383808 15:07:12 INFO - PROCESS | 6553 | 15:07:14 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58342/tests/kraken/driver.html?testName=audio-oscillator) 15:07:15 INFO - PROCESS | 6553 | RSS: Main: 280035328 15:07:15 INFO - PROCESS | 6553 | 15:07:17 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:18 INFO - PROCESS | 6553 | RSS: Main: 282025984 15:07:18 INFO - PROCESS | 6553 | 15:07:20 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58342/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:21 INFO - PROCESS | 6553 | RSS: Main: 318251008 15:07:21 INFO - PROCESS | 6553 | 15:07:24 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58342/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:25 INFO - PROCESS | 6553 | RSS: Main: 319959040 15:07:25 INFO - PROCESS | 6553 | 15:07:27 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58342/tests/kraken/driver.html?testName=json-parse-financial) 15:07:28 INFO - PROCESS | 6553 | RSS: Main: 319791104 15:07:28 INFO - PROCESS | 6553 | 15:07:30 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:07:30 INFO - PROCESS | 6553 | RSS: Main: 290934784 15:07:30 INFO - PROCESS | 6553 | 15:07:32 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:07:33 INFO - PROCESS | 6553 | RSS: Main: 296316928 15:07:33 INFO - PROCESS | 6553 | 15:07:35 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:07:35 INFO - PROCESS | 6553 | RSS: Main: 305127424 15:07:35 INFO - PROCESS | 6553 | 15:07:38 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:07:39 INFO - PROCESS | 6553 | RSS: Main: 312057856 15:07:39 INFO - PROCESS | 6553 | 15:07:42 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:07:43 INFO - PROCESS | 6553 | RSS: Main: 311558144 15:07:43 INFO - PROCESS | 6553 | 15:07:44 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:58342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58342/tests/kraken/driver.html?testName=ai-astar) 15:07:45 INFO - PROCESS | 6553 | RSS: Main: 356233216 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | __start_tp_report 15:07:45 INFO - PROCESS | 6553 | _x_x_mozilla_page_load 15:07:45 INFO - PROCESS | 6553 | _x_x_mozilla_page_load_details 15:07:45 INFO - PROCESS | 6553 | |i|pagename|runs| 15:07:45 INFO - PROCESS | 6553 | |0;ai-astar;115;122;167;145;111;114;112;113;116;112 15:07:45 INFO - PROCESS | 6553 | |1;audio-beat-detection;148;110;111;147;111;109;107;108;135;105 15:07:45 INFO - PROCESS | 6553 | |2;audio-dft;183;185;184;184;184;183;187;186;187;185 15:07:45 INFO - PROCESS | 6553 | |3;audio-fft;82;59;59;91;72;61;58;58;84;58 15:07:45 INFO - PROCESS | 6553 | |4;audio-oscillator;83;70;95;68;69;69;92;67;68;89 15:07:45 INFO - PROCESS | 6553 | |5;imaging-gaussian-blur;85;84;88;84;88;83;89;90;134;82 15:07:45 INFO - PROCESS | 6553 | |6;imaging-darkroom;93;94;93;97;99;136;149;110;101;93 15:07:45 INFO - PROCESS | 6553 | |7;imaging-desaturate;84;87;87;84;85;87;83;85;82;84 15:07:45 INFO - PROCESS | 6553 | |8;json-parse-financial;58;53;53;54;56;59;57;57;58;58 15:07:45 INFO - PROCESS | 6553 | |9;json-stringify-tinderbox;65;72;69;71;74;70;71;71;72;73 15:07:45 INFO - PROCESS | 6553 | |10;stanford-crypto-aes;83;82;83;82;84;82;83;85;91;92 15:07:45 INFO - PROCESS | 6553 | |11;stanford-crypto-ccm;140;141;139;138;137;137;141;142;174;152 15:07:45 INFO - PROCESS | 6553 | |12;stanford-crypto-pbkdf2;163;163;168;164;164;167;168;164;161;220 15:07:45 INFO - PROCESS | 6553 | |13;stanford-crypto-sha256-iterative;67;67;68;64;67;66;67;68;67;66 15:07:45 INFO - PROCESS | 6553 | __end_tp_report 15:07:45 INFO - PROCESS | 6553 | __start_cc_report 15:07:45 INFO - PROCESS | 6553 | _x_x_mozilla_cycle_collect,1979 15:07:45 INFO - PROCESS | 6553 | __end_cc_report 15:07:45 INFO - PROCESS | 6553 | __startTimestamp1477346865117__endTimestamp 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | ------- Summary: start ------- 15:07:45 INFO - PROCESS | 6553 | Number of tests: 14 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#0] ai-astar Cycles:10 Average:122.70 Median:115.50 stddev:18.56 (16.1%) stddev-sans-first:19.48 15:07:45 INFO - PROCESS | 6553 | Values: 115.0 122.0 167.0 145.0 111.0 114.0 112.0 113.0 116.0 112.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:111.00 stddev:17.16 (15.5%) stddev-sans-first:14.68 15:07:45 INFO - PROCESS | 6553 | Values: 148.0 110.0 111.0 147.0 111.0 109.0 107.0 108.0 135.0 105.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.48 (0.8%) stddev-sans-first:1.41 15:07:45 INFO - PROCESS | 6553 | Values: 183.0 185.0 184.0 184.0 184.0 183.0 187.0 186.0 187.0 185.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#3] audio-fft Cycles:10 Average:68.20 Median:66.50 stddev:12.94 (19.5%) stddev-sans-first:12.73 15:07:45 INFO - PROCESS | 6553 | Values: 82.0 59.0 59.0 91.0 72.0 61.0 58.0 58.0 84.0 58.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:76.50 stddev:11.39 (14.9%) stddev-sans-first:11.87 15:07:45 INFO - PROCESS | 6553 | Values: 83.0 70.0 95.0 68.0 69.0 69.0 92.0 67.0 68.0 89.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:86.50 stddev:15.46 (17.9%) stddev-sans-first:16.26 15:07:45 INFO - PROCESS | 6553 | Values: 85.0 84.0 88.0 84.0 88.0 83.0 89.0 90.0 134.0 82.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#6] imaging-darkroom Cycles:10 Average:106.50 Median:93.00 stddev:19.91 (21.4%) stddev-sans-first:20.51 15:07:45 INFO - PROCESS | 6553 | Values: 93.0 94.0 93.0 97.0 99.0 136.0 149.0 110.0 101.0 93.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.75 (2.1%) stddev-sans-first:1.83 15:07:45 INFO - PROCESS | 6553 | Values: 84.0 87.0 87.0 84.0 85.0 87.0 83.0 85.0 82.0 84.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.50 stddev:2.21 (3.8%) stddev-sans-first:2.26 15:07:45 INFO - PROCESS | 6553 | Values: 58.0 53.0 53.0 54.0 56.0 59.0 57.0 57.0 58.0 58.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.50 stddev:2.49 (3.5%) stddev-sans-first:1.51 15:07:45 INFO - PROCESS | 6553 | Values: 65.0 72.0 69.0 71.0 74.0 70.0 71.0 71.0 72.0 73.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.50 stddev:3.71 (4.4%) stddev-sans-first:3.89 15:07:45 INFO - PROCESS | 6553 | Values: 83.0 82.0 83.0 82.0 84.0 82.0 83.0 85.0 91.0 92.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:141.00 stddev:11.36 (8.1%) stddev-sans-first:11.95 15:07:45 INFO - PROCESS | 6553 | Values: 140.0 141.0 139.0 138.0 137.0 137.0 141.0 142.0 174.0 152.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:165.50 stddev:17.65 (10.7%) stddev-sans-first:18.53 15:07:45 INFO - PROCESS | 6553 | Values: 163.0 163.0 168.0 164.0 164.0 167.0 168.0 164.0 161.0 220.0 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - PROCESS | 6553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 15:07:45 INFO - PROCESS | 6553 | Values: 67.0 67.0 68.0 64.0 67.0 66.0 67.0 68.0 67.0 66.0 15:07:45 INFO - PROCESS | 6553 | -------- Summary: end -------- 15:07:45 INFO - PROCESS | 6553 | 15:07:45 INFO - TEST-INFO | 6553: exit 0 15:07:45 INFO - TEST-OK | kraken | took 58885ms 15:07:45 INFO - SUITE-END | took 1176s 15:07:46 INFO - Completed test suite (00:19:36) 15:07:46 INFO - javascript benchmark 15:07:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.5307030480576, 3239.611246650401, 3252.4633435483156, 3286.1291757684203, 3290.5557749703785, 5607.635503692262, 5703.629264097831, 5731.713414329277, 5735.598508104429, 5744.5117165040965, 5623.409541998092, 5697.0599851024535, 5726.226959360485, 5734.713264336777, 5745.396733343002, 5165.173572228454, 5199.558037566792, 5206.140986737184, 5206.271122042898, 5248.842534723945, 5102.69383836971, 5121.641485096045, 5128.820491282806, 5303.124984377573, 5350.063738845706, 5148.948510514903, 5206.739663016853, 5206.869828254286, 5232.529072383485, 5241.606879484035, 5183.352080989876, 5198.636095473318, 5207.869803254911, 5224.895502089975, 5255.894882102356, 5115.283860259567, 5226.242194881721, 5234.0, 5234.764435600369, 5264.499872512105, 5555.194496797982, 5568.6658800472105, 5568.832935011916, 5642.322921249435, 5748.109043098327, 6107.46191531438, 6149.046897730859, 6159.1993040904845, 6206.193194884636, 6219.440250377443, 5563.471470210324, 6239.812805615838, 6251.874662560737, 6351.396617321347, 6367.07677386781, 5485.314335708036, 5539.362973258127, 5819.156222347736, 5826.504747096545, 5864.736086876101, 6161.168242287234, 6261.749530018839, 6304.369563043659, 6316.30520642729, 6363.649999250086, 5968.120042186697, 6143.96928015357, 6188.164597779332, 6189.50483961282, 6203.906941395882, 6282.591631543935, 6303.905441418382, 6308.936910630927, 6310.5267104967315, 6322.462590679752, 5873.823785286449, 6040.214772079602, 6056.57603967718, 6099.634021958696, 6187.504999600022, 6225.533085018642, 6243.875122497525, 6250.249970003538, 6254.468370188585, 6268.435840774352, 4890.804367825318, 4945.8021679132435, 4949.925751113737, 4951.5048495150195, 4968.850934471971, 4366.126774645084, 4391.385206071152, 4405.581469760367, 4416.138852923649, 4519.480259770103, 5697.430256974352, 5741.052726300197, 5758.3090029196765, 5763.798267060716, 5780.94219057804, 6256.80358730056, 6276.748930042839, 6300.086487459293, 6324.494040476751, 6327.651979141191, 5531.751071201725, 5756.942430575725, 5787.421257874179, 5796.304443466726, 5838.5329173666005, 5299.125644268653, 5319.7340132993195, 5351.3043304370185, 5354.143337066051, 5385.973070134624, 6254.874902501924, 6305.054241863757, 6317.778877739349, 6321.273053598895, 6342.492600592034, 6332.715027823667, 6335.683215839097, 6337.0, 6339.90490142639, 6344.238691357066, 6131.724072416841, 6144.678894037804, 6166.352532983972, 6205.069239614094, 6213.440790328711, 6111.956402836337, 6117.15760190703, 6179.28938172116, 6226.25284965807, 6235.937640623717, 6205.844853878689, 6291.748330066929, 6308.621482711052, 6313.242410910537, 6323.905141422791, 5323.800549431317, 5844.15259787337, 6125.0, 6128.466687918415, 6160.199174107337, 5844.064949608042, 5940.227770389822, 5984.491318237999, 6027.367126451835, 6098.695065246631, 5873.4126587340925, 5883.852903677443, 5884.293884733688, 5887.234659494238, 5889.0, 6005.849853753516, 6027.126066720389, 6028.547858910511, 6082.695865206811, 6090.147379366804, 5728.570357223141, 5752.050911599539, 5852.4147585241135, 5891.351951285269, 5896.410358964069], "value": 5678.413392651499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.76182194368636, 509.88527581294215, 513.1942849725931, 515.4072816261297, 522.3627174846686, 24254.75745242547, 40082.59917400825, 41033.79483102584, 41112.38331425023, 44220.336694949605, 42821.0, 43284.56715432845, 43457.6962691119, 43548.34677479832, 43619.56380436195, 8750.781230469225, 9850.704478865628, 10019.74950626233, 10035.04667056632, 10053.396796192215, 8767.824643507127, 12011.63965081049, 12265.754684906296, 12293.754124917496, 12602.18085824423, 12261.938690306535, 12288.078394120432, 12305.015598752123, 12324.38378081097, 12336.93831530841, 12206.267623942547, 12306.692332691755, 12309.753804923852, 12322.383880806014, 12341.69145771354, 10258.7435314117, 11996.64010079699, 12092.972097371734, 12099.971502422304, 12102.334371609559, 40259.0, 40271.39592906109, 40327.59672403297, 40459.0, 40501.0, 3364.2598628301735, 3370.376480351143, 3383.881564145243, 3446.190145315849, 3946.6645335146545, 30838.529455778964, 31187.84406077978, 31474.842625786954, 32052.519212211602, 32446.513302300486, 3105.4720697481484, 3214.4856822908455, 3248.2529018325918, 3275.606927168755, 3298.0270820108126, 525842.0, 530321.3483932595, 532137.0, 532314.9999999962, 532826.0, 33319.66680333214, 33922.66077339245, 63649.36350636527, 64247.678761605894, 64403.67798160979, 35245.0, 35536.28927421489, 35625.82187089048, 35677.82161089178, 35687.4646880297, 15118.168500732565, 15258.618534536725, 15264.084154950739, 15266.465673701367, 15272.847271527142, 11620.76758464826, 11880.821787673192, 11906.64280071582, 12950.611481655566, 13067.0, 6326.398992095744, 7384.1877393486675, 7385.778426647209, 7673.271039251262, 7860.842783144305, 3198.1045307313525, 3246.5454836322933, 3248.0742988248708, 3263.037403965788, 3288.408086544445, 909.9363044586815, 924.713338864954, 939.3565407695751, 986.2356673577891, 1044.4046893270915, 29328.560071598942, 30259.092227233217, 30274.84862575673, 30770.076897693107, 30790.846045769627, 852.2755657690913, 1011.413380239474, 1040.7346126737634, 1111.90548803351, 1118.7930232906938, 15142.091474511564, 15618.219089045502, 15740.449084281996, 15808.68382632341, 15990.76013859793, 696769.0, 705459.0, 706819.0, 707182.0, 707494.0, 58221.0, 58615.70692146512, 58627.0, 58774.0, 58794.53013674692, 1203.8495188101488, 1231.778279909607, 1332.513632524141, 1356.7354365898752, 1380.42712274405, 29622.407551849272, 31241.37517249688, 31464.528032079994, 31538.526922095727, 32123.03630891077, 50173.74913125411, 50806.49193508018, 50807.237891430916, 50854.74572627113, 50910.236346455575, 538330.0, 539285.0, 541385.0, 542607.0, 543135.0, 26629.0, 26981.595276071268, 27349.90600375963, 27421.314467137683, 28513.00204492833, 47924.52075479201, 48274.51725482841, 48609.0, 49008.2648760276, 49652.0, 40051.599484004786, 40514.79742601268, 40949.59050409458, 41013.79493102516, 42396.78801606096, 33402.15462294137, 40082.0, 40688.98277543085, 41351.79324103481, 41522.0, 38330.80834595809, 39145.217095658496, 39187.608123919534, 39254.80372598233, 40091.79954100211, 33049.50425743568, 34539.13652158716, 35381.82309088438, 35397.64602353943, 35700.821495892356, 25857.965681372534, 25906.740932590434, 26043.95824167012, 26197.0, 26496.0], "value": 19261.364961506406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.472064821795, 351.88563716792044, 355.8292019830483, 371.7546419363219, 405.0440959335967, 14409.567712968614, 14796.260186990648, 15766.132862692562, 20077.89961050193, 20360.08379622917, 20192.495187620316, 20583.485412864688, 21346.7191968482, 21397.786022139775, 21623.891880540614, 5889.64662120272, 5921.73352199152, 6138.29409617893, 6188.350223226541, 6207.068939659042, 5980.6112602680905, 6131.049687298476, 6161.845953851167, 6166.660833654148, 6167.7841275555365, 4152.8131234094535, 4405.03089320349, 4411.338299255105, 5739.196512488255, 6106.725197366107, 6792.490563207754, 6845.0, 6880.346367095118, 6893.20728116268, 6907.965460172667, 5175.275461435402, 5438.483344082306, 5474.589405794582, 5551.167324901297, 5966.880662386728, 10953.507092180871, 12891.80662290057, 12958.15771974828, 13126.01554883378, 13127.737445251041, 2144.667576525641, 2368.5026144509675, 2395.796357309631, 2429.3881134579, 2963.866626001835, 8112.75661730149, 9141.268698504104, 9824.459654718987, 10036.24728145392, 10415.375077495375, 1770.4246120011048, 1784.5092599535233, 1796.4071856287524, 1805.2327760701648, 1889.093235247089, 112355.0, 116261.99999999916, 124156.37921810334, 124324.0, 124778.0, 11487.885121148682, 11724.824127638092, 11726.947784137741, 11753.764924701458, 11894.464749086139, 14233.85766142346, 14685.045472044283, 14686.97191196606, 14696.191709456083, 14706.117632942058, 7252.528585641917, 8664.176903194186, 8684.522351270742, 8768.912310876809, 8844.027157012724, 8165.897603823527, 8680.34897382699, 8691.304695624462, 8698.086700896441, 8861.379703420827, 4083.7549747015273, 4503.572160644799, 4534.546545345439, 4600.838970636011, 4610.05493873755, 1825.3063835742332, 1891.2529550827346, 1891.659501289781, 1892.1551487300048, 1899.1928430417017, 805.2269820971933, 870.1733353314377, 883.2536506651869, 888.6534251641865, 926.2404828040942, 20627.58744825125, 21586.676199857015, 21613.78386216149, 21625.24311649085, 21705.34883953484, 900.8063266397756, 903.6159632156439, 932.3613324872484, 954.1603389017758, 1009.2481101579224, 9128.45229286245, 10747.301425407324, 11275.436228188557, 11316.6039188628, 11370.976612104785, 488326.0, 561926.0, 565136.0, 568899.0, 571781.0, 104831.0, 125171.74828251783, 130431.34784326017, 141127.99999999793, 141417.0, 864.6757465950269, 947.5925352098664, 983.2478154212033, 1022.1516141602303, 1024.702836177515, 19262.518437039187, 19741.40775776729, 20201.0, 20217.595648086663, 20239.79760202379, 56072.719636401554, 57345.42654573401, 57439.712801437396, 57493.71253143708, 59805.40194597998, 78164.0, 80704.0, 85465.86335341666, 86974.56512717396, 86988.0, 7951.3638908886, 8018.879716804369, 8049.758507244792, 8282.751517454486, 8316.584170791315, 12387.75224495523, 12664.366781661065, 12779.936100319439, 12838.743225135631, 13228.801567976296, 7781.455298129303, 7930.9603451982375, 8051.436399451982, 8060.992375953006, 8887.955560222157, 6119.388061193845, 7564.4704870658525, 7887.0, 7988.960055199686, 8201.507909525448, 7907.84184316322, 8107.0, 8206.712765053195, 8211.58942052907, 8225.547594882339, 11950.521979120738, 12522.186057906207, 12689.619311420673, 12697.968325067945, 12959.287239201934, 7946.7615971520945, 7997.7600671979935, 8094.473859199369, 8153.369326134678, 8169.754907352789], "value": 9150.909785806989, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.77716788146, 1346.9730605387895, 1380.5789234283543, 1648.2253340929767, 1904.4381907337333, 7147.89278160828, 7811.414143939206, 8317.667293308268, 8741.0, 8965.91034089659, 8822.294216462684, 8926.37515373924, 8926.464412135276, 8938.642454301837, 8940.552972351372, 2376.8811559422047, 2392.2583998960376, 2404.7955923746504, 2405.230326295586, 2420.104561312317, 2348.729896061958, 2392.1507864708037, 2394.568977584034, 2403.230966090852, 2404.002339029301, 2350.518143780521, 2371.6679664846934, 2385.3678775124604, 2387.522495500898, 2389.7012873390827, 1998.8300994415492, 2364.267077206063, 2365.27859003004, 2370.1704403458825, 2373.181252467896, 2312.6531020346915, 2335.602947498929, 2343.8945247463903, 2347.6830627865193, 2348.8590684558812, 8770.649174033031, 8797.0, 8841.115888411172, 8862.0, 8880.111988801133, 5187.403448603422, 5214.296070030536, 5327.174287985368, 5359.1425371940695, 5435.374931882845, 2994.970050299491, 3590.622984586607, 3678.889633311005, 3679.558452985632, 3688.7233457490797, 1097.434821067151, 1101.366714139365, 1101.7465982823996, 1125.1505113639232, 1127.8815724348908, 11647.068234541217, 11741.58904438349, 11791.93872551466, 11829.645110646694, 11839.881601183964, 4425.402570652985, 4457.2645513489915, 4622.006268652256, 4640.443146822403, 4643.4660014098135, 9170.86243706345, 9181.495017774087, 9199.218066464291, 9207.76980575491, 9210.677626283183, 4523.208438523311, 5232.1628539433505, 5253.894922101536, 5265.341832270966, 5302.2046692996355, 3721.8697345593314, 4092.815823287959, 4391.121775644884, 4539.364488971547, 4909.582685471703, 3742.8315725792404, 3805.7145714071003, 3809.276237514863, 3849.7882616456363, 3864.2851072551666, 1156.8496095507699, 1158.9652310430702, 1161.0653423993597, 1169.5204965963915, 1171.1450641032095, 733.4352548537596, 808.8070096607457, 907.9773005674779, 914.4741773480275, 939.3236869454119, 5693.17448969897, 5719.48524632785, 5788.797392091256, 5885.382034886361, 5973.731182096816, 433.8828516300644, 448.5581702023504, 453.1345130800156, 463.99536004640197, 466.68265579405653, 3486.38988177068, 3869.361555343337, 3880.864169754045, 4076.3681629346906, 4080.959190408117, 10460.372377657213, 10607.469626518643, 10827.458627068772, 10925.781484370427, 11255.774884502263, 10827.83758243627, 10873.456327183609, 10902.890971090346, 10916.508757105948, 10935.125189984783, 7849.332806711379, 8106.554139522265, 8203.179682031869, 8249.546274954815, 8322.250997410141, 5884.558658100574, 5965.224520812267, 6002.87994240104, 6186.288576813724, 6222.688865556795, 10036.548355324174, 10075.193984481077, 10079.596816127272, 10092.596296148366, 10271.383716977005, 9416.152546270869, 9906.752331191778, 10251.897481025095, 10310.896891030994, 10494.632687855888, 7139.643017849191, 7306.232845551141, 7447.590382529013, 7548.0, 7664.3485303747575, 8293.170682931659, 8312.293455056388, 8396.076431592643, 8403.20169583913, 8461.788455288666, 6520.152380190545, 7550.093988721389, 7569.091708994956, 7624.847503049797, 7646.9617651911385, 6397.616143031433, 7372.778816635509, 7480.139783924918, 7519.548827070394, 7520.247975202436, 6953.20038195614, 7056.188538318159, 7061.71753129869, 7072.222055573986, 7101.11236095488, 4825.6139508838505, 4849.878753031202, 5014.197728363444, 5046.318746969112, 5164.664296820694, 4198.328267477311, 4959.280904268789, 4969.254611808257, 5050.651447077127, 5066.189409694432], "value": 4446.7008067281695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.5801474883542, 294.9675535691075, 301.41976694862393, 303.543167532863, 307.5448336462035, 4422.756748378838, 4996.300517927493, 5147.584414286069, 5341.813036543722, 5348.866278343038, 4951.900961980758, 5068.1384164692, 5116.616253780962, 5156.407013193484, 5184.766685499152, 4027.7777777777806, 4058.2492238935893, 4061.6344528992386, 4063.878083657495, 4075.755454672714, 3339.966600334002, 3625.7461977661574, 4016.5983401659746, 4042.282030137195, 4044.1102957349335, 3205.7016908152236, 3466.9653303466894, 3833.0, 3866.6326698963694, 4041.2725709372303, 3378.7803792753516, 3533.5583052118486, 3971.225611005855, 4055.3916912463073, 4066.369712694537, 3220.162757683019, 3246.480563109915, 3492.947605785915, 3526.8714011516327, 3531.4526248431534, 5182.585393168575, 5182.585393168575, 5212.322398088262, 5216.400113986864, 5217.47825217479, 3803.562590302123, 4206.894827629303, 4514.6614003949835, 4563.224251877155, 4582.1064892346, 5564.8330550083565, 5575.442455754433, 5576.9163462548095, 5582.637128586629, 5607.915881261784, 3767.3407153747985, 3776.2825063237897, 3784.280986612535, 3786.3941769316775, 3800.6697655820517, 4706.705655944608, 5066.771995260222, 5521.757604538987, 5671.659700417947, 5869.941300587025, 3400.25194457219, 3769.3780526212868, 3799.936017914988, 3823.4647149399107, 3841.4814000110186, 3401.897943061712, 3757.3612485877466, 3881.7088718346236, 3922.195949830278, 4060.796960151981, 3990.980045099756, 4035.2938235808615, 4049.230646177276, 4293.86212653647, 4568.931466027946, 5612.691301978349, 5624.85937851557, 5630.690312032795, 5630.915536266959, 5640.0, 1174.6652204121956, 1268.1186575330241, 1309.8821106100497, 1335.4858379523953, 1342.9932850335686, 826.2068414322198, 847.720252316734, 859.5788063848669, 860.6342304520554, 886.2466903132415, 4893.486183950634, 5261.447548007481, 5265.525652817218, 5320.946790532123, 5340.8664783379945, 5458.789190377904, 5712.028955077647, 5719.857003574861, 5730.684812335278, 5741.62679425836, 4969.676970996874, 5282.147640274286, 5285.207218917193, 5409.810656627078, 5425.860569280495, 2849.8056496497993, 2870.603046456191, 2958.763298936123, 3023.0, 3049.5425686147255, 4924.901501969941, 5025.321581586512, 5355.544778693777, 5612.775488980476, 5980.491658209014, 5086.54221120101, 5144.845654630367, 5268.81559145428, 5955.940440595626, 5994.220751302303, 5925.555583331267, 5993.7712768882275, 6050.364711705296, 6074.483668888194, 6128.233970753656, 4942.382202224722, 4951.48444604335, 5577.581681373832, 5740.311162660508, 5763.7982670606325, 4752.5485078917445, 4880.975595122001, 5630.5777066720975, 5757.625754325955, 5767.221425107725, 5735.76305240948, 5894.263217097863, 6000.339962604023, 6071.878562428638, 6074.179985701874, 3431.4681224410256, 3921.450996860499, 3979.900502487461, 4029.8388064478268, 4039.575844536399, 4380.5838445347645, 5085.415177254515, 5794.478496935296, 5813.709314534341, 5861.296644402699, 4223.8099285532835, 5728.94014607299, 5740.827775166752, 5744.90311036477, 5819.476247137778, 5324.577317320687, 5573.136163894603, 5585.804496842591, 5625.23109516633, 5632.211490391266, 5235.345581802275, 5488.572971027642, 5512.862178445411, 5527.226188333556, 5545.223668686468, 5355.97322013403, 5608.411116832837, 5629.718514074362, 5673.404292549388, 5678.602497825113, 5464.644798088111, 5471.534919531725, 5481.780728770805, 5502.752376143003, 5505.146702261156], "value": 4059.4994555883436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.8369640197145, 721.9278072192785, 735.6211551051206, 742.064998102391, 779.660847531324, 14825.777613335795, 15820.604484887883, 15992.200389980513, 16026.43907463239, 16030.957987730819, 14256.429742810302, 14393.352299146538, 14824.703505929874, 15074.698506029872, 15086.773698394505, 690.1097584116484, 831.0816547714763, 866.7139843851514, 873.6811063961671, 876.2639382918347, 697.979060628182, 716.0941409117471, 846.9957650211741, 870.3037569944051, 880.35294058867, 923.5474617437475, 928.0811996123823, 929.3773171974759, 931.3108299858123, 932.8460803967337, 926.9490178040205, 927.536231884058, 929.6606738540384, 930.1070971867016, 931.4225180388135, 526.3263023330144, 546.4781134017004, 659.7789740436959, 677.0, 686.7287421468542, 14897.478588249467, 15046.19445666516, 15048.645621894082, 15055.247237638183, 15075.396984120622, 13704.10923289983, 13962.511312104027, 14052.648683782885, 14149.292535373294, 14386.784198237036, 11947.94026029873, 12322.568710095104, 12509.74980500394, 12841.29372884491, 13027.609171724864, 4297.290946993742, 4535.002299494106, 4543.795529201194, 4550.522195169526, 4734.337192793012, 119639.0, 121162.39418802937, 122499.0, 123161.76838231593, 123188.76811231862, 10666.626668066736, 11095.55617775296, 11107.444627768578, 11237.662870113747, 11258.38078905668, 21830.672539911913, 21845.01697423588, 21901.12395504162, 22028.33914982553, 22031.898405080003, 7626.389888808882, 7654.349380302737, 7694.884576731353, 7723.9227607723205, 7846.372290216769, 4268.893277668021, 4341.826326946887, 4349.282368409177, 4357.694961352739, 4364.323529852878, 3454.654534546525, 3792.089898424358, 4030.858919937788, 4058.898527536835, 4067.8372865085066, 689.3279052923359, 693.0297583383303, 708.3907839258234, 708.397861817451, 717.0534893939949, 529.5684017525704, 603.5322624965687, 682.3585829320423, 688.7313947560456, 690.1511141296234, 9118.908810911938, 9355.812883742286, 9432.386894851812, 9583.568739406743, 9687.757806054764, 638.3584497579902, 638.559394018126, 646.5926466326279, 670.6378555579932, 685.4516386890567, 4587.587117159472, 4713.6464765142755, 4730.905381892343, 4789.299798571457, 4867.196912509467, 127895.0, 151922.24038879955, 160293.19853400657, 160756.0, 166005.0, 94218.0, 117145.65708685778, 125303.37348313382, 137299.0, 138860.0, 97982.53026204613, 119187.8081219194, 119562.4021879885, 120101.0, 120476.0, 8732.34507411934, 8950.53286453845, 9035.367524273237, 9077.77305567366, 9224.953875230582, 63107.36892631199, 63127.6843615779, 64425.03362449661, 64966.0, 67022.66488667525, 91055.0, 94468.0, 96065.0, 96440.0, 104260.0, 11704.531818727155, 11903.523859045888, 12351.888330050338, 12557.811632825333, 12634.167712129403, 14018.859811401755, 15343.61640958985, 15349.386024558893, 15831.525054248392, 15850.52448426549, 13484.0, 13963.720725585634, 14227.857721423068, 14401.42394304216, 14860.331285092412, 13597.796033059314, 13843.2370403633, 13981.091229070078, 14018.719625607227, 14551.563453096423, 11047.447627618747, 12672.366381681064, 12766.17019893704, 14527.782083268548, 14544.200068996306, 10699.197560182862, 10946.562137514411, 11386.487608057823, 11677.182597218452, 12342.81485777696, 9525.333226674065, 9914.553845077133, 11588.826167607323, 11716.23844450108, 11722.58970936013], "value": 7955.747722430289, "unit": "score"}], "name": "dromaeo_css", "value": 7237.733224246868, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 122.0, 167.0, 145.0, 111.0, 114.0, 112.0, 113.0, 116.0, 112.0], "value": 122.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 111.0, 147.0, 111.0, 109.0, 107.0, 108.0, 135.0, 105.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 184.0, 184.0, 184.0, 183.0, 187.0, 186.0, 187.0, 185.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 91.0, 72.0, 61.0, 58.0, 58.0, 84.0, 58.0], "value": 68.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 95.0, 68.0, 69.0, 69.0, 92.0, 67.0, 68.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 88.0, 84.0, 88.0, 83.0, 89.0, 90.0, 134.0, 82.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 97.0, 99.0, 136.0, 149.0, 110.0, 101.0, 93.0], "value": 106.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 87.0, 84.0, 85.0, 87.0, 83.0, 85.0, 82.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 53.0, 54.0, 56.0, 59.0, 57.0, 57.0, 58.0, 58.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 69.0, 71.0, 74.0, 70.0, 71.0, 71.0, 72.0, 73.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 82.0, 84.0, 82.0, 83.0, 85.0, 91.0, 92.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 139.0, 138.0, 137.0, 137.0, 141.0, 142.0, 174.0, 152.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 168.0, 164.0, 164.0, 167.0, 168.0, 164.0, 161.0, 220.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 64.0, 67.0, 66.0, 67.0, 68.0, 67.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1446.6, "alertThreshold": 2.0}]} 15:07:46 INFO - Return code: 0 15:07:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:07:46 INFO - # TBPL SUCCESS # 15:07:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:07:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:07:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:07:46 INFO - 2016-10-24 15:07:46.444 screenresolution[6557:116471] starting screenresolution argv=screenresolution get 15:07:46 INFO - 2016-10-24 15:07:46.447 screenresolution[6557:116471] Display 0: 1600x1200x32@60 15:07:46 INFO - 2016-10-24 15:07:46.453 screenresolution[6558:116474] starting screenresolution argv=screenresolution list 15:07:46 INFO - Available Modes on Display 0 15:07:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:07:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:07:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:07:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:07:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:07:46 INFO - Intel Iris: 15:07:46 INFO - Chipset Model: Intel Iris 15:07:46 INFO - Type: GPU 15:07:46 INFO - Bus: Built-In 15:07:46 INFO - VRAM (Dynamic, Max): 1536 MB 15:07:46 INFO - Vendor: Intel (0x8086) 15:07:46 INFO - Device ID: 0x0a2e 15:07:46 INFO - Revision ID: 0x0009 15:07:46 INFO - Displays: 15:07:46 INFO - Display: 15:07:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:07:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:07:46 INFO - Display Serial Number: 1600x1200 60 15:07:46 INFO - Main Display: Yes 15:07:46 INFO - Mirror: Off 15:07:46 INFO - Online: Yes 15:07:46 INFO - Rotation: Supported 15:07:46 INFO - Return code: 0 15:07:46 INFO - Running post-action listener: _resource_record_post_action 15:07:46 INFO - [mozharness: 2016-10-24 22:07:46.687400Z] Finished run-tests step (success) 15:07:46 INFO - Running post-run listener: _resource_record_post_run 15:07:46 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 2378752; Write bytes: 662625792; Read time: 21; Write time: 1900 15:07:46 INFO - TinderboxPrint: CPU usage
53.6% 15:07:46 INFO - TinderboxPrint: I/O read bytes / time
2,378,752 / 21 15:07:46 INFO - TinderboxPrint: I/O write bytes / time
662,625,792 / 1,900 15:07:46 INFO - TinderboxPrint: CPU idle
2,242.6 (46.4%) 15:07:46 INFO - TinderboxPrint: CPU system
977.5 (20.2%) 15:07:46 INFO - TinderboxPrint: CPU user
1,617.6 (33.4%) 15:07:46 INFO - TinderboxPrint: Swap in / out
366,702,592 / 0 15:07:46 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356340224; Write bytes: 357177344; Read time: 27505; Write time: 758 15:07:46 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 2378752; Write bytes: 295261696; Read time: 21; Write time: 1105 15:07:47 INFO - Running post-run listener: _upload_blobber_files 15:07:47 INFO - Blob upload gear active. 15:07:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:07:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:07:47 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'] 15:07:47 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 15:07:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:07:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:07:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:48 INFO - (blobuploader) - INFO - Done attempting. 15:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:49 INFO - (blobuploader) - INFO - Done attempting. 15:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:51 INFO - (blobuploader) - INFO - Done attempting. 15:07:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:07:51 INFO - Return code: 0 15:07:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:07:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:07:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84c6867ef709e9f120d032672528dcaa7cf13504a940af3260af97e1f59b6c1e1dcce168e28feb249425b0440b47f1a88e13760c1f3990a7c5466d3806c401de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/362b93d57d914629107e5bcb20931b3c4b8de42c306cbc06ff8a493ae66f8255e15c9c4135b36e56e010f213a7956a1e9d8501f6324f676d108cb74561824680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c7eac889515acf22d1d540bccfc96413e255c8fa596c529e9a7d7c5a3ee66b2abf52138897da0551aa7bf19f74d466176e2033d406e5baa81f8f0689fee374d"} 15:07:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:07:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:07:51 INFO - Contents: 15:07:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84c6867ef709e9f120d032672528dcaa7cf13504a940af3260af97e1f59b6c1e1dcce168e28feb249425b0440b47f1a88e13760c1f3990a7c5466d3806c401de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/362b93d57d914629107e5bcb20931b3c4b8de42c306cbc06ff8a493ae66f8255e15c9c4135b36e56e010f213a7956a1e9d8501f6324f676d108cb74561824680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c7eac889515acf22d1d540bccfc96413e255c8fa596c529e9a7d7c5a3ee66b2abf52138897da0551aa7bf19f74d466176e2033d406e5baa81f8f0689fee374d"} 15:07:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:07:51 INFO - Copying logs to upload dir... 15:07:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:07:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.706095 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-24 15:07:51.861498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 15:07:51.869137) ========= 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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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/84c6867ef709e9f120d032672528dcaa7cf13504a940af3260af97e1f59b6c1e1dcce168e28feb249425b0440b47f1a88e13760c1f3990a7c5466d3806c401de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/362b93d57d914629107e5bcb20931b3c4b8de42c306cbc06ff8a493ae66f8255e15c9c4135b36e56e010f213a7956a1e9d8501f6324f676d108cb74561824680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c7eac889515acf22d1d540bccfc96413e255c8fa596c529e9a7d7c5a3ee66b2abf52138897da0551aa7bf19f74d466176e2033d406e5baa81f8f0689fee374d"} build_url:https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/Wu8mjf94R5evynlQbHqxQw/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/84c6867ef709e9f120d032672528dcaa7cf13504a940af3260af97e1f59b6c1e1dcce168e28feb249425b0440b47f1a88e13760c1f3990a7c5466d3806c401de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/362b93d57d914629107e5bcb20931b3c4b8de42c306cbc06ff8a493ae66f8255e15c9c4135b36e56e010f213a7956a1e9d8501f6324f676d108cb74561824680", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c7eac889515acf22d1d540bccfc96413e255c8fa596c529e9a7d7c5a3ee66b2abf52138897da0551aa7bf19f74d466176e2033d406e5baa81f8f0689fee374d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 15:07:51.904623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:07:51.904992) ========= 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.Bf1lO3G1ae/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.buF6mBcGcY/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.005454 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:07:51.953535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 15:07:51.957035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 15:07:51.957519) ========= ========= Total master_lag: 0.20 =========