builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1491210241.17 results: success (0) buildid: 20170403004002 builduid: 9446648c0b89488cb2b328ef6b2ddfa4 revision: f26e2606488b9e01e63bdb8670d22bb8da77b4d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:01.166785) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:01.167276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-04-03 02:04:01.167567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-04-03 02:04:02.718107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:02.718447) ========= 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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 --2017-04-03 02:04:02-- 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% 197M=0s 2017-04-03 02:04:03 (197 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.509213 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:03.252294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:03.252613) ========= 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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.028137 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:03.302201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 02:04:03.302544) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f26e2606488b9e01e63bdb8670d22bb8da77b4d2 --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 f26e2606488b9e01e63bdb8670d22bb8da77b4d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JkmAqR9qcu/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.qWmWGJCoHm/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 2017-04-03 02:04:03,475 truncating revision to first 12 chars 2017-04-03 02:04:03,476 Setting DEBUG logging. 2017-04-03 02:04:03,476 attempt 1/10 2017-04-03 02:04:03,476 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f26e2606488b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 02:04:04,726 unpacking tar archive at: mozilla-aurora-f26e2606488b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.511656 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 02:04:04.841092) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:04.841413) ========= script_repo_revision: f26e2606488b9e01e63bdb8670d22bb8da77b4d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:04.841822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:04.842091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 02:04:04.862009) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2017-04-03 02:04:04.862393) ========= /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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:04:05 INFO - MultiFileLogger online at 20170403 02:04:05 in /builds/slave/test 02:04:05 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 02:04:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:04:05 INFO - {'append_to_log': False, 02:04:05 INFO - 'base_work_dir': '/builds/slave/test', 02:04:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:04:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:04:05 INFO - 'branch': 'Mozilla-Aurora', 02:04:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:04:05 INFO - 'config_files': ('talos/mac_config.py',), 02:04:05 INFO - 'default_actions': ('clobber', 02:04:05 INFO - 'read-buildbot-config', 02:04:05 INFO - 'download-and-extract', 02:04:05 INFO - 'populate-webroot', 02:04:05 INFO - 'create-virtualenv', 02:04:05 INFO - 'install', 02:04:05 INFO - 'run-tests'), 02:04:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:04:05 INFO - 'download_minidump_stackwalk': True, 02:04:05 INFO - 'download_symbols': 'ondemand', 02:04:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:04:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:04:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:04:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:04:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:04:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:04:05 INFO - 'gecko_profile': False, 02:04:05 INFO - 'gecko_profile_interval': 0, 02:04:05 INFO - 'installer_path': 'installer.exe', 02:04:05 INFO - 'log_level': 'info', 02:04:05 INFO - 'log_name': 'talos', 02:04:05 INFO - 'log_to_console': True, 02:04:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:04:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:04:05 INFO - 'opt_config_files': (), 02:04:05 INFO - 'pip_index': False, 02:04:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:04:05 INFO - 'cmd': ('bash', 02:04:05 INFO - '-c', 02:04:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:04:05 INFO - 'enabled': True, 02:04:05 INFO - 'halt_on_failure': False, 02:04:05 INFO - 'name': 'check_screen_resolution'},), 02:04:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:04:05 INFO - 'cmd': ('bash', 02:04:05 INFO - '-c', 02:04:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:04:05 INFO - 'enabled': True, 02:04:05 INFO - 'halt_on_failure': False, 02:04:05 INFO - 'name': 'check_screen_resolution'},), 02:04:05 INFO - 'run_cmd_checks_enabled': True, 02:04:05 INFO - 'suite': 'dromaeojs', 02:04:05 INFO - 'system_bits': '32', 02:04:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:04:05 INFO - 'title': 't-yosemite-r7-0103', 02:04:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:04:05 INFO - 'use_talos_json': True, 02:04:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:04:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:04:05 INFO - 'work_dir': 'build'} 02:04:05 INFO - [mozharness: 2017-04-03 09:04:05.152498Z] Running clobber step. 02:04:05 INFO - Running pre-action listener: _resource_record_pre_action 02:04:05 INFO - Running main action method: clobber 02:04:05 INFO - rmtree: /builds/slave/test/build 02:04:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:04:07 INFO - Running post-action listener: _resource_record_post_action 02:04:07 INFO - [mozharness: 2017-04-03 09:04:07.798152Z] Finished clobber step (success) 02:04:07 INFO - [mozharness: 2017-04-03 09:04:07.798330Z] Running read-buildbot-config step. 02:04:07 INFO - Running pre-action listener: _resource_record_pre_action 02:04:07 INFO - Running main action method: read_buildbot_config 02:04:07 INFO - Using buildbot properties: 02:04:07 INFO - { 02:04:07 INFO - "project": "", 02:04:07 INFO - "product": "firefox", 02:04:07 INFO - "script_repo_revision": "production", 02:04:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:04:07 INFO - "repository": "", 02:04:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:04:07 INFO - "buildid": "20170403004002", 02:04:07 INFO - "stage_platform": "macosx64", 02:04:07 INFO - "basedir": "/builds/slave/test", 02:04:07 INFO - "nightly_build": "True", 02:04:07 INFO - "buildnumber": 81, 02:04:07 INFO - "slavename": "t-yosemite-r7-0103", 02:04:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:04:07 INFO - "platform": "yosemite_r7", 02:04:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:04:07 INFO - "branch": "mozilla-aurora", 02:04:07 INFO - "repo_path": "releases/mozilla-aurora", 02:04:07 INFO - "revision": "f26e2606488b9e01e63bdb8670d22bb8da77b4d2", 02:04:07 INFO - "pgo_build": "False", 02:04:07 INFO - "builduid": "9446648c0b89488cb2b328ef6b2ddfa4", 02:04:07 INFO - "slavebuilddir": "test" 02:04:07 INFO - } 02:04:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:04:07 INFO - Running post-action listener: _resource_record_post_action 02:04:07 INFO - [mozharness: 2017-04-03 09:04:07.801661Z] Finished read-buildbot-config step (success) 02:04:07 INFO - [mozharness: 2017-04-03 09:04:07.801796Z] Running download-and-extract step. 02:04:07 INFO - Running pre-action listener: _resource_record_pre_action 02:04:07 INFO - Running main action method: download_and_extract 02:04:07 INFO - mkdir: /builds/slave/test/build/tests 02:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:07 INFO - trying https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:04:07 INFO - Downloading https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:04:10 INFO - Downloaded 1199 bytes. 02:04:10 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:04:10 INFO - Using the following test package requirements: 02:04:10 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:04:10 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:04:10 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:04:10 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'jsshell-mac.zip'], 02:04:10 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:04:10 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:04:10 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:04:10 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:04:10 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:04:10 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:04:10 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:04:10 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:04:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:04:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:04:10 INFO - Fetch https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:04:12 INFO - Expected file size: 51788798 02:04:12 INFO - Obtained file size: 51788798 02:04:28 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:04:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:04:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:04:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:05:00 INFO - retry: attempt #1 caught exception: '' 02:05:00 INFO - retry: Failed, sleeping 60 seconds before retrying 02:06:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #2 02:06:00 INFO - Fetch https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:06:02 INFO - Expected file size: 51788798 02:06:02 INFO - Obtained file size: 51788798 02:06:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:06:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:06:17 INFO - Fetch https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:06:18 INFO - Expected file size: 14404438 02:06:18 INFO - Obtained file size: 14404438 02:06: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')]} 02:06:19 INFO - trying https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:06:19 INFO - Downloading https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:06:21 INFO - Downloaded 74753269 bytes. 02:06:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:06:21 INFO - mkdir: /builds/slave/test/properties 02:06:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:21 INFO - Contents: 02:06:21 INFO - build_url:https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:06:22 INFO - Running post-action listener: _resource_record_post_action 02:06:22 INFO - Running post-action listener: set_extra_try_arguments 02:06:22 INFO - [mozharness: 2017-04-03 09:06:22.124868Z] Finished download-and-extract step (success) 02:06:22 INFO - [mozharness: 2017-04-03 09:06:22.125005Z] Running populate-webroot step. 02:06:22 INFO - Running pre-action listener: _resource_record_pre_action 02:06:22 INFO - Running main action method: populate_webroot 02:06:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:22 INFO - '--tppagecycles', 02:06:22 INFO - '7'], 02:06:22 INFO - 'tests': ['tsvgm']}}, 02:06:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:06:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:06:22 INFO - 'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:06:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:06:22 INFO - 'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['damp', 'tps']}, 02:06:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:06:22 INFO - 'tests': ['damp', 'tps']}, 02:06:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['dromaeo_dom']}, 02:06:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['basic_compositor_video']}, 02:06:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:06:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['a11yr', 02:06:22 INFO - 'ts_paint', 02:06:22 INFO - 'tpaint', 02:06:22 INFO - 'sessionrestore', 02:06:22 INFO - 'sessionrestore_no_auto_restore', 02:06:22 INFO - 'tabpaint']}, 02:06:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:22 INFO - 'ts_paint', 02:06:22 INFO - 'tpaint', 02:06:22 INFO - 'sessionrestore', 02:06:22 INFO - 'sessionrestore_no_auto_restore', 02:06:22 INFO - 'tabpaint']}, 02:06:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:06:22 INFO - 'ts_paint', 02:06:22 INFO - 'tpaint', 02:06:22 INFO - 'sessionrestore', 02:06:22 INFO - 'sessionrestore_no_auto_restore', 02:06:22 INFO - 'tabpaint']}, 02:06:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:06:22 INFO - 'ts_paint', 02:06:22 INFO - 'tpaint', 02:06:22 INFO - 'sessionrestore', 02:06:22 INFO - 'sessionrestore_no_auto_restore', 02:06:22 INFO - 'tabpaint']}, 02:06:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['a11yr', 02:06:22 INFO - 'ts_paint', 02:06:22 INFO - 'tpaint', 02:06:22 INFO - 'sessionrestore', 02:06:22 INFO - 'sessionrestore_no_auto_restore', 02:06:22 INFO - 'tabpaint']}, 02:06:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['a11yr', 02:06:22 INFO - 'ts_paint', 02:06:22 INFO - 'tpaint', 02:06:22 INFO - 'sessionrestore', 02:06:22 INFO - 'sessionrestore_no_auto_restore', 02:06:22 INFO - 'tabpaint']}, 02:06:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['tsvgx', 02:06:22 INFO - 'tsvgr_opacity', 02:06:22 INFO - 'tart', 02:06:22 INFO - 'tscrollx', 02:06:22 INFO - 'cart', 02:06:22 INFO - 'tsvg_static']}, 02:06:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:22 INFO - 'tsvgr_opacity', 02:06:22 INFO - 'tart', 02:06:22 INFO - 'tscrollx', 02:06:22 INFO - 'cart', 02:06:22 INFO - 'tsvg_static']}, 02:06:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:06:22 INFO - 'talos_options': ['--disable-e10s'], 02:06:22 INFO - 'tests': ['tp5o']}, 02:06:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:06:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:06:22 INFO - 'talos_options': ['--disable-e10s', 02:06:22 INFO - '--xperf_path', 02:06:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:22 INFO - 'tests': ['tp5n']}, 02:06:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:06:22 INFO - 'talos_options': ['--xperf_path', 02:06:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:22 INFO - 'tests': ['tp5n']}}, 02:06:22 INFO - 'talos.zip': {'path': '', 02:06:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:22 INFO - Running post-action listener: _resource_record_post_action 02:06:22 INFO - [mozharness: 2017-04-03 09:06:22.143588Z] Finished populate-webroot step (success) 02:06:22 INFO - [mozharness: 2017-04-03 09:06:22.143725Z] Running create-virtualenv step. 02:06:22 INFO - Running pre-action listener: _resource_record_pre_action 02:06:22 INFO - Running main action method: create_virtualenv 02:06:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:22 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 02:06:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:06:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:22 INFO - Using real prefix '/tools/python27' 02:06:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:25 INFO - Installing pip.................done. 02:06:25 INFO - Return code: 0 02:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:06:26 INFO - Reading from file tmpfile_stdout 02:06:26 INFO - Output received: 02:06:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:06:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:26 INFO - 'HOME': '/Users/cltbld', 02:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:26 INFO - 'LOGNAME': 'cltbld', 02:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:26 INFO - 'MOZ_NO_REMOTE': '1', 02:06:26 INFO - 'NO_EM_RESTART': '1', 02:06:26 INFO - 'PAGER': '/bin/cat', 02:06:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:26 INFO - 'PWD': '/builds/slave/test', 02:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:26 INFO - 'SHELL': '/bin/bash', 02:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:26 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:26 INFO - 'USER': 'cltbld', 02:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:26 INFO - 'XPC_FLAGS': '0x0', 02:06:26 INFO - 'XPC_SERVICE_NAME': '0', 02:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:26 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 02:06:26 INFO - Cleaning up... 02:06:26 INFO - Return code: 0 02:06:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:26 INFO - 'HOME': '/Users/cltbld', 02:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:26 INFO - 'LOGNAME': 'cltbld', 02:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:26 INFO - 'MOZ_NO_REMOTE': '1', 02:06:26 INFO - 'NO_EM_RESTART': '1', 02:06:26 INFO - 'PAGER': '/bin/cat', 02:06:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:26 INFO - 'PWD': '/builds/slave/test', 02:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:26 INFO - 'SHELL': '/bin/bash', 02:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:26 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:26 INFO - 'USER': 'cltbld', 02:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:26 INFO - 'XPC_FLAGS': '0x0', 02:06:26 INFO - 'XPC_SERVICE_NAME': '0', 02:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:26 INFO - Downloading/unpacking psutil>=3.1.1 02:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:30 INFO - Installing collected packages: psutil 02:06:30 INFO - Running setup.py install for psutil 02:06:30 INFO - building 'psutil._psutil_osx' extension 02:06:30 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 02:06:31 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 02:06:31 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 02:06:31 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 02:06:31 INFO - building 'psutil._psutil_posix' extension 02:06:31 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 02:06:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:06:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:06:31 INFO - ^ 02:06:31 INFO - 1 warning generated. 02:06:31 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 02:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:31 INFO - Successfully installed psutil 02:06:31 INFO - Cleaning up... 02:06:31 INFO - Return code: 0 02:06:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:31 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:31 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 02:06:31 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 02:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:31 INFO - 'HOME': '/Users/cltbld', 02:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:31 INFO - 'LOGNAME': 'cltbld', 02:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:31 INFO - 'MOZ_NO_REMOTE': '1', 02:06:31 INFO - 'NO_EM_RESTART': '1', 02:06:31 INFO - 'PAGER': '/bin/cat', 02:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:31 INFO - 'PWD': '/builds/slave/test', 02:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:31 INFO - 'SHELL': '/bin/bash', 02:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:31 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:31 INFO - 'USER': 'cltbld', 02:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:31 INFO - 'XPC_FLAGS': '0x0', 02:06:31 INFO - 'XPC_SERVICE_NAME': '0', 02:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:06:34 INFO - Installing collected packages: mozsystemmonitor 02:06:34 INFO - Running setup.py install for mozsystemmonitor 02:06:34 INFO - Successfully installed mozsystemmonitor 02:06:34 INFO - Cleaning up... 02:06:35 INFO - Return code: 0 02:06:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:35 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:35 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 02:06:35 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 02:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:35 INFO - 'HOME': '/Users/cltbld', 02:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:35 INFO - 'LOGNAME': 'cltbld', 02:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:35 INFO - 'MOZ_NO_REMOTE': '1', 02:06:35 INFO - 'NO_EM_RESTART': '1', 02:06:35 INFO - 'PAGER': '/bin/cat', 02:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:35 INFO - 'PWD': '/builds/slave/test', 02:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:35 INFO - 'SHELL': '/bin/bash', 02:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:35 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:35 INFO - 'USER': 'cltbld', 02:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:35 INFO - 'XPC_FLAGS': '0x0', 02:06:35 INFO - 'XPC_SERVICE_NAME': '0', 02:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:06:35 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 02:06:35 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 02:06:35 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 02:06:35 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 02:06:35 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 02:06:35 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 02:06:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:06:37 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 02:06:37 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 02:06:37 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 02:06:37 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 02:06:37 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 02:06:37 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 02:06:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:38 INFO - warning: no files found matching '*.txt' 02:06:38 INFO - no previously-included directories found matching 'build' 02:06:38 INFO - no previously-included directories found matching 'dist' 02:06:38 INFO - no previously-included directories found matching '.git*' 02:06:38 INFO - Installing collected packages: jsonschema, functools32 02:06:38 INFO - Running setup.py install for functools32 02:06:38 INFO - warning: no files found matching '*.txt' 02:06:38 INFO - no previously-included directories found matching 'build' 02:06:38 INFO - no previously-included directories found matching 'dist' 02:06:38 INFO - no previously-included directories found matching '.git*' 02:06:38 INFO - Successfully installed jsonschema functools32 02:06:38 INFO - Cleaning up... 02:06:38 INFO - Return code: 0 02:06:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:38 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 02:06:38 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 02:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:38 INFO - 'HOME': '/Users/cltbld', 02:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:38 INFO - 'LOGNAME': 'cltbld', 02:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:38 INFO - 'MOZ_NO_REMOTE': '1', 02:06:38 INFO - 'NO_EM_RESTART': '1', 02:06:38 INFO - 'PAGER': '/bin/cat', 02:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:38 INFO - 'PWD': '/builds/slave/test', 02:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:38 INFO - 'SHELL': '/bin/bash', 02:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:38 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:38 INFO - 'USER': 'cltbld', 02:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:38 INFO - 'XPC_FLAGS': '0x0', 02:06:38 INFO - 'XPC_SERVICE_NAME': '0', 02:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:06:39 INFO - Cleaning up... 02:06:39 INFO - Return code: 0 02:06:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:39 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')]} 02:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:39 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')]} 02:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:39 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:39 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 02:06:39 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 02:06:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:39 INFO - 'HOME': '/Users/cltbld', 02:06:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:39 INFO - 'LOGNAME': 'cltbld', 02:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:39 INFO - 'MOZ_NO_REMOTE': '1', 02:06:39 INFO - 'NO_EM_RESTART': '1', 02:06:39 INFO - 'PAGER': '/bin/cat', 02:06:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:39 INFO - 'PWD': '/builds/slave/test', 02:06:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:39 INFO - 'SHELL': '/bin/bash', 02:06:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:39 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:39 INFO - 'USER': 'cltbld', 02:06:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:39 INFO - 'XPC_FLAGS': '0x0', 02:06:39 INFO - 'XPC_SERVICE_NAME': '0', 02:06:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:42 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 02:06:42 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 02:06:42 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 02:06:42 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 02:06:42 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 02:06:42 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 02:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:42 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 02:06:42 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 02:06:42 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 02:06:42 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 02:06:42 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 02:06:42 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 02:06:43 INFO - Downloading docopt-0.6.1.tar.gz 02:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:43 INFO - Running setup.py install for blobuploader 02:06:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:43 INFO - Running setup.py install for requests 02:06:44 INFO - Running setup.py install for docopt 02:06:44 INFO - Successfully installed blobuploader requests docopt 02:06:44 INFO - Cleaning up... 02:06:44 INFO - Return code: 0 02:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:44 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:44 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 02:06:44 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 02:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:44 INFO - 'HOME': '/Users/cltbld', 02:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:44 INFO - 'LOGNAME': 'cltbld', 02:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:44 INFO - 'MOZ_NO_REMOTE': '1', 02:06:44 INFO - 'NO_EM_RESTART': '1', 02:06:44 INFO - 'PAGER': '/bin/cat', 02:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:44 INFO - 'PWD': '/builds/slave/test', 02:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:44 INFO - 'SHELL': '/bin/bash', 02:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:44 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:44 INFO - 'USER': 'cltbld', 02:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:44 INFO - 'XPC_FLAGS': '0x0', 02:06:44 INFO - 'XPC_SERVICE_NAME': '0', 02:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-EZMhs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Fr0jmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Gio1t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-z_JpAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-lAQAzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NYNdC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-jIg2wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eoscn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-y7AN_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-hTK3WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ThkTpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-LSW_vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-0yrQgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:45 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-vGQE1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:46 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-x9gegT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:46 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-356N91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:46 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ob5BNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:46 INFO - Running setup.py install for manifestparser 02:06:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:46 INFO - Running setup.py install for mozcrash 02:06:46 INFO - Running setup.py install for mozdebug 02:06:46 INFO - Running setup.py install for mozdevice 02:06:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:46 INFO - Running setup.py install for mozfile 02:06:47 INFO - Running setup.py install for mozhttpd 02:06:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:47 INFO - Running setup.py install for mozinfo 02:06:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:47 INFO - Running setup.py install for mozInstall 02:06:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:47 INFO - Running setup.py install for mozleak 02:06:47 INFO - Running setup.py install for mozlog 02:06:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:47 INFO - Running setup.py install for moznetwork 02:06:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:48 INFO - Running setup.py install for mozprocess 02:06:48 INFO - Running setup.py install for mozprofile 02:06:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:48 INFO - Running setup.py install for mozrunner 02:06:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:48 INFO - Running setup.py install for mozscreenshot 02:06:48 INFO - Running setup.py install for moztest 02:06:48 INFO - Running setup.py install for mozversion 02:06:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:48 INFO - Cleaning up... 02:06:48 INFO - Return code: 0 02:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:48 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')]} 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:48 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')]} 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:48 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:48 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 02:06:48 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 02:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:48 INFO - 'HOME': '/Users/cltbld', 02:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:48 INFO - 'LOGNAME': 'cltbld', 02:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:48 INFO - 'MOZ_NO_REMOTE': '1', 02:06:48 INFO - 'NO_EM_RESTART': '1', 02:06:48 INFO - 'PAGER': '/bin/cat', 02:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:48 INFO - 'PWD': '/builds/slave/test', 02:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:48 INFO - 'SHELL': '/bin/bash', 02:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:48 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:48 INFO - 'USER': 'cltbld', 02:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:48 INFO - 'XPC_FLAGS': '0x0', 02:06:48 INFO - 'XPC_SERVICE_NAME': '0', 02:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-FZKrHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:49 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)) 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-hRY4ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-v68lMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:49 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)) 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-iDqxM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-c4u7pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:49 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)) 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-gfgty4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:49 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)) 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Cw9rvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:49 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)) 02:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-8rs7yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:50 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-cgzxqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:50 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-UzK4I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:50 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-vqBpz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:50 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-GMjoPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-I71_X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:50 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Yj8aw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-pCfjEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:50 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-gOcabf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-M7nU7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:51 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)) 02:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:51 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)) 02:06:51 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:06:51 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:06:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:51 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 02:06:51 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 02:06:51 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 02:06:51 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 02:06:51 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 02:06:51 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 02:06:53 INFO - Downloading blessings-1.6.tar.gz 02:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:53 INFO - Installing collected packages: blessings 02:06:53 INFO - Running setup.py install for blessings 02:06:53 INFO - Successfully installed blessings 02:06:53 INFO - Cleaning up... 02:06:54 INFO - Return code: 0 02:06:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:54 INFO - Reading from file tmpfile_stdout 02:06:54 INFO - Current package versions: 02:06:54 INFO - blessings == 1.6 02:06:54 INFO - blobuploader == 1.2.4 02:06:54 INFO - docopt == 0.6.1 02:06:54 INFO - functools32 == 3.2.3-2 02:06:54 INFO - jsonschema == 2.5.1 02:06:54 INFO - manifestparser == 1.1 02:06:54 INFO - mozInstall == 1.12 02:06:54 INFO - mozcrash == 1.0 02:06:54 INFO - mozdebug == 0.1 02:06:54 INFO - mozdevice == 0.49 02:06:54 INFO - mozfile == 1.2 02:06:54 INFO - mozhttpd == 0.7 02:06:54 INFO - mozinfo == 0.9 02:06:54 INFO - mozleak == 0.1 02:06:54 INFO - mozlog == 3.4 02:06:54 INFO - moznetwork == 0.27 02:06:54 INFO - mozprocess == 0.25 02:06:54 INFO - mozprofile == 0.28 02:06:54 INFO - mozrunner == 6.13 02:06:54 INFO - mozscreenshot == 0.1 02:06:54 INFO - mozsystemmonitor == 0.3 02:06:54 INFO - moztest == 0.8 02:06:54 INFO - mozversion == 1.4 02:06:54 INFO - psutil == 3.1.1 02:06:54 INFO - requests == 1.2.3 02:06:54 INFO - wsgiref == 0.1.2 02:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:54 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')]} 02:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:54 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')]} 02:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:54 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:54 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 02:06:54 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 02:06:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:54 INFO - 'HOME': '/Users/cltbld', 02:06:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:54 INFO - 'LOGNAME': 'cltbld', 02:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:54 INFO - 'MOZ_NO_REMOTE': '1', 02:06:54 INFO - 'NO_EM_RESTART': '1', 02:06:54 INFO - 'PAGER': '/bin/cat', 02:06:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:54 INFO - 'PWD': '/builds/slave/test', 02:06:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:54 INFO - 'SHELL': '/bin/bash', 02:06:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:54 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:54 INFO - 'USER': 'cltbld', 02:06:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:54 INFO - 'XPC_FLAGS': '0x0', 02:06:54 INFO - 'XPC_SERVICE_NAME': '0', 02:06:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 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)) 02:06:54 INFO - Cleaning up... 02:06:54 INFO - Return code: 0 02:06:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:54 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')]} 02:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:54 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')]} 02:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:54 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 0x106068b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10606b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd593c79280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, '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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 02:06:54 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 02:06:54 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 02:06:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:06:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:54 INFO - 'HOME': '/Users/cltbld', 02:06:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:54 INFO - 'LOGNAME': 'cltbld', 02:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:54 INFO - 'MOZ_NO_REMOTE': '1', 02:06:54 INFO - 'NO_EM_RESTART': '1', 02:06:54 INFO - 'PAGER': '/bin/cat', 02:06:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:54 INFO - 'PWD': '/builds/slave/test', 02:06:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:54 INFO - 'SHELL': '/bin/bash', 02:06:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:06:54 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:06:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:54 INFO - 'USER': 'cltbld', 02:06:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:54 INFO - 'XPC_FLAGS': '0x0', 02:06:54 INFO - 'XPC_SERVICE_NAME': '0', 02:06:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:06:54 INFO - Cleaning up... 02:06:54 INFO - Return code: 0 02:06:54 INFO - Running post-action listener: _resource_record_post_action 02:06:54 INFO - Running post-action listener: _start_resource_monitoring 02:06:54 INFO - Starting resource monitoring. 02:06:54 INFO - [mozharness: 2017-04-03 09:06:54.869818Z] Finished create-virtualenv step (success) 02:06:54 INFO - [mozharness: 2017-04-03 09:06:54.870860Z] Running install step. 02:06:54 INFO - Running pre-action listener: _resource_record_pre_action 02:06:54 INFO - Running main action method: install 02:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:55 INFO - Reading from file tmpfile_stdout 02:06:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:55 INFO - Reading from file tmpfile_stdout 02:06:55 INFO - Output received: 02:06:55 INFO - Usage: mozinstall [options] installer 02:06:55 INFO - Options: 02:06:55 INFO - -h, --help show this help message and exit 02:06:55 INFO - -d DEST, --destination=DEST 02:06:55 INFO - Directory to install application into. [default: 02:06:55 INFO - "/builds/slave/test"] 02:06:55 INFO - --app=APP Application being installed. [default: firefox] 02:06:55 INFO - mkdir: /builds/slave/test/build/application 02:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:07:15 INFO - Reading from file tmpfile_stdout 02:07:15 INFO - Output received: 02:07:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:07:15 INFO - Running post-action listener: _resource_record_post_action 02:07:15 INFO - [mozharness: 2017-04-03 09:07:15.696045Z] Finished install step (success) 02:07:15 INFO - [mozharness: 2017-04-03 09:07:15.696139Z] Running run-tests step. 02:07:15 INFO - Running pre-action listener: _resource_record_pre_action 02:07:15 INFO - Running main action method: run_tests 02:07:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:07:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:07:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:07:15 INFO - 2017-04-03 02:07:15.709 screenresolution[1636:7883] starting screenresolution argv=screenresolution get 02:07:15 INFO - 2017-04-03 02:07:15.711 screenresolution[1636:7883] Display 0: 1600x1200x32@60 02:07:15 INFO - 2017-04-03 02:07:15.717 screenresolution[1637:7885] starting screenresolution argv=screenresolution list 02:07:15 INFO - Available Modes on Display 0 02:07:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:07:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:07:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:07:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:07:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:07:15 INFO - Intel Iris: 02:07:15 INFO - Chipset Model: Intel Iris 02:07:15 INFO - Type: GPU 02:07:15 INFO - Bus: Built-In 02:07:15 INFO - VRAM (Dynamic, Max): 1536 MB 02:07:15 INFO - Vendor: Intel (0x8086) 02:07:15 INFO - Device ID: 0x0a2e 02:07:15 INFO - Revision ID: 0x0009 02:07:15 INFO - Displays: 02:07:15 INFO - Display: 02:07:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:07:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:07:15 INFO - Display Serial Number: 1600x1200 60 02:07:15 INFO - Main Display: Yes 02:07:15 INFO - Mirror: Off 02:07:15 INFO - Online: Yes 02:07:15 INFO - Rotation: Supported 02:07:15 INFO - Return code: 0 02:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:15 INFO - Python 2.7.3 02:07:15 INFO - Return code: 0 02:07:15 INFO - grabbing minidump binary from tooltool 02:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:15 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 0x105e46d30>, '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 0x105d6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e3bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:15 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 02:07:15 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 02:07:15 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 02:07:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:16 INFO - Return code: 0 02:07:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:07:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:16 INFO - ENV: RUST_BACKTRACE is now 1 02:07:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:07:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 02:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --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 02:07:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JkmAqR9qcu/Render', 02:07:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:16 INFO - 'HOME': '/Users/cltbld', 02:07:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:16 INFO - 'LOGNAME': 'cltbld', 02:07:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:16 INFO - 'MOZ_NO_REMOTE': '1', 02:07:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:16 INFO - 'NO_EM_RESTART': '1', 02:07:16 INFO - 'PAGER': '/bin/cat', 02:07:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:16 INFO - 'PWD': '/builds/slave/test', 02:07:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:16 INFO - 'RUST_BACKTRACE': '1', 02:07:16 INFO - 'SHELL': '/bin/bash', 02:07:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWmWGJCoHm/Listeners', 02:07:16 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 02:07:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:16 INFO - 'USER': 'cltbld', 02:07:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:16 INFO - 'XPC_FLAGS': '0x0', 02:07:16 INFO - 'XPC_SERVICE_NAME': '0', 02:07:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 02:07:16 INFO - mozversion application_buildid: 20170403004002 02:07:16 INFO - mozversion application_changeset: f26e2606488b9e01e63bdb8670d22bb8da77b4d2 02:07:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:07:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:16 INFO - mozversion application_name: Firefox 02:07:16 INFO - mozversion application_remotingname: firefox-dev 02:07:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:07:16 INFO - mozversion application_vendor: Mozilla 02:07:16 INFO - mozversion application_version: 54.0a2 02:07:16 INFO - mozversion platform_buildid: 20170403004002 02:07:16 INFO - mozversion platform_changeset: f26e2606488b9e01e63bdb8670d22bb8da77b4d2 02:07:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:07:16 INFO - mozversion platform_version: 54.0a2 02:07:16 INFO - using testdate: 1491210436 02:07:16 INFO - actual date: 1491210436 02:07:16 INFO - starting webserver on 'localhost:49253' 02:07:16 INFO - SUITE-START | Running 2 tests 02:07:16 INFO - TEST-START | dromaeo_css 02:07:16 INFO - operating with platform_type : mac_ 02:07:16 INFO - Initialising browser for dromaeo_css test... 02:07:16 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpPK8yGc/profile http://localhost:49253/getInfo.html) 02:07:19 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 02:07:19 INFO - PROCESS | 1647 | colorDepth:24 02:07:19 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 02:07:19 INFO - PROCESS | 1647 | __metrics 02:07:19 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:07:19 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:20 INFO - TEST-INFO | 1647: exit 0 02:07:20 INFO - Browser initialized. 02:07:20 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:20 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpPK8yGc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:32 INFO - PROCESS | 1651 | RSS: Main: 215535616 02:07:32 INFO - PROCESS | 1651 | 02:10:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49253/tests/dromaeo/cssquery-ext.html) 02:10:39 INFO - PROCESS | 1651 | RSS: Main: 345985024 02:10:39 INFO - PROCESS | 1651 | 02:12:22 INFO - PROCESS | 1651 | ************************* 02:12:22 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 02:12:22 INFO - PROCESS | 1651 | 02:12:22 ERROR - PROCESS | 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:12:22 INFO - PROCESS | 1651 | Full stack: 02:12:22 INFO - PROCESS | 1651 | ************************* 02:13:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-ext.html (next: http://localhost:49253/tests/dromaeo/cssquery-jquery.html) 02:13:42 INFO - PROCESS | 1651 | RSS: Main: 351866880 02:13:42 INFO - PROCESS | 1651 | 02:16:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49253/tests/dromaeo/cssquery-mootools.html) 02:16:46 INFO - PROCESS | 1651 | RSS: Main: 339202048 02:16:46 INFO - PROCESS | 1651 | 02:19:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49253/tests/dromaeo/cssquery-prototype.html) 02:19:49 INFO - PROCESS | 1651 | RSS: Main: 323919872 02:19:49 INFO - PROCESS | 1651 | 02:22:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49253/tests/dromaeo/cssquery-yui.html) 02:22:53 INFO - PROCESS | 1651 | RSS: Main: 317136896 02:22:53 INFO - PROCESS | 1651 | 02:25:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-yui.html (next: http://localhost:49253/tests/dromaeo/cssquery-dojo.html) 02:25:57 INFO - PROCESS | 1651 | RSS: Main: 583680000 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | __start_tp_report 02:25:57 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 02:25:57 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 02:25:57 INFO - PROCESS | 1651 | |i|pagename|runs| 02:25:57 INFO - PROCESS | 1651 | |0;dojo.html;3200.3439294944537;3423.9315213695727;3442.5868895732515;3467.5492186015813;3504.071421073416;5999.640021598707;6010.12853136295;6015.9699201504045;6025.035994240922;6051.485623721984;6005.849853753658;6088.299845517767;6089.634621922677;6095.695215239242;6101.87796244076;5352.090144675395;5393.6763794172275;5398.91901621476;5408.567314614841;5508.9724551377385;5281.445448227919;5308.761105750231;5358.705271210082;5503.394626591072;5503.532199763005;5401.27082843815;5449.155380915964;5465.043617366965;5476.67139971601;5511.751971161288;4474.261746811772;5487.149491828733;5488.862778430531;5499.587530935196;5503.697296648683;5222.321098257202;5327.627066105374;5400.648957817729;5401.4868587484125;5460.372057213432;5834.737436815353;5863;5926.851828704273;5975.581709280352;5979.461848433619;6382.297947225801;6420.4542613877875;6427.742890284383;6433.388828061326;6433.549651524395;6410.487161027107;6475.255345635265;6480.4491618212505;6489.643069631215;6500.187476565429;5106.540411362995;5819.9418005819825;5899.144624029577;5903.822885313361;5914.792982245687;6372.107904893319;6372.458341041063;6401.103845461639;6468.741250349934;6469.159009328757;6351.301356850743;6358.841028974312;6364.236291644939;6364.681765911686;6369.7452101915405;6468.256150542654;6483.027545868157;6486.54594178403;6492.837679058061;6506.154199953976;6245.281792593819;6301.6219026858535;6378;6387.425131738166;6390.808275751735;6262.405071518198;6308.779192728232;6318.083877837687;6337.524685648595;6350.809475715736;5080.339555857715;5158.458361872024;5171.3535808024;5174.09453345663;5200.271961925334;4593.173228818845;4610.53894610543;4624.421947256593;4628.375169352162;4644.790984405709;5792.218050563204;5860.765569377178;5928.258967629046;5941.7623295067715;5945.40545945402;6288.779892703734;6292.150559674477;6294.905576416358;6305.779297724649;6312.842178945563;5912.645241285537;5920.79277225295;5927.792527261525;5938.109283607407;5951.55363347742;5522.978249023943;5573.27547418833;5575.358833734092;5579.581531385163;5587.05020146576;6541.443977261986;6573.1783527059115;6662.533622646368;6670.299618539983;6691.330866913269;5341.545968592558;6432.549721519449;6472.644004579794;6474.417302442803;6474.902876456951;6663.46692264608;6666;6682.565633233824;6685.0306705526455;6690.130283063365;6239.344868788893;6283.654399007915;6294.181756371642;6308.589941653778;6358.904616430665;6239.532035097295;6438.098666186831;6454.838629034311;6484.383983521558;6490.643014634241;5988;6137.775380989496;6222.346653601307;6294.464970477561;6298.7480500781285;6290.119383286252;6313.3686631336495;6313.463355614824;6314.715837787402;6318.178636777189;6091.329953705177;6122.020476723703;6123.877522449615;6327.873442531031;6330.8100756977365;6190.319064902767;6251;6277.2781130170615;6303.49572034227;6323.08315294289;6277.529185311211;6309.526785491014;6324.177856878577;6336.809895703136;6342.556021078481 02:25:57 INFO - PROCESS | 1651 | |1;ext.html;686.8282929267683;796.3151689546985;803.734767526716;856.8243510080434;858.9914100858994;39750.60249397505;40842;42472.36291455631;42513.93715157123;42627.78686106565;41787;42093.7895310523;42102.36846447306;42282.788586057024;42447.78776106123;7237.9276207238045;9203.21772649324;9371.250299975985;9381.437113773196;9391.577379017961;7311.415086793044;10309.948450257738;10750.731231719192;11044;11276.492557834876;11175.161862860317;11180.832287515694;11200.215984881062;11202.887971120306;11259.21185517014;7296.452766042515;11141.164412669043;11177.608783692573;11179.552817887276;11198.608048718255;7331.120265568166;10703.625373111903;10898.727531811768;10907.454627268606;10910.127189824794;39282.41076383857;39598;39602.20795584101;39612.80193599014;39621;3762.473253744478;3789.3179227738997;3804.6956243500454;3820.8280627371837;3828.1003964068423;27737.306567335778;28949.276268093254;29651.110466686034;29859.805607775663;30169.849150754326;2836.4610723962383;2874.6837847836723;2882.437924604703;2884.365439603284;2890.913272601825;361818;363426;363951;364083.1795841004;364137;42043.78978105151;42781.930451738954;52128;52278;52359;44760.55239447629;51645.48354516482;52179;52436;52752;14817.77773333401;14860.405583776528;14873.553793386216;14874.479393221185;14910.70178596422;12619.558315459099;12643.304618246084;12649.683757906127;12658.683532911751;12670;11940.343281119622;11957.864002919709;11971.880281197251;11979.520819167135;12075.51697932073;5308.57531397495;5361.222622719762;5380.461953804588;5390.568754499631;5398.271233383522;1111.9610813621484;1113.1206346985791;1137.7838210739933;1156.2311063142915;1160.22265082395;26099.608505872427;26862.731372686412;26992;27067;27150.45699086007;1201.2732296960214;1212.2908098762323;1247.7379750252549;1289.8387701537308;1291.754566632337;13345.399457024458;13705.642117681233;13861.58415247524;13915.860841391659;13929.024968252328;466445;469391;469556.65221673675;469735;469805;55518.16722749162;55572.44427555673;55638.721806390706;55709.88580228373;55783.16325255125;1202.4769225386985;1463.4877792772445;1468.1998310920574;1473.4695509616315;1475.697482016184;23816.761832381453;25402.237932862045;26494.735052649998;26526.7347326532;26557.203283901516;39097.6090239094;45635.315470267305;45653.85865353393;45679.172833086304;45687.771561141984;422391;422860;423574;423719;424464;24559;28945.85527072351;29461.558076629295;30308.545371819;33559.83220083884;37162.62837371592;38055.61944380632;38264;38818.61181388263;39211;26987.05545305905;27375.726242737317;27829.304267393476;28071;28254;27894;28606.713932860406;28705;28828.42343153167;29065.564016539345;32135.839320803247;32170.517442237917;32231.033069007968;32730;32772.180695482806;28137.57793633138;28148.577771333858;28508.859645613942;28666.42667146687;28849.85575072111;21555.568888622453;22364.664530032387;22769;22907;22984.195553156227 02:25:57 INFO - PROCESS | 1651 | |2;jquery.html;379.05993137020204;425.53191489361706;427.78521774930084;431.61154960535526;438.8639521748256;15618.843811561881;19109.331173408933;20504.769713817182;20567.897160514196;21921.780782192174;21966.560668786613;22360.664590031123;22897.885510572425;23052.538949221005;23162.65256021157;6758.087658166134;6912.516123871331;6973.02377667127;7065.364117229448;7420.666070026862;4096.5903409659095;7608.391328693691;7669.578173200472;7673.923260767377;7675.692972281102;4199.3281075028;7114.928850711504;7429.665665045059;7554;7559.773206803805;7268.491205615609;7519;7649.120351159632;7714.575698336589;7749.883751743729;7207.351338379519;7437.3306402423505;7509.173990861001;7517.661705223278;7520.21037791035;25401.491970160492;25546.48907021868;25979.61030584543;26878.193654190407;27219.455610887868;2859.3137646964788;2905.491538980691;2908.970910290891;2920.5765164051095;2992.730654241107;15357.846421535865;16374.590635234095;16466.01203927768;16564.503064908073;16941.407050753165;2019.4446527205137;2044.3049363216428;2052.7639321477923;2084.260087668886;2088.56140210556;154637.68043479355;154640;162440;162769.55845662326;162856.55715164164;14897.796973650717;19646.70529942052;19861.60276794485;19959.501012474513;20345.49136271605;26664.466710665678;31317.68682313193;31321.530177047363;32317;32673.019809405756;9994.300398972002;10415.427151506588;10522.947385263025;10538.736531586772;10693.358398496115;8772.38593298463;8789.428687135316;8790.208881200722;8901.554922253861;8997.505137217517;9378.249740020781;9405.764855878659;9498.86013678363;9582.377145485521;9604.327697061279;3942.4677668514955;4028.576999415078;4040.575739547364;4051.6961227907436;4060.5127384713433;685.3626127701186;858;897.5601955041982;927.6521304510809;936.9672061477952;17343.479695609152;18210.543156547443;20765.857877816565;21266.468338291357;21534.78465215359;931.897491275959;941.4163218804385;942.0908822985851;946.7337684986823;953.2564599612314;10292.433916134534;10988.395638239974;11065.004149626573;11153.944230278797;11268.21122521432;767901;773452;779726;781459.8343074576;806137.9693101614;151221;156200;160314;161230;161618;1173.1553281637207;1203.332150656394;1228.9783306460822;1230.7661544306552;1235.184778046485;14076.648083797987;14500.274986250855;17877.821221788137;18483.353082642043;18605.90697046506;38861.61138388693;61924.38075619186;62451.687741561;63099.369006311186;64323.678381607795;83592;85977.71033434628;86674;87216.56391718001;87635.56182219049;7462.925370746223;10054.447005414773;11237.831432528683;11266.94366528162;11284.21010529288;12841.93579032099;12847.93576032114;13018.088733788543;13271.203727776365;13375.598732038054;9136.96013495081;11003.284786488852;11259.662210133709;11325.660230193107;11368.431578421212;9501.287403444907;10229.232807539316;10466.058054775107;10556.841647375142;10567.260291779501;10634;11296.548138074386;11340.94329528347;11381.260218085798;11685.298882067103;10956.506957186786;11331.773364532499;11378.951788678118;11660.18378713482;11691.356975366436;8813.471191728517;10662.360258384522;10976.560937562408;11004.779904401707;11277 02:25:57 INFO - PROCESS | 1651 | |3;mootools.html;1552.8835337349701;1557.7974863267773;1583.4537084705773;1597.896136751111;1616.0949868073878;9435.679004939297;10778.892211077888;11201.887981120186;11227.214095013353;11235.0450211732;10696.73258168546;10886.673399797999;11053.336799792018;11124.666260012213;11186.272892261997;1992.7010948357754;2447.4493239021167;2448.1676230081857;2451;2455.3493324269084;1997.7802441731399;2348.3307257431634;2425.6240282756203;2433.85396876188;2437.81716371272;2354.9411264718347;2415.3478560788576;2417.2023232333377;2424.9757502424927;2426.575349313872;2349.330440824374;2396.7363590005084;2407.4462873539183;2409.831311808174;2430.283066495388;2407.903683852644;2420.636904464327;2429.4290841652196;2429.914952976655;2434.6713193718797;11013.83479247812;11227.933346332167;11231.045361144312;11235.606753763579;11252.887471125267;5826.766929322822;5997.460228579405;6004.639721616717;6012.669303188323;6014.30835453924;3575.106223444139;3614.042278796121;3661.6155303692994;3694.261147770457;3698.204885949534;1166.1953252256;1179.097990037622;1201.1651901928165;1228.9938550307281;1231.2735486063177;12153.878461215363;13553.525626603021;14188.716225675635;15395.769063464057;15575.532734017997;4676.392069031072;4825.276208568743;4851.805927762921;4856.975715121402;4891.608671306287;11973.922346988813;11974.64076077719;11978.281303121841;12006.75986480283;12012.819807702892;4952.083864485082;5127.897442051138;5168;5667.206591077253;5838;5096.980603879239;5277.525022747971;5339.7063161526485;5428.782848686087;5429;3964.8810535683974;3967.5238971323624;4015.9799201004394;4051.4327994080854;4052.8378864845668;1041.963246569668;1047.2773786087575;1048.5596049659162;1059.279689810936;1066.2855886556026;901.8962819275736;919.405125957503;927.8561822917459;931.7763736703142;974.9025097490194;5911.935851546763;6484.739748024928;6517.250516190604;6563.442107420923;6623.635700036448;897.4301318662697;990.782027953849;997.4613708597276;1003.5935446144323;1040.256216804988;4334.5882141196535;4476.328550717419;4517.6160026397465;4655.208614535537;4677.4854765975715;13528.864711352957;13965.86034139666;13983.161010339412;14001.439942402394;14055.156690598596;11454.026407755435;12696.80954785679;13001.934990325177;13024.674383140497;13916.51292204768;9941;10209.642662506776;10219.642312519027;10219.795604087876;10234.6417875374;6391.7123729433215;6639.867202656016;6808.183018037867;6830.965845170742;6834.726610935507;12033.338166400581;12101.576444824388;12180.634580962585;12265.877341226473;12364.938175309066;12300.569480068154;12330.445129968994;12481.687957801129;12489.0633202512;12606.180598261084;8781.03408625038;9103.590338434655;9159.313051521029;9286.30352723562;9287.48918809472;8415.915840841759;10325.793484130425;10413.687589372332;10433.373997560171;10454.215933805148;8129.430939834155;8137.430379873352;8142.307903828241;8154.75535733929;8335.958320208603;8339.874901876356;8385.37109716786;8453.873191902003;8501.93725784277;8543.273821725223;7753.302202801775;7909.24862138096;7921.960390198012;7923.286904178421;7928.960355198187;5661.915071274017;5708.54331653475;5800.76796928135;5916.112583112395;5923.111533270044;4854.781534831011;5616.354119276336;5825;5953.613015154001;5981.671008094597 02:25:57 INFO - PROCESS | 1651 | |4;prototype.html;374.9306378320011;375.24201113750223;379.4081233276088;383.7064645546156;385.62209035145565;4785.545373189546;4817.181079216532;5107.310513080733;5221.86945326367;5258.710770907604;4335.978320108403;4822.744647363024;4829.468758436569;5008.973160502097;5083.517065878745;3781.8109094545302;4245.002424430257;4287.678424118188;4383.671224658164;4458.598726114657;3777.7166712496537;3843.2121415109973;4030.6976976726864;4223.007593215591;4244.623011113787;3294.324663444;3782.6784723298415;3949.545802232751;4292.570742925714;4313.374560688699;3701.926441332024;3967.523897132334;4141.571157950502;4314.827406903752;4325.307950727884;3387.271736576648;3396.490526421032;3667.504886840269;3817.9618203817886;3922.9803850980848;4458.8885277867985;4643.791029403685;5041.1682072458;5069.2625981969695;5078.587670856351;4208.494980602347;4533.659975501851;4877.000214955926;4959.189895688084;5055.216441451581;4666.080492386412;4676.602488788423;5199.400299850075;5226.529612334908;5496.917546236809;4228.175505776375;4402.141582391435;4415.094905544356;4415.757133357664;4460.843870464518;5096.464871188509;5153.587712982952;5214.947850521522;5532.8462776217575;5538.252335934597;3760.6615404613717;4057.5333836609166;4179.766968744228;4296.505901821331;4485.259932111165;3862.2854771866732;4422.295239141536;4599.471060827981;4613.884652883705;4624.722516649012;4419.779011049499;4454.507739907167;4765.237561990065;4909.68087074339;4959.958408734206;4746.199742152078;5284.497972692588;5341.584480112773;5389.649672771257;5468.179773034077;1319.6766792135988;1412.7386433509835;1434.9480243252249;1561.3754498200583;1574.4725516951721;1052.6052730226165;1065.627030539305;1089.4692956396275;1152.8040233160382;1173;4605.585497305258;4888.388951381077;4955.776990035457;5028.468684447079;5081.263216833612;5126.436092029874;5544.63959842609;5591.8881622368135;5766.7234480449915;5774.88450230993;3894.844206231776;4553.225951588238;4802.855914322576;5172.405173405032;5181.274621552986;2404.446977195255;2654.309879431323;2752.234004825178;2934.3544420227518;2965.644122705246;5653.943460565424;5689.829305120853;5940.049592065248;5962.642241465526;5970.731317090741;4686.461056978491;5283.709395983181;5631.802886898939;5817.331006934172;5822.438127224008;5809.8547536311935;5812.651240925474;5825.79609713658;5845.561582881216;5859.648421094748;4746.691465054761;4948.38145231846;5394.514493695587;5546.500814926676;5666.518345940642;4613.908681183682;5219.582433405394;5577.020157844069;5602.971985140048;5603.7758489659955;4933.950660493493;5179.663321884065;5293.841184764463;5883.911741323969;5907.49786268172;3999.340108882002;4001.91996160081;4330.675199360124;4523.344115103358;4548.499665036909;5192.5586325162785;5378.0101362496125;5537.5634720722755;5543.0344765550235;5662.2639056922335;4812.339742788732;5479.493139386701;5515.25544051564;5530.640508366943;5541.778328866801;5065.289280968587;5199.974000129975;5499.312585926759;5516.365617953827;5518.558515318845;5030.798768049237;5037.823676171463;5287.814926477555;5332.013577488177;5341.359036915595;4818.060982800419;4926.655134140576;5097;5407.215953686772;5482.506574408163;4550.476695180097;4703.059388122458;4753.243118991046;5123.026624941249;5363.624546281723 02:25:57 INFO - PROCESS | 1651 | |5;yui.html;647.8639485708001;734.1740541890373;736.4881407421838;818.2431251092739;827.4662842466607;15386;15488.690226195484;16511.66976660466;16520.42178523752;16584.75122873158;14487.637809054779;14579;14978;14992.625184370396;15070.664047072722;923.7644400677834;948.5494390164686;948.6869333120054;951.296040929714;951.5765484359463;919.237033262394;937.3953799799125;952.0099096939175;955.4506158958592;956.0487315121463;988.0218583602218;990.1682586627231;990.9207263418946;991.8561808537758;993.5826952679855;987.7382493639192;990.2474119669031;990.5245482168527;991.4596544883057;991.9008099190096;733.4755649710429;734.1227233456023;734.9007883935707;735.5733674468795;736.4587028534023;15367.077975321516;15681.05913645185;15744.527664170093;16153.030818150832;16446.83553164477;14072;14232.580713857686;14371.06588071772;14387.28063596816;14388.568342949624;11537.711557211052;11633.941830290794;11778.705532361673;11813.468393922294;11833.349165795878;3475.395101490535;3530.2409981854025;3557.3418917500344;3594.1733401317583;3709.4806727058235;83573.58213208956;119042;119977;122294.77705222923;122786;8981.640734370552;10757.83863242052;10921.563137474572;11077.446127693584;11173.206638515981;22657.88671056634;23083.769162308163;23147.958341874655;23302.417439564146;23352;5983.730732117066;7776.961115194501;7822.413319001098;7850.646720897574;7941.960290198512;3594.029612004744;3795.4876091727265;3934.409838524244;3940.940885886714;3955.4857868476915;3505.1762835733584;3797.430385442206;3862.96137038626;3865.9226815463535;3873.070463088895;668.6088638146739;678.5962352400314;679.7858674517511;686.5537400689592;698.0889938630137;668.2463985088385;698.6506746626686;701.9368256856908;720.8342081321325;726.7565365602477;9493;10357.689269321932;10377.740556486147;10397;10407.843882341771;544.276112770015;559.8992181407305;591.1162811596605;600.4715850052014;602.9065494848218;4456.598906098467;4763.499497658227;5011.1481048221885;5018.146915024455;5040.193569028937;99524;101423.47864782035;106653;108232;114227;94836;96555;98865.01134988702;99700;100731.99268007373;65058;85869;86116;87756;87848.56075719709;7600.391968642606;9619.27855410833;9631.951840240754;9632.133108020313;9641.807163856824;44570.77714611536;44909;49283.75358123187;54719.17921231105;55673;53604;66519;71772.92340614999;72016;75892.62053689697;11547.711307217387;11552;11733.834488756369;11773.88226117728;11827.408629568316;14353;14531.564053078424;14681.559553213421;15314.923425382802;15559.766603501183;13677.31613419345;13906.652333691738;14220.004988775256;14442.277886105863;14920.701585968436;13249.761116144604;13531.323433828466;14259.928700356431;14434.639134021734;14764.114153150846;13285.466773850618;13756.380962856496;13866.4453421862;14019.789703154665;14490.275486225857;9743.658971935949;9913.603455861685;10148.898511014795;10245.948770256102;10293.74265643365;9632.95183524078;9986.181391603317;11077.556897724;11246.60636877738;11477.942610286895 02:25:57 INFO - PROCESS | 1651 | __end_tp_report 02:25:57 INFO - PROCESS | 1651 | __start_cc_report 02:25:57 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1804 02:25:57 INFO - PROCESS | 1651 | __end_cc_report 02:25:57 INFO - PROCESS | 1651 | __startTimestamp1491211557064__endTimestamp 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | ------- Summary: start ------- 02:25:57 INFO - PROCESS | 1651 | Number of tests: 6 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5936.20 Median:6222.35 stddev:670.14 (10.8%) stddev-sans-first:636.90 02:25:57 INFO - PROCESS | 1651 | Values: 3200.3 3423.9 3442.6 3467.5 3504.1 5999.6 6010.1 6016.0 6025.0 6051.5 6005.8 6088.3 6089.6 6095.7 6101.9 5352.1 5393.7 5398.9 5408.6 5509.0 5281.4 5308.8 5358.7 5503.4 5503.5 5401.3 5449.2 5465.0 5476.7 5511.8 4474.3 5487.1 5488.9 5499.6 5503.7 5222.3 5327.6 5400.6 5401.5 5460.4 5834.7 5863.0 5926.9 5975.6 5979.5 6382.3 6420.5 6427.7 6433.4 6433.5 6410.5 6475.3 6480.4 6489.6 6500.2 5106.5 5819.9 5899.1 5903.8 5914.8 6372.1 6372.5 6401.1 6468.7 6469.2 6351.3 6358.8 6364.2 6364.7 6369.7 6468.3 6483.0 6486.5 6492.8 6506.2 6245.3 6301.6 6378.0 6387.4 6390.8 6262.4 6308.8 6318.1 6337.5 6350.8 5080.3 5158.5 5171.4 5174.1 5200.3 4593.2 4610.5 4624.4 4628.4 4644.8 5792.2 5860.8 5928.3 5941.8 5945.4 6288.8 6292.2 6294.9 6305.8 6312.8 5912.6 5920.8 5927.8 5938.1 5951.6 5523.0 5573.3 5575.4 5579.6 5587.1 6541.4 6573.2 6662.5 6670.3 6691.3 5341.5 6432.5 6472.6 6474.4 6474.9 6663.5 6666.0 6682.6 6685.0 6690.1 6239.3 6283.7 6294.2 6308.6 6358.9 6239.5 6438.1 6454.8 6484.4 6490.6 5988.0 6137.8 6222.3 6294.5 6298.7 6290.1 6313.4 6313.5 6314.7 6318.2 6091.3 6122.0 6123.9 6327.9 6330.8 6190.3 6251.0 6277.3 6303.5 6323.1 6277.5 6309.5 6324.2 6336.8 6342.6 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:55228.26 Median:29263.56 stddev:111672.83 (381.6%) stddev-sans-first:111911.02 02:25:57 INFO - PROCESS | 1651 | Values: 686.8 796.3 803.7 856.8 859.0 39750.6 40842.0 42472.4 42513.9 42627.8 41787.0 42093.8 42102.4 42282.8 42447.8 7237.9 9203.2 9371.3 9381.4 9391.6 7311.4 10309.9 10750.7 11044.0 11276.5 11175.2 11180.8 11200.2 11202.9 11259.2 7296.5 11141.2 11177.6 11179.6 11198.6 7331.1 10703.6 10898.7 10907.5 10910.1 39282.4 39598.0 39602.2 39612.8 39621.0 3762.5 3789.3 3804.7 3820.8 3828.1 27737.3 28949.3 29651.1 29859.8 30169.8 2836.5 2874.7 2882.4 2884.4 2890.9 361818.0 363426.0 363951.0 364083.2 364137.0 42043.8 42781.9 52128.0 52278.0 52359.0 44760.6 51645.5 52179.0 52436.0 52752.0 14817.8 14860.4 14873.6 14874.5 14910.7 12619.6 12643.3 12649.7 12658.7 12670.0 11940.3 11957.9 11971.9 11979.5 12075.5 5308.6 5361.2 5380.5 5390.6 5398.3 1112.0 1113.1 1137.8 1156.2 1160.2 26099.6 26862.7 26992.0 27067.0 27150.5 1201.3 1212.3 1247.7 1289.8 1291.8 13345.4 13705.6 13861.6 13915.9 13929.0 466445.0 469391.0 469556.7 469735.0 469805.0 55518.2 55572.4 55638.7 55709.9 55783.2 1202.5 1463.5 1468.2 1473.5 1475.7 23816.8 25402.2 26494.7 26526.7 26557.2 39097.6 45635.3 45653.9 45679.2 45687.8 422391.0 422860.0 423574.0 423719.0 424464.0 24559.0 28945.9 29461.6 30308.5 33559.8 37162.6 38055.6 38264.0 38818.6 39211.0 26987.1 27375.7 27829.3 28071.0 28254.0 27894.0 28606.7 28705.0 28828.4 29065.6 32135.8 32170.5 32231.0 32730.0 32772.2 28137.6 28148.6 28508.9 28666.4 28849.9 21555.6 22364.7 22769.0 22907.0 22984.2 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:43898.57 Median:25473.99 stddev:130394.09 (511.9%) stddev-sans-first:130718.93 02:25:57 INFO - PROCESS | 1651 | Values: 379.1 425.5 427.8 431.6 438.9 15618.8 19109.3 20504.8 20567.9 21921.8 21966.6 22360.7 22897.9 23052.5 23162.7 6758.1 6912.5 6973.0 7065.4 7420.7 4096.6 7608.4 7669.6 7673.9 7675.7 4199.3 7114.9 7429.7 7554.0 7559.8 7268.5 7519.0 7649.1 7714.6 7749.9 7207.4 7437.3 7509.2 7517.7 7520.2 25401.5 25546.5 25979.6 26878.2 27219.5 2859.3 2905.5 2909.0 2920.6 2992.7 15357.8 16374.6 16466.0 16564.5 16941.4 2019.4 2044.3 2052.8 2084.3 2088.6 154637.7 154640.0 162440.0 162769.6 162856.6 14897.8 19646.7 19861.6 19959.5 20345.5 26664.5 31317.7 31321.5 32317.0 32673.0 9994.3 10415.4 10522.9 10538.7 10693.4 8772.4 8789.4 8790.2 8901.6 8997.5 9378.2 9405.8 9498.9 9582.4 9604.3 3942.5 4028.6 4040.6 4051.7 4060.5 685.4 858.0 897.6 927.7 937.0 17343.5 18210.5 20765.9 21266.5 21534.8 931.9 941.4 942.1 946.7 953.3 10292.4 10988.4 11065.0 11153.9 11268.2 767901.0 773452.0 779726.0 781459.8 806138.0 151221.0 156200.0 160314.0 161230.0 161618.0 1173.2 1203.3 1229.0 1230.8 1235.2 14076.6 14500.3 17877.8 18483.4 18605.9 38861.6 61924.4 62451.7 63099.4 64323.7 83592.0 85977.7 86674.0 87216.6 87635.6 7462.9 10054.4 11237.8 11266.9 11284.2 12841.9 12847.9 13018.1 13271.2 13375.6 9137.0 11003.3 11259.7 11325.7 11368.4 9501.3 10229.2 10466.1 10556.8 10567.3 10634.0 11296.5 11340.9 11381.3 11685.3 10956.5 11331.8 11379.0 11660.2 11691.4 8813.5 10662.4 10976.6 11004.8 11277.0 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:6671.53 Median:2447.81 stddev:4125.82 (168.6%) stddev-sans-first:4119.47 02:25:57 INFO - PROCESS | 1651 | Values: 1552.9 1557.8 1583.5 1597.9 1616.1 9435.7 10778.9 11201.9 11227.2 11235.0 10696.7 10886.7 11053.3 11124.7 11186.3 1992.7 2447.4 2448.2 2451.0 2455.3 1997.8 2348.3 2425.6 2433.9 2437.8 2354.9 2415.3 2417.2 2425.0 2426.6 2349.3 2396.7 2407.4 2409.8 2430.3 2407.9 2420.6 2429.4 2429.9 2434.7 11013.8 11227.9 11231.0 11235.6 11252.9 5826.8 5997.5 6004.6 6012.7 6014.3 3575.1 3614.0 3661.6 3694.3 3698.2 1166.2 1179.1 1201.2 1229.0 1231.3 12153.9 13553.5 14188.7 15395.8 15575.5 4676.4 4825.3 4851.8 4857.0 4891.6 11973.9 11974.6 11978.3 12006.8 12012.8 4952.1 5127.9 5168.0 5667.2 5838.0 5097.0 5277.5 5339.7 5428.8 5429.0 3964.9 3967.5 4016.0 4051.4 4052.8 1042.0 1047.3 1048.6 1059.3 1066.3 901.9 919.4 927.9 931.8 974.9 5911.9 6484.7 6517.3 6563.4 6623.6 897.4 990.8 997.5 1003.6 1040.3 4334.6 4476.3 4517.6 4655.2 4677.5 13528.9 13965.9 13983.2 14001.4 14055.2 11454.0 12696.8 13001.9 13024.7 13916.5 9941.0 10209.6 10219.6 10219.8 10234.6 6391.7 6639.9 6808.2 6831.0 6834.7 12033.3 12101.6 12180.6 12265.9 12364.9 12300.6 12330.4 12481.7 12489.1 12606.2 8781.0 9103.6 9159.3 9286.3 9287.5 8415.9 10325.8 10413.7 10433.4 10454.2 8129.4 8137.4 8142.3 8154.8 8336.0 8339.9 8385.4 8453.9 8501.9 8543.3 7753.3 7909.2 7922.0 7923.3 7929.0 5661.9 5708.5 5800.8 5916.1 5923.1 4854.8 5616.4 5825.0 5953.6 5981.7 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4510.62 Median:4826.11 stddev:1278.49 (26.5%) stddev-sans-first:1243.83 02:25:57 INFO - PROCESS | 1651 | Values: 374.9 375.2 379.4 383.7 385.6 4785.5 4817.2 5107.3 5221.9 5258.7 4336.0 4822.7 4829.5 5009.0 5083.5 3781.8 4245.0 4287.7 4383.7 4458.6 3777.7 3843.2 4030.7 4223.0 4244.6 3294.3 3782.7 3949.5 4292.6 4313.4 3701.9 3967.5 4141.6 4314.8 4325.3 3387.3 3396.5 3667.5 3818.0 3923.0 4458.9 4643.8 5041.2 5069.3 5078.6 4208.5 4533.7 4877.0 4959.2 5055.2 4666.1 4676.6 5199.4 5226.5 5496.9 4228.2 4402.1 4415.1 4415.8 4460.8 5096.5 5153.6 5214.9 5532.8 5538.3 3760.7 4057.5 4179.8 4296.5 4485.3 3862.3 4422.3 4599.5 4613.9 4624.7 4419.8 4454.5 4765.2 4909.7 4960.0 4746.2 5284.5 5341.6 5389.6 5468.2 1319.7 1412.7 1434.9 1561.4 1574.5 1052.6 1065.6 1089.5 1152.8 1173.0 4605.6 4888.4 4955.8 5028.5 5081.3 5126.4 5544.6 5591.9 5766.7 5774.9 3894.8 4553.2 4802.9 5172.4 5181.3 2404.4 2654.3 2752.2 2934.4 2965.6 5653.9 5689.8 5940.0 5962.6 5970.7 4686.5 5283.7 5631.8 5817.3 5822.4 5809.9 5812.7 5825.8 5845.6 5859.6 4746.7 4948.4 5394.5 5546.5 5666.5 4613.9 5219.6 5577.0 5603.0 5603.8 4934.0 5179.7 5293.8 5883.9 5907.5 3999.3 4001.9 4330.7 4523.3 4548.5 5192.6 5378.0 5537.6 5543.0 5662.3 4812.3 5479.5 5515.3 5530.6 5541.8 5065.3 5200.0 5499.3 5516.4 5518.6 5030.8 5037.8 5287.8 5332.0 5341.4 4818.1 4926.7 5097.0 5407.2 5482.5 4550.5 4703.1 4753.2 5123.0 5363.6 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:21230.14 Median:3937.68 stddev:31298.81 (794.9%) stddev-sans-first:31348.46 02:25:57 INFO - PROCESS | 1651 | Values: 647.9 734.2 736.5 818.2 827.5 15386.0 15488.7 16511.7 16520.4 16584.8 14487.6 14579.0 14978.0 14992.6 15070.7 923.8 948.5 948.7 951.3 951.6 919.2 937.4 952.0 955.5 956.0 988.0 990.2 990.9 991.9 993.6 987.7 990.2 990.5 991.5 991.9 733.5 734.1 734.9 735.6 736.5 15367.1 15681.1 15744.5 16153.0 16446.8 14072.0 14232.6 14371.1 14387.3 14388.6 11537.7 11633.9 11778.7 11813.5 11833.3 3475.4 3530.2 3557.3 3594.2 3709.5 83573.6 119042.0 119977.0 122294.8 122786.0 8981.6 10757.8 10921.6 11077.4 11173.2 22657.9 23083.8 23148.0 23302.4 23352.0 5983.7 7777.0 7822.4 7850.6 7942.0 3594.0 3795.5 3934.4 3940.9 3955.5 3505.2 3797.4 3863.0 3865.9 3873.1 668.6 678.6 679.8 686.6 698.1 668.2 698.7 701.9 720.8 726.8 9493.0 10357.7 10377.7 10397.0 10407.8 544.3 559.9 591.1 600.5 602.9 4456.6 4763.5 5011.1 5018.1 5040.2 99524.0 101423.5 106653.0 108232.0 114227.0 94836.0 96555.0 98865.0 99700.0 100732.0 65058.0 85869.0 86116.0 87756.0 87848.6 7600.4 9619.3 9632.0 9632.1 9641.8 44570.8 44909.0 49283.8 54719.2 55673.0 53604.0 66519.0 71772.9 72016.0 75892.6 11547.7 11552.0 11733.8 11773.9 11827.4 14353.0 14531.6 14681.6 15314.9 15559.8 13677.3 13906.7 14220.0 14442.3 14920.7 13249.8 13531.3 14259.9 14434.6 14764.1 13285.5 13756.4 13866.4 14019.8 14490.3 9743.7 9913.6 10148.9 10245.9 10293.7 9633.0 9986.2 11077.6 11246.6 11477.9 02:25:57 INFO - PROCESS | 1651 | -------- Summary: end -------- 02:25:57 INFO - PROCESS | 1651 | 02:25:57 INFO - TEST-INFO | 1651: exit 0 02:25:57 INFO - TEST-OK | dromaeo_css | took 1121538ms 02:25:57 INFO - TEST-START | kraken 02:25:57 INFO - operating with platform_type : mac_ 02:25:57 INFO - Initialising browser for kraken test... 02:25:57 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpyF2tzZ/profile http://localhost:49253/getInfo.html) 02:26:00 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 02:26:00 INFO - PROCESS | 1656 | colorDepth:24 02:26:00 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 02:26:00 INFO - PROCESS | 1656 | __metrics 02:26:00 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:26:00 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:01 INFO - TEST-INFO | 1656: exit 0 02:26:01 INFO - Browser initialized. 02:26:01 INFO - Running cycle 1/1 for kraken test... 02:26:01 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpyF2tzZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:13 INFO - PROCESS | 1658 | RSS: Main: 215191552 02:26:13 INFO - PROCESS | 1658 | 02:26:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:16 INFO - PROCESS | 1658 | RSS: Main: 268431360 02:26:16 INFO - PROCESS | 1658 | 02:26:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-dft) 02:26:20 INFO - PROCESS | 1658 | RSS: Main: 279453696 02:26:20 INFO - PROCESS | 1658 | 02:26:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-fft) 02:26:24 INFO - PROCESS | 1658 | RSS: Main: 376184832 02:26:24 INFO - PROCESS | 1658 | 02:26:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator) 02:26:26 INFO - PROCESS | 1658 | RSS: Main: 278294528 02:26:26 INFO - PROCESS | 1658 | 02:26:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:29 INFO - PROCESS | 1658 | RSS: Main: 279322624 02:26:29 INFO - PROCESS | 1658 | 02:26:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:33 INFO - PROCESS | 1658 | RSS: Main: 320372736 02:26:33 INFO - PROCESS | 1658 | 02:26:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:36 INFO - PROCESS | 1658 | RSS: Main: 321974272 02:26:36 INFO - PROCESS | 1658 | 02:26:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial) 02:26:40 INFO - PROCESS | 1658 | RSS: Main: 318066688 02:26:40 INFO - PROCESS | 1658 | 02:26:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:42 INFO - PROCESS | 1658 | RSS: Main: 294076416 02:26:42 INFO - PROCESS | 1658 | 02:26:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:44 INFO - PROCESS | 1658 | RSS: Main: 298086400 02:26:44 INFO - PROCESS | 1658 | 02:26:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:47 INFO - PROCESS | 1658 | RSS: Main: 305123328 02:26:47 INFO - PROCESS | 1658 | 02:26:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:51 INFO - PROCESS | 1658 | RSS: Main: 318189568 02:26:51 INFO - PROCESS | 1658 | 02:26:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:55 INFO - PROCESS | 1658 | RSS: Main: 311128064 02:26:55 INFO - PROCESS | 1658 | 02:26:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49253/tests/kraken/driver.html?testName=ai-astar) 02:26:56 INFO - PROCESS | 1658 | RSS: Main: 355672064 02:26:56 INFO - PROCESS | 1658 | 02:26:56 INFO - PROCESS | 1658 | __start_tp_report 02:26:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 02:26:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 02:26:56 INFO - PROCESS | 1658 | |i|pagename|runs| 02:26:56 INFO - PROCESS | 1658 | |0;ai-astar;118;117;116;116;116;116;116;118;116;117 02:26:56 INFO - PROCESS | 1658 | |1;audio-beat-detection;141;111;111;141;111;109;108;109;128;109 02:26:56 INFO - PROCESS | 1658 | |2;audio-dft;188;182;183;184;184;203;261;207;184;187 02:26:56 INFO - PROCESS | 1658 | |3;audio-fft;82;61;62;91;61;60;59;61;76;62 02:26:56 INFO - PROCESS | 1658 | |4;audio-oscillator;85;71;101;100;101;67;83;69;67;84 02:26:56 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;90;90;86;129;102;90;90;90;91;90 02:26:56 INFO - PROCESS | 1658 | |6;imaging-darkroom;94;95;95;96;94;96;95;96;95;96 02:26:56 INFO - PROCESS | 1658 | |7;imaging-desaturate;86;84;85;87;85;85;83;86;85;83 02:26:56 INFO - PROCESS | 1658 | |8;json-parse-financial;62;61;59;60;65;64;65;63;63;63 02:26:56 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;61;59;56;64;62;58;58;57;57;57 02:26:56 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;86;82;83;86;83;82;85;86;83;90 02:26:56 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;135;139;137;127;138;138;139;141;192;145 02:26:56 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;166;169;146;217;215;163;164;166;163;165 02:26:56 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;64;65;65;65;65;66;64;65;62;64 02:26:56 INFO - PROCESS | 1658 | __end_tp_report 02:26:56 INFO - PROCESS | 1658 | __start_cc_report 02:26:56 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2146 02:26:56 INFO - PROCESS | 1658 | __end_cc_report 02:26:56 INFO - PROCESS | 1658 | __startTimestamp1491211616988__endTimestamp 02:26:56 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | ------- Summary: start ------- 02:26:57 INFO - PROCESS | 1658 | Number of tests: 14 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:116.60 Median:116.50 stddev:0.84 (0.7%) stddev-sans-first:0.73 02:26:57 INFO - PROCESS | 1658 | Values: 118.0 117.0 116.0 116.0 116.0 116.0 116.0 118.0 116.0 117.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:111.00 stddev:13.53 (12.2%) stddev-sans-first:11.45 02:26:57 INFO - PROCESS | 1658 | Values: 141.0 111.0 111.0 141.0 111.0 109.0 108.0 109.0 128.0 109.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:196.30 Median:187.50 stddev:24.35 (13.0%) stddev-sans-first:25.64 02:26:57 INFO - PROCESS | 1658 | Values: 188.0 182.0 183.0 184.0 184.0 203.0 261.0 207.0 184.0 187.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:67.50 Median:62.00 stddev:11.31 (18.2%) stddev-sans-first:10.71 02:26:57 INFO - PROCESS | 1658 | Values: 82.0 61.0 62.0 91.0 61.0 60.0 59.0 61.0 76.0 62.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:70.00 stddev:14.12 (20.2%) stddev-sans-first:14.95 02:26:57 INFO - PROCESS | 1658 | Values: 85.0 71.0 101.0 100.0 101.0 67.0 83.0 69.0 67.0 84.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:90.00 stddev:12.70 (14.1%) stddev-sans-first:13.35 02:26:57 INFO - PROCESS | 1658 | Values: 90.0 90.0 86.0 129.0 102.0 90.0 90.0 90.0 91.0 90.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 02:26:57 INFO - PROCESS | 1658 | Values: 94.0 95.0 95.0 96.0 94.0 96.0 95.0 96.0 95.0 96.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:1.30 02:26:57 INFO - PROCESS | 1658 | Values: 86.0 84.0 85.0 87.0 85.0 85.0 83.0 86.0 85.0 83.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:2.01 (3.2%) stddev-sans-first:2.13 02:26:57 INFO - PROCESS | 1658 | Values: 62.0 61.0 59.0 60.0 65.0 64.0 65.0 63.0 63.0 63.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:58.50 stddev:2.60 (4.4%) stddev-sans-first:2.65 02:26:57 INFO - PROCESS | 1658 | Values: 61.0 59.0 56.0 64.0 62.0 58.0 58.0 57.0 57.0 57.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.50 stddev:2.50 (2.9%) stddev-sans-first:2.60 02:26:57 INFO - PROCESS | 1658 | Values: 86.0 82.0 83.0 86.0 83.0 82.0 85.0 86.0 83.0 90.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:139.00 stddev:17.79 (12.8%) stddev-sans-first:18.62 02:26:57 INFO - PROCESS | 1658 | Values: 135.0 139.0 137.0 127.0 138.0 138.0 139.0 141.0 192.0 145.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:166.00 stddev:23.30 (14.0%) stddev-sans-first:24.56 02:26:57 INFO - PROCESS | 1658 | Values: 166.0 169.0 146.0 217.0 215.0 163.0 164.0 166.0 163.0 165.0 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 02:26:57 INFO - PROCESS | 1658 | Values: 64.0 65.0 65.0 65.0 65.0 66.0 64.0 65.0 62.0 64.0 02:26:57 INFO - PROCESS | 1658 | -------- Summary: end -------- 02:26:57 INFO - PROCESS | 1658 | 02:26:57 INFO - TEST-INFO | 1658: exit 0 02:26:57 INFO - TEST-OK | kraken | took 60152ms 02:26:57 INFO - SUITE-END | took 1181s 02:26:58 INFO - Completed test suite (00:19:41) 02:26:58 INFO - javascript benchmark 02:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7655.925241113839, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3200.3439294944537, 3423.9315213695727, 3442.5868895732515, 3467.5492186015813, 3504.071421073416, 5999.640021598707, 6010.12853136295, 6015.9699201504045, 6025.035994240922, 6051.485623721984, 6005.849853753658, 6088.299845517767, 6089.634621922677, 6095.695215239242, 6101.87796244076, 5352.090144675395, 5393.6763794172275, 5398.91901621476, 5408.567314614841, 5508.9724551377385, 5281.445448227919, 5308.761105750231, 5358.705271210082, 5503.394626591072, 5503.532199763005, 5401.27082843815, 5449.155380915964, 5465.043617366965, 5476.67139971601, 5511.751971161288, 4474.261746811772, 5487.149491828733, 5488.862778430531, 5499.587530935196, 5503.697296648683, 5222.321098257202, 5327.627066105374, 5400.648957817729, 5401.4868587484125, 5460.372057213432, 5834.737436815353, 5863.0, 5926.851828704273, 5975.581709280352, 5979.461848433619, 6382.297947225801, 6420.4542613877875, 6427.742890284383, 6433.388828061326, 6433.549651524395, 6410.487161027107, 6475.255345635265, 6480.4491618212505, 6489.643069631215, 6500.187476565429, 5106.540411362995, 5819.9418005819825, 5899.144624029577, 5903.822885313361, 5914.792982245687, 6372.107904893319, 6372.458341041063, 6401.103845461639, 6468.741250349934, 6469.159009328757, 6351.301356850743, 6358.841028974312, 6364.236291644939, 6364.681765911686, 6369.7452101915405, 6468.256150542654, 6483.027545868157, 6486.54594178403, 6492.837679058061, 6506.154199953976, 6245.281792593819, 6301.6219026858535, 6378.0, 6387.425131738166, 6390.808275751735, 6262.405071518198, 6308.779192728232, 6318.083877837687, 6337.524685648595, 6350.809475715736, 5080.339555857715, 5158.458361872024, 5171.3535808024, 5174.09453345663, 5200.271961925334, 4593.173228818845, 4610.53894610543, 4624.421947256593, 4628.375169352162, 4644.790984405709, 5792.218050563204, 5860.765569377178, 5928.258967629046, 5941.7623295067715, 5945.40545945402, 6288.779892703734, 6292.150559674477, 6294.905576416358, 6305.779297724649, 6312.842178945563, 5912.645241285537, 5920.79277225295, 5927.792527261525, 5938.109283607407, 5951.55363347742, 5522.978249023943, 5573.27547418833, 5575.358833734092, 5579.581531385163, 5587.05020146576, 6541.443977261986, 6573.1783527059115, 6662.533622646368, 6670.299618539983, 6691.330866913269, 5341.545968592558, 6432.549721519449, 6472.644004579794, 6474.417302442803, 6474.902876456951, 6663.46692264608, 6666.0, 6682.565633233824, 6685.0306705526455, 6690.130283063365, 6239.344868788893, 6283.654399007915, 6294.181756371642, 6308.589941653778, 6358.904616430665, 6239.532035097295, 6438.098666186831, 6454.838629034311, 6484.383983521558, 6490.643014634241, 5988.0, 6137.775380989496, 6222.346653601307, 6294.464970477561, 6298.7480500781285, 6290.119383286252, 6313.3686631336495, 6313.463355614824, 6314.715837787402, 6318.178636777189, 6091.329953705177, 6122.020476723703, 6123.877522449615, 6327.873442531031, 6330.8100756977365, 6190.319064902767, 6251.0, 6277.2781130170615, 6303.49572034227, 6323.08315294289, 6277.529185311211, 6309.526785491014, 6324.177856878577, 6336.809895703136, 6342.556021078481], "value": 5892.576867849265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.8282929267683, 796.3151689546985, 803.734767526716, 856.8243510080434, 858.9914100858994, 39750.60249397505, 40842.0, 42472.36291455631, 42513.93715157123, 42627.78686106565, 41787.0, 42093.7895310523, 42102.36846447306, 42282.788586057024, 42447.78776106123, 7237.9276207238045, 9203.21772649324, 9371.250299975985, 9381.437113773196, 9391.577379017961, 7311.415086793044, 10309.948450257738, 10750.731231719192, 11044.0, 11276.492557834876, 11175.161862860317, 11180.832287515694, 11200.215984881062, 11202.887971120306, 11259.21185517014, 7296.452766042515, 11141.164412669043, 11177.608783692573, 11179.552817887276, 11198.608048718255, 7331.120265568166, 10703.625373111903, 10898.727531811768, 10907.454627268606, 10910.127189824794, 39282.41076383857, 39598.0, 39602.20795584101, 39612.80193599014, 39621.0, 3762.473253744478, 3789.3179227738997, 3804.6956243500454, 3820.8280627371837, 3828.1003964068423, 27737.306567335778, 28949.276268093254, 29651.110466686034, 29859.805607775663, 30169.849150754326, 2836.4610723962383, 2874.6837847836723, 2882.437924604703, 2884.365439603284, 2890.913272601825, 361818.0, 363426.0, 363951.0, 364083.1795841004, 364137.0, 42043.78978105151, 42781.930451738954, 52128.0, 52278.0, 52359.0, 44760.55239447629, 51645.48354516482, 52179.0, 52436.0, 52752.0, 14817.77773333401, 14860.405583776528, 14873.553793386216, 14874.479393221185, 14910.70178596422, 12619.558315459099, 12643.304618246084, 12649.683757906127, 12658.683532911751, 12670.0, 11940.343281119622, 11957.864002919709, 11971.880281197251, 11979.520819167135, 12075.51697932073, 5308.57531397495, 5361.222622719762, 5380.461953804588, 5390.568754499631, 5398.271233383522, 1111.9610813621484, 1113.1206346985791, 1137.7838210739933, 1156.2311063142915, 1160.22265082395, 26099.608505872427, 26862.731372686412, 26992.0, 27067.0, 27150.45699086007, 1201.2732296960214, 1212.2908098762323, 1247.7379750252549, 1289.8387701537308, 1291.754566632337, 13345.399457024458, 13705.642117681233, 13861.58415247524, 13915.860841391659, 13929.024968252328, 466445.0, 469391.0, 469556.65221673675, 469735.0, 469805.0, 55518.16722749162, 55572.44427555673, 55638.721806390706, 55709.88580228373, 55783.16325255125, 1202.4769225386985, 1463.4877792772445, 1468.1998310920574, 1473.4695509616315, 1475.697482016184, 23816.761832381453, 25402.237932862045, 26494.735052649998, 26526.7347326532, 26557.203283901516, 39097.6090239094, 45635.315470267305, 45653.85865353393, 45679.172833086304, 45687.771561141984, 422391.0, 422860.0, 423574.0, 423719.0, 424464.0, 24559.0, 28945.85527072351, 29461.558076629295, 30308.545371819, 33559.83220083884, 37162.62837371592, 38055.61944380632, 38264.0, 38818.61181388263, 39211.0, 26987.05545305905, 27375.726242737317, 27829.304267393476, 28071.0, 28254.0, 27894.0, 28606.713932860406, 28705.0, 28828.42343153167, 29065.564016539345, 32135.839320803247, 32170.517442237917, 32231.033069007968, 32730.0, 32772.180695482806, 28137.57793633138, 28148.577771333858, 28508.859645613942, 28666.42667146687, 28849.85575072111, 21555.568888622453, 22364.664530032387, 22769.0, 22907.0, 22984.195553156227], "value": 18421.722839541217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.05993137020204, 425.53191489361706, 427.78521774930084, 431.61154960535526, 438.8639521748256, 15618.843811561881, 19109.331173408933, 20504.769713817182, 20567.897160514196, 21921.780782192174, 21966.560668786613, 22360.664590031123, 22897.885510572425, 23052.538949221005, 23162.65256021157, 6758.087658166134, 6912.516123871331, 6973.02377667127, 7065.364117229448, 7420.666070026862, 4096.5903409659095, 7608.391328693691, 7669.578173200472, 7673.923260767377, 7675.692972281102, 4199.3281075028, 7114.928850711504, 7429.665665045059, 7554.0, 7559.773206803805, 7268.491205615609, 7519.0, 7649.120351159632, 7714.575698336589, 7749.883751743729, 7207.351338379519, 7437.3306402423505, 7509.173990861001, 7517.661705223278, 7520.21037791035, 25401.491970160492, 25546.48907021868, 25979.61030584543, 26878.193654190407, 27219.455610887868, 2859.3137646964788, 2905.491538980691, 2908.970910290891, 2920.5765164051095, 2992.730654241107, 15357.846421535865, 16374.590635234095, 16466.01203927768, 16564.503064908073, 16941.407050753165, 2019.4446527205137, 2044.3049363216428, 2052.7639321477923, 2084.260087668886, 2088.56140210556, 154637.68043479355, 154640.0, 162440.0, 162769.55845662326, 162856.55715164164, 14897.796973650717, 19646.70529942052, 19861.60276794485, 19959.501012474513, 20345.49136271605, 26664.466710665678, 31317.68682313193, 31321.530177047363, 32317.0, 32673.019809405756, 9994.300398972002, 10415.427151506588, 10522.947385263025, 10538.736531586772, 10693.358398496115, 8772.38593298463, 8789.428687135316, 8790.208881200722, 8901.554922253861, 8997.505137217517, 9378.249740020781, 9405.764855878659, 9498.86013678363, 9582.377145485521, 9604.327697061279, 3942.4677668514955, 4028.576999415078, 4040.575739547364, 4051.6961227907436, 4060.5127384713433, 685.3626127701186, 858.0, 897.5601955041982, 927.6521304510809, 936.9672061477952, 17343.479695609152, 18210.543156547443, 20765.857877816565, 21266.468338291357, 21534.78465215359, 931.897491275959, 941.4163218804385, 942.0908822985851, 946.7337684986823, 953.2564599612314, 10292.433916134534, 10988.395638239974, 11065.004149626573, 11153.944230278797, 11268.21122521432, 767901.0, 773452.0, 779726.0, 781459.8343074576, 806137.9693101614, 151221.0, 156200.0, 160314.0, 161230.0, 161618.0, 1173.1553281637207, 1203.332150656394, 1228.9783306460822, 1230.7661544306552, 1235.184778046485, 14076.648083797987, 14500.274986250855, 17877.821221788137, 18483.353082642043, 18605.90697046506, 38861.61138388693, 61924.38075619186, 62451.687741561, 63099.369006311186, 64323.678381607795, 83592.0, 85977.71033434628, 86674.0, 87216.56391718001, 87635.56182219049, 7462.925370746223, 10054.447005414773, 11237.831432528683, 11266.94366528162, 11284.21010529288, 12841.93579032099, 12847.93576032114, 13018.088733788543, 13271.203727776365, 13375.598732038054, 9136.96013495081, 11003.284786488852, 11259.662210133709, 11325.660230193107, 11368.431578421212, 9501.287403444907, 10229.232807539316, 10466.058054775107, 10556.841647375142, 10567.260291779501, 10634.0, 11296.548138074386, 11340.94329528347, 11381.260218085798, 11685.298882067103, 10956.506957186786, 11331.773364532499, 11378.951788678118, 11660.18378713482, 11691.356975366436, 8813.471191728517, 10662.360258384522, 10976.560937562408, 11004.779904401707, 11277.0], "value": 11452.985398261038, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1552.8835337349701, 1557.7974863267773, 1583.4537084705773, 1597.896136751111, 1616.0949868073878, 9435.679004939297, 10778.892211077888, 11201.887981120186, 11227.214095013353, 11235.0450211732, 10696.73258168546, 10886.673399797999, 11053.336799792018, 11124.666260012213, 11186.272892261997, 1992.7010948357754, 2447.4493239021167, 2448.1676230081857, 2451.0, 2455.3493324269084, 1997.7802441731399, 2348.3307257431634, 2425.6240282756203, 2433.85396876188, 2437.81716371272, 2354.9411264718347, 2415.3478560788576, 2417.2023232333377, 2424.9757502424927, 2426.575349313872, 2349.330440824374, 2396.7363590005084, 2407.4462873539183, 2409.831311808174, 2430.283066495388, 2407.903683852644, 2420.636904464327, 2429.4290841652196, 2429.914952976655, 2434.6713193718797, 11013.83479247812, 11227.933346332167, 11231.045361144312, 11235.606753763579, 11252.887471125267, 5826.766929322822, 5997.460228579405, 6004.639721616717, 6012.669303188323, 6014.30835453924, 3575.106223444139, 3614.042278796121, 3661.6155303692994, 3694.261147770457, 3698.204885949534, 1166.1953252256, 1179.097990037622, 1201.1651901928165, 1228.9938550307281, 1231.2735486063177, 12153.878461215363, 13553.525626603021, 14188.716225675635, 15395.769063464057, 15575.532734017997, 4676.392069031072, 4825.276208568743, 4851.805927762921, 4856.975715121402, 4891.608671306287, 11973.922346988813, 11974.64076077719, 11978.281303121841, 12006.75986480283, 12012.819807702892, 4952.083864485082, 5127.897442051138, 5168.0, 5667.206591077253, 5838.0, 5096.980603879239, 5277.525022747971, 5339.7063161526485, 5428.782848686087, 5429.0, 3964.8810535683974, 3967.5238971323624, 4015.9799201004394, 4051.4327994080854, 4052.8378864845668, 1041.963246569668, 1047.2773786087575, 1048.5596049659162, 1059.279689810936, 1066.2855886556026, 901.8962819275736, 919.405125957503, 927.8561822917459, 931.7763736703142, 974.9025097490194, 5911.935851546763, 6484.739748024928, 6517.250516190604, 6563.442107420923, 6623.635700036448, 897.4301318662697, 990.782027953849, 997.4613708597276, 1003.5935446144323, 1040.256216804988, 4334.5882141196535, 4476.328550717419, 4517.6160026397465, 4655.208614535537, 4677.4854765975715, 13528.864711352957, 13965.86034139666, 13983.161010339412, 14001.439942402394, 14055.156690598596, 11454.026407755435, 12696.80954785679, 13001.934990325177, 13024.674383140497, 13916.51292204768, 9941.0, 10209.642662506776, 10219.642312519027, 10219.795604087876, 10234.6417875374, 6391.7123729433215, 6639.867202656016, 6808.183018037867, 6830.965845170742, 6834.726610935507, 12033.338166400581, 12101.576444824388, 12180.634580962585, 12265.877341226473, 12364.938175309066, 12300.569480068154, 12330.445129968994, 12481.687957801129, 12489.0633202512, 12606.180598261084, 8781.03408625038, 9103.590338434655, 9159.313051521029, 9286.30352723562, 9287.48918809472, 8415.915840841759, 10325.793484130425, 10413.687589372332, 10433.373997560171, 10454.215933805148, 8129.430939834155, 8137.430379873352, 8142.307903828241, 8154.75535733929, 8335.958320208603, 8339.874901876356, 8385.37109716786, 8453.873191902003, 8501.93725784277, 8543.273821725223, 7753.302202801775, 7909.24862138096, 7921.960390198012, 7923.286904178421, 7928.960355198187, 5661.915071274017, 5708.54331653475, 5800.76796928135, 5916.112583112395, 5923.111533270044, 4854.781534831011, 5616.354119276336, 5825.0, 5953.613015154001, 5981.671008094597], "value": 5116.652243989916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.9306378320011, 375.24201113750223, 379.4081233276088, 383.7064645546156, 385.62209035145565, 4785.545373189546, 4817.181079216532, 5107.310513080733, 5221.86945326367, 5258.710770907604, 4335.978320108403, 4822.744647363024, 4829.468758436569, 5008.973160502097, 5083.517065878745, 3781.8109094545302, 4245.002424430257, 4287.678424118188, 4383.671224658164, 4458.598726114657, 3777.7166712496537, 3843.2121415109973, 4030.6976976726864, 4223.007593215591, 4244.623011113787, 3294.324663444, 3782.6784723298415, 3949.545802232751, 4292.570742925714, 4313.374560688699, 3701.926441332024, 3967.523897132334, 4141.571157950502, 4314.827406903752, 4325.307950727884, 3387.271736576648, 3396.490526421032, 3667.504886840269, 3817.9618203817886, 3922.9803850980848, 4458.8885277867985, 4643.791029403685, 5041.1682072458, 5069.2625981969695, 5078.587670856351, 4208.494980602347, 4533.659975501851, 4877.000214955926, 4959.189895688084, 5055.216441451581, 4666.080492386412, 4676.602488788423, 5199.400299850075, 5226.529612334908, 5496.917546236809, 4228.175505776375, 4402.141582391435, 4415.094905544356, 4415.757133357664, 4460.843870464518, 5096.464871188509, 5153.587712982952, 5214.947850521522, 5532.8462776217575, 5538.252335934597, 3760.6615404613717, 4057.5333836609166, 4179.766968744228, 4296.505901821331, 4485.259932111165, 3862.2854771866732, 4422.295239141536, 4599.471060827981, 4613.884652883705, 4624.722516649012, 4419.779011049499, 4454.507739907167, 4765.237561990065, 4909.68087074339, 4959.958408734206, 4746.199742152078, 5284.497972692588, 5341.584480112773, 5389.649672771257, 5468.179773034077, 1319.6766792135988, 1412.7386433509835, 1434.9480243252249, 1561.3754498200583, 1574.4725516951721, 1052.6052730226165, 1065.627030539305, 1089.4692956396275, 1152.8040233160382, 1173.0, 4605.585497305258, 4888.388951381077, 4955.776990035457, 5028.468684447079, 5081.263216833612, 5126.436092029874, 5544.63959842609, 5591.8881622368135, 5766.7234480449915, 5774.88450230993, 3894.844206231776, 4553.225951588238, 4802.855914322576, 5172.405173405032, 5181.274621552986, 2404.446977195255, 2654.309879431323, 2752.234004825178, 2934.3544420227518, 2965.644122705246, 5653.943460565424, 5689.829305120853, 5940.049592065248, 5962.642241465526, 5970.731317090741, 4686.461056978491, 5283.709395983181, 5631.802886898939, 5817.331006934172, 5822.438127224008, 5809.8547536311935, 5812.651240925474, 5825.79609713658, 5845.561582881216, 5859.648421094748, 4746.691465054761, 4948.38145231846, 5394.514493695587, 5546.500814926676, 5666.518345940642, 4613.908681183682, 5219.582433405394, 5577.020157844069, 5602.971985140048, 5603.7758489659955, 4933.950660493493, 5179.663321884065, 5293.841184764463, 5883.911741323969, 5907.49786268172, 3999.340108882002, 4001.91996160081, 4330.675199360124, 4523.344115103358, 4548.499665036909, 5192.5586325162785, 5378.0101362496125, 5537.5634720722755, 5543.0344765550235, 5662.2639056922335, 4812.339742788732, 5479.493139386701, 5515.25544051564, 5530.640508366943, 5541.778328866801, 5065.289280968587, 5199.974000129975, 5499.312585926759, 5516.365617953827, 5518.558515318845, 5030.798768049237, 5037.823676171463, 5287.814926477555, 5332.013577488177, 5341.359036915595, 4818.060982800419, 4926.655134140576, 5097.0, 5407.215953686772, 5482.506574408163, 4550.476695180097, 4703.059388122458, 4753.243118991046, 5123.026624941249, 5363.624546281723], "value": 4138.557116596673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.8639485708001, 734.1740541890373, 736.4881407421838, 818.2431251092739, 827.4662842466607, 15386.0, 15488.690226195484, 16511.66976660466, 16520.42178523752, 16584.75122873158, 14487.637809054779, 14579.0, 14978.0, 14992.625184370396, 15070.664047072722, 923.7644400677834, 948.5494390164686, 948.6869333120054, 951.296040929714, 951.5765484359463, 919.237033262394, 937.3953799799125, 952.0099096939175, 955.4506158958592, 956.0487315121463, 988.0218583602218, 990.1682586627231, 990.9207263418946, 991.8561808537758, 993.5826952679855, 987.7382493639192, 990.2474119669031, 990.5245482168527, 991.4596544883057, 991.9008099190096, 733.4755649710429, 734.1227233456023, 734.9007883935707, 735.5733674468795, 736.4587028534023, 15367.077975321516, 15681.05913645185, 15744.527664170093, 16153.030818150832, 16446.83553164477, 14072.0, 14232.580713857686, 14371.06588071772, 14387.28063596816, 14388.568342949624, 11537.711557211052, 11633.941830290794, 11778.705532361673, 11813.468393922294, 11833.349165795878, 3475.395101490535, 3530.2409981854025, 3557.3418917500344, 3594.1733401317583, 3709.4806727058235, 83573.58213208956, 119042.0, 119977.0, 122294.77705222923, 122786.0, 8981.640734370552, 10757.83863242052, 10921.563137474572, 11077.446127693584, 11173.206638515981, 22657.88671056634, 23083.769162308163, 23147.958341874655, 23302.417439564146, 23352.0, 5983.730732117066, 7776.961115194501, 7822.413319001098, 7850.646720897574, 7941.960290198512, 3594.029612004744, 3795.4876091727265, 3934.409838524244, 3940.940885886714, 3955.4857868476915, 3505.1762835733584, 3797.430385442206, 3862.96137038626, 3865.9226815463535, 3873.070463088895, 668.6088638146739, 678.5962352400314, 679.7858674517511, 686.5537400689592, 698.0889938630137, 668.2463985088385, 698.6506746626686, 701.9368256856908, 720.8342081321325, 726.7565365602477, 9493.0, 10357.689269321932, 10377.740556486147, 10397.0, 10407.843882341771, 544.276112770015, 559.8992181407305, 591.1162811596605, 600.4715850052014, 602.9065494848218, 4456.598906098467, 4763.499497658227, 5011.1481048221885, 5018.146915024455, 5040.193569028937, 99524.0, 101423.47864782035, 106653.0, 108232.0, 114227.0, 94836.0, 96555.0, 98865.01134988702, 99700.0, 100731.99268007373, 65058.0, 85869.0, 86116.0, 87756.0, 87848.56075719709, 7600.391968642606, 9619.27855410833, 9631.951840240754, 9632.133108020313, 9641.807163856824, 44570.77714611536, 44909.0, 49283.75358123187, 54719.17921231105, 55673.0, 53604.0, 66519.0, 71772.92340614999, 72016.0, 75892.62053689697, 11547.711307217387, 11552.0, 11733.834488756369, 11773.88226117728, 11827.408629568316, 14353.0, 14531.564053078424, 14681.559553213421, 15314.923425382802, 15559.766603501183, 13677.31613419345, 13906.652333691738, 14220.004988775256, 14442.277886105863, 14920.701585968436, 13249.761116144604, 13531.323433828466, 14259.928700356431, 14434.639134021734, 14764.114153150846, 13285.466773850618, 13756.380962856496, 13866.4453421862, 14019.789703154665, 14490.275486225857, 9743.658971935949, 9913.603455861685, 10148.898511014795, 10245.948770256102, 10293.74265643365, 9632.95183524078, 9986.181391603317, 11077.556897724, 11246.60636877738, 11477.942610286895], "value": 7648.1362137824935, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1442.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 118.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 111.0, 141.0, 111.0, 109.0, 108.0, 109.0, 128.0, 109.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 182.0, 183.0, 184.0, 184.0, 203.0, 261.0, 207.0, 184.0, 187.0], "value": 196.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 62.0, 91.0, 61.0, 60.0, 59.0, 61.0, 76.0, 62.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 101.0, 100.0, 101.0, 67.0, 83.0, 69.0, 67.0, 84.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 86.0, 129.0, 102.0, 90.0, 90.0, 90.0, 91.0, 90.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 94.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 87.0, 85.0, 85.0, 83.0, 86.0, 85.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 59.0, 60.0, 65.0, 64.0, 65.0, 63.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 56.0, 64.0, 62.0, 58.0, 58.0, 57.0, 57.0, 57.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 86.0, 83.0, 82.0, 85.0, 86.0, 83.0, 90.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 137.0, 127.0, 138.0, 138.0, 139.0, 141.0, 192.0, 145.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 146.0, 217.0, 215.0, 163.0, 164.0, 166.0, 163.0, 165.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 62.0, 64.0], "value": 64.5, "unit": "score"}]}]} 02:26:58 INFO - Return code: 0 02:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:26:58 ERROR - # TBPL SUCCESS # 02:26:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:26:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:26:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:26:58 INFO - 2017-04-03 02:26:58.346 screenresolution[1662:10179] starting screenresolution argv=screenresolution get 02:26:58 INFO - 2017-04-03 02:26:58.348 screenresolution[1662:10179] Display 0: 1600x1200x32@60 02:26:58 INFO - 2017-04-03 02:26:58.354 screenresolution[1663:10182] starting screenresolution argv=screenresolution list 02:26:58 INFO - Available Modes on Display 0 02:26:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:26:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:26:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:26:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:26:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:26:58 INFO - Intel Iris: 02:26:58 INFO - Chipset Model: Intel Iris 02:26:58 INFO - Type: GPU 02:26:58 INFO - Bus: Built-In 02:26:58 INFO - VRAM (Dynamic, Max): 1536 MB 02:26:58 INFO - Vendor: Intel (0x8086) 02:26:58 INFO - Device ID: 0x0a2e 02:26:58 INFO - Revision ID: 0x0009 02:26:58 INFO - Displays: 02:26:58 INFO - Display: 02:26:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:26:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:26:58 INFO - Display Serial Number: 1600x1200 60 02:26:58 INFO - Main Display: Yes 02:26:58 INFO - Mirror: Off 02:26:58 INFO - Online: Yes 02:26:58 INFO - Rotation: Supported 02:26:58 INFO - Return code: 0 02:26:58 INFO - Running post-action listener: _resource_record_post_action 02:26:58 INFO - [mozharness: 2017-04-03 09:26:58.597224Z] Finished run-tests step (success) 02:26:58 INFO - Running post-run listener: _resource_record_post_run 02:26:58 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 33852416; Write bytes: 508894208; Read time: 306; Write time: 1626 02:26:58 INFO - TinderboxPrint: CPU usage
53.8% 02:26:58 INFO - TinderboxPrint: I/O read bytes / time
33,852,416 / 306 02:26:58 INFO - TinderboxPrint: I/O write bytes / time
508,894,208 / 1,626 02:26:58 INFO - TinderboxPrint: CPU idle
2,222.2 (46.2%) 02:26:58 INFO - TinderboxPrint: CPU system
960.3 (19.9%) 02:26:58 INFO - TinderboxPrint: CPU user
1,631.5 (33.9%) 02:26:58 INFO - TinderboxPrint: Swap in / out
237,711,360 / 0 02:26:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 199776768; Write bytes: 200943616; Read time: 15686; Write time: 416 02:26:58 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 32910336; Write bytes: 298038272; Read time: 291; Write time: 1174 02:26:59 INFO - Running post-run listener: _upload_blobber_files 02:26:59 INFO - Blob upload gear active. 02:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:59 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 02:26:59 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'] 02:26:59 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 02:27:00 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:02 INFO - (blobuploader) - INFO - Done attempting. 02:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:04 INFO - (blobuploader) - INFO - Done attempting. 02:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:07 INFO - (blobuploader) - INFO - Done attempting. 02:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:11 INFO - (blobuploader) - INFO - Done attempting. 02:27:11 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:11 INFO - Return code: 0 02:27:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78343d0d4879c6e237d617b69bcaa7eddc326750b2acbe5847ba1e2be9cd211382642c79ca349b55fc8ccdeb299a9d65da9cb07e9ce23d7df653b9f485ebd625", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4fe748ac6622f4bfac04fd4dcb2816ecf021092e76f3154b2cf5683929d3ff8956b962791564e3e47e8eab265e4f4116c8fcc2e977d5115c067c859a2bdea48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fffcc8508193c19e57d501a26301165414b3c2c9cbd7ffc6099ea258137e1feb8ab48507112a18db5c85c1cfe55b5063710cb0ba30a41ed185e23dfca7b12d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8d4e5c6bc76b494f6c1219180cfd61886b88930ef203f7047ddd63f5f4b95c37b2f17bf4974a03bca5b5888134dd1f15b96951c5f2c5478831bb89e8aa1de25"} 02:27:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:11 INFO - Contents: 02:27:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78343d0d4879c6e237d617b69bcaa7eddc326750b2acbe5847ba1e2be9cd211382642c79ca349b55fc8ccdeb299a9d65da9cb07e9ce23d7df653b9f485ebd625", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4fe748ac6622f4bfac04fd4dcb2816ecf021092e76f3154b2cf5683929d3ff8956b962791564e3e47e8eab265e4f4116c8fcc2e977d5115c067c859a2bdea48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fffcc8508193c19e57d501a26301165414b3c2c9cbd7ffc6099ea258137e1feb8ab48507112a18db5c85c1cfe55b5063710cb0ba30a41ed185e23dfca7b12d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8d4e5c6bc76b494f6c1219180cfd61886b88930ef203f7047ddd63f5f4b95c37b2f17bf4974a03bca5b5888134dd1f15b96951c5f2c5478831bb89e8aa1de25"} 02:27:11 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:11 INFO - Copying logs to upload dir... 02:27:11 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1386.639547 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2017-04-03 02:27:11.636592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 02:27:11.640224) ========= 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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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/78343d0d4879c6e237d617b69bcaa7eddc326750b2acbe5847ba1e2be9cd211382642c79ca349b55fc8ccdeb299a9d65da9cb07e9ce23d7df653b9f485ebd625", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4fe748ac6622f4bfac04fd4dcb2816ecf021092e76f3154b2cf5683929d3ff8956b962791564e3e47e8eab265e4f4116c8fcc2e977d5115c067c859a2bdea48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fffcc8508193c19e57d501a26301165414b3c2c9cbd7ffc6099ea258137e1feb8ab48507112a18db5c85c1cfe55b5063710cb0ba30a41ed185e23dfca7b12d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8d4e5c6bc76b494f6c1219180cfd61886b88930ef203f7047ddd63f5f4b95c37b2f17bf4974a03bca5b5888134dd1f15b96951c5f2c5478831bb89e8aa1de25"} build_url:https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/fKBGZuBdSG-ZgAXOlhdQMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78343d0d4879c6e237d617b69bcaa7eddc326750b2acbe5847ba1e2be9cd211382642c79ca349b55fc8ccdeb299a9d65da9cb07e9ce23d7df653b9f485ebd625", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4fe748ac6622f4bfac04fd4dcb2816ecf021092e76f3154b2cf5683929d3ff8956b962791564e3e47e8eab265e4f4116c8fcc2e977d5115c067c859a2bdea48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fffcc8508193c19e57d501a26301165414b3c2c9cbd7ffc6099ea258137e1feb8ab48507112a18db5c85c1cfe55b5063710cb0ba30a41ed185e23dfca7b12d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8d4e5c6bc76b494f6c1219180cfd61886b88930ef203f7047ddd63f5f4b95c37b2f17bf4974a03bca5b5888134dd1f15b96951c5f2c5478831bb89e8aa1de25"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 02:27:11.678892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:27:11.679189) ========= 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.JkmAqR9qcu/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.qWmWGJCoHm/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005150 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:27:11.727172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 02:27:11.727454) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 02:27:11.727753) ========= ========= Total master_lag: 0.28 =========