builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0171 starttime: 1493657055.43 results: success (0) buildid: 20170501075617 builduid: 0c88bfb3eaf24f19b1ef585087204725 revision: 57b37213d81150642f5139764e7044b07b9dccc3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.432854) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.433360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.433676) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.460219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.460880) ========= 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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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-05-01 09:44:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2017-05-01 09:44:15 (15.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118723 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.608261) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.608766) ========= 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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.029630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:15.664672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 09:44:15.665661) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 57b37213d81150642f5139764e7044b07b9dccc3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 57b37213d81150642f5139764e7044b07b9dccc3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8ScyaRrTi3/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.jnB4qfTmcs/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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-05-01 09:44:15,764 truncating revision to first 12 chars 2017-05-01 09:44:15,764 Setting DEBUG logging. 2017-05-01 09:44:15,764 attempt 1/10 2017-05-01 09:44:15,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/57b37213d811?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 09:44:16,697 unpacking tar archive at: mozilla-central-57b37213d811/testing/mozharness/ program finished with exit code 0 elapsedTime=1.209254 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 09:44:16.906990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:16.907586) ========= script_repo_revision: 57b37213d81150642f5139764e7044b07b9dccc3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:16.908413) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:16.908804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 09:44:16.932044) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-05-01 09:44:16.932987) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8ScyaRrTi3/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.jnB4qfTmcs/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:44:17 INFO - MultiFileLogger online at 20170501 09:44:17 in /builds/slave/test 09:44:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:44:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:17 INFO - {'append_to_log': False, 09:44:17 INFO - 'base_work_dir': '/builds/slave/test', 09:44:17 INFO - 'blob_upload_branch': 'Firefox', 09:44:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:17 INFO - 'branch': 'Firefox', 09:44:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:17 INFO - 'config_files': ('talos/mac_config.py',), 09:44:17 INFO - 'default_actions': ('clobber', 09:44:17 INFO - 'read-buildbot-config', 09:44:17 INFO - 'download-and-extract', 09:44:17 INFO - 'populate-webroot', 09:44:17 INFO - 'create-virtualenv', 09:44:17 INFO - 'install', 09:44:17 INFO - 'run-tests'), 09:44:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:17 INFO - 'download_minidump_stackwalk': True, 09:44:17 INFO - 'download_symbols': 'ondemand', 09:44:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:17 INFO - 'gecko_profile': False, 09:44:17 INFO - 'gecko_profile_interval': 0, 09:44:17 INFO - 'installer_path': 'installer.exe', 09:44:17 INFO - 'log_level': 'info', 09:44:17 INFO - 'log_name': 'talos', 09:44:17 INFO - 'log_to_console': True, 09:44:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:44:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:44:17 INFO - 'opt_config_files': (), 09:44:17 INFO - 'pip_index': False, 09:44:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:17 INFO - 'cmd': ('bash', 09:44:17 INFO - '-c', 09:44:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:17 INFO - 'enabled': True, 09:44:17 INFO - 'halt_on_failure': False, 09:44:17 INFO - 'name': 'check_screen_resolution'},), 09:44:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:17 INFO - 'cmd': ('bash', 09:44:17 INFO - '-c', 09:44:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:17 INFO - 'enabled': True, 09:44:17 INFO - 'halt_on_failure': False, 09:44:17 INFO - 'name': 'check_screen_resolution'},), 09:44:17 INFO - 'run_cmd_checks_enabled': True, 09:44:17 INFO - 'suite': 'dromaeojs', 09:44:17 INFO - 'system_bits': '32', 09:44:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:17 INFO - 'title': 't-yosemite-r7-0171', 09:44:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:17 INFO - 'use_talos_json': True, 09:44:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:17 INFO - 'work_dir': 'build'} 09:44:17 INFO - [mozharness: 2017-05-01 16:44:17.144735Z] Running clobber step. 09:44:17 INFO - Running pre-action listener: _resource_record_pre_action 09:44:17 INFO - Running main action method: clobber 09:44:17 INFO - rmtree: /builds/slave/test/build 09:44:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:19 INFO - Running post-action listener: _resource_record_post_action 09:44:19 INFO - [mozharness: 2017-05-01 16:44:19.806470Z] Finished clobber step (success) 09:44:19 INFO - [mozharness: 2017-05-01 16:44:19.806602Z] Running read-buildbot-config step. 09:44:19 INFO - Running pre-action listener: _resource_record_pre_action 09:44:19 INFO - Running main action method: read_buildbot_config 09:44:19 INFO - Using buildbot properties: 09:44:19 INFO - { 09:44:19 INFO - "project": "", 09:44:19 INFO - "product": "firefox", 09:44:19 INFO - "script_repo_revision": "production", 09:44:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:44:19 INFO - "repository": "", 09:44:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:44:19 INFO - "buildid": "20170501075617", 09:44:19 INFO - "pgo_build": "False", 09:44:19 INFO - "basedir": "/builds/slave/test", 09:44:19 INFO - "buildnumber": 27, 09:44:19 INFO - "slavename": "t-yosemite-r7-0171", 09:44:19 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:44:19 INFO - "platform": "yosemite_r7", 09:44:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:44:19 INFO - "branch": "mozilla-central", 09:44:19 INFO - "repo_path": "mozilla-central", 09:44:19 INFO - "revision": "57b37213d81150642f5139764e7044b07b9dccc3", 09:44:19 INFO - "stage_platform": "macosx64", 09:44:19 INFO - "builduid": "0c88bfb3eaf24f19b1ef585087204725", 09:44:19 INFO - "slavebuilddir": "test" 09:44:19 INFO - } 09:44:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:44:19 INFO - Running post-action listener: _resource_record_post_action 09:44:19 INFO - [mozharness: 2017-05-01 16:44:19.809847Z] Finished read-buildbot-config step (success) 09:44:19 INFO - [mozharness: 2017-05-01 16:44:19.809954Z] Running download-and-extract step. 09:44:19 INFO - Running pre-action listener: _resource_record_pre_action 09:44:19 INFO - Running main action method: download_and_extract 09:44:19 INFO - mkdir: /builds/slave/test/build/tests 09:44: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')]} 09:44:19 INFO - trying https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:44:19 INFO - Downloading https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:44:21 INFO - Downloaded 1325 bytes. 09:44:21 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:44:21 INFO - Using the following test package requirements: 09:44:21 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:44:21 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:44:21 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:44:21 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:44:21 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'jsshell-mac.zip'], 09:44:21 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:44:21 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:44:21 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:44:21 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:44:21 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:44:21 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:44:21 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:44:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:44:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:44:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:21 INFO - Fetch https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:44:22 INFO - Content-Length response header: 52698526 09:44:22 INFO - Bytes received: 52698526 09:44:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:44:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:44:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:44:41 INFO - Content-Length response header: 52698526 09:44:41 INFO - Bytes received: 52698526 09:44:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:44:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:44:56 INFO - Fetch https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:44:57 INFO - Content-Length response header: 14408811 09:44:57 INFO - Bytes received: 14408811 09:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:58 INFO - trying https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:44:58 INFO - Downloading https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:45:00 INFO - Downloaded 71250457 bytes. 09:45:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:45:00 INFO - mkdir: /builds/slave/test/properties 09:45:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:00 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:00 INFO - Contents: 09:45:00 INFO - build_url:https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:45:01 INFO - Running post-action listener: _resource_record_post_action 09:45:01 INFO - Running post-action listener: set_extra_try_arguments 09:45:01 INFO - [mozharness: 2017-05-01 16:45:01.332985Z] Finished download-and-extract step (success) 09:45:01 INFO - [mozharness: 2017-05-01 16:45:01.333088Z] Running populate-webroot step. 09:45:01 INFO - Running pre-action listener: _resource_record_pre_action 09:45:01 INFO - Running main action method: populate_webroot 09:45:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:01 INFO - '--tppagecycles', 09:45:01 INFO - '7'], 09:45:01 INFO - 'tests': ['tsvgm']}}, 09:45:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:45:01 INFO - 'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:45:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:45:01 INFO - 'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['damp', 'tps']}, 09:45:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:45:01 INFO - 'tests': ['damp', 'tps']}, 09:45:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['dromaeo_dom']}, 09:45:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:45:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:45:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['a11yr', 09:45:01 INFO - 'ts_paint', 09:45:01 INFO - 'tpaint', 09:45:01 INFO - 'sessionrestore', 09:45:01 INFO - 'sessionrestore_no_auto_restore', 09:45:01 INFO - 'tabpaint']}, 09:45:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:01 INFO - 'ts_paint', 09:45:01 INFO - 'tpaint', 09:45:01 INFO - 'sessionrestore', 09:45:01 INFO - 'sessionrestore_no_auto_restore', 09:45:01 INFO - 'tabpaint']}, 09:45:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:01 INFO - 'ts_paint', 09:45:01 INFO - 'tpaint', 09:45:01 INFO - 'sessionrestore', 09:45:01 INFO - 'sessionrestore_no_auto_restore', 09:45:01 INFO - 'tabpaint']}, 09:45:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:01 INFO - 'ts_paint', 09:45:01 INFO - 'tpaint', 09:45:01 INFO - 'sessionrestore', 09:45:01 INFO - 'sessionrestore_no_auto_restore', 09:45:01 INFO - 'tabpaint']}, 09:45:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['a11yr', 09:45:01 INFO - 'ts_paint', 09:45:01 INFO - 'tpaint', 09:45:01 INFO - 'sessionrestore', 09:45:01 INFO - 'sessionrestore_no_auto_restore', 09:45:01 INFO - 'tabpaint']}, 09:45:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['a11yr', 09:45:01 INFO - 'ts_paint', 09:45:01 INFO - 'tpaint', 09:45:01 INFO - 'sessionrestore', 09:45:01 INFO - 'sessionrestore_no_auto_restore', 09:45:01 INFO - 'tabpaint']}, 09:45:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:45:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:45:01 INFO - 'bloom_basic_ref']}, 09:45:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['tsvgx', 09:45:01 INFO - 'tsvgr_opacity', 09:45:01 INFO - 'tart', 09:45:01 INFO - 'tscrollx', 09:45:01 INFO - 'cart', 09:45:01 INFO - 'tsvg_static']}, 09:45:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:01 INFO - 'tsvgr_opacity', 09:45:01 INFO - 'tart', 09:45:01 INFO - 'tscrollx', 09:45:01 INFO - 'cart', 09:45:01 INFO - 'tsvg_static']}, 09:45:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:45:01 INFO - 'talos_options': ['--disable-e10s'], 09:45:01 INFO - 'tests': ['tp5o']}, 09:45:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:45:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:45:01 INFO - 'talos_options': ['--disable-e10s', 09:45:01 INFO - '--xperf_path', 09:45:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:01 INFO - 'tests': ['tp5n']}, 09:45:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:45:01 INFO - 'talos_options': ['--xperf_path', 09:45:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:01 INFO - 'tests': ['tp5n']}}, 09:45:01 INFO - 'talos.zip': {'path': '', 09:45:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:01 INFO - Running post-action listener: _resource_record_post_action 09:45:01 INFO - [mozharness: 2017-05-01 16:45:01.349039Z] Finished populate-webroot step (success) 09:45:01 INFO - [mozharness: 2017-05-01 16:45:01.349149Z] Running create-virtualenv step. 09:45:01 INFO - Running pre-action listener: _resource_record_pre_action 09:45:01 INFO - Running main action method: create_virtualenv 09:45:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:45:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:01 INFO - Using real prefix '/tools/python27' 09:45:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:05 INFO - Installing pip.................done. 09:45:05 INFO - Return code: 0 09:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:45:05 INFO - Reading from file tmpfile_stdout 09:45:05 INFO - Output received: 09:45:05 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) 09:45:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:05 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:05 INFO - 'HOME': '/Users/cltbld', 09:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:05 INFO - 'LOGNAME': 'cltbld', 09:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:05 INFO - 'MOZ_NO_REMOTE': '1', 09:45:05 INFO - 'NO_EM_RESTART': '1', 09:45:05 INFO - 'PAGER': '/bin/cat', 09:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:05 INFO - 'PWD': '/builds/slave/test', 09:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:05 INFO - 'SHELL': '/bin/bash', 09:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:05 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:05 INFO - 'USER': 'cltbld', 09:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:05 INFO - 'XPC_FLAGS': '0x0', 09:45:05 INFO - 'XPC_SERVICE_NAME': '0', 09:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:45:05 INFO - Cleaning up... 09:45:05 INFO - Return code: 0 09:45:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:05 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:05 INFO - 'HOME': '/Users/cltbld', 09:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:05 INFO - 'LOGNAME': 'cltbld', 09:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:05 INFO - 'MOZ_NO_REMOTE': '1', 09:45:05 INFO - 'NO_EM_RESTART': '1', 09:45:05 INFO - 'PAGER': '/bin/cat', 09:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:05 INFO - 'PWD': '/builds/slave/test', 09:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:05 INFO - 'SHELL': '/bin/bash', 09:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:05 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:05 INFO - 'USER': 'cltbld', 09:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:05 INFO - 'XPC_FLAGS': '0x0', 09:45:05 INFO - 'XPC_SERVICE_NAME': '0', 09:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:05 INFO - Downloading/unpacking psutil>=3.1.1 09:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:09 INFO - Installing collected packages: psutil 09:45:09 INFO - Running setup.py install for psutil 09:45:09 INFO - building 'psutil._psutil_osx' extension 09:45:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:45:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:45:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:45:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:45:10 INFO - building 'psutil._psutil_posix' extension 09:45:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:45:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:45:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:45:10 INFO - ^ 09:45:10 INFO - 1 warning generated. 09:45:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:45:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:10 INFO - Successfully installed psutil 09:45:10 INFO - Cleaning up... 09:45:10 INFO - Return code: 0 09:45:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:45:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:11 INFO - 'HOME': '/Users/cltbld', 09:45:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:11 INFO - 'LOGNAME': 'cltbld', 09:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:11 INFO - 'MOZ_NO_REMOTE': '1', 09:45:11 INFO - 'NO_EM_RESTART': '1', 09:45:11 INFO - 'PAGER': '/bin/cat', 09:45:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:11 INFO - 'PWD': '/builds/slave/test', 09:45:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:11 INFO - 'SHELL': '/bin/bash', 09:45:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:11 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:11 INFO - 'USER': 'cltbld', 09:45:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:11 INFO - 'XPC_FLAGS': '0x0', 09:45:11 INFO - 'XPC_SERVICE_NAME': '0', 09:45:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:14 INFO - Installing collected packages: mozsystemmonitor 09:45:14 INFO - Running setup.py install for mozsystemmonitor 09:45:14 INFO - Successfully installed mozsystemmonitor 09:45:14 INFO - Cleaning up... 09:45:14 INFO - Return code: 0 09:45:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:14 INFO - 'HOME': '/Users/cltbld', 09:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:14 INFO - 'LOGNAME': 'cltbld', 09:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:14 INFO - 'MOZ_NO_REMOTE': '1', 09:45:14 INFO - 'NO_EM_RESTART': '1', 09:45:14 INFO - 'PAGER': '/bin/cat', 09:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:14 INFO - 'PWD': '/builds/slave/test', 09:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:14 INFO - 'SHELL': '/bin/bash', 09:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:14 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:14 INFO - 'USER': 'cltbld', 09:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:14 INFO - 'XPC_FLAGS': '0x0', 09:45:14 INFO - 'XPC_SERVICE_NAME': '0', 09:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:15 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:18 INFO - warning: no files found matching '*.txt' 09:45:18 INFO - no previously-included directories found matching 'build' 09:45:18 INFO - no previously-included directories found matching 'dist' 09:45:18 INFO - no previously-included directories found matching '.git*' 09:45:18 INFO - Installing collected packages: jsonschema, functools32 09:45:18 INFO - Running setup.py install for functools32 09:45:18 INFO - warning: no files found matching '*.txt' 09:45:18 INFO - no previously-included directories found matching 'build' 09:45:18 INFO - no previously-included directories found matching 'dist' 09:45:18 INFO - no previously-included directories found matching '.git*' 09:45:18 INFO - Successfully installed jsonschema functools32 09:45:18 INFO - Cleaning up... 09:45:18 INFO - Return code: 0 09:45:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:18 INFO - 'HOME': '/Users/cltbld', 09:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:18 INFO - 'LOGNAME': 'cltbld', 09:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:18 INFO - 'MOZ_NO_REMOTE': '1', 09:45:18 INFO - 'NO_EM_RESTART': '1', 09:45:18 INFO - 'PAGER': '/bin/cat', 09:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:18 INFO - 'PWD': '/builds/slave/test', 09:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:18 INFO - 'SHELL': '/bin/bash', 09:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:18 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:18 INFO - 'USER': 'cltbld', 09:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:18 INFO - 'XPC_FLAGS': '0x0', 09:45:18 INFO - 'XPC_SERVICE_NAME': '0', 09:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:45:18 INFO - Cleaning up... 09:45:18 INFO - Return code: 0 09:45:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:18 INFO - 'HOME': '/Users/cltbld', 09:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:18 INFO - 'LOGNAME': 'cltbld', 09:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:18 INFO - 'MOZ_NO_REMOTE': '1', 09:45:18 INFO - 'NO_EM_RESTART': '1', 09:45:18 INFO - 'PAGER': '/bin/cat', 09:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:18 INFO - 'PWD': '/builds/slave/test', 09:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:18 INFO - 'SHELL': '/bin/bash', 09:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:18 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:18 INFO - 'USER': 'cltbld', 09:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:18 INFO - 'XPC_FLAGS': '0x0', 09:45:18 INFO - 'XPC_SERVICE_NAME': '0', 09:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:19 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:23 INFO - Downloading docopt-0.6.1.tar.gz 09:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:23 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:23 INFO - Running setup.py install for blobuploader 09:45:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:23 INFO - Running setup.py install for requests 09:45:23 INFO - Running setup.py install for docopt 09:45:23 INFO - Successfully installed blobuploader requests docopt 09:45:23 INFO - Cleaning up... 09:45:24 INFO - Return code: 0 09:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:24 INFO - 'HOME': '/Users/cltbld', 09:45:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:24 INFO - 'LOGNAME': 'cltbld', 09:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:24 INFO - 'MOZ_NO_REMOTE': '1', 09:45:24 INFO - 'NO_EM_RESTART': '1', 09:45:24 INFO - 'PAGER': '/bin/cat', 09:45:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:24 INFO - 'PWD': '/builds/slave/test', 09:45:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:24 INFO - 'SHELL': '/bin/bash', 09:45:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:24 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:24 INFO - 'USER': 'cltbld', 09:45:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:24 INFO - 'XPC_FLAGS': '0x0', 09:45:24 INFO - 'XPC_SERVICE_NAME': '0', 09:45:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-biZdDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-xoOKI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-3HEdiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-tHbIks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-QW0oVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Cv5TdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-2H7kDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-GS_aBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-a_7o5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-KqufES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-AL47zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-mwzYqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ONheVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-POAcAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-l7JV8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-BGynWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:25 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-CrqdZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:26 INFO - Running setup.py install for manifestparser 09:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:26 INFO - Running setup.py install for mozcrash 09:45:26 INFO - Running setup.py install for mozdebug 09:45:26 INFO - Running setup.py install for mozdevice 09:45:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:26 INFO - Running setup.py install for mozfile 09:45:26 INFO - Running setup.py install for mozhttpd 09:45:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:26 INFO - Running setup.py install for mozinfo 09:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozInstall 09:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozleak 09:45:27 INFO - Running setup.py install for mozlog 09:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for moznetwork 09:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozprocess 09:45:27 INFO - Running setup.py install for mozprofile 09:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozrunner 09:45:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Running setup.py install for mozscreenshot 09:45:28 INFO - Running setup.py install for moztest 09:45:28 INFO - Running setup.py install for mozversion 09:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:28 INFO - Cleaning up... 09:45:28 INFO - Return code: 0 09:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:28 INFO - 'HOME': '/Users/cltbld', 09:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:28 INFO - 'LOGNAME': 'cltbld', 09:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:28 INFO - 'MOZ_NO_REMOTE': '1', 09:45:28 INFO - 'NO_EM_RESTART': '1', 09:45:28 INFO - 'PAGER': '/bin/cat', 09:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:28 INFO - 'PWD': '/builds/slave/test', 09:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:28 INFO - 'SHELL': '/bin/bash', 09:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:28 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:28 INFO - 'USER': 'cltbld', 09:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:28 INFO - 'XPC_FLAGS': '0x0', 09:45:28 INFO - 'XPC_SERVICE_NAME': '0', 09:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-JRBlvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-WSpR1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-EaJIRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-pV9O9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1glOvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-mZdrLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-SI_wFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-DYrZjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-65gVr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-h9md_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-tY1kxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:30 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-EaFeGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:30 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)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:30 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Jsq2Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:30 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Bj8jWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:30 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)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:30 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-duSKhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:30 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-7E2Ohb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:30 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)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:30 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-3umqR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:45:30 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)) 09:45:30 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)) 09:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:45:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:33 INFO - Downloading blessings-1.6.tar.gz 09:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:33 INFO - Installing collected packages: blessings 09:45:33 INFO - Running setup.py install for blessings 09:45:33 INFO - Successfully installed blessings 09:45:33 INFO - Cleaning up... 09:45:33 INFO - Return code: 0 09:45:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:33 INFO - Reading from file tmpfile_stdout 09:45:33 INFO - Current package versions: 09:45:33 INFO - blessings == 1.6 09:45:33 INFO - blobuploader == 1.2.4 09:45:33 INFO - docopt == 0.6.1 09:45:33 INFO - functools32 == 3.2.3-2 09:45:33 INFO - jsonschema == 2.5.1 09:45:33 INFO - manifestparser == 1.1 09:45:33 INFO - mozInstall == 1.12 09:45:33 INFO - mozcrash == 1.0 09:45:33 INFO - mozdebug == 0.1 09:45:33 INFO - mozdevice == 0.50 09:45:33 INFO - mozfile == 1.2 09:45:33 INFO - mozhttpd == 0.7 09:45:33 INFO - mozinfo == 0.9 09:45:33 INFO - mozleak == 0.1 09:45:33 INFO - mozlog == 3.4 09:45:33 INFO - moznetwork == 0.27 09:45:33 INFO - mozprocess == 0.25 09:45:33 INFO - mozprofile == 0.28 09:45:33 INFO - mozrunner == 6.13 09:45:33 INFO - mozscreenshot == 0.1 09:45:33 INFO - mozsystemmonitor == 0.3 09:45:33 INFO - moztest == 0.8 09:45:33 INFO - mozversion == 1.4 09:45:33 INFO - psutil == 3.1.1 09:45:33 INFO - requests == 1.2.3 09:45:33 INFO - wsgiref == 0.1.2 09:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:33 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:33 INFO - 'HOME': '/Users/cltbld', 09:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:33 INFO - 'LOGNAME': 'cltbld', 09:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:33 INFO - 'MOZ_NO_REMOTE': '1', 09:45:33 INFO - 'NO_EM_RESTART': '1', 09:45:33 INFO - 'PAGER': '/bin/cat', 09:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:33 INFO - 'PWD': '/builds/slave/test', 09:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:33 INFO - 'SHELL': '/bin/bash', 09:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:33 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:33 INFO - 'USER': 'cltbld', 09:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:33 INFO - 'XPC_FLAGS': '0x0', 09:45:33 INFO - 'XPC_SERVICE_NAME': '0', 09:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:45:34 INFO - Cleaning up... 09:45:34 INFO - Return code: 0 09:45:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:34 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 0x107e22b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e25768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7c148d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, '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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:34 INFO - 'HOME': '/Users/cltbld', 09:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:34 INFO - 'LOGNAME': 'cltbld', 09:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:34 INFO - 'MOZ_NO_REMOTE': '1', 09:45:34 INFO - 'NO_EM_RESTART': '1', 09:45:34 INFO - 'PAGER': '/bin/cat', 09:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:34 INFO - 'PWD': '/builds/slave/test', 09:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:34 INFO - 'SHELL': '/bin/bash', 09:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:34 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:34 INFO - 'USER': 'cltbld', 09:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:34 INFO - 'XPC_FLAGS': '0x0', 09:45:34 INFO - 'XPC_SERVICE_NAME': '0', 09:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:34 INFO - Cleaning up... 09:45:34 INFO - Return code: 0 09:45:34 INFO - Running post-action listener: _resource_record_post_action 09:45:34 INFO - Running post-action listener: _start_resource_monitoring 09:45:34 INFO - Starting resource monitoring. 09:45:34 INFO - [mozharness: 2017-05-01 16:45:34.528009Z] Finished create-virtualenv step (success) 09:45:34 INFO - [mozharness: 2017-05-01 16:45:34.528945Z] Running install step. 09:45:34 INFO - Running pre-action listener: _resource_record_pre_action 09:45:34 INFO - Running main action method: install 09:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:34 INFO - Reading from file tmpfile_stdout 09:45:34 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:34 INFO - Reading from file tmpfile_stdout 09:45:34 INFO - Output received: 09:45:34 INFO - Usage: mozinstall [options] installer 09:45:34 INFO - Options: 09:45:34 INFO - -h, --help show this help message and exit 09:45:34 INFO - -d DEST, --destination=DEST 09:45:34 INFO - Directory to install application into. [default: 09:45:34 INFO - "/builds/slave/test"] 09:45:34 INFO - --app=APP Application being installed. [default: firefox] 09:45:34 INFO - mkdir: /builds/slave/test/build/application 09:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:45:54 INFO - Reading from file tmpfile_stdout 09:45:54 INFO - Output received: 09:45:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:45:54 INFO - Running post-action listener: _resource_record_post_action 09:45:54 INFO - [mozharness: 2017-05-01 16:45:54.609633Z] Finished install step (success) 09:45:54 INFO - [mozharness: 2017-05-01 16:45:54.609756Z] Running run-tests step. 09:45:54 INFO - Running pre-action listener: _resource_record_pre_action 09:45:54 INFO - Running main action method: run_tests 09:45:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:45:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:45:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:45:54 INFO - 2017-05-01 09:45:54.624 screenresolution[1630:7449] starting screenresolution argv=screenresolution get 09:45:54 INFO - 2017-05-01 09:45:54.626 screenresolution[1630:7449] Display 0: 1600x1200x32@60 09:45:54 INFO - 2017-05-01 09:45:54.632 screenresolution[1631:7451] starting screenresolution argv=screenresolution list 09:45:54 INFO - Available Modes on Display 0 09:45:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:45:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:45:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:45:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:45:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:45:54 INFO - Intel Iris: 09:45:54 INFO - Chipset Model: Intel Iris 09:45:54 INFO - Type: GPU 09:45:54 INFO - Bus: Built-In 09:45:54 INFO - VRAM (Dynamic, Max): 1536 MB 09:45:54 INFO - Vendor: Intel (0x8086) 09:45:54 INFO - Device ID: 0x0a2e 09:45:54 INFO - Revision ID: 0x0009 09:45:54 INFO - Displays: 09:45:54 INFO - Display: 09:45:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:45:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:45:54 INFO - Display Serial Number: 1600x1200 60 09:45:54 INFO - Main Display: Yes 09:45:54 INFO - Mirror: Off 09:45:54 INFO - Online: Yes 09:45:54 INFO - Rotation: Supported 09:45:54 INFO - Return code: 0 09:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:54 INFO - Python 2.7.3 09:45:54 INFO - Return code: 0 09:45:54 INFO - grabbing minidump binary from tooltool 09:45: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')]} 09:45:54 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 0x107c00d30>, '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 0x107b26db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bf5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:45:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:45:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:45:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:54 INFO - Return code: 0 09:45:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:45:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:54 INFO - ENV: RUST_BACKTRACE is now 1 09:45:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:45:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ScyaRrTi3/Render', 09:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:54 INFO - 'HOME': '/Users/cltbld', 09:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:54 INFO - 'LOGNAME': 'cltbld', 09:45:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:54 INFO - 'MOZ_NO_REMOTE': '1', 09:45:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:54 INFO - 'NO_EM_RESTART': '1', 09:45:54 INFO - 'PAGER': '/bin/cat', 09:45:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:54 INFO - 'PWD': '/builds/slave/test', 09:45:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:54 INFO - 'RUST_BACKTRACE': '1', 09:45:54 INFO - 'SHELL': '/bin/bash', 09:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jnB4qfTmcs/Listeners', 09:45:54 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:54 INFO - 'USER': 'cltbld', 09:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:54 INFO - 'XPC_FLAGS': '0x0', 09:45:54 INFO - 'XPC_SERVICE_NAME': '0', 09:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:45:55 INFO - mozversion application_buildid: 20170501075617 09:45:55 INFO - mozversion application_changeset: 57b37213d81150642f5139764e7044b07b9dccc3 09:45:55 INFO - mozversion application_display_name: Nightly 09:45:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:55 INFO - mozversion application_name: Firefox 09:45:55 INFO - mozversion application_remotingname: firefox 09:45:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:45:55 INFO - mozversion application_vendor: Mozilla 09:45:55 INFO - mozversion application_version: 55.0a1 09:45:55 INFO - mozversion platform_buildid: 20170501075617 09:45:55 INFO - mozversion platform_changeset: 57b37213d81150642f5139764e7044b07b9dccc3 09:45:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:45:55 INFO - mozversion platform_version: 55.0a1 09:45:55 INFO - using testdate: 1493657155 09:45:55 INFO - actual date: 1493657155 09:45:55 INFO - starting webserver on 'localhost:49229' 09:45:55 INFO - SUITE-START | Running 2 tests 09:45:55 INFO - TEST-START | dromaeo_css 09:45:55 INFO - operating with platform_type : mac_ 09:45:55 INFO - Initialising browser for dromaeo_css test... 09:45:55 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmplQNT4d/profile http://localhost:49229/getInfo.html) 09:45:57 INFO - PID 1641 | __metrics Screen width/height:1600/1200 09:45:57 INFO - PID 1641 | colorDepth:24 09:45:57 INFO - PID 1641 | Browser inner width/height: 1024/689 09:45:57 INFO - PID 1641 | __metrics 09:45:57 INFO - PID 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:45:57 INFO - PID 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:58 INFO - TEST-INFO | 1641: exit 0 09:45:58 INFO - Browser initialized. 09:45:58 INFO - Running cycle 1/1 for dromaeo_css test... 09:45:58 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmplQNT4d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:11 INFO - PID 1643 | RSS: Main: 240713728 09:46:11 INFO - PID 1643 | 09:49:16 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49229/tests/dromaeo/cssquery-ext.html) 09:49:18 INFO - PID 1643 | RSS: Main: 412401664 09:49:18 INFO - PID 1643 | 09:51:01 INFO - PID 1643 | ************************* 09:51:01 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:51:01 INFO - PID 1643 | 09:51:01 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:01 INFO - PID 1643 | Full stack: 09:51:01 INFO - PID 1643 | ************************* 09:51:01 INFO - PID 1643 | ************************* 09:51:01 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:51:01 INFO - PID 1643 | 09:51:01 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:01 INFO - PID 1643 | Full stack: 09:51:01 INFO - PID 1643 | ************************* 09:51:01 INFO - PID 1643 | ************************* 09:51:01 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:51:01 INFO - PID 1643 | 09:51:01 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:01 INFO - PID 1643 | Full stack: 09:51:01 INFO - PID 1643 | ************************* 09:51:01 INFO - PID 1643 | ************************* 09:51:01 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 09:51:01 INFO - PID 1643 | 09:51:01 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:01 INFO - PID 1643 | Full stack: 09:51:01 INFO - PID 1643 | ************************* 09:52:21 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-ext.html (next: http://localhost:49229/tests/dromaeo/cssquery-jquery.html) 09:52:21 INFO - PID 1643 | RSS: Main: 367783936 09:52:21 INFO - PID 1643 | 09:55:23 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49229/tests/dromaeo/cssquery-mootools.html) 09:55:24 INFO - PID 1643 | RSS: Main: 329527296 09:55:24 INFO - PID 1643 | 09:58:27 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49229/tests/dromaeo/cssquery-prototype.html) 09:58:27 INFO - PID 1643 | RSS: Main: 328466432 09:58:27 INFO - PID 1643 | 10:01:31 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49229/tests/dromaeo/cssquery-yui.html) 10:01:31 INFO - PID 1643 | RSS: Main: 339427328 10:01:31 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-yui.html (next: http://localhost:49229/tests/dromaeo/cssquery-dojo.html) 10:04:34 INFO - PID 1643 | RSS: Main: 373071872 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | __start_tp_report 10:04:34 INFO - PID 1643 | _x_x_mozilla_page_load 10:04:34 INFO - PID 1643 | _x_x_mozilla_page_load_details 10:04:34 INFO - PID 1643 | |i|pagename|runs| 10:04:34 INFO - PID 1643 | |0;dojo.html;3500.6499350064983;3502.7723197992113;3505.1061979195306;3525.9647403525973;3563.94863515263;5912.556558258137;6067.757289708417;6162.506999440046;6169.598976066558;6184.0723891416255;6093.939060609393;6106.267247930244;6158.199434073565;6177.783777567786;6187.907181392283;5156.845294641148;5201.479852014806;5264.6051546134095;5286.709230992294;5339.172428273624;5404.378496472917;5410.5401040911565;5421.9457805422035;5424.0779067558415;5461.0716178249795;5218.504242096995;5287.947120528784;5318.601104917147;5328.44051374604;5336.519713225809;5294.338207724035;5307.150855863082;5309.973450132763;5313.309269794902;5317.016351974897;5210.218467229908;5231.084560201987;5265.973670131625;5271.525562699337;5285.312909321802;6027.849303767397;6032.9698351508405;6066.272047354301;6127.6782420562195;6152.984757515004;6406.295307516216;6453.645049522274;6457.321981192001;6458.451031662267;6478.902816457757;6121.326654068049;6434.613923164625;6558.967205163991;6561.80314590563;6580;6111.205543279345;6144.77104579086;6149.385061493815;6238.532110091761;6262.467690246334;6477.967610161919;6498.6425746583445;6614.503912206604;6694.129763130859;6702.564333318319;6313.2424109107205;6324.683765811691;6344.111824344595;6356.968215158895;6366.681665916685;6484.286728459866;6485.059666348353;6489.837754056186;6491.156149700509;6491.961286194186;6322.430981211621;6435.839104022343;6445.581037232565;6454.580452270588;6462.870742585122;6305.022721478178;6362.713677884506;6388;6421.646809425433;6448.613083215022;5147.433782283946;5163.380394352626;5173;5217.8173763918085;5220.738963051908;4644.7213167210075;4646.279826626878;4646.4888862225125;4654.86035418938;4656.4877863434995;5995.52035837132;6047.909281360695;6159.3224745277985;6170.50635949123;6175.814725558241;6319.210098737658;6329.841753956188;6350.491960643138;6351.872962540723;6353.8729225416155;5852.648841069549;5905.645661260338;5916.55625828056;5922.851928701817;5926.525877929756;5548.389677135512;5549.19536667181;5555.388907220203;5558.388577256498;5563.054280772279;6393.552451328363;6395.2645445773405;6396.360363963567;6401.679916004088;6426.775062872871;6356.2054743157105;6444.45222156122;6511.902321465276;6534.967325163344;6548.47612191014;6712.798616041527;6718.328167183243;6720.6975686093265;6723.092382528296;6724.226713927961;6347.841303967253;6355.491560675227;6369;6369.14016607752;6370.522210834113;6168.136460895568;6384.329645387354;6421.5825971311715;6494.6103233806125;6508.60948343082;6274.686265686789;6330.778422755181;6331.430171284606;6339.651319177489;6355.110284560073;6300.62196268207;6326.905096423466;6374.3306952771145;6375.298717141018;6375.713092910737;6182.28903676083;6312.210973628296;6317.6209427434505;6319;6343.143675603919;5397;6130.0006981778415;6357.14178585885;6357.7139028742895;6359.491240700825;5175.689458632494;6131.866048757656;6200.224971878515;6293.590916590407;6342.460890824332 10:04:34 INFO - PID 1643 | |1;ext.html;648.7307767276579;747.5850902748972;796.1878883538791;1098.6703988803356;1124.5895248234397;26721.866390668045;37343.8796836095;37360.43959340612;37554.248915021686;37584.81207593965;39363.21273574527;39613.20773584534;39666.809995700176;39730.60269397305;39853.60146398535;5954.9404505955035;8333;8491.320694344438;8522.616482258314;8539.274161696263;5197.66215196011;5219.243209734586;6103.633781973073;6115.174451449064;6123.601965872226;7513.549187048795;7689.923100769005;7949.006374203224;8431.95784021079;8493.617787199591;8405.41162118652;8456.154384561556;8461.492310461392;8479.236868681848;8484.066752657203;5937.732802023919;6031.849203769941;8335.958320208421;8374.455660382057;8441.409101362908;36282.27435451303;36563.63436365629;36610.8169459151;36612.26775464476;36619.63380366215;3563.4832949222478;3593.2274560969254;3599.6400359964055;3599.8380072896784;3605.2248766515327;30498.695013049808;30567.388652227055;30589.847050764827;30634.54048189279;30648.693513064805;3092.6443459002276;3154.1168472827644;3171.6511183769767;3182.98408507956;3184.952225716593;293204;298998.50500747573;299626;299896.01039895834;301322;49001;49056.52830415093;49085.75457122691;49124.50875491199;49142;51524.969500610525;51538.96922061538;51555.22667159996;51591.226131608055;51613.74193129085;14043;14149.363278652485;14169.929150354183;14183.71632567343;14187.574372768833;11522.942385288019;11527.423628818526;11534.365609891536;11536.307821530734;11538.59614913474;10996.395198264012;11008.834867476995;12777.93611031939;12838.871611283954;12998.870011299767;5262.815801446931;5286.656367336111;5308.336457942757;5321.255024296602;5331.173668081454;998.4308943901906;998.5157198758596;1017.9491025448698;1029.8558201851747;1032.9690109296732;18631.81368186301;23500.7649923502;24443.877780610983;24498.60167798613;24559.140430084863;1072.9624463143753;1073.4900922062113;1119.6976816259564;1123.8763735989035;1139.5726602524053;12143.75712485763;12523.499060037679;14681.853181468048;16116.189031691723;16276.593085172966;295992;296526;296629;296736;297474.025259749;53483.732581336844;53591.92816143655;53615.24693271433;53695;53797.731011344695;1421.8862491000696;1447.5223176351567;1499.1230130373854;1501.797257370263;1517.6054225901346;28420.715792842635;28962.27594310159;29313.267168320963;29341.119766407042;29381.85309073441;37315.06712332214;37319.25361492809;37372.25255494929;37375.813120934225;37378.878633641034;265861;266267.66866165545;266300;266720;267282;32285.869994550078;32929.34141317208;33008.66991330056;33052;33113.50329745104;37130.6286937138;37282.627173729;37357.0660733473;42285.57714422816;42497;28246.15261542157;28404;29474.852625736734;30606;30653;23213.651795222748;24461.51076978486;25911.481770364866;29570.260743481584;30206.54690179605;34932.650673493954;36234.8188259057;36321.636783631824;36330.091747706516;36379.636203638685;26790.196294111207;29128.7087129126;29436.411271774872;30371.39257214799;30694.386112278076;20687.965601720156;21716.45708857291;22675.773242268027;23271.418214544094;23771.881140594185 10:04:34 INFO - PID 1643 | |2;jquery.html;421.9951376672662;429.4646638268188;439.8130794412374;442.5463899503009;456.6438178220987;19562.31531896384;20957.16171353144;21690.3492895213;21816.89091554544;21934.341969740894;21320.57358852822;21667.45831354217;22108.447288817748;22247.332580022627;22491.55016899661;5871.089981052944;6171.074338849164;6177.814665560018;6181.196444462236;6187.978983467745;5038.823641172559;5862.237909071815;6170.382961703816;6184.96907515464;6192.628442293454;5778.306603207621;6137.11011903276;6142.692865356737;6145.139680444741;6155.538334624921;5834.154047663086;5975.58170928033;5980.611260268069;5983.282006159288;5985.940140598582;5185.974070129663;5309.33633295838;5310.203469479609;5317.787288508455;5356.598255130881;26435.413875167553;26512.204633861016;26708;26724.866375668193;26952.05667801637;2173.6413491773997;2237.955240895173;2240.2383189715574;2241.6973708549463;2243.170027089971;17086.829131708648;17229.310827566882;17824.821751782445;17836;17881.642367152584;2098.3390232076845;2116.968245476319;2145.388564259194;2151.075037733774;2151.429871084164;159049;159525;161943;162203;164165;9359.859602105973;11945;11966.760664786829;12066.457009434596;12325.013998880067;16018.119003454689;16020.67958640844;16022;16035.037897726173;16080.758788618181;8541.103184165573;8835.955820220986;8866.468011919305;8979.820403592023;9005.819883602422;8375.958120209481;8403.789905252295;8414.032386275534;8607.397482176313;8635.74092777205;6646.4350530205475;7062.364387205176;7615.847683046308;7635.694572217049;7636.770896873103;2094.162335065955;2106.125957727526;2111.524906895967;2122.225387733497;2297.988884890676;818.4189225649856;855.8373908957278;903.9548022598975;915.1854849184232;915.4919019943862;16380.754288685679;19728.210871565265;19952.30166944179;20155;20756.896215518827;795.9761207163795;935.854942483916;940.9764755881021;970.9854352184723;975.8048390321964;9081.77295567616;10351.327163734333;10464.215183861088;10470.005349491787;10493.370397776158;549315;556747;562074;563303;564175;133829.3308533451;134960;137101.3144934289;137977;141181.882271766;1029.7322696099068;1080.5623722392443;1110.8666959964855;1111.8109921313396;1111.8610173728284;21526.89236553807;21577.921103945053;21683;21708.0231389591;21967.340979770634;58392.708036459546;59239.40760592339;59747.103793444;60162.097568537385;60286.0528012873;79115.20884791309;81599.3680126406;82123;82401.75982401952;83407.16592834237;7406.296401841816;8615.396922215385;8912.910870891208;8988.797744552627;9071.863922041042;13528.188308701509;14169.504067357593;14271.928640357148;14416.711665766836;14674.486392976194;11716.121290903387;11996.64010079699;12007.579734709243;12176.75646487083;12183.451744671689;8780.956095219482;10623.734406639587;10831.67504974852;11005.559777609125;11228.943855280671;9610.327277090537;11526.250793698382;11558.190926635054;11807.350595717318;12109.939450302692;12624.3687815607;12979;13313;13344.999125065464;13477.056606037484;11879.643610691694;12140.757184856076;12260.448279827608;12270.570530031406;12288.692782680148 10:04:34 INFO - PID 1643 | |3;mootools.html;1190.476190476191;1212.327158427073;1405.7680482720352;1445.1979151570881;1469.0598017268949;9665.46839923804;10120.493975301233;11467.254628449155;11720.531178752839;11729.178957472981;11347.375894325809;11502.194846360759;11563.421828908564;11567.016803571685;11583.957443830053;2086.4470915207407;2465.3466831289725;2509.711383190929;2512.4472616024536;2522.054229663876;2161.1139432832542;2439.42673471734;2524.116559204273;2527.0144643589015;2529.8355606885493;2232.983992283507;2463.7782599566035;2494.1270555305678;2500.0749722602663;2506.0727530813533;2295.116380193629;2450.2281781238853;2450.8652024138664;2455.3247856839334;2457.3733697907096;2406.89168987396;2432.3311089450544;2434.6104623260194;2442.9983706680355;2445.6942882139733;11339.829902551386;11600.767984640344;11630.825537616942;11649.534018639244;11674.591389301419;6514.218293804726;6761.357671021246;6772.72909083636;6773.1872175338785;6779.694913728845;3864.14988702485;4042;4204.348326009474;4214.452121224222;4257.8509752158525;1250.8936740376987;1252.2531069158472;1281.685986933198;1291.4640424223935;1296.7925131978839;16589.419370321983;16621.83378166215;16639.584010399838;16643;16656.333746650118;5885.47030767233;5910.674912879746;5947.167396564484;5966.791162309299;6043.184170137063;13660.11209271414;13672.248026358646;13689;13689.247091409869;13703.177809331472;6768.187817461936;6770.255271920085;6773.8645227095185;6774.153230846145;6786.694598743068;5199.324087868553;5380.300560927054;6068.6358818471035;6132.8773424532155;6236.220472440945;4129.938050929239;4226.682998775104;4230.576942305806;4234.3860140279485;4245.830166793294;1431.4488921765196;1435.8205224346957;1482.169984808489;1486.1169331496862;1490.4857824050684;756.1757684124331;784.6390660296328;799.1129845871078;801.7474495533888;802.2178376083272;6469.450096741735;6552.3447655234095;6950.860982780316;7027.5080744348425;7296.927030729731;918.2975024106564;930.4882314726873;932.6689025396022;934.3226161033332;955;3761.0221342450614;4336.50130235027;4373.8846594118295;4399.604035636744;4405.537418571068;14404.85595144056;14795.260236988323;14918.4778532753;14977.1013739176;15217.163056032025;13147.802782958262;13582.388792504362;13591.86408135906;14523.491677791439;14891.702165956836;8220.671173153127;8498.107698691672;8550.74347769568;8596.35527335465;8599.14008599135;6852.5203235773015;6879.3120687930805;6944.548604340702;7048.788536343918;7073.787786366417;12886.355682215664;13148.079634425498;13314.267715275753;13650;13653.249071301174;13377.464901403835;13699.520516781864;13700.24648644334;13859.37632806506;14050.578482645536;9271.351005429555;9295.163435290857;9430.575624096795;9503.477308748084;9508.667196648084;10510.527026283682;10652.84020739674;10793.19051071157;10797.406142662228;10799.67600971972;8786.736397908073;9027.864582031143;9133.041030691682;9258.583363748783;9411.764705882408;8870.383236945247;9024.684136055206;9123.90876091257;9125.726228213165;9182.265418766616;7678.923210767821;7969.521828690297;8056.395770317133;8136.267735903797;8288.58557072156;6079.817605471843;6096.268447786294;6100.877982440237;6106.1451396803595;6171.9691401542705;5159.716215608028;5991.430814072656;6145.477634401126;6157.630542167484;6212.347703491249 10:04:34 INFO - PID 1643 | |4;prototype.html;334.620206066115;398.81455123367647;404.3691840728464;407.4173931278271;410.9506859176899;5702.45826646469;5766.942330576693;5781.508571771399;5786.148432501601;5802.680852553113;4787.66486345955;5449.509544141027;5555.8888822223535;5671.347795003576;5722.256106706122;4358.6077253047215;4372.97813510932;4382.452193475816;4406.537313582084;4414;3666.0671462829764;4391.802368893407;4404.801783919731;4406.65596992917;4419.8066522039035;3941.586133455989;4320.891977700567;4393.670474714393;4418.624416924566;4425.645948324142;4357.498887627916;4365.759883206422;4384.473863136428;4385.495667998189;4414.889627759332;3428.6571342865764;3907.8046097695;3921.039345360405;3945.3687410014545;3953.683705303569;5207.192885102815;5266.368035835686;5418.7019713915715;5605.887882242373;5640.323161220639;4722.268048452495;4972.8259510917305;4976.850694479172;5216.895662086775;5244.16093425054;6117.602355846856;6147.559409922251;6153.2000839890525;6160.4455598995855;6162.291336496271;3448.3103379323984;3921.784301863396;4099.487564054493;4151.36021271596;4165.958340416587;6178.011518157074;6324.557280990287;6361.522885783585;6415.620641562086;6457.935420645827;3635.472856435802;4037.647388125011;4167.9583204168175;4176.331786914079;4195.349720793282;3557.096953130115;4016.9598304016586;4114.7119701621195;4248.346422077011;4257.40396344512;4211.620954114144;4694.976525117352;4815.253635686474;4859.708417494961;4993.975030124826;5114.465660301895;5143.756400969215;6231.813045608639;6258.123862659231;6268.435840774261;1411.9011669183058;1433.9139651620935;1444.3211690505445;1453.7964684944116;1459.1463993563673;936.7611259128879;942.8020115775627;948.393028461785;951.1867353412871;962.3600305796567;5808.477237048686;5910.48326245883;5913;5918.704064796743;5927.347991720907;5788.913166302509;6081.452669259788;6336.17629708135;6465.870682586322;6501.447376972916;4950.430700469492;5654.943450565524;5678.4605462480995;5884.558658100659;5909.527237820964;2964.5256758918467;3324.5678061852286;3371.157210697326;3373.628900820908;3379.831008449617;6156.661383623854;6343.9849624059925;6354.586951848115;6667.133272674619;6672.9332706673285;6104.572679912452;6693.665316734144;6701.832454188684;6726.661303459241;6740.325967403221;6352.428281454691;6637.535372523974;6756.121704178524;6780.762673306509;6788.660566971632;5103.295253515643;5864.912026319524;5902.203202567598;6052.613174274811;6395.20059992501;5561.860953476195;6176.733769577316;6410.326915673787;6413.679316034087;6421.389967953037;6539.705713243011;6657.833554160991;6717.943335782305;6726.8654626908165;6741.258461569321;4168.43726096973;4699.120351859147;4734.680006796713;4738.407699037621;4745.952540474551;6164.938350616437;6344.777932772331;6476.902846457213;6533.308680595448;6574.408303252731;5711.286089238845;5915.763369465345;6184.319724830355;6274.623522588659;6292.433680968735;5235.738213089407;5446.319210098738;6060.575759696779;6258.9374106260175;6291.528135389773;6058.091286307089;6103.969480152571;6137.140800287874;6156.661383623944;6169.259688837368;4934.407871055496;5751.942480575308;6259.280182779039;6262.68686565679;6306.117143599991;5941.465268125717;6087.330393656783;6137.232845894263;6138.938610613836;6150.231221097363 10:04:34 INFO - PID 1643 | |5;yui.html;701.828052127229;732.5568031341038;844.3161039557963;851.3104385447788;866.8990382214588;12641.620751377463;18061.096945152756;18197.818021819778;18670.973096479705;18681.972491512963;17413.825861741378;17467;17920.551986200353;17943.64112717745;17952.73070903934;969.6073090398382;991.6281394477071;992.2657233647085;993.2749093161996;993.3096497933939;667.3826710292984;681.5229339462371;976.9658061967832;1006.7533454303706;1012.1902478017556;1031.025680731709;1034.286342423729;1035.3580779916424;1036.7200855768938;1040.0847254416103;1027.2244455436173;1029.7785976015155;1030.9381437113798;1031.9793604127951;1035.7203555040135;509.2488579345473;520.5523250004993;749.1123019222239;754.8263899303191;774.1175060431113;16547.089910054943;16754.99470031802;16770.07764572948;16838;16880.577985550335;16045.358185672676;16598.75101873473;16709.749353759704;16801.24394402255;16813.327466901308;12682.175658582162;13216.801747973788;13222.86777132226;13253.668658283523;13256.668583285398;3486.4247399179103;3569.785812851237;3614.9096272593133;3616.041748936534;3617.5658920929395;94784.52607736917;116251.4187429066;117862.41068794687;118230.22654660187;120082.39958800237;11263.774724505463;11580.536778528933;13209.273489957952;13331.333433328295;13351.065425420322;19582.020898954994;24837.87581062083;25239.36901577475;25449.236522904343;25674.48651026969;7817.257360550739;7917.604119794102;7941.205879412013;8008.479448835807;8010.83978320442;3114.4549703801745;3855.63371479709;4010.3583426651594;4016.59834016596;4020.155767288902;4380.956190438055;4426.9778651106535;4450.46594408673;4464.374987501752;4469.508354081048;925.8750068740768;926.5135803703109;928.8281667891326;938.2165891480554;943.9716808495756;636.1570918532963;656.9868602627921;658.1411258307954;666.4068978609042;689.183317768446;11157.66527004191;11915.523379064914;11918;11949.163558550817;12161.878381216075;643.6299128001418;643.7264162730821;643.9613623182624;644.291279592454;654.2966311215463;5465.344158700981;5548.639338442988;5610.584123814278;5638.154276858504;5644.294463192101;102567.4871625637;105779.47110264399;107924;108231;112201;91398.08601913895;91999.08000920039;93082;93184;94048;60954.69522652358;75500;82661.58669206615;83528;84701.57649211715;10034.360838603772;10257.33327333721;10414.843777343498;11234.831477528007;11350.432478376213;34768.82615586906;41686.16627667369;42443;43323;43452;54636.634084148216;54740;55521.7223913894;55766.72116639391;56628.716856415456;14104;14140.292985350898;14495.275236237934;14526.564203073925;14543.272836358352;15543.98964067332;15670.686586268439;15695;15775.36898524092;15902.443414480438;14508.419663213353;14712.337944792296;14885.404583816959;14902.85097149058;16297.348106075624;16773.832261677715;16995.235214415134;17231.22459489301;17536.649267014844;17565.648687026445;16284.674306513567;17022.404215852384;17077.402290920254;17085.829141708426;17180;8690.608922598372;11775.941120294343;12174.14780965324;12348.506059757869;12529.686757831127;12009.579664711693;12985.831275185279;13092.672683182996;13273.933630331787;13307.733845323233 10:04:34 INFO - PID 1643 | __end_tp_report 10:04:34 INFO - PID 1643 | __start_cc_report 10:04:34 INFO - PID 1643 | _x_x_mozilla_cycle_collect,1886 10:04:34 INFO - PID 1643 | __end_cc_report 10:04:34 INFO - PID 1643 | __startTimestamp1493658274359__endTimestamp 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | ------- Summary: start ------- 10:04:34 INFO - PID 1643 | Number of tests: 6 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:5967.40 Median:6262.47 stddev:672.65 (10.7%) stddev-sans-first:646.27 10:04:34 INFO - PID 1643 | Values: 3500.6 3502.8 3505.1 3526.0 3563.9 5912.6 6067.8 6162.5 6169.6 6184.1 6093.9 6106.3 6158.2 6177.8 6187.9 5156.8 5201.5 5264.6 5286.7 5339.2 5404.4 5410.5 5421.9 5424.1 5461.1 5218.5 5287.9 5318.6 5328.4 5336.5 5294.3 5307.2 5310.0 5313.3 5317.0 5210.2 5231.1 5266.0 5271.5 5285.3 6027.8 6033.0 6066.3 6127.7 6153.0 6406.3 6453.6 6457.3 6458.5 6478.9 6121.3 6434.6 6559.0 6561.8 6580.0 6111.2 6144.8 6149.4 6238.5 6262.5 6478.0 6498.6 6614.5 6694.1 6702.6 6313.2 6324.7 6344.1 6357.0 6366.7 6484.3 6485.1 6489.8 6491.2 6492.0 6322.4 6435.8 6445.6 6454.6 6462.9 6305.0 6362.7 6388.0 6421.6 6448.6 5147.4 5163.4 5173.0 5217.8 5220.7 4644.7 4646.3 4646.5 4654.9 4656.5 5995.5 6047.9 6159.3 6170.5 6175.8 6319.2 6329.8 6350.5 6351.9 6353.9 5852.6 5905.6 5916.6 5922.9 5926.5 5548.4 5549.2 5555.4 5558.4 5563.1 6393.6 6395.3 6396.4 6401.7 6426.8 6356.2 6444.5 6511.9 6535.0 6548.5 6712.8 6718.3 6720.7 6723.1 6724.2 6347.8 6355.5 6369.0 6369.1 6370.5 6168.1 6384.3 6421.6 6494.6 6508.6 6274.7 6330.8 6331.4 6339.7 6355.1 6300.6 6326.9 6374.3 6375.3 6375.7 6182.3 6312.2 6317.6 6319.0 6343.1 5397.0 6130.0 6357.1 6357.7 6359.5 5175.7 6131.9 6200.2 6293.6 6342.5 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:43613.51 Median:17735.41 stddev:75391.44 (425.1%) stddev-sans-first:75533.91 10:04:34 INFO - PID 1643 | Values: 648.7 747.6 796.2 1098.7 1124.6 26721.9 37343.9 37360.4 37554.2 37584.8 39363.2 39613.2 39666.8 39730.6 39853.6 5954.9 8333.0 8491.3 8522.6 8539.3 5197.7 5219.2 6103.6 6115.2 6123.6 7513.5 7689.9 7949.0 8432.0 8493.6 8405.4 8456.2 8461.5 8479.2 8484.1 5937.7 6031.8 8336.0 8374.5 8441.4 36282.3 36563.6 36610.8 36612.3 36619.6 3563.5 3593.2 3599.6 3599.8 3605.2 30498.7 30567.4 30589.8 30634.5 30648.7 3092.6 3154.1 3171.7 3183.0 3185.0 293204.0 298998.5 299626.0 299896.0 301322.0 49001.0 49056.5 49085.8 49124.5 49142.0 51525.0 51539.0 51555.2 51591.2 51613.7 14043.0 14149.4 14169.9 14183.7 14187.6 11522.9 11527.4 11534.4 11536.3 11538.6 10996.4 11008.8 12777.9 12838.9 12998.9 5262.8 5286.7 5308.3 5321.3 5331.2 998.4 998.5 1017.9 1029.9 1033.0 18631.8 23500.8 24443.9 24498.6 24559.1 1073.0 1073.5 1119.7 1123.9 1139.6 12143.8 12523.5 14681.9 16116.2 16276.6 295992.0 296526.0 296629.0 296736.0 297474.0 53483.7 53591.9 53615.2 53695.0 53797.7 1421.9 1447.5 1499.1 1501.8 1517.6 28420.7 28962.3 29313.3 29341.1 29381.9 37315.1 37319.3 37372.3 37375.8 37378.9 265861.0 266267.7 266300.0 266720.0 267282.0 32285.9 32929.3 33008.7 33052.0 33113.5 37130.6 37282.6 37357.1 42285.6 42497.0 28246.2 28404.0 29474.9 30606.0 30653.0 23213.7 24461.5 25911.5 29570.3 30206.5 34932.7 36234.8 36321.6 36330.1 36379.6 26790.2 29128.7 29436.4 30371.4 30694.4 20688.0 21716.5 22675.8 23271.4 23771.9 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:36411.33 Median:2239.10 stddev:95228.02 (4253.0%) stddev-sans-first:95456.82 10:04:34 INFO - PID 1643 | Values: 422.0 429.5 439.8 442.5 456.6 19562.3 20957.2 21690.3 21816.9 21934.3 21320.6 21667.5 22108.4 22247.3 22491.6 5871.1 6171.1 6177.8 6181.2 6188.0 5038.8 5862.2 6170.4 6185.0 6192.6 5778.3 6137.1 6142.7 6145.1 6155.5 5834.2 5975.6 5980.6 5983.3 5985.9 5186.0 5309.3 5310.2 5317.8 5356.6 26435.4 26512.2 26708.0 26724.9 26952.1 2173.6 2238.0 2240.2 2241.7 2243.2 17086.8 17229.3 17824.8 17836.0 17881.6 2098.3 2117.0 2145.4 2151.1 2151.4 159049.0 159525.0 161943.0 162203.0 164165.0 9359.9 11945.0 11966.8 12066.5 12325.0 16018.1 16020.7 16022.0 16035.0 16080.8 8541.1 8836.0 8866.5 8979.8 9005.8 8376.0 8403.8 8414.0 8607.4 8635.7 6646.4 7062.4 7615.8 7635.7 7636.8 2094.2 2106.1 2111.5 2122.2 2298.0 818.4 855.8 904.0 915.2 915.5 16380.8 19728.2 19952.3 20155.0 20756.9 796.0 935.9 941.0 971.0 975.8 9081.8 10351.3 10464.2 10470.0 10493.4 549315.0 556747.0 562074.0 563303.0 564175.0 133829.3 134960.0 137101.3 137977.0 141181.9 1029.7 1080.6 1110.9 1111.8 1111.9 21526.9 21577.9 21683.0 21708.0 21967.3 58392.7 59239.4 59747.1 60162.1 60286.1 79115.2 81599.4 82123.0 82401.8 83407.2 7406.3 8615.4 8912.9 8988.8 9071.9 13528.2 14169.5 14271.9 14416.7 14674.5 11716.1 11996.6 12007.6 12176.8 12183.5 8781.0 10623.7 10831.7 11005.6 11228.9 9610.3 11526.3 11558.2 11807.4 12109.9 12624.4 12979.0 13313.0 13345.0 13477.1 11879.6 12140.8 12260.4 12270.6 12288.7 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7130.50 Median:3953.07 stddev:4504.49 (113.9%) stddev-sans-first:4495.01 10:04:34 INFO - PID 1643 | Values: 1190.5 1212.3 1405.8 1445.2 1469.1 9665.5 10120.5 11467.3 11720.5 11729.2 11347.4 11502.2 11563.4 11567.0 11584.0 2086.4 2465.3 2509.7 2512.4 2522.1 2161.1 2439.4 2524.1 2527.0 2529.8 2233.0 2463.8 2494.1 2500.1 2506.1 2295.1 2450.2 2450.9 2455.3 2457.4 2406.9 2432.3 2434.6 2443.0 2445.7 11339.8 11600.8 11630.8 11649.5 11674.6 6514.2 6761.4 6772.7 6773.2 6779.7 3864.1 4042.0 4204.3 4214.5 4257.9 1250.9 1252.3 1281.7 1291.5 1296.8 16589.4 16621.8 16639.6 16643.0 16656.3 5885.5 5910.7 5947.2 5966.8 6043.2 13660.1 13672.2 13689.0 13689.2 13703.2 6768.2 6770.3 6773.9 6774.2 6786.7 5199.3 5380.3 6068.6 6132.9 6236.2 4129.9 4226.7 4230.6 4234.4 4245.8 1431.4 1435.8 1482.2 1486.1 1490.5 756.2 784.6 799.1 801.7 802.2 6469.5 6552.3 6950.9 7027.5 7296.9 918.3 930.5 932.7 934.3 955.0 3761.0 4336.5 4373.9 4399.6 4405.5 14404.9 14795.3 14918.5 14977.1 15217.2 13147.8 13582.4 13591.9 14523.5 14891.7 8220.7 8498.1 8550.7 8596.4 8599.1 6852.5 6879.3 6944.5 7048.8 7073.8 12886.4 13148.1 13314.3 13650.0 13653.2 13377.5 13699.5 13700.2 13859.4 14050.6 9271.4 9295.2 9430.6 9503.5 9508.7 10510.5 10652.8 10793.2 10797.4 10799.7 8786.7 9027.9 9133.0 9258.6 9411.8 8870.4 9024.7 9123.9 9125.7 9182.3 7678.9 7969.5 8056.4 8136.3 8288.6 6079.8 6096.3 6100.9 6106.1 6172.0 5159.7 5991.4 6145.5 6157.6 6212.3 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5033.37 Median:5716.77 stddev:1574.08 (27.5%) stddev-sans-first:1538.48 10:04:34 INFO - PID 1643 | Values: 334.6 398.8 404.4 407.4 411.0 5702.5 5766.9 5781.5 5786.1 5802.7 4787.7 5449.5 5555.9 5671.3 5722.3 4358.6 4373.0 4382.5 4406.5 4414.0 3666.1 4391.8 4404.8 4406.7 4419.8 3941.6 4320.9 4393.7 4418.6 4425.6 4357.5 4365.8 4384.5 4385.5 4414.9 3428.7 3907.8 3921.0 3945.4 3953.7 5207.2 5266.4 5418.7 5605.9 5640.3 4722.3 4972.8 4976.9 5216.9 5244.2 6117.6 6147.6 6153.2 6160.4 6162.3 3448.3 3921.8 4099.5 4151.4 4166.0 6178.0 6324.6 6361.5 6415.6 6457.9 3635.5 4037.6 4168.0 4176.3 4195.3 3557.1 4017.0 4114.7 4248.3 4257.4 4211.6 4695.0 4815.3 4859.7 4994.0 5114.5 5143.8 6231.8 6258.1 6268.4 1411.9 1433.9 1444.3 1453.8 1459.1 936.8 942.8 948.4 951.2 962.4 5808.5 5910.5 5913.0 5918.7 5927.3 5788.9 6081.5 6336.2 6465.9 6501.4 4950.4 5654.9 5678.5 5884.6 5909.5 2964.5 3324.6 3371.2 3373.6 3379.8 6156.7 6344.0 6354.6 6667.1 6672.9 6104.6 6693.7 6701.8 6726.7 6740.3 6352.4 6637.5 6756.1 6780.8 6788.7 5103.3 5864.9 5902.2 6052.6 6395.2 5561.9 6176.7 6410.3 6413.7 6421.4 6539.7 6657.8 6717.9 6726.9 6741.3 4168.4 4699.1 4734.7 4738.4 4746.0 6164.9 6344.8 6476.9 6533.3 6574.4 5711.3 5915.8 6184.3 6274.6 6292.4 5235.7 5446.3 6060.6 6258.9 6291.5 6058.1 6104.0 6137.1 6156.7 6169.3 4934.4 5751.9 6259.3 6262.7 6306.1 5941.5 6087.3 6137.2 6138.9 6150.2 10:04:34 INFO - PID 1643 | 10:04:34 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:21248.21 Median:18006.91 stddev:29784.14 (165.4%) stddev-sans-first:29827.74 10:04:34 INFO - PID 1643 | Values: 701.8 732.6 844.3 851.3 866.9 12641.6 18061.1 18197.8 18671.0 18682.0 17413.8 17467.0 17920.6 17943.6 17952.7 969.6 991.6 992.3 993.3 993.3 667.4 681.5 977.0 1006.8 1012.2 1031.0 1034.3 1035.4 1036.7 1040.1 1027.2 1029.8 1030.9 1032.0 1035.7 509.2 520.6 749.1 754.8 774.1 16547.1 16755.0 16770.1 16838.0 16880.6 16045.4 16598.8 16709.7 16801.2 16813.3 12682.2 13216.8 13222.9 13253.7 13256.7 3486.4 3569.8 3614.9 3616.0 3617.6 94784.5 116251.4 117862.4 118230.2 120082.4 11263.8 11580.5 13209.3 13331.3 13351.1 19582.0 24837.9 25239.4 25449.2 25674.5 7817.3 7917.6 7941.2 8008.5 8010.8 3114.5 3855.6 4010.4 4016.6 4020.2 4381.0 4427.0 4450.5 4464.4 4469.5 925.9 926.5 928.8 938.2 944.0 636.2 657.0 658.1 666.4 689.2 11157.7 11915.5 11918.0 11949.2 12161.9 643.6 643.7 644.0 644.3 654.3 5465.3 5548.6 5610.6 5638.2 5644.3 102567.5 105779.5 107924.0 108231.0 112201.0 91398.1 91999.1 93082.0 93184.0 94048.0 60954.7 75500.0 82661.6 83528.0 84701.6 10034.4 10257.3 10414.8 11234.8 11350.4 34768.8 41686.2 42443.0 43323.0 43452.0 54636.6 54740.0 55521.7 55766.7 56628.7 14104.0 14140.3 14495.3 14526.6 14543.3 15544.0 15670.7 15695.0 15775.4 15902.4 14508.4 14712.3 14885.4 14902.9 16297.3 16773.8 16995.2 17231.2 17536.6 17565.6 16284.7 17022.4 17077.4 17085.8 17180.0 8690.6 11775.9 12174.1 12348.5 12529.7 12009.6 12985.8 13092.7 13273.9 13307.7 10:04:34 INFO - PID 1643 | -------- Summary: end -------- 10:04:34 INFO - PID 1643 | 10:04:35 INFO - TEST-INFO | 1643: exit 0 10:04:35 INFO - TEST-OK | dromaeo_css | took 1119965ms 10:04:35 INFO - TEST-START | kraken 10:04:35 INFO - operating with platform_type : mac_ 10:04:35 INFO - Initialising browser for kraken test... 10:04:35 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmp08ZH40/profile http://localhost:49229/getInfo.html) 10:04:37 INFO - PID 1654 | __metrics Screen width/height:1600/1200 10:04:37 INFO - PID 1654 | colorDepth:24 10:04:37 INFO - PID 1654 | Browser inner width/height: 1024/689 10:04:37 INFO - PID 1654 | __metrics 10:04:37 INFO - PID 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:04:37 INFO - PID 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:38 INFO - TEST-INFO | 1654: exit 0 10:04:38 INFO - Browser initialized. 10:04:38 INFO - Running cycle 1/1 for kraken test... 10:04:38 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmp08ZH40/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:51 INFO - PID 1655 | RSS: Main: 240271360 10:04:51 INFO - PID 1655 | 10:04:54 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:55 INFO - PID 1655 | RSS: Main: 310030336 10:04:55 INFO - PID 1655 | 10:04:57 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-dft) 10:04:58 INFO - PID 1655 | RSS: Main: 293924864 10:04:58 INFO - PID 1655 | 10:05:01 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-fft) 10:05:02 INFO - PID 1655 | RSS: Main: 386453504 10:05:02 INFO - PID 1655 | 10:05:04 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator) 10:05:04 INFO - PID 1655 | RSS: Main: 288251904 10:05:04 INFO - PID 1655 | 10:05:07 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:07 INFO - PID 1655 | RSS: Main: 290082816 10:05:07 INFO - PID 1655 | 10:05:10 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:11 INFO - PID 1655 | RSS: Main: 353546240 10:05:11 INFO - PID 1655 | 10:05:14 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:14 INFO - PID 1655 | RSS: Main: 369778688 10:05:14 INFO - PID 1655 | 10:05:17 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial) 10:05:18 INFO - PID 1655 | RSS: Main: 380932096 10:05:18 INFO - PID 1655 | 10:05:19 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:20 INFO - PID 1655 | RSS: Main: 331517952 10:05:20 INFO - PID 1655 | 10:05:21 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:22 INFO - PID 1655 | RSS: Main: 334622720 10:05:22 INFO - PID 1655 | 10:05:24 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:25 INFO - PID 1655 | RSS: Main: 336072704 10:05:25 INFO - PID 1655 | 10:05:28 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:28 INFO - PID 1655 | RSS: Main: 353763328 10:05:28 INFO - PID 1655 | 10:05:31 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:32 INFO - PID 1655 | RSS: Main: 346054656 10:05:32 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49229/tests/kraken/driver.html?testName=ai-astar) 10:05:34 INFO - PID 1655 | RSS: Main: 388530176 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | __start_tp_report 10:05:34 INFO - PID 1655 | _x_x_mozilla_page_load 10:05:34 INFO - PID 1655 | _x_x_mozilla_page_load_details 10:05:34 INFO - PID 1655 | |i|pagename|runs| 10:05:34 INFO - PID 1655 | |0;ai-astar;109;110;109;112;91;152;159;160;128;114 10:05:34 INFO - PID 1655 | |1;audio-beat-detection;144;108;105;149;112;108;107;104;144;127 10:05:34 INFO - PID 1655 | |2;audio-dft;187;185;184;182;187;182;185;184;182;185 10:05:34 INFO - PID 1655 | |3;audio-fft;77;57;60;87;61;60;59;58;87;56 10:05:34 INFO - PID 1655 | |4;audio-oscillator;90;70;87;70;71;68;108;103;104;93 10:05:34 INFO - PID 1655 | |5;imaging-gaussian-blur;88;88;88;89;89;88;88;88;88;92 10:05:34 INFO - PID 1655 | |6;imaging-darkroom;95;97;95;95;95;95;95;95;96;95 10:05:34 INFO - PID 1655 | |7;imaging-desaturate;85;84;84;85;84;83;83;84;84;83 10:05:34 INFO - PID 1655 | |8;json-parse-financial;46;46;46;47;48;49;47;48;48;48 10:05:34 INFO - PID 1655 | |9;json-stringify-tinderbox;56;65;57;70;62;62;57;57;58;59 10:05:34 INFO - PID 1655 | |10;stanford-crypto-aes;84;84;83;82;83;81;82;83;83;81 10:05:34 INFO - PID 1655 | |11;stanford-crypto-ccm;136;144;146;151;148;135;138;134;177;154 10:05:34 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;186;184;183;185;184;183;181;182;182;172 10:05:34 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;68;67;67;65;67;67;69;68;67;67 10:05:34 INFO - PID 1655 | __end_tp_report 10:05:34 INFO - PID 1655 | __start_cc_report 10:05:34 INFO - PID 1655 | _x_x_mozilla_cycle_collect,2158 10:05:34 INFO - PID 1655 | __end_cc_report 10:05:34 INFO - PID 1655 | __startTimestamp1493658334553__endTimestamp 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | ------- Summary: start ------- 10:05:34 INFO - PID 1655 | Number of tests: 14 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:124.40 Median:140.00 stddev:24.26 (17.3%) stddev-sans-first:25.09 10:05:34 INFO - PID 1655 | Values: 109.0 110.0 109.0 112.0 91.0 152.0 159.0 160.0 128.0 114.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:119.50 stddev:18.37 (15.4%) stddev-sans-first:17.46 10:05:34 INFO - PID 1655 | Values: 144.0 108.0 105.0 149.0 112.0 108.0 107.0 104.0 144.0 127.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.89 (1.0%) stddev-sans-first:1.73 10:05:34 INFO - PID 1655 | Values: 187.0 185.0 184.0 182.0 187.0 182.0 185.0 184.0 182.0 185.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:12.44 (20.6%) stddev-sans-first:12.57 10:05:34 INFO - PID 1655 | Values: 77.0 57.0 60.0 87.0 61.0 60.0 59.0 58.0 87.0 56.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:70.50 stddev:15.71 (22.3%) stddev-sans-first:16.61 10:05:34 INFO - PID 1655 | Values: 90.0 70.0 87.0 70.0 71.0 68.0 108.0 103.0 104.0 93.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:88.00 stddev:1.26 (1.4%) stddev-sans-first:1.32 10:05:34 INFO - PID 1655 | Values: 88.0 88.0 88.0 89.0 89.0 88.0 88.0 88.0 88.0 92.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:05:34 INFO - PID 1655 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 10:05:34 INFO - PID 1655 | Values: 85.0 84.0 84.0 85.0 84.0 83.0 83.0 84.0 84.0 83.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:47.30 Median:48.00 stddev:1.06 (2.2%) stddev-sans-first:1.01 10:05:34 INFO - PID 1655 | Values: 46.0 46.0 46.0 47.0 48.0 49.0 47.0 48.0 48.0 48.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:4.47 (7.4%) stddev-sans-first:4.47 10:05:34 INFO - PID 1655 | Values: 56.0 65.0 57.0 70.0 62.0 62.0 57.0 57.0 58.0 59.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.07 (1.3%) stddev-sans-first:1.01 10:05:34 INFO - PID 1655 | Values: 84.0 84.0 83.0 82.0 83.0 81.0 82.0 83.0 83.0 81.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:147.00 stddev:12.85 (8.7%) stddev-sans-first:13.08 10:05:34 INFO - PID 1655 | Values: 136.0 144.0 146.0 151.0 148.0 135.0 138.0 134.0 177.0 154.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:183.50 stddev:3.88 (2.1%) stddev-sans-first:3.87 10:05:34 INFO - PID 1655 | Values: 186.0 184.0 183.0 185.0 184.0 183.0 181.0 182.0 182.0 172.0 10:05:34 INFO - PID 1655 | 10:05:34 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 10:05:34 INFO - PID 1655 | Values: 68.0 67.0 67.0 65.0 67.0 67.0 69.0 68.0 67.0 67.0 10:05:34 INFO - PID 1655 | -------- Summary: end -------- 10:05:34 INFO - PID 1655 | 10:05:35 INFO - TEST-INFO | 1655: exit 0 10:05:35 INFO - TEST-OK | kraken | took 60453ms 10:05:35 INFO - SUITE-END | took 1180s 10:05:35 INFO - Completed test suite (00:19:40) 10:05:35 INFO - javascript benchmark 10:05:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7704.354847695878, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3500.6499350064983, 3502.7723197992113, 3505.1061979195306, 3525.9647403525973, 3563.94863515263, 5912.556558258137, 6067.757289708417, 6162.506999440046, 6169.598976066558, 6184.0723891416255, 6093.939060609393, 6106.267247930244, 6158.199434073565, 6177.783777567786, 6187.907181392283, 5156.845294641148, 5201.479852014806, 5264.6051546134095, 5286.709230992294, 5339.172428273624, 5404.378496472917, 5410.5401040911565, 5421.9457805422035, 5424.0779067558415, 5461.0716178249795, 5218.504242096995, 5287.947120528784, 5318.601104917147, 5328.44051374604, 5336.519713225809, 5294.338207724035, 5307.150855863082, 5309.973450132763, 5313.309269794902, 5317.016351974897, 5210.218467229908, 5231.084560201987, 5265.973670131625, 5271.525562699337, 5285.312909321802, 6027.849303767397, 6032.9698351508405, 6066.272047354301, 6127.6782420562195, 6152.984757515004, 6406.295307516216, 6453.645049522274, 6457.321981192001, 6458.451031662267, 6478.902816457757, 6121.326654068049, 6434.613923164625, 6558.967205163991, 6561.80314590563, 6580.0, 6111.205543279345, 6144.77104579086, 6149.385061493815, 6238.532110091761, 6262.467690246334, 6477.967610161919, 6498.6425746583445, 6614.503912206604, 6694.129763130859, 6702.564333318319, 6313.2424109107205, 6324.683765811691, 6344.111824344595, 6356.968215158895, 6366.681665916685, 6484.286728459866, 6485.059666348353, 6489.837754056186, 6491.156149700509, 6491.961286194186, 6322.430981211621, 6435.839104022343, 6445.581037232565, 6454.580452270588, 6462.870742585122, 6305.022721478178, 6362.713677884506, 6388.0, 6421.646809425433, 6448.613083215022, 5147.433782283946, 5163.380394352626, 5173.0, 5217.8173763918085, 5220.738963051908, 4644.7213167210075, 4646.279826626878, 4646.4888862225125, 4654.86035418938, 4656.4877863434995, 5995.52035837132, 6047.909281360695, 6159.3224745277985, 6170.50635949123, 6175.814725558241, 6319.210098737658, 6329.841753956188, 6350.491960643138, 6351.872962540723, 6353.8729225416155, 5852.648841069549, 5905.645661260338, 5916.55625828056, 5922.851928701817, 5926.525877929756, 5548.389677135512, 5549.19536667181, 5555.388907220203, 5558.388577256498, 5563.054280772279, 6393.552451328363, 6395.2645445773405, 6396.360363963567, 6401.679916004088, 6426.775062872871, 6356.2054743157105, 6444.45222156122, 6511.902321465276, 6534.967325163344, 6548.47612191014, 6712.798616041527, 6718.328167183243, 6720.6975686093265, 6723.092382528296, 6724.226713927961, 6347.841303967253, 6355.491560675227, 6369.0, 6369.14016607752, 6370.522210834113, 6168.136460895568, 6384.329645387354, 6421.5825971311715, 6494.6103233806125, 6508.60948343082, 6274.686265686789, 6330.778422755181, 6331.430171284606, 6339.651319177489, 6355.110284560073, 6300.62196268207, 6326.905096423466, 6374.3306952771145, 6375.298717141018, 6375.713092910737, 6182.28903676083, 6312.210973628296, 6317.6209427434505, 6319.0, 6343.143675603919, 5397.0, 6130.0006981778415, 6357.14178585885, 6357.7139028742895, 6359.491240700825, 5175.689458632494, 6131.866048757656, 6200.224971878515, 6293.590916590407, 6342.460890824332], "value": 5923.968765400545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.7307767276579, 747.5850902748972, 796.1878883538791, 1098.6703988803356, 1124.5895248234397, 26721.866390668045, 37343.8796836095, 37360.43959340612, 37554.248915021686, 37584.81207593965, 39363.21273574527, 39613.20773584534, 39666.809995700176, 39730.60269397305, 39853.60146398535, 5954.9404505955035, 8333.0, 8491.320694344438, 8522.616482258314, 8539.274161696263, 5197.66215196011, 5219.243209734586, 6103.633781973073, 6115.174451449064, 6123.601965872226, 7513.549187048795, 7689.923100769005, 7949.006374203224, 8431.95784021079, 8493.617787199591, 8405.41162118652, 8456.154384561556, 8461.492310461392, 8479.236868681848, 8484.066752657203, 5937.732802023919, 6031.849203769941, 8335.958320208421, 8374.455660382057, 8441.409101362908, 36282.27435451303, 36563.63436365629, 36610.8169459151, 36612.26775464476, 36619.63380366215, 3563.4832949222478, 3593.2274560969254, 3599.6400359964055, 3599.8380072896784, 3605.2248766515327, 30498.695013049808, 30567.388652227055, 30589.847050764827, 30634.54048189279, 30648.693513064805, 3092.6443459002276, 3154.1168472827644, 3171.6511183769767, 3182.98408507956, 3184.952225716593, 293204.0, 298998.50500747573, 299626.0, 299896.01039895834, 301322.0, 49001.0, 49056.52830415093, 49085.75457122691, 49124.50875491199, 49142.0, 51524.969500610525, 51538.96922061538, 51555.22667159996, 51591.226131608055, 51613.74193129085, 14043.0, 14149.363278652485, 14169.929150354183, 14183.71632567343, 14187.574372768833, 11522.942385288019, 11527.423628818526, 11534.365609891536, 11536.307821530734, 11538.59614913474, 10996.395198264012, 11008.834867476995, 12777.93611031939, 12838.871611283954, 12998.870011299767, 5262.815801446931, 5286.656367336111, 5308.336457942757, 5321.255024296602, 5331.173668081454, 998.4308943901906, 998.5157198758596, 1017.9491025448698, 1029.8558201851747, 1032.9690109296732, 18631.81368186301, 23500.7649923502, 24443.877780610983, 24498.60167798613, 24559.140430084863, 1072.9624463143753, 1073.4900922062113, 1119.6976816259564, 1123.8763735989035, 1139.5726602524053, 12143.75712485763, 12523.499060037679, 14681.853181468048, 16116.189031691723, 16276.593085172966, 295992.0, 296526.0, 296629.0, 296736.0, 297474.025259749, 53483.732581336844, 53591.92816143655, 53615.24693271433, 53695.0, 53797.731011344695, 1421.8862491000696, 1447.5223176351567, 1499.1230130373854, 1501.797257370263, 1517.6054225901346, 28420.715792842635, 28962.27594310159, 29313.267168320963, 29341.119766407042, 29381.85309073441, 37315.06712332214, 37319.25361492809, 37372.25255494929, 37375.813120934225, 37378.878633641034, 265861.0, 266267.66866165545, 266300.0, 266720.0, 267282.0, 32285.869994550078, 32929.34141317208, 33008.66991330056, 33052.0, 33113.50329745104, 37130.6286937138, 37282.627173729, 37357.0660733473, 42285.57714422816, 42497.0, 28246.15261542157, 28404.0, 29474.852625736734, 30606.0, 30653.0, 23213.651795222748, 24461.51076978486, 25911.481770364866, 29570.260743481584, 30206.54690179605, 34932.650673493954, 36234.8188259057, 36321.636783631824, 36330.091747706516, 36379.636203638685, 26790.196294111207, 29128.7087129126, 29436.411271774872, 30371.39257214799, 30694.386112278076, 20687.965601720156, 21716.45708857291, 22675.773242268027, 23271.418214544094, 23771.881140594185], "value": 16943.613379941544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.9951376672662, 429.4646638268188, 439.8130794412374, 442.5463899503009, 456.6438178220987, 19562.31531896384, 20957.16171353144, 21690.3492895213, 21816.89091554544, 21934.341969740894, 21320.57358852822, 21667.45831354217, 22108.447288817748, 22247.332580022627, 22491.55016899661, 5871.089981052944, 6171.074338849164, 6177.814665560018, 6181.196444462236, 6187.978983467745, 5038.823641172559, 5862.237909071815, 6170.382961703816, 6184.96907515464, 6192.628442293454, 5778.306603207621, 6137.11011903276, 6142.692865356737, 6145.139680444741, 6155.538334624921, 5834.154047663086, 5975.58170928033, 5980.611260268069, 5983.282006159288, 5985.940140598582, 5185.974070129663, 5309.33633295838, 5310.203469479609, 5317.787288508455, 5356.598255130881, 26435.413875167553, 26512.204633861016, 26708.0, 26724.866375668193, 26952.05667801637, 2173.6413491773997, 2237.955240895173, 2240.2383189715574, 2241.6973708549463, 2243.170027089971, 17086.829131708648, 17229.310827566882, 17824.821751782445, 17836.0, 17881.642367152584, 2098.3390232076845, 2116.968245476319, 2145.388564259194, 2151.075037733774, 2151.429871084164, 159049.0, 159525.0, 161943.0, 162203.0, 164165.0, 9359.859602105973, 11945.0, 11966.760664786829, 12066.457009434596, 12325.013998880067, 16018.119003454689, 16020.67958640844, 16022.0, 16035.037897726173, 16080.758788618181, 8541.103184165573, 8835.955820220986, 8866.468011919305, 8979.820403592023, 9005.819883602422, 8375.958120209481, 8403.789905252295, 8414.032386275534, 8607.397482176313, 8635.74092777205, 6646.4350530205475, 7062.364387205176, 7615.847683046308, 7635.694572217049, 7636.770896873103, 2094.162335065955, 2106.125957727526, 2111.524906895967, 2122.225387733497, 2297.988884890676, 818.4189225649856, 855.8373908957278, 903.9548022598975, 915.1854849184232, 915.4919019943862, 16380.754288685679, 19728.210871565265, 19952.30166944179, 20155.0, 20756.896215518827, 795.9761207163795, 935.854942483916, 940.9764755881021, 970.9854352184723, 975.8048390321964, 9081.77295567616, 10351.327163734333, 10464.215183861088, 10470.005349491787, 10493.370397776158, 549315.0, 556747.0, 562074.0, 563303.0, 564175.0, 133829.3308533451, 134960.0, 137101.3144934289, 137977.0, 141181.882271766, 1029.7322696099068, 1080.5623722392443, 1110.8666959964855, 1111.8109921313396, 1111.8610173728284, 21526.89236553807, 21577.921103945053, 21683.0, 21708.0231389591, 21967.340979770634, 58392.708036459546, 59239.40760592339, 59747.103793444, 60162.097568537385, 60286.0528012873, 79115.20884791309, 81599.3680126406, 82123.0, 82401.75982401952, 83407.16592834237, 7406.296401841816, 8615.396922215385, 8912.910870891208, 8988.797744552627, 9071.863922041042, 13528.188308701509, 14169.504067357593, 14271.928640357148, 14416.711665766836, 14674.486392976194, 11716.121290903387, 11996.64010079699, 12007.579734709243, 12176.75646487083, 12183.451744671689, 8780.956095219482, 10623.734406639587, 10831.67504974852, 11005.559777609125, 11228.943855280671, 9610.327277090537, 11526.250793698382, 11558.190926635054, 11807.350595717318, 12109.939450302692, 12624.3687815607, 12979.0, 13313.0, 13344.999125065464, 13477.056606037484, 11879.643610691694, 12140.757184856076, 12260.448279827608, 12270.570530031406, 12288.692782680148], "value": 10418.867220258064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.476190476191, 1212.327158427073, 1405.7680482720352, 1445.1979151570881, 1469.0598017268949, 9665.46839923804, 10120.493975301233, 11467.254628449155, 11720.531178752839, 11729.178957472981, 11347.375894325809, 11502.194846360759, 11563.421828908564, 11567.016803571685, 11583.957443830053, 2086.4470915207407, 2465.3466831289725, 2509.711383190929, 2512.4472616024536, 2522.054229663876, 2161.1139432832542, 2439.42673471734, 2524.116559204273, 2527.0144643589015, 2529.8355606885493, 2232.983992283507, 2463.7782599566035, 2494.1270555305678, 2500.0749722602663, 2506.0727530813533, 2295.116380193629, 2450.2281781238853, 2450.8652024138664, 2455.3247856839334, 2457.3733697907096, 2406.89168987396, 2432.3311089450544, 2434.6104623260194, 2442.9983706680355, 2445.6942882139733, 11339.829902551386, 11600.767984640344, 11630.825537616942, 11649.534018639244, 11674.591389301419, 6514.218293804726, 6761.357671021246, 6772.72909083636, 6773.1872175338785, 6779.694913728845, 3864.14988702485, 4042.0, 4204.348326009474, 4214.452121224222, 4257.8509752158525, 1250.8936740376987, 1252.2531069158472, 1281.685986933198, 1291.4640424223935, 1296.7925131978839, 16589.419370321983, 16621.83378166215, 16639.584010399838, 16643.0, 16656.333746650118, 5885.47030767233, 5910.674912879746, 5947.167396564484, 5966.791162309299, 6043.184170137063, 13660.11209271414, 13672.248026358646, 13689.0, 13689.247091409869, 13703.177809331472, 6768.187817461936, 6770.255271920085, 6773.8645227095185, 6774.153230846145, 6786.694598743068, 5199.324087868553, 5380.300560927054, 6068.6358818471035, 6132.8773424532155, 6236.220472440945, 4129.938050929239, 4226.682998775104, 4230.576942305806, 4234.3860140279485, 4245.830166793294, 1431.4488921765196, 1435.8205224346957, 1482.169984808489, 1486.1169331496862, 1490.4857824050684, 756.1757684124331, 784.6390660296328, 799.1129845871078, 801.7474495533888, 802.2178376083272, 6469.450096741735, 6552.3447655234095, 6950.860982780316, 7027.5080744348425, 7296.927030729731, 918.2975024106564, 930.4882314726873, 932.6689025396022, 934.3226161033332, 955.0, 3761.0221342450614, 4336.50130235027, 4373.8846594118295, 4399.604035636744, 4405.537418571068, 14404.85595144056, 14795.260236988323, 14918.4778532753, 14977.1013739176, 15217.163056032025, 13147.802782958262, 13582.388792504362, 13591.86408135906, 14523.491677791439, 14891.702165956836, 8220.671173153127, 8498.107698691672, 8550.74347769568, 8596.35527335465, 8599.14008599135, 6852.5203235773015, 6879.3120687930805, 6944.548604340702, 7048.788536343918, 7073.787786366417, 12886.355682215664, 13148.079634425498, 13314.267715275753, 13650.0, 13653.249071301174, 13377.464901403835, 13699.520516781864, 13700.24648644334, 13859.37632806506, 14050.578482645536, 9271.351005429555, 9295.163435290857, 9430.575624096795, 9503.477308748084, 9508.667196648084, 10510.527026283682, 10652.84020739674, 10793.19051071157, 10797.406142662228, 10799.67600971972, 8786.736397908073, 9027.864582031143, 9133.041030691682, 9258.583363748783, 9411.764705882408, 8870.383236945247, 9024.684136055206, 9123.90876091257, 9125.726228213165, 9182.265418766616, 7678.923210767821, 7969.521828690297, 8056.395770317133, 8136.267735903797, 8288.58557072156, 6079.817605471843, 6096.268447786294, 6100.877982440237, 6106.1451396803595, 6171.9691401542705, 5159.716215608028, 5991.430814072656, 6145.477634401126, 6157.630542167484, 6212.347703491249], "value": 5395.759154846705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.620206066115, 398.81455123367647, 404.3691840728464, 407.4173931278271, 410.9506859176899, 5702.45826646469, 5766.942330576693, 5781.508571771399, 5786.148432501601, 5802.680852553113, 4787.66486345955, 5449.509544141027, 5555.8888822223535, 5671.347795003576, 5722.256106706122, 4358.6077253047215, 4372.97813510932, 4382.452193475816, 4406.537313582084, 4414.0, 3666.0671462829764, 4391.802368893407, 4404.801783919731, 4406.65596992917, 4419.8066522039035, 3941.586133455989, 4320.891977700567, 4393.670474714393, 4418.624416924566, 4425.645948324142, 4357.498887627916, 4365.759883206422, 4384.473863136428, 4385.495667998189, 4414.889627759332, 3428.6571342865764, 3907.8046097695, 3921.039345360405, 3945.3687410014545, 3953.683705303569, 5207.192885102815, 5266.368035835686, 5418.7019713915715, 5605.887882242373, 5640.323161220639, 4722.268048452495, 4972.8259510917305, 4976.850694479172, 5216.895662086775, 5244.16093425054, 6117.602355846856, 6147.559409922251, 6153.2000839890525, 6160.4455598995855, 6162.291336496271, 3448.3103379323984, 3921.784301863396, 4099.487564054493, 4151.36021271596, 4165.958340416587, 6178.011518157074, 6324.557280990287, 6361.522885783585, 6415.620641562086, 6457.935420645827, 3635.472856435802, 4037.647388125011, 4167.9583204168175, 4176.331786914079, 4195.349720793282, 3557.096953130115, 4016.9598304016586, 4114.7119701621195, 4248.346422077011, 4257.40396344512, 4211.620954114144, 4694.976525117352, 4815.253635686474, 4859.708417494961, 4993.975030124826, 5114.465660301895, 5143.756400969215, 6231.813045608639, 6258.123862659231, 6268.435840774261, 1411.9011669183058, 1433.9139651620935, 1444.3211690505445, 1453.7964684944116, 1459.1463993563673, 936.7611259128879, 942.8020115775627, 948.393028461785, 951.1867353412871, 962.3600305796567, 5808.477237048686, 5910.48326245883, 5913.0, 5918.704064796743, 5927.347991720907, 5788.913166302509, 6081.452669259788, 6336.17629708135, 6465.870682586322, 6501.447376972916, 4950.430700469492, 5654.943450565524, 5678.4605462480995, 5884.558658100659, 5909.527237820964, 2964.5256758918467, 3324.5678061852286, 3371.157210697326, 3373.628900820908, 3379.831008449617, 6156.661383623854, 6343.9849624059925, 6354.586951848115, 6667.133272674619, 6672.9332706673285, 6104.572679912452, 6693.665316734144, 6701.832454188684, 6726.661303459241, 6740.325967403221, 6352.428281454691, 6637.535372523974, 6756.121704178524, 6780.762673306509, 6788.660566971632, 5103.295253515643, 5864.912026319524, 5902.203202567598, 6052.613174274811, 6395.20059992501, 5561.860953476195, 6176.733769577316, 6410.326915673787, 6413.679316034087, 6421.389967953037, 6539.705713243011, 6657.833554160991, 6717.943335782305, 6726.8654626908165, 6741.258461569321, 4168.43726096973, 4699.120351859147, 4734.680006796713, 4738.407699037621, 4745.952540474551, 6164.938350616437, 6344.777932772331, 6476.902846457213, 6533.308680595448, 6574.408303252731, 5711.286089238845, 5915.763369465345, 6184.319724830355, 6274.623522588659, 6292.433680968735, 5235.738213089407, 5446.319210098738, 6060.575759696779, 6258.9374106260175, 6291.528135389773, 6058.091286307089, 6103.969480152571, 6137.140800287874, 6156.661383623944, 6169.259688837368, 4934.407871055496, 5751.942480575308, 6259.280182779039, 6262.68686565679, 6306.117143599991, 5941.465268125717, 6087.330393656783, 6137.232845894263, 6138.938610613836, 6150.231221097363], "value": 4542.800238841763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.828052127229, 732.5568031341038, 844.3161039557963, 851.3104385447788, 866.8990382214588, 12641.620751377463, 18061.096945152756, 18197.818021819778, 18670.973096479705, 18681.972491512963, 17413.825861741378, 17467.0, 17920.551986200353, 17943.64112717745, 17952.73070903934, 969.6073090398382, 991.6281394477071, 992.2657233647085, 993.2749093161996, 993.3096497933939, 667.3826710292984, 681.5229339462371, 976.9658061967832, 1006.7533454303706, 1012.1902478017556, 1031.025680731709, 1034.286342423729, 1035.3580779916424, 1036.7200855768938, 1040.0847254416103, 1027.2244455436173, 1029.7785976015155, 1030.9381437113798, 1031.9793604127951, 1035.7203555040135, 509.2488579345473, 520.5523250004993, 749.1123019222239, 754.8263899303191, 774.1175060431113, 16547.089910054943, 16754.99470031802, 16770.07764572948, 16838.0, 16880.577985550335, 16045.358185672676, 16598.75101873473, 16709.749353759704, 16801.24394402255, 16813.327466901308, 12682.175658582162, 13216.801747973788, 13222.86777132226, 13253.668658283523, 13256.668583285398, 3486.4247399179103, 3569.785812851237, 3614.9096272593133, 3616.041748936534, 3617.5658920929395, 94784.52607736917, 116251.4187429066, 117862.41068794687, 118230.22654660187, 120082.39958800237, 11263.774724505463, 11580.536778528933, 13209.273489957952, 13331.333433328295, 13351.065425420322, 19582.020898954994, 24837.87581062083, 25239.36901577475, 25449.236522904343, 25674.48651026969, 7817.257360550739, 7917.604119794102, 7941.205879412013, 8008.479448835807, 8010.83978320442, 3114.4549703801745, 3855.63371479709, 4010.3583426651594, 4016.59834016596, 4020.155767288902, 4380.956190438055, 4426.9778651106535, 4450.46594408673, 4464.374987501752, 4469.508354081048, 925.8750068740768, 926.5135803703109, 928.8281667891326, 938.2165891480554, 943.9716808495756, 636.1570918532963, 656.9868602627921, 658.1411258307954, 666.4068978609042, 689.183317768446, 11157.66527004191, 11915.523379064914, 11918.0, 11949.163558550817, 12161.878381216075, 643.6299128001418, 643.7264162730821, 643.9613623182624, 644.291279592454, 654.2966311215463, 5465.344158700981, 5548.639338442988, 5610.584123814278, 5638.154276858504, 5644.294463192101, 102567.4871625637, 105779.47110264399, 107924.0, 108231.0, 112201.0, 91398.08601913895, 91999.08000920039, 93082.0, 93184.0, 94048.0, 60954.69522652358, 75500.0, 82661.58669206615, 83528.0, 84701.57649211715, 10034.360838603772, 10257.33327333721, 10414.843777343498, 11234.831477528007, 11350.432478376213, 34768.82615586906, 41686.16627667369, 42443.0, 43323.0, 43452.0, 54636.634084148216, 54740.0, 55521.7223913894, 55766.72116639391, 56628.716856415456, 14104.0, 14140.292985350898, 14495.275236237934, 14526.564203073925, 14543.272836358352, 15543.98964067332, 15670.686586268439, 15695.0, 15775.36898524092, 15902.443414480438, 14508.419663213353, 14712.337944792296, 14885.404583816959, 14902.85097149058, 16297.348106075624, 16773.832261677715, 16995.235214415134, 17231.22459489301, 17536.649267014844, 17565.648687026445, 16284.674306513567, 17022.404215852384, 17077.402290920254, 17085.829141708426, 17180.0, 8690.608922598372, 11775.941120294343, 12174.14780965324, 12348.506059757869, 12529.686757831127, 12009.579664711693, 12985.831275185279, 13092.672683182996, 13273.933630331787, 13307.733845323233], "value": 8157.751038669206, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1435.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 109.0, 112.0, 91.0, 152.0, 159.0, 160.0, 128.0, 114.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 105.0, 149.0, 112.0, 108.0, 107.0, 104.0, 144.0, 127.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 184.0, 182.0, 187.0, 182.0, 185.0, 184.0, 182.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 57.0, 60.0, 87.0, 61.0, 60.0, 59.0, 58.0, 87.0, 56.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 87.0, 70.0, 71.0, 68.0, 108.0, 103.0, 104.0, 93.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 89.0, 89.0, 88.0, 88.0, 88.0, 88.0, 92.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 83.0, 83.0, 84.0, 84.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 46.0, 47.0, 48.0, 49.0, 47.0, 48.0, 48.0, 48.0], "value": 47.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 65.0, 57.0, 70.0, 62.0, 62.0, 57.0, 57.0, 58.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 82.0, 83.0, 81.0, 82.0, 83.0, 83.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 144.0, 146.0, 151.0, 148.0, 135.0, 138.0, 134.0, 177.0, 154.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 183.0, 185.0, 184.0, 183.0, 181.0, 182.0, 182.0, 172.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 65.0, 67.0, 67.0, 69.0, 68.0, 67.0, 67.0], "value": 67.2, "unit": "score"}]}]} 10:05:35 INFO - Return code: 0 10:05:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:35 ERROR - # TBPL SUCCESS # 10:05:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:35 INFO - 2017-05-01 10:05:35.876 screenresolution[1660:9845] starting screenresolution argv=screenresolution get 10:05:35 INFO - 2017-05-01 10:05:35.879 screenresolution[1660:9845] Display 0: 1600x1200x32@60 10:05:35 INFO - 2017-05-01 10:05:35.885 screenresolution[1661:9848] starting screenresolution argv=screenresolution list 10:05:35 INFO - Available Modes on Display 0 10:05:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:36 INFO - Intel Iris: 10:05:36 INFO - Chipset Model: Intel Iris 10:05:36 INFO - Type: GPU 10:05:36 INFO - Bus: Built-In 10:05:36 INFO - VRAM (Dynamic, Max): 1536 MB 10:05:36 INFO - Vendor: Intel (0x8086) 10:05:36 INFO - Device ID: 0x0a2e 10:05:36 INFO - Revision ID: 0x0009 10:05:36 INFO - Displays: 10:05:36 INFO - Display: 10:05:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:36 INFO - Display Serial Number: 1600x1200 60 10:05:36 INFO - Main Display: Yes 10:05:36 INFO - Mirror: Off 10:05:36 INFO - Online: Yes 10:05:36 INFO - Rotation: Supported 10:05:36 INFO - Return code: 0 10:05:36 INFO - Running post-action listener: _resource_record_post_action 10:05:36 INFO - [mozharness: 2017-05-01 17:05:36.127636Z] Finished run-tests step (success) 10:05:36 INFO - Running post-run listener: _resource_record_post_run 10:05:36 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 40351232; Write bytes: 512741376; Read time: 421; Write time: 1732 10:05:36 INFO - TinderboxPrint: CPU usage
53.3% 10:05:36 INFO - TinderboxPrint: I/O read bytes / time
40,351,232 / 421 10:05:36 INFO - TinderboxPrint: I/O write bytes / time
512,741,376 / 1,732 10:05:36 INFO - TinderboxPrint: CPU idle
2,242.2 (46.7%) 10:05:36 INFO - TinderboxPrint: CPU system
958.0 (19.9%) 10:05:36 INFO - TinderboxPrint: CPU user
1,605.3 (33.4%) 10:05:36 INFO - TinderboxPrint: Swap in / out
247,627,776 / 0 10:05:36 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209801728; Write bytes: 213248000; Read time: 16172; Write time: 509 10:05:36 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 35415552; Write bytes: 298158080; Read time: 386; Write time: 1218 10:05:36 INFO - Running post-run listener: _upload_blobber_files 10:05:36 INFO - Blob upload gear active. 10:05:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:36 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 10:05:36 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:05:36 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:05:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:38 INFO - (blobuploader) - INFO - Done attempting. 10:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:39 INFO - (blobuploader) - INFO - Done attempting. 10:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:40 INFO - (blobuploader) - INFO - Done attempting. 10:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:42 INFO - (blobuploader) - INFO - Done attempting. 10:05:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:42 INFO - Return code: 0 10:05:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/892418183d4eb1831ec19238558e298f99748d84fbb48cc603897e005bc3d1a0de6d5097b11c096ad51caff8139bc232d0e82001610c7412447b073e9881b2c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3513ee52b463e7bc2a29110c4b85b5ac8e50bbf11ddcbe5103f6a0fd5f3a4d91272de3a8621ccc2a17b7d4f8d5f4a15f8c584b21ef08075e9862672ba6150c98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d56ee0a9e5f4908029aa27d7cc0062f781895a2065399f3325686e9877b3b65feec028ac4d2561dcf76363609c114491b817833b681b89b473a618af57f1c9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9761265bd21c30d8e9ccbce76d85a20a7c8a8d3160619cea1427fbebaa1b50f2eef3860ec363504da0fbb15b32780d6ad21f6c30ccf5a3931bee13badab0f92a"} 10:05:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:42 INFO - Contents: 10:05:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/892418183d4eb1831ec19238558e298f99748d84fbb48cc603897e005bc3d1a0de6d5097b11c096ad51caff8139bc232d0e82001610c7412447b073e9881b2c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3513ee52b463e7bc2a29110c4b85b5ac8e50bbf11ddcbe5103f6a0fd5f3a4d91272de3a8621ccc2a17b7d4f8d5f4a15f8c584b21ef08075e9862672ba6150c98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d56ee0a9e5f4908029aa27d7cc0062f781895a2065399f3325686e9877b3b65feec028ac4d2561dcf76363609c114491b817833b681b89b473a618af57f1c9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9761265bd21c30d8e9ccbce76d85a20a7c8a8d3160619cea1427fbebaa1b50f2eef3860ec363504da0fbb15b32780d6ad21f6c30ccf5a3931bee13badab0f92a"} 10:05:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:42 INFO - Copying logs to upload dir... 10:05:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.540377 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-05-01 10:05:42.521530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 10:05:42.525346) ========= 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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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/Firefox/sha512/892418183d4eb1831ec19238558e298f99748d84fbb48cc603897e005bc3d1a0de6d5097b11c096ad51caff8139bc232d0e82001610c7412447b073e9881b2c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3513ee52b463e7bc2a29110c4b85b5ac8e50bbf11ddcbe5103f6a0fd5f3a4d91272de3a8621ccc2a17b7d4f8d5f4a15f8c584b21ef08075e9862672ba6150c98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d56ee0a9e5f4908029aa27d7cc0062f781895a2065399f3325686e9877b3b65feec028ac4d2561dcf76363609c114491b817833b681b89b473a618af57f1c9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9761265bd21c30d8e9ccbce76d85a20a7c8a8d3160619cea1427fbebaa1b50f2eef3860ec363504da0fbb15b32780d6ad21f6c30ccf5a3931bee13badab0f92a"} build_url:https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/MmeoB3JIQUC0Um33qcsSlg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/892418183d4eb1831ec19238558e298f99748d84fbb48cc603897e005bc3d1a0de6d5097b11c096ad51caff8139bc232d0e82001610c7412447b073e9881b2c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3513ee52b463e7bc2a29110c4b85b5ac8e50bbf11ddcbe5103f6a0fd5f3a4d91272de3a8621ccc2a17b7d4f8d5f4a15f8c584b21ef08075e9862672ba6150c98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d56ee0a9e5f4908029aa27d7cc0062f781895a2065399f3325686e9877b3b65feec028ac4d2561dcf76363609c114491b817833b681b89b473a618af57f1c9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9761265bd21c30d8e9ccbce76d85a20a7c8a8d3160619cea1427fbebaa1b50f2eef3860ec363504da0fbb15b32780d6ad21f6c30ccf5a3931bee13badab0f92a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 10:05:42.562493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 10:05:42.562975) ========= 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.8ScyaRrTi3/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.jnB4qfTmcs/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005057 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 10:05:42.611526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 10:05:42.611832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 10:05:42.612128) ========= ========= Total master_lag: 0.20 =========