builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0202 starttime: 1472749693.38 results: success (0) buildid: 20160901080621 builduid: 977bd45b4c144820ba596a5f50184de3 revision: aa1a7886af087c5c13cd087ac1c67dac7e553492 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.380714) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.381441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.381906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.409685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.410306) ========= 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.4AH4WkGZqn/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.SW2juCw8zl/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-01 10:08:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-09-01 10:08:13 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124326 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.560669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.561211) ========= 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.4AH4WkGZqn/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.SW2juCw8zl/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.027661 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:13.611546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 10:08:13.611920) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aa1a7886af087c5c13cd087ac1c67dac7e553492 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev aa1a7886af087c5c13cd087ac1c67dac7e553492 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4AH4WkGZqn/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.SW2juCw8zl/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-01 10:08:13,699 truncating revision to first 12 chars 2016-09-01 10:08:13,699 Setting DEBUG logging. 2016-09-01 10:08:13,699 attempt 1/10 2016-09-01 10:08:13,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aa1a7886af08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 10:08:14,349 unpacking tar archive at: fx-team-aa1a7886af08/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928294 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 10:08:14.623065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:14.623431) ========= script_repo_revision: aa1a7886af087c5c13cd087ac1c67dac7e553492 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:14.623853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:14.624138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 10:08:14.660222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-01 10:08:14.660724) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4AH4WkGZqn/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.SW2juCw8zl/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:14 INFO - MultiFileLogger online at 20160901 10:08:14 in /builds/slave/test 10:08:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:08:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:14 INFO - {'append_to_log': False, 10:08:14 INFO - 'base_work_dir': '/builds/slave/test', 10:08:14 INFO - 'blob_upload_branch': 'Fx-Team', 10:08:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:14 INFO - 'branch': 'Fx-Team', 10:08:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:14 INFO - 'config_files': ('talos/mac_config.py',), 10:08:14 INFO - 'default_actions': ('clobber', 10:08:14 INFO - 'read-buildbot-config', 10:08:14 INFO - 'download-and-extract', 10:08:14 INFO - 'populate-webroot', 10:08:14 INFO - 'create-virtualenv', 10:08:14 INFO - 'install', 10:08:14 INFO - 'run-tests'), 10:08:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:14 INFO - 'download_minidump_stackwalk': True, 10:08:14 INFO - 'download_symbols': 'ondemand', 10:08:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:14 INFO - 'installer_path': 'installer.exe', 10:08:14 INFO - 'log_level': 'info', 10:08:14 INFO - 'log_name': 'talos', 10:08:14 INFO - 'log_to_console': True, 10:08:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:08:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:08:14 INFO - 'opt_config_files': (), 10:08:14 INFO - 'pip_index': False, 10:08:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:08:14 INFO - 'cmd': ('bash', 10:08:14 INFO - '-c', 10:08:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:08:14 INFO - 'enabled': True, 10:08:14 INFO - 'halt_on_failure': False, 10:08:14 INFO - 'name': 'check_screen_resolution'},), 10:08:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:08:14 INFO - 'cmd': ('bash', 10:08:14 INFO - '-c', 10:08:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:08:14 INFO - 'enabled': True, 10:08:14 INFO - 'halt_on_failure': False, 10:08:14 INFO - 'name': 'check_screen_resolution'},), 10:08:14 INFO - 'run_cmd_checks_enabled': True, 10:08:14 INFO - 'sps_profile': False, 10:08:14 INFO - 'sps_profile_interval': 0, 10:08:14 INFO - 'suite': 'dromaeojs-e10s', 10:08:14 INFO - 'system_bits': '32', 10:08:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:14 INFO - 'title': 't-yosemite-r7-0202', 10:08:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:14 INFO - 'use_talos_json': True, 10:08:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:14 INFO - 'work_dir': 'build'} 10:08:14 INFO - [mozharness: 2016-09-01 17:08:14.858139Z] Running clobber step. 10:08:14 INFO - Running pre-action listener: _resource_record_pre_action 10:08:14 INFO - Running main action method: clobber 10:08:14 INFO - rmtree: /builds/slave/test/build 10:08:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:16 INFO - Running post-action listener: _resource_record_post_action 10:08:16 INFO - [mozharness: 2016-09-01 17:08:16.716755Z] Finished clobber step (success) 10:08:16 INFO - [mozharness: 2016-09-01 17:08:16.716897Z] Running read-buildbot-config step. 10:08:16 INFO - Running pre-action listener: _resource_record_pre_action 10:08:16 INFO - Running main action method: read_buildbot_config 10:08:16 INFO - Using buildbot properties: 10:08:16 INFO - { 10:08:16 INFO - "project": "", 10:08:16 INFO - "product": "firefox", 10:08:16 INFO - "script_repo_revision": "production", 10:08:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:08:16 INFO - "repository": "", 10:08:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:08:16 INFO - "buildid": "20160901080621", 10:08:16 INFO - "pgo_build": "False", 10:08:16 INFO - "basedir": "/builds/slave/test", 10:08:16 INFO - "buildnumber": 89, 10:08:16 INFO - "slavename": "t-yosemite-r7-0202", 10:08:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:08:16 INFO - "platform": "yosemite_r7", 10:08:16 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:08:16 INFO - "branch": "fx-team", 10:08:16 INFO - "repo_path": "integration/fx-team", 10:08:16 INFO - "revision": "aa1a7886af087c5c13cd087ac1c67dac7e553492", 10:08:16 INFO - "stage_platform": "macosx64", 10:08:16 INFO - "builduid": "977bd45b4c144820ba596a5f50184de3", 10:08:16 INFO - "slavebuilddir": "test" 10:08:16 INFO - } 10:08:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:08:16 INFO - Running post-action listener: _resource_record_post_action 10:08:16 INFO - [mozharness: 2016-09-01 17:08:16.720303Z] Finished read-buildbot-config step (success) 10:08:16 INFO - [mozharness: 2016-09-01 17:08:16.720433Z] Running download-and-extract step. 10:08:16 INFO - Running pre-action listener: _resource_record_pre_action 10:08:16 INFO - Running main action method: download_and_extract 10:08:16 INFO - mkdir: /builds/slave/test/build/tests 10:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:16 INFO - trying https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:08:16 INFO - Downloading https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 10:08:18 INFO - Downloaded 1199 bytes. 10:08:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:08:18 INFO - Using the following test package requirements: 10:08:18 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:08:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:08:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:08:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'jsshell-mac.zip'], 10:08:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:08:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:08:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:08:18 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:08:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:08:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:08:18 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:08:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:08: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')]} 10:08:18 INFO - trying https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:08:18 INFO - Downloading https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:08:19 INFO - Downloaded 16399877 bytes. 10:08:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:08:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:26 INFO - trying https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:08:26 INFO - Downloading https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:08:27 INFO - Downloaded 16399877 bytes. 10:08:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:08: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')]} 10:08:33 INFO - trying https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:08:33 INFO - Downloading https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:08:34 INFO - Downloaded 14413998 bytes. 10:08:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:35 INFO - trying https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:08:35 INFO - Downloading https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 10:08:38 INFO - Downloaded 111593410 bytes. 10:08:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:08:38 INFO - mkdir: /builds/slave/test/properties 10:08:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:38 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:38 INFO - Contents: 10:08:38 INFO - build_url:https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:08:38 INFO - Running post-action listener: _resource_record_post_action 10:08:38 INFO - Running post-action listener: set_extra_try_arguments 10:08:38 INFO - [mozharness: 2016-09-01 17:08:38.902005Z] Finished download-and-extract step (success) 10:08:38 INFO - [mozharness: 2016-09-01 17:08:38.902156Z] Running populate-webroot step. 10:08:38 INFO - Running pre-action listener: _resource_record_pre_action 10:08:38 INFO - Running main action method: populate_webroot 10:08:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:38 INFO - '--tppagecycles', 10:08:38 INFO - '7'], 10:08:38 INFO - 'tests': ['tsvgm']}}, 10:08:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['damp', 'tps']}, 10:08:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'tests': ['damp', 'tps']}, 10:08:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['dromaeo_dom']}, 10:08:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['basic_compositor_video']}, 10:08:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:08:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['a11yr', 10:08:38 INFO - 'ts_paint', 10:08:38 INFO - 'tpaint', 10:08:38 INFO - 'sessionrestore', 10:08:38 INFO - 'sessionrestore_no_auto_restore', 10:08:38 INFO - 'tabpaint']}, 10:08:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:38 INFO - 'ts_paint', 10:08:38 INFO - 'tpaint', 10:08:38 INFO - 'sessionrestore', 10:08:38 INFO - 'sessionrestore_no_auto_restore', 10:08:38 INFO - 'tabpaint']}, 10:08:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:38 INFO - 'ts_paint', 10:08:38 INFO - 'tpaint', 10:08:38 INFO - 'sessionrestore', 10:08:38 INFO - 'sessionrestore_no_auto_restore', 10:08:38 INFO - 'tabpaint']}, 10:08:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:38 INFO - 'ts_paint', 10:08:38 INFO - 'tpaint', 10:08:38 INFO - 'sessionrestore', 10:08:38 INFO - 'sessionrestore_no_auto_restore', 10:08:38 INFO - 'tabpaint']}, 10:08:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['a11yr', 10:08:38 INFO - 'ts_paint', 10:08:38 INFO - 'tpaint', 10:08:38 INFO - 'sessionrestore', 10:08:38 INFO - 'sessionrestore_no_auto_restore', 10:08:38 INFO - 'tabpaint']}, 10:08:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['a11yr', 10:08:38 INFO - 'ts_paint', 10:08:38 INFO - 'tpaint', 10:08:38 INFO - 'sessionrestore', 10:08:38 INFO - 'sessionrestore_no_auto_restore', 10:08:38 INFO - 'tabpaint']}, 10:08:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['tsvgx', 10:08:38 INFO - 'tsvgr_opacity', 10:08:38 INFO - 'tart', 10:08:38 INFO - 'tscrollx', 10:08:38 INFO - 'cart']}, 10:08:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:38 INFO - 'tsvgr_opacity', 10:08:38 INFO - 'tart', 10:08:38 INFO - 'tscrollx', 10:08:38 INFO - 'cart']}, 10:08:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'talos_options': ['--disable-e10s'], 10:08:38 INFO - 'tests': ['tp5o']}, 10:08:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'tests': ['tp5o']}, 10:08:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'talos_options': ['--disable-e10s', 10:08:38 INFO - '--xperf_path', 10:08:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:38 INFO - 'tests': ['tp5n']}, 10:08:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:38 INFO - 'talos_options': ['--xperf_path', 10:08:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:38 INFO - 'tests': ['tp5n']}}, 10:08:38 INFO - 'talos.zip': {'path': '', 10:08:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:38 INFO - Running post-action listener: _resource_record_post_action 10:08:38 INFO - [mozharness: 2016-09-01 17:08:38.921187Z] Finished populate-webroot step (success) 10:08:38 INFO - [mozharness: 2016-09-01 17:08:38.921316Z] Running create-virtualenv step. 10:08:38 INFO - Running pre-action listener: _resource_record_pre_action 10:08:38 INFO - Running main action method: create_virtualenv 10:08:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:38 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 10:08:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:39 INFO - Using real prefix '/tools/python27' 10:08:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:42 INFO - Installing pip.................done. 10:08:42 INFO - Return code: 0 10:08:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:42 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:42 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 10:08:42 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 10:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:42 INFO - 'HOME': '/Users/cltbld', 10:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:42 INFO - 'LOGNAME': 'cltbld', 10:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:42 INFO - 'MOZ_NO_REMOTE': '1', 10:08:42 INFO - 'NO_EM_RESTART': '1', 10:08:42 INFO - 'PAGER': '/bin/cat', 10:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:42 INFO - 'PWD': '/builds/slave/test', 10:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:42 INFO - 'SHELL': '/bin/bash', 10:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:08:42 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:42 INFO - 'USER': 'cltbld', 10:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:42 INFO - 'XPC_FLAGS': '0x0', 10:08:42 INFO - 'XPC_SERVICE_NAME': '0', 10:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:42 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 10:08:42 INFO - Cleaning up... 10:08:42 INFO - Return code: 0 10:08:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:42 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:42 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 10:08:42 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 10:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:42 INFO - 'HOME': '/Users/cltbld', 10:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:42 INFO - 'LOGNAME': 'cltbld', 10:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:42 INFO - 'MOZ_NO_REMOTE': '1', 10:08:42 INFO - 'NO_EM_RESTART': '1', 10:08:42 INFO - 'PAGER': '/bin/cat', 10:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:42 INFO - 'PWD': '/builds/slave/test', 10:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:42 INFO - 'SHELL': '/bin/bash', 10:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:08:42 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:42 INFO - 'USER': 'cltbld', 10:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:42 INFO - 'XPC_FLAGS': '0x0', 10:08:42 INFO - 'XPC_SERVICE_NAME': '0', 10:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:43 INFO - Downloading/unpacking psutil>=3.1.1 10:08:43 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 10:08:43 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 10:08:43 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 10:08:43 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 10:08:43 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 10:08:43 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 10:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:46 INFO - Installing collected packages: psutil 10:08:46 INFO - Running setup.py install for psutil 10:08:46 INFO - building 'psutil._psutil_osx' extension 10:08:46 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 10:08:47 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 10:08:47 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 10:08:47 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 10:08:47 INFO - building 'psutil._psutil_posix' extension 10:08:47 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 10:08:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:08:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:08:47 INFO - ^ 10:08:47 INFO - 1 warning generated. 10:08:47 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 10:08:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:47 INFO - Successfully installed psutil 10:08:47 INFO - Cleaning up... 10:08:47 INFO - Return code: 0 10:08:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:08:47 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')]} 10:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:47 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')]} 10:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:47 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:47 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 10:08:47 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 10:08:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:08:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:47 INFO - 'HOME': '/Users/cltbld', 10:08:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:47 INFO - 'LOGNAME': 'cltbld', 10:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:47 INFO - 'MOZ_NO_REMOTE': '1', 10:08:47 INFO - 'NO_EM_RESTART': '1', 10:08:47 INFO - 'PAGER': '/bin/cat', 10:08:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:47 INFO - 'PWD': '/builds/slave/test', 10:08:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:47 INFO - 'SHELL': '/bin/bash', 10:08:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:08:47 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:08:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:47 INFO - 'USER': 'cltbld', 10:08:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:47 INFO - 'XPC_FLAGS': '0x0', 10:08:47 INFO - 'XPC_SERVICE_NAME': '0', 10:08:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:08:47 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 10:08:47 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 10:08:47 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 10:08:47 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 10:08:47 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 10:08:47 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 10:08:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:08:50 INFO - Installing collected packages: mozsystemmonitor 10:08:50 INFO - Running setup.py install for mozsystemmonitor 10:08:50 INFO - Successfully installed mozsystemmonitor 10:08:50 INFO - Cleaning up... 10:08:50 INFO - Return code: 0 10:08:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:08:50 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')]} 10:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:50 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')]} 10:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:50 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:50 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 10:08:50 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 10:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:50 INFO - 'HOME': '/Users/cltbld', 10:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:50 INFO - 'LOGNAME': 'cltbld', 10:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:50 INFO - 'MOZ_NO_REMOTE': '1', 10:08:50 INFO - 'NO_EM_RESTART': '1', 10:08:50 INFO - 'PAGER': '/bin/cat', 10:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:50 INFO - 'PWD': '/builds/slave/test', 10:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:50 INFO - 'SHELL': '/bin/bash', 10:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:08:50 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:50 INFO - 'USER': 'cltbld', 10:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:50 INFO - 'XPC_FLAGS': '0x0', 10:08:50 INFO - 'XPC_SERVICE_NAME': '0', 10:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:51 INFO - Downloading/unpacking jsonschema==2.5.1 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:08:53 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 10:08:53 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 10:08:53 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 10:08:53 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 10:08:53 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 10:08:53 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 10:08:53 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:54 INFO - warning: no files found matching '*.txt' 10:08:54 INFO - no previously-included directories found matching 'build' 10:08:54 INFO - no previously-included directories found matching 'dist' 10:08:54 INFO - no previously-included directories found matching '.git*' 10:08:54 INFO - Installing collected packages: jsonschema, functools32 10:08:54 INFO - Running setup.py install for functools32 10:08:54 INFO - warning: no files found matching '*.txt' 10:08:54 INFO - no previously-included directories found matching 'build' 10:08:54 INFO - no previously-included directories found matching 'dist' 10:08:54 INFO - no previously-included directories found matching '.git*' 10:08:54 INFO - Successfully installed jsonschema functools32 10:08:54 INFO - Cleaning up... 10:08:54 INFO - Return code: 0 10:08:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:54 INFO - 'HOME': '/Users/cltbld', 10:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:54 INFO - 'LOGNAME': 'cltbld', 10:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:54 INFO - 'MOZ_NO_REMOTE': '1', 10:08:54 INFO - 'NO_EM_RESTART': '1', 10:08:54 INFO - 'PAGER': '/bin/cat', 10:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:54 INFO - 'PWD': '/builds/slave/test', 10:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:54 INFO - 'SHELL': '/bin/bash', 10:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:08:54 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:54 INFO - 'USER': 'cltbld', 10:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:54 INFO - 'XPC_FLAGS': '0x0', 10:08:54 INFO - 'XPC_SERVICE_NAME': '0', 10:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:08:54 INFO - Cleaning up... 10:08:54 INFO - Return code: 0 10:08:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:54 INFO - 'HOME': '/Users/cltbld', 10:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:54 INFO - 'LOGNAME': 'cltbld', 10:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:54 INFO - 'MOZ_NO_REMOTE': '1', 10:08:54 INFO - 'NO_EM_RESTART': '1', 10:08:54 INFO - 'PAGER': '/bin/cat', 10:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:54 INFO - 'PWD': '/builds/slave/test', 10:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:54 INFO - 'SHELL': '/bin/bash', 10:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:08:54 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:54 INFO - 'USER': 'cltbld', 10:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:54 INFO - 'XPC_FLAGS': '0x0', 10:08:54 INFO - 'XPC_SERVICE_NAME': '0', 10:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:54 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 10:08:54 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 10:08:54 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 10:08:54 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 10:08:54 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 10:08:54 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 10:08:57 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:57 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 10:08:57 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 10:08:57 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 10:08:57 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 10:08:57 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 10:08:57 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 10:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:58 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 10:08:58 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 10:08:58 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 10:08:58 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 10:08:58 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 10:08:58 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 10:08:58 INFO - Downloading docopt-0.6.1.tar.gz 10:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:58 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:58 INFO - Running setup.py install for blobuploader 10:08:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:58 INFO - Running setup.py install for requests 10:08:59 INFO - Running setup.py install for docopt 10:08:59 INFO - Successfully installed blobuploader requests docopt 10:08:59 INFO - Cleaning up... 10:08:59 INFO - Return code: 0 10:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:59 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')]} 10:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:59 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')]} 10:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:59 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:08:59 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 10:08:59 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 10:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:59 INFO - 'HOME': '/Users/cltbld', 10:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:59 INFO - 'LOGNAME': 'cltbld', 10:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:59 INFO - 'MOZ_NO_REMOTE': '1', 10:08:59 INFO - 'NO_EM_RESTART': '1', 10:08:59 INFO - 'PAGER': '/bin/cat', 10:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:59 INFO - 'PWD': '/builds/slave/test', 10:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:59 INFO - 'SHELL': '/bin/bash', 10:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:08:59 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:59 INFO - 'USER': 'cltbld', 10:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:59 INFO - 'XPC_FLAGS': '0x0', 10:08:59 INFO - 'XPC_SERVICE_NAME': '0', 10:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-OTRHLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-KuoFxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-MVnncS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-x7XSsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-bC1305-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-SmFi3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-2FO6XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-5YPCHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-wC3wxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-nL8lvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-jzQdtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Sx0qjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:01 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-n2SZoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:01 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-NvX4f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:01 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-ag5un9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:01 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-N1ygwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:01 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-jcJo0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:01 INFO - Running setup.py install for manifestparser 10:09:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:01 INFO - Running setup.py install for mozcrash 10:09:01 INFO - Running setup.py install for mozdebug 10:09:01 INFO - Running setup.py install for mozdevice 10:09:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozfile 10:09:02 INFO - Running setup.py install for mozhttpd 10:09:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozinfo 10:09:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozInstall 10:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozleak 10:09:02 INFO - Running setup.py install for mozlog 10:09:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for moznetwork 10:09:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozprocess 10:09:03 INFO - Running setup.py install for mozprofile 10:09:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozrunner 10:09:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozscreenshot 10:09:03 INFO - Running setup.py install for moztest 10:09:03 INFO - Running setup.py install for mozversion 10:09:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:04 INFO - Cleaning up... 10:09:04 INFO - Return code: 0 10:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:04 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')]} 10:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 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')]} 10:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:09:04 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 10:09:04 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 10:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:04 INFO - 'HOME': '/Users/cltbld', 10:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:04 INFO - 'LOGNAME': 'cltbld', 10:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:04 INFO - 'MOZ_NO_REMOTE': '1', 10:09:04 INFO - 'NO_EM_RESTART': '1', 10:09:04 INFO - 'PAGER': '/bin/cat', 10:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:04 INFO - 'PWD': '/builds/slave/test', 10:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:04 INFO - 'SHELL': '/bin/bash', 10:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:09:04 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:04 INFO - 'USER': 'cltbld', 10:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:04 INFO - 'XPC_FLAGS': '0x0', 10:09:04 INFO - 'XPC_SERVICE_NAME': '0', 10:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-WAoVBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:04 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)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-1Ya9o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-r8UBnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:04 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)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-QfsW0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-B7_okv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:04 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)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-XnVRJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-ro2rEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-HYsIBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-AheYPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-G5ECFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-B7bKMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-xMN1aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-NjFPZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-f_3rpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-xikrbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:06 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)) 10:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:06 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-QE63bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:06 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-wZxQM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:06 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)) 10:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:06 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)) 10:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:09:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:06 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 10:09:06 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 10:09:06 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 10:09:06 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 10:09:06 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 10:09:06 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 10:09:08 INFO - Downloading blessings-1.6.tar.gz 10:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:08 INFO - Installing collected packages: blessings 10:09:08 INFO - Running setup.py install for blessings 10:09:09 INFO - Successfully installed blessings 10:09:09 INFO - Cleaning up... 10:09:09 INFO - Return code: 0 10:09:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:09 INFO - Reading from file tmpfile_stdout 10:09:09 INFO - Current package versions: 10:09:09 INFO - blessings == 1.6 10:09:09 INFO - blobuploader == 1.2.4 10:09:09 INFO - docopt == 0.6.1 10:09:09 INFO - functools32 == 3.2.3-2 10:09:09 INFO - jsonschema == 2.5.1 10:09:09 INFO - manifestparser == 1.1 10:09:09 INFO - mozInstall == 1.12 10:09:09 INFO - mozcrash == 0.17 10:09:09 INFO - mozdebug == 0.1 10:09:09 INFO - mozdevice == 0.48 10:09:09 INFO - mozfile == 1.2 10:09:09 INFO - mozhttpd == 0.7 10:09:09 INFO - mozinfo == 0.9 10:09:09 INFO - mozleak == 0.1 10:09:09 INFO - mozlog == 3.3 10:09:09 INFO - moznetwork == 0.27 10:09:09 INFO - mozprocess == 0.23 10:09:09 INFO - mozprofile == 0.28 10:09:09 INFO - mozrunner == 6.12 10:09:09 INFO - mozscreenshot == 0.1 10:09:09 INFO - mozsystemmonitor == 0.3 10:09:09 INFO - moztest == 0.7 10:09:09 INFO - mozversion == 1.4 10:09:09 INFO - psutil == 3.1.1 10:09:09 INFO - requests == 1.2.3 10:09:09 INFO - wsgiref == 0.1.2 10:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:09 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:09:09 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 10:09:09 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 10:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:09 INFO - 'HOME': '/Users/cltbld', 10:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:09 INFO - 'LOGNAME': 'cltbld', 10:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:09 INFO - 'MOZ_NO_REMOTE': '1', 10:09:09 INFO - 'NO_EM_RESTART': '1', 10:09:09 INFO - 'PAGER': '/bin/cat', 10:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:09 INFO - 'PWD': '/builds/slave/test', 10:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:09 INFO - 'SHELL': '/bin/bash', 10:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:09:09 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:09 INFO - 'USER': 'cltbld', 10:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:09 INFO - 'XPC_FLAGS': '0x0', 10:09:09 INFO - 'XPC_SERVICE_NAME': '0', 10:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 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)) 10:09:10 INFO - Cleaning up... 10:09:10 INFO - Return code: 0 10:09:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:10 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 0x1078b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107948618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36bdad6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, '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.4AH4WkGZqn/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.SW2juCw8zl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 10:09:10 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 10:09:10 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 10:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:10 INFO - 'HOME': '/Users/cltbld', 10:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:10 INFO - 'LOGNAME': 'cltbld', 10:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:10 INFO - 'MOZ_NO_REMOTE': '1', 10:09:10 INFO - 'NO_EM_RESTART': '1', 10:09:10 INFO - 'PAGER': '/bin/cat', 10:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:10 INFO - 'PWD': '/builds/slave/test', 10:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:10 INFO - 'SHELL': '/bin/bash', 10:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:09:10 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:10 INFO - 'USER': 'cltbld', 10:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:10 INFO - 'XPC_FLAGS': '0x0', 10:09:10 INFO - 'XPC_SERVICE_NAME': '0', 10:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:09:10 INFO - Cleaning up... 10:09:10 INFO - Return code: 0 10:09:10 INFO - Running post-action listener: _resource_record_post_action 10:09:10 INFO - Running post-action listener: _start_resource_monitoring 10:09:10 INFO - Starting resource monitoring. 10:09:10 INFO - [mozharness: 2016-09-01 17:09:10.326093Z] Finished create-virtualenv step (success) 10:09:10 INFO - [mozharness: 2016-09-01 17:09:10.327153Z] Running install step. 10:09:10 INFO - Running pre-action listener: _resource_record_pre_action 10:09:10 INFO - Running main action method: install 10:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:10 INFO - Reading from file tmpfile_stdout 10:09:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:10 INFO - Reading from file tmpfile_stdout 10:09:10 INFO - Output received: 10:09:10 INFO - Usage: mozinstall [options] installer 10:09:10 INFO - Options: 10:09:10 INFO - -h, --help show this help message and exit 10:09:10 INFO - -d DEST, --destination=DEST 10:09:10 INFO - Directory to install application into. [default: 10:09:10 INFO - "/builds/slave/test"] 10:09:10 INFO - --app=APP Application being installed. [default: firefox] 10:09:10 INFO - mkdir: /builds/slave/test/build/application 10:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:09:44 INFO - Reading from file tmpfile_stdout 10:09:44 INFO - Output received: 10:09:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:09:44 INFO - Running post-action listener: _resource_record_post_action 10:09:44 INFO - [mozharness: 2016-09-01 17:09:44.432610Z] Finished install step (success) 10:09:44 INFO - [mozharness: 2016-09-01 17:09:44.432745Z] Running run-tests step. 10:09:44 INFO - Running pre-action listener: _resource_record_pre_action 10:09:44 INFO - Running main action method: run_tests 10:09:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:44 INFO - 2016-09-01 10:09:44.447 screenresolution[1638:7564] starting screenresolution argv=screenresolution get 10:09:44 INFO - 2016-09-01 10:09:44.449 screenresolution[1638:7564] Display 0: 1600x1200x32@60 10:09:44 INFO - 2016-09-01 10:09:44.455 screenresolution[1639:7566] starting screenresolution argv=screenresolution list 10:09:44 INFO - Available Modes on Display 0 10:09:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:44 INFO - Intel Iris: 10:09:44 INFO - Chipset Model: Intel Iris 10:09:44 INFO - Type: GPU 10:09:44 INFO - Bus: Built-In 10:09:44 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:44 INFO - Vendor: Intel (0x8086) 10:09:44 INFO - Device ID: 0x0a2e 10:09:44 INFO - Revision ID: 0x0009 10:09:44 INFO - Displays: 10:09:44 INFO - Display: 10:09:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:44 INFO - Display Serial Number: 1600x1200 60 10:09:44 INFO - Main Display: Yes 10:09:44 INFO - Mirror: Off 10:09:44 INFO - Online: Yes 10:09:44 INFO - Rotation: Supported 10:09:44 INFO - Return code: 0 10:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:44 INFO - Python 2.7.3 10:09:44 INFO - Return code: 0 10:09:44 INFO - grabbing minidump binary from tooltool 10:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:44 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 0x107817d30>, '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 0x10757cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10780fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:44 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 10:09:44 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 10:09:44 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 10:09:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:44 INFO - Return code: 0 10:09:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:09:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:09:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0202 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4AH4WkGZqn/Render', 10:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:44 INFO - 'HOME': '/Users/cltbld', 10:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:44 INFO - 'LOGNAME': 'cltbld', 10:09:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:44 INFO - 'MOZ_NO_REMOTE': '1', 10:09:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:44 INFO - 'NO_EM_RESTART': '1', 10:09:44 INFO - 'PAGER': '/bin/cat', 10:09:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:44 INFO - 'PWD': '/builds/slave/test', 10:09:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:44 INFO - 'SHELL': '/bin/bash', 10:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SW2juCw8zl/Listeners', 10:09:44 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 10:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:44 INFO - 'USER': 'cltbld', 10:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:44 INFO - 'XPC_FLAGS': '0x0', 10:09:44 INFO - 'XPC_SERVICE_NAME': '0', 10:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:09:45 INFO - mozversion application_buildid: 20160901080621 10:09:45 INFO - mozversion application_changeset: aa1a7886af087c5c13cd087ac1c67dac7e553492 10:09:45 INFO - mozversion application_display_name: Nightly 10:09:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:45 INFO - mozversion application_name: Firefox 10:09:45 INFO - mozversion application_remotingname: firefox 10:09:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:09:45 INFO - mozversion application_vendor: Mozilla 10:09:45 INFO - mozversion application_version: 51.0a1 10:09:45 INFO - mozversion platform_buildid: 20160901080621 10:09:45 INFO - mozversion platform_changeset: aa1a7886af087c5c13cd087ac1c67dac7e553492 10:09:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:09:45 INFO - mozversion platform_version: 51.0a1 10:09:45 INFO - using testdate: 1472749785 10:09:45 INFO - actual date: 1472749785 10:09:45 INFO - starting webserver on 'localhost:49268' 10:09:45 INFO - SUITE-START | Running 2 tests 10:09:45 INFO - TEST-START | dromaeo_css 10:09:45 INFO - operating with platform_type : mac_ 10:09:45 INFO - Initialising browser for dromaeo_css test... 10:09:45 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmp5pDzLZ/profile http://localhost:49268/getInfo.html) 10:09:47 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 10:09:47 INFO - PROCESS | 1649 | colorDepth:24 10:09:47 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 10:09:47 INFO - PROCESS | 1649 | __metrics 10:09:48 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 10:09:48 INFO - TEST-INFO | 1649: exit 0 10:09:48 INFO - Browser initialized. 10:09:48 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:48 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmp5pDzLZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:00 INFO - PROCESS | 1652 | RSS: Main: 245518336 10:10:00 INFO - PROCESS | 1652 | 10:10:50 INFO - PROCESS | 1652 | 1472749850441 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:13:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 10:13:03 INFO - PROCESS | 1652 | RSS: Main: 268185600 10:13:03 INFO - PROCESS | 1652 | 10:16:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 10:16:06 INFO - PROCESS | 1652 | RSS: Main: 277065728 10:16:06 INFO - PROCESS | 1652 | 10:19:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 10:19:09 INFO - PROCESS | 1652 | RSS: Main: 276647936 10:19:09 INFO - PROCESS | 1652 | 10:22:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 10:22:11 INFO - PROCESS | 1652 | RSS: Main: 271753216 10:22:11 INFO - PROCESS | 1652 | 10:25:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 10:25:15 INFO - PROCESS | 1652 | RSS: Main: 277151744 10:25:15 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 10:28:18 INFO - PROCESS | 1652 | RSS: Main: 280059904 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | __start_tp_report 10:28:18 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:28:18 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:28:18 INFO - PROCESS | 1652 | |i|pagename|runs| 10:28:18 INFO - PROCESS | 1652 | |0;dojo.html;2825.604415381847;3418.8803391881283;3421.264428147948;3450.2581944881845;3462.532558104657;4532.932006019904;5822.737976791049;5839.124131380289;5839.6496210227415;5888.852778680535;5640.182173584828;5793.855153621162;5798.594098413113;5866.589338746278;5884.941150588493;5205.817796377128;5225.790968361271;5272.446393128724;5294.814681486148;5363.704996225206;4427.203103441379;5282.07563676357;5315.202719592054;5463.590230732691;5468.234447177399;5199.66202196856;5315.654482458628;5326.573874090063;5351.625386222966;5376.301080859483;5218.112920803473;5284.920726189111;5309.761060752276;5313.0967735485065;5333.973330133364;5214.369635780692;5217.139172036609;5225.947740522584;5255.6072640750235;5299.417064122943;4669.719816810968;5680.375158732578;5712;5798.130280457923;5827.125931110325;6190.133381326618;6204.844878878019;6262.96868515659;6291.43377096059;6301.557402031557;6260.342664020258;6281.7173227204885;6293.213348331458;6304.464120549759;6327.4938004959495;5799.39106393831;5956.851078723066;6011.248593925759;6013.54898382623;6017.398260174035;6328.145700330489;6392.776252831129;6400.839979000562;6415.486761059104;6423.775167869196;5178.378594568676;6190.659513726699;6199.194104766351;6216.2540495140875;6230.252369715572;6133.76314253068;6165.229346331708;6194.752209911553;6205.596636218722;6257.561970662101;6148.415900489446;6212.409821066992;6215.098810672427;6216.44052035319;6216.7824126155365;5599.60802743804;6227.688615569204;6261.342559031236;6292.842678933063;6305.4009869062365;3915.9021024474614;4731;4869.95130048695;4972.204447288416;4973.32860063894;3859.4789703390243;4426.424564806619;4445.666575006888;4458.821647134143;4517.88705282364;5874.853128671732;5962.522998160137;6003;6015.608985415934;6065.4541091302;5494.725263736877;6203.906941395882;6240.157578726905;6291.748330066837;6297.559170857996;5917.585768996215;6058.485028772604;6077.908831367533;6083.8174854754425;6103.1455596216565;4666.393368862026;5495.917561236584;5501.862453438696;5505.614606977553;5553.444655534414;6253.499720022478;6324.3991820776955;6415.13395691585;6434.64609446485;6435.51733619971;6209.099680546386;6260.7495700171485;6284.340144284967;6311.873762524816;6312.873742525032;6331.6517591531065;6403.423691867568;6419.101325814483;6425.8714825704155;6427.453666438405;6126.5098792097415;6153.323134455117;6216.72024758896;6247.625142491465;6255.96872015637;6209.59637623553;6257;6278.623282603058;6306.905396419149;6325.462335701517;5276.683398996072;5306.389765176899;5833.183354330312;5851.824445266649;6216.595921265103;6057.273127224761;6083.756649734138;6190.2571691397325;6226.315105338319;6229.359127450079;5954.434328738763;5989.970050149721;6000.69996500182;6078.149059131637;6093.75624974996;6092.116643086816;6186.81439556814;6217.689115544114;6219.875602488016;6225.688715564113;5887.264091988502;5995.880082398415;6024.216851809237;6055.7577696893395;6082.695865206811 10:28:18 INFO - PROCESS | 1652 | |1;ext.html;432.85499357715145;454.9112922980018;508.4432546361735;509.6457961716606;520.2456438164662;38644;40784.59215407845;40891.9777005575;40911.97720056996;40932.79533602335;41389.79305103478;41683;42002;42019.57980420195;42555;7647.923520764777;8160.9591952040155;8732.781680457976;9563.234941204686;9627.711168664951;9482;9551.0926461986;9571.569279382444;9640.71077867665;9681.322307438482;9574.28192885533;9625.037496250354;9646.42121472714;9662.371945823534;9677.27420443466;9558.044195580456;9570.90429095707;9584.712458626253;9625.326227164102;9630.422174669542;8315.293200078;9615.903840961571;9700.466474343908;9702.27232957524;9739.951300243525;39097.80451097755;39598;39641.40537891934;39646.0088497787;39701.40447893284;3241.4489536778806;3454.844531996066;3581.5344005279408;4008.498937632796;4029.3351596986463;25451.745482545124;30246.941357052616;30497.542536861965;30562.235944101354;31047;3233.9353212935844;3283.7357617317507;3285.129440698217;3320.767546271762;3370.2753907909673;415511;490013.99999999645;491361;491611;494377;58324;58566.4143358561;58624;58688;58856.705716471144;33289.83355083209;34529.654703452645;35292.47061294083;35565.64434355623;61194.0820887687;15859;16242;16264.51206463808;16372.918135409247;16384.83615163833;12510.937445312715;12540.372981350896;12564.937175314248;12565.434555445026;12595.929346005509;18101.275948962157;18804.905975470036;18837.24651013944;18849.623007539773;19024.42926712201;6522.836929076716;7988.920110798934;8012.911801006403;8021.679132834622;8082.797930051795;849.9277561407349;932.7807965128189;949.5584553182803;970.509892504295;1026.9127124194379;26489.602655960178;29238;30510.84744576263;30720.53919191214;30784.69215307863;931.7624005878457;1025.876894772632;1054.6466933577337;1150.010990548128;1209.7701436726993;14888.032277902119;15094.698106037818;15502.84497155014;15673.451429199924;15817.604559886095;525230;670385;670820;670845;674430;56800.43199568034;57280.71359643175;57731.42268577345;57927.4207257922;58110;1109.2567979453786;1135.318808714781;1229.7724920889664;1393.7212557488542;1424.0387738276622;24051.518969620858;29328.56007159937;29389.971351002612;29440.705592944654;30980.845095774377;51369.229461557356;58245.54386140381;59750.70124649349;59944;60007.699961499915;616339;616925;617873;620281;622549;42785.57214427816;42908.78545607252;43182.13635727205;43393;43905.78047109744;47710;47832.282515761595;47855.5214447851;48273.275900862216;49038.264426032925;39926.201475969734;40164.3934242627;40232.82633551036;40612.59387406088;40953.38569921394;38822.6117738819;38840.41739373855;39201.80399097986;40189.59810401859;40318.59681403266;36086.45870311895;38771.41842872303;39148.608513915635;39187.608123919534;39215.019624509616;32053.51919721253;34698.65301346954;34788;35039.47440788339;35486.82256588804;25086.62370064414;25318;25561.977520898956;25668;25769 10:28:18 INFO - PROCESS | 1652 | |2;jquery.html;356.63444968906873;365.26217041576;373.39882788710173;380.30214556289206;405.24421953057555;19491.707624385628;20905.268315608955;21393;21625.45936351592;21705.457363565918;20073.498162545908;20363.694544581842;20832.68750968733;20860.956952152406;21081.894590527027;5970.88058238836;6074.088886667013;6139.416755408229;6196.349383314755;6218.502519798405;4217.683673724468;5931.228940237763;6126.938730612704;6166.7224974876235;6598.67006649668;6806.761763338284;6950.652467376636;6963.512554121214;6964.303569643046;6967.581945083286;6599.5380323377385;6753.257141714407;6847.178338599375;6944.4444444444325;6955.826104347407;5753.88492230153;5824.126381042835;5831.446012628793;5846.064629659234;5955.434233747787;25849.870750646125;26562;26567.202983910513;26707.332316692045;26778.464430711472;2169.913203471859;2268.8638681678985;2558.283680569425;2674.2779449548707;2749.931251718703;12758.681032974157;15400.537983860502;15721;15732;15733.685326293524;1858.219547789918;1940.602176553803;1944.844412447015;1961.5096225943514;1978.5251539630528;97413;99474;116264.67470650624;123462.38268808689;127486;10635.521401536795;10767;11068.446577671084;11069.335839849635;11457.59898403552;11977.461014254379;13554.186748795104;13680.247586382646;13703;13713;8334;8563.657453701782;8629.266512346521;8696.391252612257;8743.256823169975;7431.777046688608;8303;8476.406651534457;8580.485170889766;8722.607482663296;5612.803551875665;6591.571547849375;6709.295523969913;6714.462842972551;6795.3204679531655;1387.6253411578816;1395.9441622335196;1557.3459147158221;1839.696450085721;1884.44408899375;726.7056841979007;842.5534466732519;866.4368160695599;899.4558292233236;900.7254734550537;17629.294828206985;21055.052522636517;21176.894115529325;21650;22133.557328853334;718.9712411503481;743.4312750745684;874.0123660263861;920.3787443475627;965.1699538396973;9346.345755797165;10712;11333.320000799979;11387.975082242472;11392.373419462008;567427;597141;611723;615479;621901;129450;137702.98435102557;139620;141975;142742;995.6564985079991;1013.361582203222;1030;1031.4533297352416;1044.9738756530996;18433.815661843746;18587.535311617317;18906.52733681669;18994.86030838154;19086.427407177805;52928;54682.726586366814;54684;54790.45209547853;54969.1754623673;80365;80721.38557228705;81313.59343203483;82004.58997704973;82021.58989205016;8077.515349078839;8083;8202;8354.331653467829;8363.707270245512;11975.76048479043;13083.345832708517;13262.336883155996;13334.533291335145;13606.979476539102;10893.455327233765;11374.260673056226;11575.884241157817;11583.710407239887;11676.766464670829;10363.63727269542;11092.556297748322;11309.886901130883;11420.657380278604;11459.770804583695;9614.375065620712;10252.538635761557;11528.827067593826;11605.6518304451;11955.940220299191;7940.28537431634;8056.154103819014;8169.673213071411;8182.631781569963;8393.664253429795;8332.541710205996;10832.837507437238;11533.769324613628;11535;11595.8260626089 10:28:18 INFO - PROCESS | 1652 | |3;mootools.html;1445.9927700361498;1503.70677717845;1692.5430133863856;1794.5962158514344;1846.2707230643905;7963.2036796320335;8501.19238672326;8667.349948753854;8980.23667988221;8983.955080224598;8656.220940115389;8718.520481373522;8722.869156962635;8736.956315218431;8740.91259087409;2373.1931143411193;2382.892769825362;2394.5929192037397;2406.542756876188;2407.0973384980634;2345.9530809383887;2369.763023697625;2398.0647547456506;2400.063975049732;2404.170561156407;2378.0725517048363;2378.904843806254;2379.0127097254617;2397.2328854766483;2397.352714767012;2343.8945247463735;2362.751911049341;2365.947153516686;2372.51363470489;2377.263048454976;2341.6487526871106;2352.8353015288935;2354.3643216331666;2360.433495960974;2368.9052437902465;7482;8645.438046526955;8716.825663486758;8791.384603077788;8822.602982865787;5112.284280200774;5217.399999000126;5243.842684719464;5244.554212891909;5258.737063146866;3592.6766591006935;3599.748017638766;3600.9099772505633;3631.2918980798754;3657.250263695936;1083.1226706367868;1083.967480975572;1084.3764835219781;1091.939943303118;1112.5104953820373;11167.604049493813;11267;11306.491207895582;11310.547578096866;11327.376994265229;4034.841359872454;4300.462442194726;4560.566746159109;4727.432708075053;4739.265413860857;9630.374025688448;9667.323287369958;9674.08096230857;9679.467629280458;9684.41893486393;5180.119379705459;5238.973805131026;5249.501297376743;5250.501202385767;5252.212168174728;3986.22268657609;4377;4486.102779444124;4754.168020596382;4910.533499317559;3815.637514436124;3884.3008258513173;3938.0154961259686;3941.3693808990997;3974.940375894364;1292.7091404433927;1297.6626077219992;1298.3248710670587;1298.4416700818738;1303.9674008149682;686.6189264957997;878.789090618247;901.2519608724742;924.6255266617031;928.8095940332215;5680.8863822723315;5744.684042377626;5927.496162826122;5961.612495187799;6123.9387606124255;422.32638940889234;425.8360531195512;434.96955213134777;437.4837691524032;448.2357580325537;3592.389293820057;3760.6085748273313;4018.4374187613757;4064.8170832312617;4111.671066314688;8785.560721963877;9015.27877769777;10074.74813129663;10518.631847885288;10557.627508423855;10300.175985921109;10450.529726162342;10452.16382689383;10463.581456741797;10480;7765;7900.762977110696;7993.400494962901;8011.319037881729;8027.759167224993;5750.131207357542;5751.9424805751405;5764.913526297193;5790.94209057904;5809.8547536311935;9597.952010239904;9651.118031983695;9675.806483870143;9721.756956075871;9785.510724463891;9566.139047485482;9737.61049558038;9796.804063918824;9834.065763752433;9935.602575896883;6910.7581234656545;7298.452616053711;7312.232215617283;7369.44729145327;7421.925780742339;8293.046299675614;8359.95820020896;8386.077531471412;8392.20274073962;8404.285635720787;7352.926470735224;7451.925480745123;7494.850102998019;7507.774766757006;7550.018497595277;7304.63476826146;7344;7376.151742549676;7502.549847009197;7603.467757256939;6910.170779506491;6934.16789985205;6948.826279343057;6976.511644185061;6984.580925144508;4890.380290889854;4965.602751779921;5030.4466508684745;5063.696178229318;5073.264376665289;4917.26241063829;4986.202207646759;5062.519060689228;5077.1876499759865;5132.076226279306 10:28:18 INFO - PROCESS | 1652 | |4;prototype.html;287.3663571824128;301.430296739163;315.0658298145997;315.29846092444313;316.78616933569833;4824.541668541483;5166.785805335748;5224.440024388051;5304.734763261836;5393.575079824311;5481.5340696040785;5544.889102217953;5568.582356323282;5616.382197958222;5631.761012577237;4262.87211383659;4266.210751011073;4268.850590229343;4269.231538323101;4276.5295817460055;3230.499272612749;4113.321301985184;4165.416841642173;4243.893902652428;4272.743635381887;3702.5186725725616;4188.664906807463;4193.169610512907;4223.788810559475;4237.936430953539;3782.56500502443;3976.8210430530694;4066.7356621819636;4172.143396188712;4271.594198551133;3137.6427222871534;3168.825714585697;3666.358387282215;3677.632236776301;3679.7056235501095;5221.425643179247;5413.318943118677;5430.8913821723345;5445.782168713246;5451.3458384994055;4031.8912299117683;4820.975895120537;4871.634627402959;4878.268259761029;4896.387951506062;4863.465018847924;5151.278820965068;5625.931073096099;5904.439078287556;5962.97018514909;3355.2953879685297;3366.377220214268;3411.4541673332396;3543.6102028776813;3761.39817629178;5468.589855760833;6234.283057448406;6243.344448832852;6265.838285791395;6270.930592904377;3589.277146969417;3695;4085.7140000200293;4100.384942258685;4104.4664193654635;3275.6078666566614;3603.207294395229;3779.3764028935466;3910.96089039106;3943.7830919299713;4805.37530121089;4809.711417314902;4848.612111031109;4861.659683822169;4866.294387313819;5500.532454741392;5561.277033985637;5974.761009559656;6010.849728756816;6025.457708806229;1335.6660834791303;1385.6466601016675;1386.5995344701923;1408.8661577150153;1417.780244062172;795.6340083561511;911.544227886057;915.873475624985;945.1635302756972;947.7014740356766;5074.391073071181;5164.9741751291;5198.2202669599865;5224.373075230997;5410.621256512085;5222.8955420892125;5878.882422351529;5912.280351038485;5951.184888608929;5977.701114944235;4250.596193361625;4497.865064048084;4781.856544303677;4996.975619997892;5405.7567409466665;2344.9179278725164;2555.4505781257117;2608.7130415654265;2634.6970098438924;2695.2992222022417;4045.474088368493;4486.932696009562;4554.337666751612;5193.143770925975;5199.2201169824075;5048.495150484922;5075.695458272516;5092.592592592584;5355.625106242604;5591.776328946878;5421.783128674809;6379.202599675041;6424.678766061678;6446.258680251831;6479.384458476437;6000.279966404059;6080.361562035922;6139.754409823557;6142.815715528542;6165.965231473692;5031.987205117982;5699.5725320600295;5923.482519929099;5927.91748290895;6133.417325354084;5377.596680249075;6425.228972523327;6449.806505804833;6454.612258364474;6462.547621666438;3696.4824924511126;3912.628300311466;4011.578784227614;4024.1348110156455;4043.7775922324554;5103.958416633376;6044.304904935812;6086.117512960507;6105.419985101408;6117.388261173847;4856.781444835062;5511;5886.94113058864;5913.674747888907;5991.820245392645;5896.410358964069;5910.231669882888;5927.496162826035;5931.436513531207;5979.790707325223;5528.778848846001;5695.889301586151;5725.398833122629;5727.6849773262875;5831.912521312269;5930.318013428511;5956.404359564009;6005.039193728982;6010.128531363015;6041.640630858197;4990.525900039491;5340.703497496114;5653.010723123519;5748;5853.824385268449 10:28:18 INFO - PROCESS | 1652 | |5;yui.html;629.5813284166027;682.2427105912436;709.3403135084372;734.6877577029761;818.5293456262649;15265.236738163088;15440.459583914566;15751.92124039381;15960.52118436446;15997.760033599505;14221.21783301918;14485.493007744732;14513.854861451382;14516.201608911506;14524;824.7979245084963;838.2246422059601;842.5871323051691;842.7977285451509;847.2798121596655;659.426299119764;815.3721634341554;836.9707060252892;850.0437008365589;850.6427300533791;879.8284334554764;883.3021912688968;890.274426342532;890.8574628059512;892.8660700894853;878.7319867440428;886.1271647427279;887.3078998381272;888.8577827547593;890.9866352004725;634.4416913116474;657.9735612444601;661.206552137437;661.3915198017835;663.1909070933501;12241.877581224251;12266.754664906652;12823.294718790463;14742;14797.964142510029;13951.58145255644;14511.782323265159;14751;14761.18813465259;14809.629759256104;11448.656540303804;11667.591634292843;11935.104867134913;11987.160898737093;12386.81419778704;3415.9829200854083;3509.0350153707677;3818.579956204815;3883.805809709503;3979.880603581897;121594;122026;123068;126524.36737816253;126808.73191268061;8924.732258032269;10933.835992460119;11074.667759967213;11141.498632561554;11299.774004519864;22190.445238869157;22581.0967561299;23040.423989400064;23324.766752332598;23367;8082.353411727047;8163.265306122477;8192;8250.298724608476;8379.49723016621;4474.7762611869275;4525.7510836904285;4537.1833070047705;4542.613877820422;4559.863204103882;3512.121969507623;3638.6361363863402;3642.9635703643153;3646.197836475971;3656;565.2962062232547;568.2328856044389;572.1617829879164;575.5165660844826;576.9942300577025;548.8847342058212;594.5689375203029;595.9910601340983;641.887669657808;642.7750287399373;8381.790455238668;8710.346723995726;9031.864522032174;9286.95356523213;9450.621975120917;553.4576115406924;556.1296570866581;607.8784243151388;655.3217419970308;655.3512023097195;4098.569650186747;4201.957980420218;4590.67865249436;4655.930161047587;4668.60159879548;139130.3043484776;142982;147074;149337;164709.17645411697;110016;127478;136199.63800362067;137665;139031;111689.88310116794;113915.43042284735;114601.85398145912;114771;115323.42338288423;10023.255466528539;10116.544755486168;10171.186305095722;10203.897961020295;10240.180785537288;58198.4180158193;62895;65785.34214657792;66983.32066717277;67849;95401;99563;100121.49939250258;100409.49795250977;101745;11562.537498499965;13905.791413128609;14094.788578171541;14365.497207597684;14635.853641463875;14294.642633934234;14934;15000.549983500512;15220.771688424462;15242.923785381003;13870.988706637683;13981.370838312503;14173;14221.64445888861;14314.069585476911;11293;13694.93152534231;13975.930120349332;13999.720005599627;14049.297535122998;10469.528871200662;11493.138014648768;12855.742885142057;13433;14403.495877644233;11194;11246.66260012201;11522.308661480338;11551.826722599335;11922.821157682469;9847.655332063343;11043.834342484708;11429.142814289127;11496.367699776258;11622.535098595961 10:28:18 INFO - PROCESS | 1652 | __end_tp_report 10:28:18 INFO - PROCESS | 1652 | __start_cc_report 10:28:18 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,389 10:28:18 INFO - PROCESS | 1652 | __end_cc_report 10:28:18 INFO - PROCESS | 1652 | __startTimestamp1472750898414__endTimestamp 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:28:18 INFO - PROCESS | 1652 | Number of tests: 6 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5760.41 Median:6024.22 stddev:697.59 (11.6%) stddev-sans-first:660.64 10:28:18 INFO - PROCESS | 1652 | Values: 2825.6 3418.9 3421.3 3450.3 3462.5 4532.9 5822.7 5839.1 5839.6 5888.9 5640.2 5793.9 5798.6 5866.6 5884.9 5205.8 5225.8 5272.4 5294.8 5363.7 4427.2 5282.1 5315.2 5463.6 5468.2 5199.7 5315.7 5326.6 5351.6 5376.3 5218.1 5284.9 5309.8 5313.1 5334.0 5214.4 5217.1 5225.9 5255.6 5299.4 4669.7 5680.4 5712.0 5798.1 5827.1 6190.1 6204.8 6263.0 6291.4 6301.6 6260.3 6281.7 6293.2 6304.5 6327.5 5799.4 5956.9 6011.2 6013.5 6017.4 6328.1 6392.8 6400.8 6415.5 6423.8 5178.4 6190.7 6199.2 6216.3 6230.3 6133.8 6165.2 6194.8 6205.6 6257.6 6148.4 6212.4 6215.1 6216.4 6216.8 5599.6 6227.7 6261.3 6292.8 6305.4 3915.9 4731.0 4870.0 4972.2 4973.3 3859.5 4426.4 4445.7 4458.8 4517.9 5874.9 5962.5 6003.0 6015.6 6065.5 5494.7 6203.9 6240.2 6291.7 6297.6 5917.6 6058.5 6077.9 6083.8 6103.1 4666.4 5495.9 5501.9 5505.6 5553.4 6253.5 6324.4 6415.1 6434.6 6435.5 6209.1 6260.7 6284.3 6311.9 6312.9 6331.7 6403.4 6419.1 6425.9 6427.5 6126.5 6153.3 6216.7 6247.6 6256.0 6209.6 6257.0 6278.6 6306.9 6325.5 5276.7 5306.4 5833.2 5851.8 6216.6 6057.3 6083.8 6190.3 6226.3 6229.4 5954.4 5990.0 6000.7 6078.1 6093.8 6092.1 6186.8 6217.7 6219.9 6225.7 5887.3 5995.9 6024.2 6055.8 6082.7 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:71091.98 Median:40901.98 stddev:156484.32 (382.6%) stddev-sans-first:156833.37 10:28:18 INFO - PROCESS | 1652 | Values: 432.9 454.9 508.4 509.6 520.2 38644.0 40784.6 40892.0 40912.0 40932.8 41389.8 41683.0 42002.0 42019.6 42555.0 7647.9 8161.0 8732.8 9563.2 9627.7 9482.0 9551.1 9571.6 9640.7 9681.3 9574.3 9625.0 9646.4 9662.4 9677.3 9558.0 9570.9 9584.7 9625.3 9630.4 8315.3 9615.9 9700.5 9702.3 9740.0 39097.8 39598.0 39641.4 39646.0 39701.4 3241.4 3454.8 3581.5 4008.5 4029.3 25451.7 30246.9 30497.5 30562.2 31047.0 3233.9 3283.7 3285.1 3320.8 3370.3 415511.0 490014.0 491361.0 491611.0 494377.0 58324.0 58566.4 58624.0 58688.0 58856.7 33289.8 34529.7 35292.5 35565.6 61194.1 15859.0 16242.0 16264.5 16372.9 16384.8 12510.9 12540.4 12564.9 12565.4 12595.9 18101.3 18804.9 18837.2 18849.6 19024.4 6522.8 7988.9 8012.9 8021.7 8082.8 849.9 932.8 949.6 970.5 1026.9 26489.6 29238.0 30510.8 30720.5 30784.7 931.8 1025.9 1054.6 1150.0 1209.8 14888.0 15094.7 15502.8 15673.5 15817.6 525230.0 670385.0 670820.0 670845.0 674430.0 56800.4 57280.7 57731.4 57927.4 58110.0 1109.3 1135.3 1229.8 1393.7 1424.0 24051.5 29328.6 29390.0 29440.7 30980.8 51369.2 58245.5 59750.7 59944.0 60007.7 616339.0 616925.0 617873.0 620281.0 622549.0 42785.6 42908.8 43182.1 43393.0 43905.8 47710.0 47832.3 47855.5 48273.3 49038.3 39926.2 40164.4 40232.8 40612.6 40953.4 38822.6 38840.4 39201.8 40189.6 40318.6 36086.5 38771.4 39148.6 39187.6 39215.0 32053.5 34698.7 34788.0 35039.5 35486.8 25086.6 25318.0 25562.0 25668.0 25769.0 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35700.52 Median:14690.81 stddev:100776.63 (686.0%) stddev-sans-first:101024.39 10:28:18 INFO - PROCESS | 1652 | Values: 356.6 365.3 373.4 380.3 405.2 19491.7 20905.3 21393.0 21625.5 21705.5 20073.5 20363.7 20832.7 20861.0 21081.9 5970.9 6074.1 6139.4 6196.3 6218.5 4217.7 5931.2 6126.9 6166.7 6598.7 6806.8 6950.7 6963.5 6964.3 6967.6 6599.5 6753.3 6847.2 6944.4 6955.8 5753.9 5824.1 5831.4 5846.1 5955.4 25849.9 26562.0 26567.2 26707.3 26778.5 2169.9 2268.9 2558.3 2674.3 2749.9 12758.7 15400.5 15721.0 15732.0 15733.7 1858.2 1940.6 1944.8 1961.5 1978.5 97413.0 99474.0 116264.7 123462.4 127486.0 10635.5 10767.0 11068.4 11069.3 11457.6 11977.5 13554.2 13680.2 13703.0 13713.0 8334.0 8563.7 8629.3 8696.4 8743.3 7431.8 8303.0 8476.4 8580.5 8722.6 5612.8 6591.6 6709.3 6714.5 6795.3 1387.6 1395.9 1557.3 1839.7 1884.4 726.7 842.6 866.4 899.5 900.7 17629.3 21055.1 21176.9 21650.0 22133.6 719.0 743.4 874.0 920.4 965.2 9346.3 10712.0 11333.3 11388.0 11392.4 567427.0 597141.0 611723.0 615479.0 621901.0 129450.0 137703.0 139620.0 141975.0 142742.0 995.7 1013.4 1030.0 1031.5 1045.0 18433.8 18587.5 18906.5 18994.9 19086.4 52928.0 54682.7 54684.0 54790.5 54969.2 80365.0 80721.4 81313.6 82004.6 82021.6 8077.5 8083.0 8202.0 8354.3 8363.7 11975.8 13083.3 13262.3 13334.5 13607.0 10893.5 11374.3 11575.9 11583.7 11676.8 10363.6 11092.6 11309.9 11420.7 11459.8 9614.4 10252.5 11528.8 11605.7 11955.9 7940.3 8056.2 8169.7 8182.6 8393.7 8332.5 10832.8 11533.8 11535.0 11595.8 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5601.56 Median:5075.23 stddev:3106.53 (61.2%) stddev-sans-first:3099.55 10:28:18 INFO - PROCESS | 1652 | Values: 1446.0 1503.7 1692.5 1794.6 1846.3 7963.2 8501.2 8667.3 8980.2 8984.0 8656.2 8718.5 8722.9 8737.0 8740.9 2373.2 2382.9 2394.6 2406.5 2407.1 2346.0 2369.8 2398.1 2400.1 2404.2 2378.1 2378.9 2379.0 2397.2 2397.4 2343.9 2362.8 2365.9 2372.5 2377.3 2341.6 2352.8 2354.4 2360.4 2368.9 7482.0 8645.4 8716.8 8791.4 8822.6 5112.3 5217.4 5243.8 5244.6 5258.7 3592.7 3599.7 3600.9 3631.3 3657.3 1083.1 1084.0 1084.4 1091.9 1112.5 11167.6 11267.0 11306.5 11310.5 11327.4 4034.8 4300.5 4560.6 4727.4 4739.3 9630.4 9667.3 9674.1 9679.5 9684.4 5180.1 5239.0 5249.5 5250.5 5252.2 3986.2 4377.0 4486.1 4754.2 4910.5 3815.6 3884.3 3938.0 3941.4 3974.9 1292.7 1297.7 1298.3 1298.4 1304.0 686.6 878.8 901.3 924.6 928.8 5680.9 5744.7 5927.5 5961.6 6123.9 422.3 425.8 435.0 437.5 448.2 3592.4 3760.6 4018.4 4064.8 4111.7 8785.6 9015.3 10074.7 10518.6 10557.6 10300.2 10450.5 10452.2 10463.6 10480.0 7765.0 7900.8 7993.4 8011.3 8027.8 5750.1 5751.9 5764.9 5790.9 5809.9 9598.0 9651.1 9675.8 9721.8 9785.5 9566.1 9737.6 9796.8 9834.1 9935.6 6910.8 7298.5 7312.2 7369.4 7421.9 8293.0 8360.0 8386.1 8392.2 8404.3 7352.9 7451.9 7494.9 7507.8 7550.0 7304.6 7344.0 7376.2 7502.5 7603.5 6910.2 6934.2 6948.8 6976.5 6984.6 4890.4 4965.6 5030.4 5063.7 5073.3 4917.3 4986.2 5062.5 5077.2 5132.1 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4663.84 Median:5195.68 stddev:1496.31 (28.8%) stddev-sans-first:1464.00 10:28:18 INFO - PROCESS | 1652 | Values: 287.4 301.4 315.1 315.3 316.8 4824.5 5166.8 5224.4 5304.7 5393.6 5481.5 5544.9 5568.6 5616.4 5631.8 4262.9 4266.2 4268.9 4269.2 4276.5 3230.5 4113.3 4165.4 4243.9 4272.7 3702.5 4188.7 4193.2 4223.8 4237.9 3782.6 3976.8 4066.7 4172.1 4271.6 3137.6 3168.8 3666.4 3677.6 3679.7 5221.4 5413.3 5430.9 5445.8 5451.3 4031.9 4821.0 4871.6 4878.3 4896.4 4863.5 5151.3 5625.9 5904.4 5963.0 3355.3 3366.4 3411.5 3543.6 3761.4 5468.6 6234.3 6243.3 6265.8 6270.9 3589.3 3695.0 4085.7 4100.4 4104.5 3275.6 3603.2 3779.4 3911.0 3943.8 4805.4 4809.7 4848.6 4861.7 4866.3 5500.5 5561.3 5974.8 6010.8 6025.5 1335.7 1385.6 1386.6 1408.9 1417.8 795.6 911.5 915.9 945.2 947.7 5074.4 5165.0 5198.2 5224.4 5410.6 5222.9 5878.9 5912.3 5951.2 5977.7 4250.6 4497.9 4781.9 4997.0 5405.8 2344.9 2555.5 2608.7 2634.7 2695.3 4045.5 4486.9 4554.3 5193.1 5199.2 5048.5 5075.7 5092.6 5355.6 5591.8 5421.8 6379.2 6424.7 6446.3 6479.4 6000.3 6080.4 6139.8 6142.8 6166.0 5032.0 5699.6 5923.5 5927.9 6133.4 5377.6 6425.2 6449.8 6454.6 6462.5 3696.5 3912.6 4011.6 4024.1 4043.8 5104.0 6044.3 6086.1 6105.4 6117.4 4856.8 5511.0 5886.9 5913.7 5991.8 5896.4 5910.2 5927.5 5931.4 5979.8 5528.8 5695.9 5725.4 5727.7 5831.9 5930.3 5956.4 6005.0 6010.1 6041.6 4990.5 5340.7 5653.0 5748.0 5853.8 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25711.00 Median:93449.81 stddev:41281.78 (44.2%) stddev-sans-first:41354.64 10:28:18 INFO - PROCESS | 1652 | Values: 629.6 682.2 709.3 734.7 818.5 15265.2 15440.5 15751.9 15960.5 15997.8 14221.2 14485.5 14513.9 14516.2 14524.0 824.8 838.2 842.6 842.8 847.3 659.4 815.4 837.0 850.0 850.6 879.8 883.3 890.3 890.9 892.9 878.7 886.1 887.3 888.9 891.0 634.4 658.0 661.2 661.4 663.2 12241.9 12266.8 12823.3 14742.0 14798.0 13951.6 14511.8 14751.0 14761.2 14809.6 11448.7 11667.6 11935.1 11987.2 12386.8 3416.0 3509.0 3818.6 3883.8 3979.9 121594.0 122026.0 123068.0 126524.4 126808.7 8924.7 10933.8 11074.7 11141.5 11299.8 22190.4 22581.1 23040.4 23324.8 23367.0 8082.4 8163.3 8192.0 8250.3 8379.5 4474.8 4525.8 4537.2 4542.6 4559.9 3512.1 3638.6 3643.0 3646.2 3656.0 565.3 568.2 572.2 575.5 577.0 548.9 594.6 596.0 641.9 642.8 8381.8 8710.3 9031.9 9287.0 9450.6 553.5 556.1 607.9 655.3 655.4 4098.6 4202.0 4590.7 4655.9 4668.6 139130.3 142982.0 147074.0 149337.0 164709.2 110016.0 127478.0 136199.6 137665.0 139031.0 111689.9 113915.4 114601.9 114771.0 115323.4 10023.3 10116.5 10171.2 10203.9 10240.2 58198.4 62895.0 65785.3 66983.3 67849.0 95401.0 99563.0 100121.5 100409.5 101745.0 11562.5 13905.8 14094.8 14365.5 14635.9 14294.6 14934.0 15000.5 15220.8 15242.9 13871.0 13981.4 14173.0 14221.6 14314.1 11293.0 13694.9 13975.9 13999.7 14049.3 10469.5 11493.1 12855.7 13433.0 14403.5 11194.0 11246.7 11522.3 11551.8 11922.8 9847.7 11043.8 11429.1 11496.4 11622.5 10:28:18 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:28:18 INFO - PROCESS | 1652 | 10:28:18 INFO - TEST-INFO | 1652: exit 0 10:28:19 INFO - TEST-OK | dromaeo_css | took 1113979ms 10:28:19 INFO - TEST-START | kraken 10:28:19 INFO - operating with platform_type : mac_ 10:28:19 INFO - Initialising browser for kraken test... 10:28:19 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpXk4FWF/profile http://localhost:49268/getInfo.html) 10:28:21 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 10:28:21 INFO - PROCESS | 1661 | colorDepth:24 10:28:21 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 10:28:21 INFO - PROCESS | 1661 | __metrics 10:28:21 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 10:28:22 INFO - TEST-INFO | 1661: exit 0 10:28:22 INFO - Browser initialized. 10:28:22 INFO - Running cycle 1/1 for kraken test... 10:28:22 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpXk4FWF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:34 INFO - PROCESS | 1663 | RSS: Main: 245620736 10:28:34 INFO - PROCESS | 1663 | 10:28:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:38 INFO - PROCESS | 1663 | RSS: Main: 258510848 10:28:38 INFO - PROCESS | 1663 | 10:28:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 10:28:41 INFO - PROCESS | 1663 | RSS: Main: 267153408 10:28:41 INFO - PROCESS | 1663 | 10:28:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 10:28:45 INFO - PROCESS | 1663 | RSS: Main: 265551872 10:28:45 INFO - PROCESS | 1663 | 10:28:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 10:28:48 INFO - PROCESS | 1663 | RSS: Main: 267919360 10:28:48 INFO - PROCESS | 1663 | 10:28:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:51 INFO - PROCESS | 1663 | RSS: Main: 268595200 10:28:51 INFO - PROCESS | 1663 | 10:28:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:54 INFO - PROCESS | 1663 | RSS: Main: 268898304 10:28:54 INFO - PROCESS | 1663 | 10:28:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:58 INFO - PROCESS | 1663 | RSS: Main: 269148160 10:28:58 INFO - PROCESS | 1663 | 10:29:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 10:29:01 INFO - PROCESS | 1663 | RSS: Main: 269242368 10:29:01 INFO - PROCESS | 1663 | 10:29:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:03 INFO - PROCESS | 1663 | RSS: Main: 268931072 10:29:03 INFO - PROCESS | 1663 | 10:29:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:06 INFO - PROCESS | 1663 | RSS: Main: 268951552 10:29:06 INFO - PROCESS | 1663 | 10:29:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:09 INFO - PROCESS | 1663 | RSS: Main: 269221888 10:29:09 INFO - PROCESS | 1663 | 10:29:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:13 INFO - PROCESS | 1663 | RSS: Main: 269631488 10:29:13 INFO - PROCESS | 1663 | 10:29:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:16 INFO - PROCESS | 1663 | RSS: Main: 269680640 10:29:16 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 10:29:18 INFO - PROCESS | 1663 | RSS: Main: 271691776 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | __start_tp_report 10:29:18 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 10:29:18 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 10:29:18 INFO - PROCESS | 1663 | |i|pagename|runs| 10:29:18 INFO - PROCESS | 1663 | |0;ai-astar;107;117;142;161;151;119;116;117;118;132 10:29:18 INFO - PROCESS | 1663 | |1;audio-beat-detection;146;107;133;159;109;129;132;111;158;111 10:29:18 INFO - PROCESS | 1663 | |2;audio-dft;197;197;236;223;206;252;259;200;198;199 10:29:18 INFO - PROCESS | 1663 | |3;audio-fft;70;78;75;141;60;59;59;60;133;60 10:29:18 INFO - PROCESS | 1663 | |4;audio-oscillator;68;73;125;87;100;105;127;71;75;114 10:29:18 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;86;88;74;137;132;89;85;88;95 10:29:18 INFO - PROCESS | 1663 | |6;imaging-darkroom;99;98;98;97;100;98;98;100;136;150 10:29:18 INFO - PROCESS | 1663 | |7;imaging-desaturate;93;94;92;90;92;92;90;92;92;108 10:29:18 INFO - PROCESS | 1663 | |8;json-parse-financial;54;59;59;56;58;58;59;58;55;58 10:29:18 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;67;70;82;61;78;99;113;104;72;72 10:29:18 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;85;89;93;79;78;75;106;111;107;86 10:29:18 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;136;138;170;146;156;156;162;165;189;141 10:29:18 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;172;172;236;240;186;170;173;175;172;177 10:29:18 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;70;66;70;70;70;70;68;66;67;70 10:29:18 INFO - PROCESS | 1663 | __end_tp_report 10:29:18 INFO - PROCESS | 1663 | __start_cc_report 10:29:18 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,954 10:29:18 INFO - PROCESS | 1663 | __end_cc_report 10:29:18 INFO - PROCESS | 1663 | __startTimestamp1472750958607__endTimestamp 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | ------- Summary: start ------- 10:29:18 INFO - PROCESS | 1663 | Number of tests: 14 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:128.00 Median:125.50 stddev:17.76 (14.1%) stddev-sans-first:17.13 10:29:18 INFO - PROCESS | 1663 | Values: 107.0 117.0 142.0 161.0 151.0 119.0 116.0 117.0 118.0 132.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:132.50 stddev:19.96 (15.1%) stddev-sans-first:20.25 10:29:18 INFO - PROCESS | 1663 | Values: 146.0 107.0 133.0 159.0 109.0 129.0 132.0 111.0 158.0 111.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:216.70 Median:214.50 stddev:24.22 (11.3%) stddev-sans-first:24.62 10:29:18 INFO - PROCESS | 1663 | Values: 197.0 197.0 236.0 223.0 206.0 252.0 259.0 200.0 198.0 199.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:79.50 Median:60.00 stddev:31.16 (51.9%) stddev-sans-first:32.86 10:29:18 INFO - PROCESS | 1663 | Values: 70.0 78.0 75.0 141.0 60.0 59.0 59.0 60.0 133.0 60.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:69.50 stddev:22.76 (32.7%) stddev-sans-first:22.02 10:29:18 INFO - PROCESS | 1663 | Values: 68.0 73.0 125.0 87.0 100.0 105.0 127.0 71.0 75.0 114.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.00 stddev:20.84 (23.7%) stddev-sans-first:21.93 10:29:18 INFO - PROCESS | 1663 | Values: 89.0 86.0 88.0 74.0 137.0 132.0 89.0 85.0 88.0 95.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:98.00 stddev:19.07 (19.5%) stddev-sans-first:19.99 10:29:18 INFO - PROCESS | 1663 | Values: 99.0 98.0 98.0 97.0 100.0 98.0 98.0 100.0 136.0 150.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:92.00 stddev:5.23 (5.7%) stddev-sans-first:5.55 10:29:18 INFO - PROCESS | 1663 | Values: 93.0 94.0 92.0 90.0 92.0 92.0 90.0 92.0 92.0 108.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.78 (3.1%) stddev-sans-first:1.39 10:29:18 INFO - PROCESS | 1663 | Values: 54.0 59.0 59.0 56.0 58.0 58.0 59.0 58.0 55.0 58.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:81.80 Median:72.00 stddev:17.51 (24.3%) stddev-sans-first:17.73 10:29:18 INFO - PROCESS | 1663 | Values: 67.0 70.0 82.0 61.0 78.0 99.0 113.0 104.0 72.0 72.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:82.00 stddev:12.99 (15.8%) stddev-sans-first:13.60 10:29:18 INFO - PROCESS | 1663 | Values: 85.0 89.0 93.0 79.0 78.0 75.0 106.0 111.0 107.0 86.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:159.00 stddev:16.50 (10.4%) stddev-sans-first:15.85 10:29:18 INFO - PROCESS | 1663 | Values: 136.0 138.0 170.0 146.0 156.0 156.0 162.0 165.0 189.0 141.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.30 Median:176.00 stddev:27.11 (15.4%) stddev-sans-first:28.18 10:29:18 INFO - PROCESS | 1663 | Values: 172.0 172.0 236.0 240.0 186.0 170.0 173.0 175.0 172.0 177.0 10:29:18 INFO - PROCESS | 1663 | 10:29:18 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:70.00 stddev:1.77 (2.5%) stddev-sans-first:1.81 10:29:18 INFO - PROCESS | 1663 | Values: 70.0 66.0 70.0 70.0 70.0 70.0 68.0 66.0 67.0 70.0 10:29:18 INFO - PROCESS | 1663 | -------- Summary: end -------- 10:29:18 INFO - PROCESS | 1663 | 10:29:19 INFO - TEST-INFO | 1663: exit 0 10:29:19 INFO - TEST-OK | kraken | took 60381ms 10:29:19 INFO - SUITE-END | took 1174s 10:29:19 INFO - Completed test suite (00:19:34) 10:29:19 INFO - javascript benchmark 10:29:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7399.049016767635, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2825.604415381847, 3418.8803391881283, 3421.264428147948, 3450.2581944881845, 3462.532558104657, 4532.932006019904, 5822.737976791049, 5839.124131380289, 5839.6496210227415, 5888.852778680535, 5640.182173584828, 5793.855153621162, 5798.594098413113, 5866.589338746278, 5884.941150588493, 5205.817796377128, 5225.790968361271, 5272.446393128724, 5294.814681486148, 5363.704996225206, 4427.203103441379, 5282.07563676357, 5315.202719592054, 5463.590230732691, 5468.234447177399, 5199.66202196856, 5315.654482458628, 5326.573874090063, 5351.625386222966, 5376.301080859483, 5218.112920803473, 5284.920726189111, 5309.761060752276, 5313.0967735485065, 5333.973330133364, 5214.369635780692, 5217.139172036609, 5225.947740522584, 5255.6072640750235, 5299.417064122943, 4669.719816810968, 5680.375158732578, 5712.0, 5798.130280457923, 5827.125931110325, 6190.133381326618, 6204.844878878019, 6262.96868515659, 6291.43377096059, 6301.557402031557, 6260.342664020258, 6281.7173227204885, 6293.213348331458, 6304.464120549759, 6327.4938004959495, 5799.39106393831, 5956.851078723066, 6011.248593925759, 6013.54898382623, 6017.398260174035, 6328.145700330489, 6392.776252831129, 6400.839979000562, 6415.486761059104, 6423.775167869196, 5178.378594568676, 6190.659513726699, 6199.194104766351, 6216.2540495140875, 6230.252369715572, 6133.76314253068, 6165.229346331708, 6194.752209911553, 6205.596636218722, 6257.561970662101, 6148.415900489446, 6212.409821066992, 6215.098810672427, 6216.44052035319, 6216.7824126155365, 5599.60802743804, 6227.688615569204, 6261.342559031236, 6292.842678933063, 6305.4009869062365, 3915.9021024474614, 4731.0, 4869.95130048695, 4972.204447288416, 4973.32860063894, 3859.4789703390243, 4426.424564806619, 4445.666575006888, 4458.821647134143, 4517.88705282364, 5874.853128671732, 5962.522998160137, 6003.0, 6015.608985415934, 6065.4541091302, 5494.725263736877, 6203.906941395882, 6240.157578726905, 6291.748330066837, 6297.559170857996, 5917.585768996215, 6058.485028772604, 6077.908831367533, 6083.8174854754425, 6103.1455596216565, 4666.393368862026, 5495.917561236584, 5501.862453438696, 5505.614606977553, 5553.444655534414, 6253.499720022478, 6324.3991820776955, 6415.13395691585, 6434.64609446485, 6435.51733619971, 6209.099680546386, 6260.7495700171485, 6284.340144284967, 6311.873762524816, 6312.873742525032, 6331.6517591531065, 6403.423691867568, 6419.101325814483, 6425.8714825704155, 6427.453666438405, 6126.5098792097415, 6153.323134455117, 6216.72024758896, 6247.625142491465, 6255.96872015637, 6209.59637623553, 6257.0, 6278.623282603058, 6306.905396419149, 6325.462335701517, 5276.683398996072, 5306.389765176899, 5833.183354330312, 5851.824445266649, 6216.595921265103, 6057.273127224761, 6083.756649734138, 6190.2571691397325, 6226.315105338319, 6229.359127450079, 5954.434328738763, 5989.970050149721, 6000.69996500182, 6078.149059131637, 6093.75624974996, 6092.116643086816, 6186.81439556814, 6217.689115544114, 6219.875602488016, 6225.688715564113, 5887.264091988502, 5995.880082398415, 6024.216851809237, 6055.7577696893395, 6082.695865206811], "value": 5714.868822892383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.85499357715145, 454.9112922980018, 508.4432546361735, 509.6457961716606, 520.2456438164662, 38644.0, 40784.59215407845, 40891.9777005575, 40911.97720056996, 40932.79533602335, 41389.79305103478, 41683.0, 42002.0, 42019.57980420195, 42555.0, 7647.923520764777, 8160.9591952040155, 8732.781680457976, 9563.234941204686, 9627.711168664951, 9482.0, 9551.0926461986, 9571.569279382444, 9640.71077867665, 9681.322307438482, 9574.28192885533, 9625.037496250354, 9646.42121472714, 9662.371945823534, 9677.27420443466, 9558.044195580456, 9570.90429095707, 9584.712458626253, 9625.326227164102, 9630.422174669542, 8315.293200078, 9615.903840961571, 9700.466474343908, 9702.27232957524, 9739.951300243525, 39097.80451097755, 39598.0, 39641.40537891934, 39646.0088497787, 39701.40447893284, 3241.4489536778806, 3454.844531996066, 3581.5344005279408, 4008.498937632796, 4029.3351596986463, 25451.745482545124, 30246.941357052616, 30497.542536861965, 30562.235944101354, 31047.0, 3233.9353212935844, 3283.7357617317507, 3285.129440698217, 3320.767546271762, 3370.2753907909673, 415511.0, 490013.99999999645, 491361.0, 491611.0, 494377.0, 58324.0, 58566.4143358561, 58624.0, 58688.0, 58856.705716471144, 33289.83355083209, 34529.654703452645, 35292.47061294083, 35565.64434355623, 61194.0820887687, 15859.0, 16242.0, 16264.51206463808, 16372.918135409247, 16384.83615163833, 12510.937445312715, 12540.372981350896, 12564.937175314248, 12565.434555445026, 12595.929346005509, 18101.275948962157, 18804.905975470036, 18837.24651013944, 18849.623007539773, 19024.42926712201, 6522.836929076716, 7988.920110798934, 8012.911801006403, 8021.679132834622, 8082.797930051795, 849.9277561407349, 932.7807965128189, 949.5584553182803, 970.509892504295, 1026.9127124194379, 26489.602655960178, 29238.0, 30510.84744576263, 30720.53919191214, 30784.69215307863, 931.7624005878457, 1025.876894772632, 1054.6466933577337, 1150.010990548128, 1209.7701436726993, 14888.032277902119, 15094.698106037818, 15502.84497155014, 15673.451429199924, 15817.604559886095, 525230.0, 670385.0, 670820.0, 670845.0, 674430.0, 56800.43199568034, 57280.71359643175, 57731.42268577345, 57927.4207257922, 58110.0, 1109.2567979453786, 1135.318808714781, 1229.7724920889664, 1393.7212557488542, 1424.0387738276622, 24051.518969620858, 29328.56007159937, 29389.971351002612, 29440.705592944654, 30980.845095774377, 51369.229461557356, 58245.54386140381, 59750.70124649349, 59944.0, 60007.699961499915, 616339.0, 616925.0, 617873.0, 620281.0, 622549.0, 42785.57214427816, 42908.78545607252, 43182.13635727205, 43393.0, 43905.78047109744, 47710.0, 47832.282515761595, 47855.5214447851, 48273.275900862216, 49038.264426032925, 39926.201475969734, 40164.3934242627, 40232.82633551036, 40612.59387406088, 40953.38569921394, 38822.6117738819, 38840.41739373855, 39201.80399097986, 40189.59810401859, 40318.59681403266, 36086.45870311895, 38771.41842872303, 39148.608513915635, 39187.608123919534, 39215.019624509616, 32053.51919721253, 34698.65301346954, 34788.0, 35039.47440788339, 35486.82256588804, 25086.62370064414, 25318.0, 25561.977520898956, 25668.0, 25769.0], "value": 20004.230175463817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.63444968906873, 365.26217041576, 373.39882788710173, 380.30214556289206, 405.24421953057555, 19491.707624385628, 20905.268315608955, 21393.0, 21625.45936351592, 21705.457363565918, 20073.498162545908, 20363.694544581842, 20832.68750968733, 20860.956952152406, 21081.894590527027, 5970.88058238836, 6074.088886667013, 6139.416755408229, 6196.349383314755, 6218.502519798405, 4217.683673724468, 5931.228940237763, 6126.938730612704, 6166.7224974876235, 6598.67006649668, 6806.761763338284, 6950.652467376636, 6963.512554121214, 6964.303569643046, 6967.581945083286, 6599.5380323377385, 6753.257141714407, 6847.178338599375, 6944.4444444444325, 6955.826104347407, 5753.88492230153, 5824.126381042835, 5831.446012628793, 5846.064629659234, 5955.434233747787, 25849.870750646125, 26562.0, 26567.202983910513, 26707.332316692045, 26778.464430711472, 2169.913203471859, 2268.8638681678985, 2558.283680569425, 2674.2779449548707, 2749.931251718703, 12758.681032974157, 15400.537983860502, 15721.0, 15732.0, 15733.685326293524, 1858.219547789918, 1940.602176553803, 1944.844412447015, 1961.5096225943514, 1978.5251539630528, 97413.0, 99474.0, 116264.67470650624, 123462.38268808689, 127486.0, 10635.521401536795, 10767.0, 11068.446577671084, 11069.335839849635, 11457.59898403552, 11977.461014254379, 13554.186748795104, 13680.247586382646, 13703.0, 13713.0, 8334.0, 8563.657453701782, 8629.266512346521, 8696.391252612257, 8743.256823169975, 7431.777046688608, 8303.0, 8476.406651534457, 8580.485170889766, 8722.607482663296, 5612.803551875665, 6591.571547849375, 6709.295523969913, 6714.462842972551, 6795.3204679531655, 1387.6253411578816, 1395.9441622335196, 1557.3459147158221, 1839.696450085721, 1884.44408899375, 726.7056841979007, 842.5534466732519, 866.4368160695599, 899.4558292233236, 900.7254734550537, 17629.294828206985, 21055.052522636517, 21176.894115529325, 21650.0, 22133.557328853334, 718.9712411503481, 743.4312750745684, 874.0123660263861, 920.3787443475627, 965.1699538396973, 9346.345755797165, 10712.0, 11333.320000799979, 11387.975082242472, 11392.373419462008, 567427.0, 597141.0, 611723.0, 615479.0, 621901.0, 129450.0, 137702.98435102557, 139620.0, 141975.0, 142742.0, 995.6564985079991, 1013.361582203222, 1030.0, 1031.4533297352416, 1044.9738756530996, 18433.815661843746, 18587.535311617317, 18906.52733681669, 18994.86030838154, 19086.427407177805, 52928.0, 54682.726586366814, 54684.0, 54790.45209547853, 54969.1754623673, 80365.0, 80721.38557228705, 81313.59343203483, 82004.58997704973, 82021.58989205016, 8077.515349078839, 8083.0, 8202.0, 8354.331653467829, 8363.707270245512, 11975.76048479043, 13083.345832708517, 13262.336883155996, 13334.533291335145, 13606.979476539102, 10893.455327233765, 11374.260673056226, 11575.884241157817, 11583.710407239887, 11676.766464670829, 10363.63727269542, 11092.556297748322, 11309.886901130883, 11420.657380278604, 11459.770804583695, 9614.375065620712, 10252.538635761557, 11528.827067593826, 11605.6518304451, 11955.940220299191, 7940.28537431634, 8056.154103819014, 8169.673213071411, 8182.631781569963, 8393.664253429795, 8332.541710205996, 10832.837507437238, 11533.769324613628, 11535.0, 11595.8260626089], "value": 9846.256498832337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.9927700361498, 1503.70677717845, 1692.5430133863856, 1794.5962158514344, 1846.2707230643905, 7963.2036796320335, 8501.19238672326, 8667.349948753854, 8980.23667988221, 8983.955080224598, 8656.220940115389, 8718.520481373522, 8722.869156962635, 8736.956315218431, 8740.91259087409, 2373.1931143411193, 2382.892769825362, 2394.5929192037397, 2406.542756876188, 2407.0973384980634, 2345.9530809383887, 2369.763023697625, 2398.0647547456506, 2400.063975049732, 2404.170561156407, 2378.0725517048363, 2378.904843806254, 2379.0127097254617, 2397.2328854766483, 2397.352714767012, 2343.8945247463735, 2362.751911049341, 2365.947153516686, 2372.51363470489, 2377.263048454976, 2341.6487526871106, 2352.8353015288935, 2354.3643216331666, 2360.433495960974, 2368.9052437902465, 7482.0, 8645.438046526955, 8716.825663486758, 8791.384603077788, 8822.602982865787, 5112.284280200774, 5217.399999000126, 5243.842684719464, 5244.554212891909, 5258.737063146866, 3592.6766591006935, 3599.748017638766, 3600.9099772505633, 3631.2918980798754, 3657.250263695936, 1083.1226706367868, 1083.967480975572, 1084.3764835219781, 1091.939943303118, 1112.5104953820373, 11167.604049493813, 11267.0, 11306.491207895582, 11310.547578096866, 11327.376994265229, 4034.841359872454, 4300.462442194726, 4560.566746159109, 4727.432708075053, 4739.265413860857, 9630.374025688448, 9667.323287369958, 9674.08096230857, 9679.467629280458, 9684.41893486393, 5180.119379705459, 5238.973805131026, 5249.501297376743, 5250.501202385767, 5252.212168174728, 3986.22268657609, 4377.0, 4486.102779444124, 4754.168020596382, 4910.533499317559, 3815.637514436124, 3884.3008258513173, 3938.0154961259686, 3941.3693808990997, 3974.940375894364, 1292.7091404433927, 1297.6626077219992, 1298.3248710670587, 1298.4416700818738, 1303.9674008149682, 686.6189264957997, 878.789090618247, 901.2519608724742, 924.6255266617031, 928.8095940332215, 5680.8863822723315, 5744.684042377626, 5927.496162826122, 5961.612495187799, 6123.9387606124255, 422.32638940889234, 425.8360531195512, 434.96955213134777, 437.4837691524032, 448.2357580325537, 3592.389293820057, 3760.6085748273313, 4018.4374187613757, 4064.8170832312617, 4111.671066314688, 8785.560721963877, 9015.27877769777, 10074.74813129663, 10518.631847885288, 10557.627508423855, 10300.175985921109, 10450.529726162342, 10452.16382689383, 10463.581456741797, 10480.0, 7765.0, 7900.762977110696, 7993.400494962901, 8011.319037881729, 8027.759167224993, 5750.131207357542, 5751.9424805751405, 5764.913526297193, 5790.94209057904, 5809.8547536311935, 9597.952010239904, 9651.118031983695, 9675.806483870143, 9721.756956075871, 9785.510724463891, 9566.139047485482, 9737.61049558038, 9796.804063918824, 9834.065763752433, 9935.602575896883, 6910.7581234656545, 7298.452616053711, 7312.232215617283, 7369.44729145327, 7421.925780742339, 8293.046299675614, 8359.95820020896, 8386.077531471412, 8392.20274073962, 8404.285635720787, 7352.926470735224, 7451.925480745123, 7494.850102998019, 7507.774766757006, 7550.018497595277, 7304.63476826146, 7344.0, 7376.151742549676, 7502.549847009197, 7603.467757256939, 6910.170779506491, 6934.16789985205, 6948.826279343057, 6976.511644185061, 6984.580925144508, 4890.380290889854, 4965.602751779921, 5030.4466508684745, 5063.696178229318, 5073.264376665289, 4917.26241063829, 4986.202207646759, 5062.519060689228, 5077.1876499759865, 5132.076226279306], "value": 4449.265964936099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.3663571824128, 301.430296739163, 315.0658298145997, 315.29846092444313, 316.78616933569833, 4824.541668541483, 5166.785805335748, 5224.440024388051, 5304.734763261836, 5393.575079824311, 5481.5340696040785, 5544.889102217953, 5568.582356323282, 5616.382197958222, 5631.761012577237, 4262.87211383659, 4266.210751011073, 4268.850590229343, 4269.231538323101, 4276.5295817460055, 3230.499272612749, 4113.321301985184, 4165.416841642173, 4243.893902652428, 4272.743635381887, 3702.5186725725616, 4188.664906807463, 4193.169610512907, 4223.788810559475, 4237.936430953539, 3782.56500502443, 3976.8210430530694, 4066.7356621819636, 4172.143396188712, 4271.594198551133, 3137.6427222871534, 3168.825714585697, 3666.358387282215, 3677.632236776301, 3679.7056235501095, 5221.425643179247, 5413.318943118677, 5430.8913821723345, 5445.782168713246, 5451.3458384994055, 4031.8912299117683, 4820.975895120537, 4871.634627402959, 4878.268259761029, 4896.387951506062, 4863.465018847924, 5151.278820965068, 5625.931073096099, 5904.439078287556, 5962.97018514909, 3355.2953879685297, 3366.377220214268, 3411.4541673332396, 3543.6102028776813, 3761.39817629178, 5468.589855760833, 6234.283057448406, 6243.344448832852, 6265.838285791395, 6270.930592904377, 3589.277146969417, 3695.0, 4085.7140000200293, 4100.384942258685, 4104.4664193654635, 3275.6078666566614, 3603.207294395229, 3779.3764028935466, 3910.96089039106, 3943.7830919299713, 4805.37530121089, 4809.711417314902, 4848.612111031109, 4861.659683822169, 4866.294387313819, 5500.532454741392, 5561.277033985637, 5974.761009559656, 6010.849728756816, 6025.457708806229, 1335.6660834791303, 1385.6466601016675, 1386.5995344701923, 1408.8661577150153, 1417.780244062172, 795.6340083561511, 911.544227886057, 915.873475624985, 945.1635302756972, 947.7014740356766, 5074.391073071181, 5164.9741751291, 5198.2202669599865, 5224.373075230997, 5410.621256512085, 5222.8955420892125, 5878.882422351529, 5912.280351038485, 5951.184888608929, 5977.701114944235, 4250.596193361625, 4497.865064048084, 4781.856544303677, 4996.975619997892, 5405.7567409466665, 2344.9179278725164, 2555.4505781257117, 2608.7130415654265, 2634.6970098438924, 2695.2992222022417, 4045.474088368493, 4486.932696009562, 4554.337666751612, 5193.143770925975, 5199.2201169824075, 5048.495150484922, 5075.695458272516, 5092.592592592584, 5355.625106242604, 5591.776328946878, 5421.783128674809, 6379.202599675041, 6424.678766061678, 6446.258680251831, 6479.384458476437, 6000.279966404059, 6080.361562035922, 6139.754409823557, 6142.815715528542, 6165.965231473692, 5031.987205117982, 5699.5725320600295, 5923.482519929099, 5927.91748290895, 6133.417325354084, 5377.596680249075, 6425.228972523327, 6449.806505804833, 6454.612258364474, 6462.547621666438, 3696.4824924511126, 3912.628300311466, 4011.578784227614, 4024.1348110156455, 4043.7775922324554, 5103.958416633376, 6044.304904935812, 6086.117512960507, 6105.419985101408, 6117.388261173847, 4856.781444835062, 5511.0, 5886.94113058864, 5913.674747888907, 5991.820245392645, 5896.410358964069, 5910.231669882888, 5927.496162826035, 5931.436513531207, 5979.790707325223, 5528.778848846001, 5695.889301586151, 5725.398833122629, 5727.6849773262875, 5831.912521312269, 5930.318013428511, 5956.404359564009, 6005.039193728982, 6010.128531363015, 6041.640630858197, 4990.525900039491, 5340.703497496114, 5653.010723123519, 5748.0, 5853.824385268449], "value": 4185.265327799058, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.5813284166027, 682.2427105912436, 709.3403135084372, 734.6877577029761, 818.5293456262649, 15265.236738163088, 15440.459583914566, 15751.92124039381, 15960.52118436446, 15997.760033599505, 14221.21783301918, 14485.493007744732, 14513.854861451382, 14516.201608911506, 14524.0, 824.7979245084963, 838.2246422059601, 842.5871323051691, 842.7977285451509, 847.2798121596655, 659.426299119764, 815.3721634341554, 836.9707060252892, 850.0437008365589, 850.6427300533791, 879.8284334554764, 883.3021912688968, 890.274426342532, 890.8574628059512, 892.8660700894853, 878.7319867440428, 886.1271647427279, 887.3078998381272, 888.8577827547593, 890.9866352004725, 634.4416913116474, 657.9735612444601, 661.206552137437, 661.3915198017835, 663.1909070933501, 12241.877581224251, 12266.754664906652, 12823.294718790463, 14742.0, 14797.964142510029, 13951.58145255644, 14511.782323265159, 14751.0, 14761.18813465259, 14809.629759256104, 11448.656540303804, 11667.591634292843, 11935.104867134913, 11987.160898737093, 12386.81419778704, 3415.9829200854083, 3509.0350153707677, 3818.579956204815, 3883.805809709503, 3979.880603581897, 121594.0, 122026.0, 123068.0, 126524.36737816253, 126808.73191268061, 8924.732258032269, 10933.835992460119, 11074.667759967213, 11141.498632561554, 11299.774004519864, 22190.445238869157, 22581.0967561299, 23040.423989400064, 23324.766752332598, 23367.0, 8082.353411727047, 8163.265306122477, 8192.0, 8250.298724608476, 8379.49723016621, 4474.7762611869275, 4525.7510836904285, 4537.1833070047705, 4542.613877820422, 4559.863204103882, 3512.121969507623, 3638.6361363863402, 3642.9635703643153, 3646.197836475971, 3656.0, 565.2962062232547, 568.2328856044389, 572.1617829879164, 575.5165660844826, 576.9942300577025, 548.8847342058212, 594.5689375203029, 595.9910601340983, 641.887669657808, 642.7750287399373, 8381.790455238668, 8710.346723995726, 9031.864522032174, 9286.95356523213, 9450.621975120917, 553.4576115406924, 556.1296570866581, 607.8784243151388, 655.3217419970308, 655.3512023097195, 4098.569650186747, 4201.957980420218, 4590.67865249436, 4655.930161047587, 4668.60159879548, 139130.3043484776, 142982.0, 147074.0, 149337.0, 164709.17645411697, 110016.0, 127478.0, 136199.63800362067, 137665.0, 139031.0, 111689.88310116794, 113915.43042284735, 114601.85398145912, 114771.0, 115323.42338288423, 10023.255466528539, 10116.544755486168, 10171.186305095722, 10203.897961020295, 10240.180785537288, 58198.4180158193, 62895.0, 65785.34214657792, 66983.32066717277, 67849.0, 95401.0, 99563.0, 100121.49939250258, 100409.49795250977, 101745.0, 11562.537498499965, 13905.791413128609, 14094.788578171541, 14365.497207597684, 14635.853641463875, 14294.642633934234, 14934.0, 15000.549983500512, 15220.771688424462, 15242.923785381003, 13870.988706637683, 13981.370838312503, 14173.0, 14221.64445888861, 14314.069585476911, 11293.0, 13694.93152534231, 13975.930120349332, 13999.720005599627, 14049.297535122998, 10469.528871200662, 11493.138014648768, 12855.742885142057, 13433.0, 14403.495877644233, 11194.0, 11246.66260012201, 11522.308661480338, 11551.826722599335, 11922.821157682469, 9847.655332063343, 11043.834342484708, 11429.142814289127, 11496.367699776258, 11622.535098595961], "value": 7827.053851807171, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 142.0, 161.0, 151.0, 119.0, 116.0, 117.0, 118.0, 132.0], "value": 128.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 107.0, 133.0, 159.0, 109.0, 129.0, 132.0, 111.0, 158.0, 111.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 236.0, 223.0, 206.0, 252.0, 259.0, 200.0, 198.0, 199.0], "value": 216.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 75.0, 141.0, 60.0, 59.0, 59.0, 60.0, 133.0, 60.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 125.0, 87.0, 100.0, 105.0, 127.0, 71.0, 75.0, 114.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 74.0, 137.0, 132.0, 89.0, 85.0, 88.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 98.0, 97.0, 100.0, 98.0, 98.0, 100.0, 136.0, 150.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 92.0, 90.0, 92.0, 92.0, 90.0, 92.0, 92.0, 108.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 59.0, 56.0, 58.0, 58.0, 59.0, 58.0, 55.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 82.0, 61.0, 78.0, 99.0, 113.0, 104.0, 72.0, 72.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 93.0, 79.0, 78.0, 75.0, 106.0, 111.0, 107.0, 86.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 170.0, 146.0, 156.0, 156.0, 162.0, 165.0, 189.0, 141.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 236.0, 240.0, 186.0, 170.0, 173.0, 175.0, 172.0, 177.0], "value": 187.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 70.0, 70.0, 70.0, 70.0, 68.0, 66.0, 67.0, 70.0], "value": 68.7, "unit": "score"}]}]} 10:29:19 INFO - Return code: 0 10:29:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:29:19 ERROR - # TBPL SUCCESS # 10:29:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:29:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:29:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:29:19 INFO - 2016-09-01 10:29:19.941 screenresolution[1668:10517] starting screenresolution argv=screenresolution get 10:29:19 INFO - 2016-09-01 10:29:19.944 screenresolution[1668:10517] Display 0: 1600x1200x32@60 10:29:19 INFO - 2016-09-01 10:29:19.950 screenresolution[1669:10521] starting screenresolution argv=screenresolution list 10:29:19 INFO - Available Modes on Display 0 10:29:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:29:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:29:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:29:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:29:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:29:20 INFO - Intel Iris: 10:29:20 INFO - Chipset Model: Intel Iris 10:29:20 INFO - Type: GPU 10:29:20 INFO - Bus: Built-In 10:29:20 INFO - VRAM (Dynamic, Max): 1536 MB 10:29:20 INFO - Vendor: Intel (0x8086) 10:29:20 INFO - Device ID: 0x0a2e 10:29:20 INFO - Revision ID: 0x0009 10:29:20 INFO - Displays: 10:29:20 INFO - Display: 10:29:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:29:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:29:20 INFO - Display Serial Number: 1600x1200 60 10:29:20 INFO - Main Display: Yes 10:29:20 INFO - Mirror: Off 10:29:20 INFO - Online: Yes 10:29:20 INFO - Rotation: Supported 10:29:20 INFO - Return code: 0 10:29:20 INFO - Running post-action listener: _resource_record_post_action 10:29:20 INFO - [mozharness: 2016-09-01 17:29:20.185420Z] Finished run-tests step (success) 10:29:20 INFO - Running post-run listener: _resource_record_post_run 10:29:20 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 36643840; Write bytes: 708326912; Read time: 232; Write time: 2026 10:29:20 INFO - TinderboxPrint: CPU usage
54.4% 10:29:20 INFO - TinderboxPrint: I/O read bytes / time
36,643,840 / 232 10:29:20 INFO - TinderboxPrint: I/O write bytes / time
708,326,912 / 2,026 10:29:20 INFO - TinderboxPrint: CPU idle
2,204.7 (45.6%) 10:29:20 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 10:29:20 INFO - TinderboxPrint: CPU user
1,656.5 (34.2%) 10:29:20 INFO - TinderboxPrint: Swap in / out
443,179,008 / 0 10:29:20 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 412498432; Write bytes: 408229888; Read time: 30032; Write time: 835 10:29:20 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29096960; Write bytes: 296228864; Read time: 170; Write time: 1174 10:29:20 INFO - Running post-run listener: _upload_blobber_files 10:29:20 INFO - Blob upload gear active. 10:29:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:20 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:29:20 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:29:20 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:29:21 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:22 INFO - (blobuploader) - INFO - Done attempting. 10:29:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:23 INFO - (blobuploader) - INFO - Done attempting. 10:29:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:25 INFO - (blobuploader) - INFO - Done attempting. 10:29:25 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:25 INFO - Return code: 0 10:29:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1046b91bc50ddcb3943c4a4c590563d8229e37486177cf34db0e3ebb11ffc060a51bea8d64db188c1fdfd950161ae0ac3cbf19c3d4e2ce4ad37cebe0fc68e4d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5de08ecd38cabf7ee2c9daa074db26cac52b6f2db6d973d04367d6560d9563b6a1f6b05786e45304857ff45efe5f50df935bc286da8d649fe31c3f17a815013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fe88f90679a62b4a904dba77ca4545f332c79ef790aaed4b413901779f098e4a76c733379cde50572e098ae3741b0d3311f8ad32a85d8ec344e28e8f5b7076d"} 10:29:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:25 INFO - Contents: 10:29:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1046b91bc50ddcb3943c4a4c590563d8229e37486177cf34db0e3ebb11ffc060a51bea8d64db188c1fdfd950161ae0ac3cbf19c3d4e2ce4ad37cebe0fc68e4d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5de08ecd38cabf7ee2c9daa074db26cac52b6f2db6d973d04367d6560d9563b6a1f6b05786e45304857ff45efe5f50df935bc286da8d649fe31c3f17a815013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fe88f90679a62b4a904dba77ca4545f332c79ef790aaed4b413901779f098e4a76c733379cde50572e098ae3741b0d3311f8ad32a85d8ec344e28e8f5b7076d"} 10:29:25 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:25 INFO - Copying logs to upload dir... 10:29:25 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.773938 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-01 10:29:25.473174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 10:29:25.476798) ========= 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.4AH4WkGZqn/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.SW2juCw8zl/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1046b91bc50ddcb3943c4a4c590563d8229e37486177cf34db0e3ebb11ffc060a51bea8d64db188c1fdfd950161ae0ac3cbf19c3d4e2ce4ad37cebe0fc68e4d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5de08ecd38cabf7ee2c9daa074db26cac52b6f2db6d973d04367d6560d9563b6a1f6b05786e45304857ff45efe5f50df935bc286da8d649fe31c3f17a815013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fe88f90679a62b4a904dba77ca4545f332c79ef790aaed4b413901779f098e4a76c733379cde50572e098ae3741b0d3311f8ad32a85d8ec344e28e8f5b7076d"} build_url:https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/QEKhC--1SseiVw7heQC5WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1046b91bc50ddcb3943c4a4c590563d8229e37486177cf34db0e3ebb11ffc060a51bea8d64db188c1fdfd950161ae0ac3cbf19c3d4e2ce4ad37cebe0fc68e4d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5de08ecd38cabf7ee2c9daa074db26cac52b6f2db6d973d04367d6560d9563b6a1f6b05786e45304857ff45efe5f50df935bc286da8d649fe31c3f17a815013", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fe88f90679a62b4a904dba77ca4545f332c79ef790aaed4b413901779f098e4a76c733379cde50572e098ae3741b0d3311f8ad32a85d8ec344e28e8f5b7076d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 10:29:25.514030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:29:25.514367) ========= 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.4AH4WkGZqn/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.SW2juCw8zl/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.005165 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 10:29:25.564640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 10:29:25.564954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 10:29:25.565287) ========= ========= Total master_lag: 0.24 =========