builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0346 starttime: 1472690461.87 results: success (0) buildid: 20160831142219 builduid: 3100d6125bb643ad86ad127c4a4227aa revision: 215b219482a545aea1118d436eb77334bbb4be21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:01.866502) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:01.866931) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:01.867207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:01.956610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:01.956986) ========= 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.AvSscmefOa/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.xiv5WQIjdJ/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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-08-31 17:41:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.0M=0.001s 2016-08-31 17:41:02 (11.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:02.128879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:02.129186) ========= 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.AvSscmefOa/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.xiv5WQIjdJ/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.026271 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:02.179665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-31 17:41:02.180040) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 215b219482a545aea1118d436eb77334bbb4be21 --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 215b219482a545aea1118d436eb77334bbb4be21 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AvSscmefOa/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.xiv5WQIjdJ/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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-08-31 17:41:02,266 truncating revision to first 12 chars 2016-08-31 17:41:02,266 Setting DEBUG logging. 2016-08-31 17:41:02,266 attempt 1/10 2016-08-31 17:41:02,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/215b219482a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 17:41:04,199 unpacking tar archive at: fx-team-215b219482a5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.205476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-31 17:41:04.408674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:04.409048) ========= script_repo_revision: 215b219482a545aea1118d436eb77334bbb4be21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:04.409486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:04.409807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 17:41:04.428633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-31 17:41:04.428977) ========= /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.AvSscmefOa/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.xiv5WQIjdJ/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:04 INFO - MultiFileLogger online at 20160831 17:41:04 in /builds/slave/test 17:41:04 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 17:41:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:41:04 INFO - {'append_to_log': False, 17:41:04 INFO - 'base_work_dir': '/builds/slave/test', 17:41:04 INFO - 'blob_upload_branch': 'Fx-Team', 17:41:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:41:04 INFO - 'branch': 'Fx-Team', 17:41:04 INFO - 'buildbot_json_path': 'buildprops.json', 17:41:04 INFO - 'config_files': ('talos/mac_config.py',), 17:41:04 INFO - 'default_actions': ('clobber', 17:41:04 INFO - 'read-buildbot-config', 17:41:04 INFO - 'download-and-extract', 17:41:04 INFO - 'populate-webroot', 17:41:04 INFO - 'create-virtualenv', 17:41:04 INFO - 'install', 17:41:04 INFO - 'run-tests'), 17:41:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:41:04 INFO - 'download_minidump_stackwalk': True, 17:41:04 INFO - 'download_symbols': 'ondemand', 17:41:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:41:04 INFO - 'tooltool.py': '/tools/tooltool.py', 17:41:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:41:04 INFO - '/tools/misc-python/virtualenv.py')}, 17:41:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:41:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:41:04 INFO - 'installer_path': 'installer.exe', 17:41:04 INFO - 'log_level': 'info', 17:41:04 INFO - 'log_name': 'talos', 17:41:04 INFO - 'log_to_console': True, 17:41:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:41:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:41:04 INFO - 'opt_config_files': (), 17:41:04 INFO - 'pip_index': False, 17:41:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:41:04 INFO - 'cmd': ('bash', 17:41:04 INFO - '-c', 17:41:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:41:04 INFO - 'enabled': True, 17:41:04 INFO - 'halt_on_failure': False, 17:41:04 INFO - 'name': 'check_screen_resolution'},), 17:41:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:41:04 INFO - 'cmd': ('bash', 17:41:04 INFO - '-c', 17:41:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:41:04 INFO - 'enabled': True, 17:41:04 INFO - 'halt_on_failure': False, 17:41:04 INFO - 'name': 'check_screen_resolution'},), 17:41:04 INFO - 'run_cmd_checks_enabled': True, 17:41:04 INFO - 'sps_profile': False, 17:41:04 INFO - 'sps_profile_interval': 0, 17:41:04 INFO - 'suite': 'dromaeojs-e10s', 17:41:04 INFO - 'system_bits': '32', 17:41:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:41:04 INFO - 'title': 't-yosemite-r7-0346', 17:41:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:41:04 INFO - 'use_talos_json': True, 17:41:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:41:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:41:04 INFO - 'work_dir': 'build'} 17:41:04 INFO - [mozharness: 2016-09-01 00:41:04.625183Z] Running clobber step. 17:41:04 INFO - Running pre-action listener: _resource_record_pre_action 17:41:04 INFO - Running main action method: clobber 17:41:04 INFO - rmtree: /builds/slave/test/build 17:41:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:41:06 INFO - Running post-action listener: _resource_record_post_action 17:41:06 INFO - [mozharness: 2016-09-01 00:41:06.628149Z] Finished clobber step (success) 17:41:06 INFO - [mozharness: 2016-09-01 00:41:06.628278Z] Running read-buildbot-config step. 17:41:06 INFO - Running pre-action listener: _resource_record_pre_action 17:41:06 INFO - Running main action method: read_buildbot_config 17:41:06 INFO - Using buildbot properties: 17:41:06 INFO - { 17:41:06 INFO - "project": "", 17:41:06 INFO - "product": "firefox", 17:41:06 INFO - "script_repo_revision": "production", 17:41:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:41:06 INFO - "repository": "", 17:41:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:41:06 INFO - "buildid": "20160831142219", 17:41:06 INFO - "pgo_build": "False", 17:41:06 INFO - "basedir": "/builds/slave/test", 17:41:06 INFO - "buildnumber": 13, 17:41:06 INFO - "slavename": "t-yosemite-r7-0346", 17:41:06 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:41:06 INFO - "platform": "yosemite_r7", 17:41:06 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:41:06 INFO - "branch": "fx-team", 17:41:06 INFO - "repo_path": "integration/fx-team", 17:41:06 INFO - "revision": "215b219482a545aea1118d436eb77334bbb4be21", 17:41:06 INFO - "stage_platform": "macosx64", 17:41:06 INFO - "builduid": "3100d6125bb643ad86ad127c4a4227aa", 17:41:06 INFO - "slavebuilddir": "test" 17:41:06 INFO - } 17:41:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:41:06 INFO - Running post-action listener: _resource_record_post_action 17:41:06 INFO - [mozharness: 2016-09-01 00:41:06.631569Z] Finished read-buildbot-config step (success) 17:41:06 INFO - [mozharness: 2016-09-01 00:41:06.631687Z] Running download-and-extract step. 17:41:06 INFO - Running pre-action listener: _resource_record_pre_action 17:41:06 INFO - Running main action method: download_and_extract 17:41:06 INFO - mkdir: /builds/slave/test/build/tests 17:41:06 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')]} 17:41:06 INFO - trying https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:41:06 INFO - Downloading https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:07 INFO - Downloaded 1199 bytes. 17:41:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:41:07 INFO - Using the following test package requirements: 17:41:07 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:41:07 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:41:07 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:41:07 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'jsshell-mac.zip'], 17:41:07 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:41:07 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:41:07 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:41:07 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:41:07 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:41:07 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:41:07 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:41:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:07 INFO - trying https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:41:07 INFO - Downloading https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:08 INFO - Downloaded 16396920 bytes. 17:41:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:41:15 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 17:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:15 INFO - trying https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:41:15 INFO - Downloading https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:16 INFO - Downloaded 16396920 bytes. 17:41:16 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:22 INFO - trying https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:41:22 INFO - Downloading https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:24 INFO - Downloaded 14413998 bytes. 17:41:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 17:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:25 INFO - trying https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:41:25 INFO - Downloading https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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 17:41:28 INFO - Downloaded 111572073 bytes. 17:41:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:41:28 INFO - mkdir: /builds/slave/test/properties 17:41:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:41:28 INFO - Writing to file /builds/slave/test/properties/build_url 17:41:28 INFO - Contents: 17:41:28 INFO - build_url:https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:41:28 INFO - Running post-action listener: _resource_record_post_action 17:41:28 INFO - Running post-action listener: set_extra_try_arguments 17:41:28 INFO - [mozharness: 2016-09-01 00:41:28.793121Z] Finished download-and-extract step (success) 17:41:28 INFO - [mozharness: 2016-09-01 00:41:28.793272Z] Running populate-webroot step. 17:41:28 INFO - Running pre-action listener: _resource_record_pre_action 17:41:28 INFO - Running main action method: populate_webroot 17:41:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:41:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:41:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:41:28 INFO - '--tppagecycles', 17:41:28 INFO - '7'], 17:41:28 INFO - 'tests': ['tsvgm']}}, 17:41:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:41:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:41:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:41:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:41:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['damp', 'tps']}, 17:41:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'tests': ['damp', 'tps']}, 17:41:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['dromaeo_dom']}, 17:41:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:41:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['basic_compositor_video']}, 17:41:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:41:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other-e10s': {'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['a11yr', 17:41:28 INFO - 'ts_paint', 17:41:28 INFO - 'tpaint', 17:41:28 INFO - 'sessionrestore', 17:41:28 INFO - 'sessionrestore_no_auto_restore', 17:41:28 INFO - 'tabpaint']}, 17:41:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tsvgx', 17:41:28 INFO - 'tsvgr_opacity', 17:41:28 INFO - 'tart', 17:41:28 INFO - 'tscrollx', 17:41:28 INFO - 'cart']}, 17:41:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:41:28 INFO - 'tsvgr_opacity', 17:41:28 INFO - 'tart', 17:41:28 INFO - 'tscrollx', 17:41:28 INFO - 'cart']}, 17:41:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s'], 17:41:28 INFO - 'tests': ['tp5o']}, 17:41:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'tests': ['tp5o']}, 17:41:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--disable-e10s', 17:41:28 INFO - '--xperf_path', 17:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:28 INFO - 'tests': ['tp5n']}, 17:41:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:28 INFO - 'talos_options': ['--xperf_path', 17:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:28 INFO - 'tests': ['tp5n']}}, 17:41:28 INFO - 'talos.zip': {'path': '', 17:41:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:41:28 INFO - Running post-action listener: _resource_record_post_action 17:41:28 INFO - [mozharness: 2016-09-01 00:41:28.811857Z] Finished populate-webroot step (success) 17:41:28 INFO - [mozharness: 2016-09-01 00:41:28.812000Z] Running create-virtualenv step. 17:41:28 INFO - Running pre-action listener: _resource_record_pre_action 17:41:28 INFO - Running main action method: create_virtualenv 17:41:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:41:28 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 17:41:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:41:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:41:28 INFO - Using real prefix '/tools/python27' 17:41:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:41:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:41:32 INFO - Installing pip.................done. 17:41:32 INFO - Return code: 0 17:41:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:32 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:32 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 17:41:32 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 17:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:32 INFO - 'HOME': '/Users/cltbld', 17:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:32 INFO - 'LOGNAME': 'cltbld', 17:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:32 INFO - 'MOZ_NO_REMOTE': '1', 17:41:32 INFO - 'NO_EM_RESTART': '1', 17:41:32 INFO - 'PAGER': '/bin/cat', 17:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:32 INFO - 'PWD': '/builds/slave/test', 17:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:32 INFO - 'SHELL': '/bin/bash', 17:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:32 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:32 INFO - 'USER': 'cltbld', 17:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:32 INFO - 'XPC_FLAGS': '0x0', 17:41:32 INFO - 'XPC_SERVICE_NAME': '0', 17:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:32 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 17:41:32 INFO - Cleaning up... 17:41:32 INFO - Return code: 0 17:41:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:32 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:32 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 17:41:32 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 17:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:32 INFO - 'HOME': '/Users/cltbld', 17:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:32 INFO - 'LOGNAME': 'cltbld', 17:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:32 INFO - 'MOZ_NO_REMOTE': '1', 17:41:32 INFO - 'NO_EM_RESTART': '1', 17:41:32 INFO - 'PAGER': '/bin/cat', 17:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:32 INFO - 'PWD': '/builds/slave/test', 17:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:32 INFO - 'SHELL': '/bin/bash', 17:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:32 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:32 INFO - 'USER': 'cltbld', 17:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:32 INFO - 'XPC_FLAGS': '0x0', 17:41:32 INFO - 'XPC_SERVICE_NAME': '0', 17:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:33 INFO - Downloading/unpacking psutil>=3.1.1 17:41:33 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 17:41:33 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 17:41:33 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 17:41:33 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 17:41:33 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 17:41:33 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 17:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:35 INFO - Installing collected packages: psutil 17:41:35 INFO - Running setup.py install for psutil 17:41:36 INFO - building 'psutil._psutil_osx' extension 17:41:36 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 17:41:36 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 17:41:36 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 17:41:36 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 17:41:36 INFO - building 'psutil._psutil_posix' extension 17:41:36 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 17:41:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:41:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:41:36 INFO - ^ 17:41:36 INFO - 1 warning generated. 17:41:36 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 17:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:37 INFO - Successfully installed psutil 17:41:37 INFO - Cleaning up... 17:41:37 INFO - Return code: 0 17:41:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:37 INFO - 'HOME': '/Users/cltbld', 17:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:37 INFO - 'LOGNAME': 'cltbld', 17:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:37 INFO - 'MOZ_NO_REMOTE': '1', 17:41:37 INFO - 'NO_EM_RESTART': '1', 17:41:37 INFO - 'PAGER': '/bin/cat', 17:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:37 INFO - 'PWD': '/builds/slave/test', 17:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:37 INFO - 'SHELL': '/bin/bash', 17:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:37 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:37 INFO - 'USER': 'cltbld', 17:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:37 INFO - 'XPC_FLAGS': '0x0', 17:41:37 INFO - 'XPC_SERVICE_NAME': '0', 17:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:41:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:41:40 INFO - Installing collected packages: mozsystemmonitor 17:41:40 INFO - Running setup.py install for mozsystemmonitor 17:41:40 INFO - Successfully installed mozsystemmonitor 17:41:40 INFO - Cleaning up... 17:41:40 INFO - Return code: 0 17:41:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:41:40 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')]} 17:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:40 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')]} 17:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:40 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:40 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 17:41:40 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 17:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:40 INFO - 'HOME': '/Users/cltbld', 17:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:40 INFO - 'LOGNAME': 'cltbld', 17:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:40 INFO - 'MOZ_NO_REMOTE': '1', 17:41:40 INFO - 'NO_EM_RESTART': '1', 17:41:40 INFO - 'PAGER': '/bin/cat', 17:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:40 INFO - 'PWD': '/builds/slave/test', 17:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:40 INFO - 'SHELL': '/bin/bash', 17:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:40 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:40 INFO - 'USER': 'cltbld', 17:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:40 INFO - 'XPC_FLAGS': '0x0', 17:41:40 INFO - 'XPC_SERVICE_NAME': '0', 17:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:40 INFO - Downloading/unpacking jsonschema==2.5.1 17:41:40 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 17:41:40 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 17:41:40 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 17:41:40 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 17:41:40 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 17:41:40 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 17:41:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:41:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:43 INFO - Downloading functools32-3.2.3-2.tar.gz 17:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:41:43 INFO - warning: no files found matching '*.txt' 17:41:43 INFO - no previously-included directories found matching 'build' 17:41:43 INFO - no previously-included directories found matching 'dist' 17:41:43 INFO - no previously-included directories found matching '.git*' 17:41:43 INFO - Installing collected packages: jsonschema, functools32 17:41:43 INFO - Running setup.py install for functools32 17:41:43 INFO - warning: no files found matching '*.txt' 17:41:43 INFO - no previously-included directories found matching 'build' 17:41:43 INFO - no previously-included directories found matching 'dist' 17:41:43 INFO - no previously-included directories found matching '.git*' 17:41:43 INFO - Successfully installed jsonschema functools32 17:41:43 INFO - Cleaning up... 17:41:43 INFO - Return code: 0 17:41:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:41:43 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')]} 17:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:43 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')]} 17:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:43 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:43 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 17:41:43 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 17:41:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:43 INFO - 'HOME': '/Users/cltbld', 17:41:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:43 INFO - 'LOGNAME': 'cltbld', 17:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:43 INFO - 'MOZ_NO_REMOTE': '1', 17:41:43 INFO - 'NO_EM_RESTART': '1', 17:41:43 INFO - 'PAGER': '/bin/cat', 17:41:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:43 INFO - 'PWD': '/builds/slave/test', 17:41:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:43 INFO - 'SHELL': '/bin/bash', 17:41:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:43 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:43 INFO - 'USER': 'cltbld', 17:41:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:43 INFO - 'XPC_FLAGS': '0x0', 17:41:43 INFO - 'XPC_SERVICE_NAME': '0', 17:41:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:41:43 INFO - Cleaning up... 17:41:43 INFO - Return code: 0 17:41:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:41:43 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')]} 17:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:43 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')]} 17:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:43 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:43 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 17:41:43 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 17:41:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:43 INFO - 'HOME': '/Users/cltbld', 17:41:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:43 INFO - 'LOGNAME': 'cltbld', 17:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:43 INFO - 'MOZ_NO_REMOTE': '1', 17:41:43 INFO - 'NO_EM_RESTART': '1', 17:41:43 INFO - 'PAGER': '/bin/cat', 17:41:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:43 INFO - 'PWD': '/builds/slave/test', 17:41:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:43 INFO - 'SHELL': '/bin/bash', 17:41:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:43 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:43 INFO - 'USER': 'cltbld', 17:41:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:43 INFO - 'XPC_FLAGS': '0x0', 17:41:43 INFO - 'XPC_SERVICE_NAME': '0', 17:41:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:44 INFO - Downloading/unpacking blobuploader==1.2.4 17:41:44 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 17:41:44 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 17:41:44 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 17:41:44 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 17:41:44 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 17:41:44 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 17:41:46 INFO - Downloading blobuploader-1.2.4.tar.gz 17:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:41:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:41:46 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 17:41:46 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 17:41:46 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 17:41:46 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 17:41:46 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 17:41:46 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 17:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:41:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:41: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 17:41: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 17:41: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 17:41: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 17:41: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 17:41: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 17:41:47 INFO - Downloading docopt-0.6.1.tar.gz 17:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:41:47 INFO - Installing collected packages: blobuploader, requests, docopt 17:41:47 INFO - Running setup.py install for blobuploader 17:41:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:41:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:41:48 INFO - Running setup.py install for requests 17:41:48 INFO - Running setup.py install for docopt 17:41:48 INFO - Successfully installed blobuploader requests docopt 17:41:48 INFO - Cleaning up... 17:41:48 INFO - Return code: 0 17:41:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:48 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:48 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 17:41:48 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 17:41:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:48 INFO - 'HOME': '/Users/cltbld', 17:41:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:48 INFO - 'LOGNAME': 'cltbld', 17:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:48 INFO - 'MOZ_NO_REMOTE': '1', 17:41:48 INFO - 'NO_EM_RESTART': '1', 17:41:48 INFO - 'PAGER': '/bin/cat', 17:41:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:48 INFO - 'PWD': '/builds/slave/test', 17:41:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:48 INFO - 'SHELL': '/bin/bash', 17:41:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:48 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:48 INFO - 'USER': 'cltbld', 17:41:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:48 INFO - 'XPC_FLAGS': '0x0', 17:41:48 INFO - 'XPC_SERVICE_NAME': '0', 17:41:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-dsWJqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-m21RQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-gVtBKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-KHrSDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-BBG1MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-UuTjvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-JDMvIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-LCvy_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-A7SDBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:49 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-j289mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:50 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-vSVlhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:50 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-NfPDea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:50 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-wEt8SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:50 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-_ggkID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:50 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-c0urPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:50 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-UaPxj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:50 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-0psyqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:41:50 INFO - Running setup.py install for manifestparser 17:41:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:41:50 INFO - Running setup.py install for mozcrash 17:41:51 INFO - Running setup.py install for mozdebug 17:41:51 INFO - Running setup.py install for mozdevice 17:41:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Running setup.py install for mozfile 17:41:51 INFO - Running setup.py install for mozhttpd 17:41:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Running setup.py install for mozinfo 17:41:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Running setup.py install for mozInstall 17:41:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:41:51 INFO - Running setup.py install for mozleak 17:41:52 INFO - Running setup.py install for mozlog 17:41:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:41:52 INFO - Running setup.py install for moznetwork 17:41:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:41:52 INFO - Running setup.py install for mozprocess 17:41:52 INFO - Running setup.py install for mozprofile 17:41:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:41:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:41:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:41:52 INFO - Running setup.py install for mozrunner 17:41:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:41:52 INFO - Running setup.py install for mozscreenshot 17:41:53 INFO - Running setup.py install for moztest 17:41:53 INFO - Running setup.py install for mozversion 17:41:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:41:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:41:53 INFO - Cleaning up... 17:41:53 INFO - Return code: 0 17:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:53 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')]} 17:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:53 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')]} 17:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:53 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:53 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 17:41:53 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 17:41:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:53 INFO - 'HOME': '/Users/cltbld', 17:41:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:53 INFO - 'LOGNAME': 'cltbld', 17:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:53 INFO - 'MOZ_NO_REMOTE': '1', 17:41:53 INFO - 'NO_EM_RESTART': '1', 17:41:53 INFO - 'PAGER': '/bin/cat', 17:41:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:53 INFO - 'PWD': '/builds/slave/test', 17:41:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:53 INFO - 'SHELL': '/bin/bash', 17:41:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:53 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:53 INFO - 'USER': 'cltbld', 17:41:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:53 INFO - 'XPC_FLAGS': '0x0', 17:41:53 INFO - 'XPC_SERVICE_NAME': '0', 17:41:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:53 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-9idbbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:53 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)) 17:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:53 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-byy8T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:53 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)) 17:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:53 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-iO4Fz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:53 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)) 17:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:53 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-ECpUyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-0rlD7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Ftokta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-lgr9cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-gtaj9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-srsbj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-BxiZPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-EdNo6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-BhEDzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:54 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)) 17:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:54 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-NcJSVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:55 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)) 17:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-rUUmg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:55 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)) 17:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-KApjw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:55 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)) 17:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-hGbomv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:55 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)) 17:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:55 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-2nKTiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:55 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)) 17:41:55 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)) 17:41:55 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)) 17:41:55 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)) 17:41:55 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)) 17:41:55 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)) 17:41:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:41:55 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 17:41:55 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 17:41:55 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 17:41:55 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 17:41:55 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 17:41:55 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 17:41:57 INFO - Downloading blessings-1.6.tar.gz 17:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:41:57 INFO - Installing collected packages: blessings 17:41:57 INFO - Running setup.py install for blessings 17:41:58 INFO - Successfully installed blessings 17:41:58 INFO - Cleaning up... 17:41:58 INFO - Return code: 0 17:41:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:41:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:58 INFO - Reading from file tmpfile_stdout 17:41:58 INFO - Current package versions: 17:41:58 INFO - blessings == 1.6 17:41:58 INFO - blobuploader == 1.2.4 17:41:58 INFO - docopt == 0.6.1 17:41:58 INFO - functools32 == 3.2.3-2 17:41:58 INFO - jsonschema == 2.5.1 17:41:58 INFO - manifestparser == 1.1 17:41:58 INFO - mozInstall == 1.12 17:41:58 INFO - mozcrash == 0.17 17:41:58 INFO - mozdebug == 0.1 17:41:58 INFO - mozdevice == 0.48 17:41:58 INFO - mozfile == 1.2 17:41:58 INFO - mozhttpd == 0.7 17:41:58 INFO - mozinfo == 0.9 17:41:58 INFO - mozleak == 0.1 17:41:58 INFO - mozlog == 3.3 17:41:58 INFO - moznetwork == 0.27 17:41:58 INFO - mozprocess == 0.23 17:41:58 INFO - mozprofile == 0.28 17:41:58 INFO - mozrunner == 6.12 17:41:58 INFO - mozscreenshot == 0.1 17:41:58 INFO - mozsystemmonitor == 0.3 17:41:58 INFO - moztest == 0.7 17:41:58 INFO - mozversion == 1.4 17:41:58 INFO - psutil == 3.1.1 17:41:58 INFO - requests == 1.2.3 17:41:58 INFO - wsgiref == 0.1.2 17:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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')]} 17:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:59 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:59 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 17:41:59 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 17:41:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:59 INFO - 'HOME': '/Users/cltbld', 17:41:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:59 INFO - 'LOGNAME': 'cltbld', 17:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:59 INFO - 'MOZ_NO_REMOTE': '1', 17:41:59 INFO - 'NO_EM_RESTART': '1', 17:41:59 INFO - 'PAGER': '/bin/cat', 17:41:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:59 INFO - 'PWD': '/builds/slave/test', 17:41:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:59 INFO - 'SHELL': '/bin/bash', 17:41:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:59 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:59 INFO - 'USER': 'cltbld', 17:41:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:59 INFO - 'XPC_FLAGS': '0x0', 17:41:59 INFO - 'XPC_SERVICE_NAME': '0', 17:41:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 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)) 17:41:59 INFO - Cleaning up... 17:41:59 INFO - Return code: 0 17:41:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:41: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')]} 17:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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')]} 17:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:59 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 0x10bc15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcaa618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94735bfc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, '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.AvSscmefOa/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.xiv5WQIjdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 17:41:59 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 17:41:59 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 17:41:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:41:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:59 INFO - 'HOME': '/Users/cltbld', 17:41:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:59 INFO - 'LOGNAME': 'cltbld', 17:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:59 INFO - 'MOZ_NO_REMOTE': '1', 17:41:59 INFO - 'NO_EM_RESTART': '1', 17:41:59 INFO - 'PAGER': '/bin/cat', 17:41:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:59 INFO - 'PWD': '/builds/slave/test', 17:41:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:59 INFO - 'SHELL': '/bin/bash', 17:41:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:41:59 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:41:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:59 INFO - 'USER': 'cltbld', 17:41:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:59 INFO - 'XPC_FLAGS': '0x0', 17:41:59 INFO - 'XPC_SERVICE_NAME': '0', 17:41:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:41:59 INFO - Cleaning up... 17:41:59 INFO - Return code: 0 17:41:59 INFO - Running post-action listener: _resource_record_post_action 17:41:59 INFO - Running post-action listener: _start_resource_monitoring 17:41:59 INFO - Starting resource monitoring. 17:41:59 INFO - [mozharness: 2016-09-01 00:41:59.797902Z] Finished create-virtualenv step (success) 17:41:59 INFO - [mozharness: 2016-09-01 00:41:59.798883Z] Running install step. 17:41:59 INFO - Running pre-action listener: _resource_record_pre_action 17:41:59 INFO - Running main action method: install 17:41:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:00 INFO - Reading from file tmpfile_stdout 17:42:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:00 INFO - Reading from file tmpfile_stdout 17:42:00 INFO - Output received: 17:42:00 INFO - Usage: mozinstall [options] installer 17:42:00 INFO - Options: 17:42:00 INFO - -h, --help show this help message and exit 17:42:00 INFO - -d DEST, --destination=DEST 17:42:00 INFO - Directory to install application into. [default: 17:42:00 INFO - "/builds/slave/test"] 17:42:00 INFO - --app=APP Application being installed. [default: firefox] 17:42:00 INFO - mkdir: /builds/slave/test/build/application 17:42:00 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'] 17:42:00 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 17:42:34 INFO - Reading from file tmpfile_stdout 17:42:34 INFO - Output received: 17:42:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:42:34 INFO - Running post-action listener: _resource_record_post_action 17:42:34 INFO - [mozharness: 2016-09-01 00:42:34.323287Z] Finished install step (success) 17:42:34 INFO - [mozharness: 2016-09-01 00:42:34.323379Z] Running run-tests step. 17:42:34 INFO - Running pre-action listener: _resource_record_pre_action 17:42:34 INFO - Running main action method: run_tests 17:42:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:42:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:42:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:42:34 INFO - 2016-08-31 17:42:34.335 screenresolution[1640:7474] starting screenresolution argv=screenresolution get 17:42:34 INFO - 2016-08-31 17:42:34.338 screenresolution[1640:7474] Display 0: 1600x1200x32@60 17:42:34 INFO - 2016-08-31 17:42:34.343 screenresolution[1641:7476] starting screenresolution argv=screenresolution list 17:42:34 INFO - Available Modes on Display 0 17:42:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:42:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:42:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:42:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:42:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:42:34 INFO - Intel Iris: 17:42:34 INFO - Chipset Model: Intel Iris 17:42:34 INFO - Type: GPU 17:42:34 INFO - Bus: Built-In 17:42:34 INFO - VRAM (Dynamic, Max): 1536 MB 17:42:34 INFO - Vendor: Intel (0x8086) 17:42:34 INFO - Device ID: 0x0a2e 17:42:34 INFO - Revision ID: 0x0009 17:42:34 INFO - Displays: 17:42:34 INFO - Display: 17:42:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:42:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:42:34 INFO - Display Serial Number: 1600x1200 60 17:42:34 INFO - Main Display: Yes 17:42:34 INFO - Mirror: Off 17:42:34 INFO - Online: Yes 17:42:34 INFO - Rotation: Supported 17:42:34 INFO - Return code: 0 17:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:34 INFO - Python 2.7.3 17:42:34 INFO - Return code: 0 17:42:34 INFO - grabbing minidump binary from tooltool 17:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:34 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 0x10bb79d30>, '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 0x10b8dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb71b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:34 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 17:42:34 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 17:42:34 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 17:42:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:34 INFO - Return code: 0 17:42:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:42:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:42:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:34 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/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 17:42:34 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/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0346 --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 17:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AvSscmefOa/Render', 17:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:34 INFO - 'HOME': '/Users/cltbld', 17:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:34 INFO - 'LOGNAME': 'cltbld', 17:42:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:34 INFO - 'MOZ_NO_REMOTE': '1', 17:42:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:34 INFO - 'NO_EM_RESTART': '1', 17:42:34 INFO - 'PAGER': '/bin/cat', 17:42:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:34 INFO - 'PWD': '/builds/slave/test', 17:42:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:34 INFO - 'SHELL': '/bin/bash', 17:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xiv5WQIjdJ/Listeners', 17:42:34 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:34 INFO - 'USER': 'cltbld', 17:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:34 INFO - 'XPC_FLAGS': '0x0', 17:42:34 INFO - 'XPC_SERVICE_NAME': '0', 17:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:34 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/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 17:42:34 INFO - mozversion application_buildid: 20160831142219 17:42:34 INFO - mozversion application_changeset: 215b219482a545aea1118d436eb77334bbb4be21 17:42:34 INFO - mozversion application_display_name: Nightly 17:42:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:34 INFO - mozversion application_name: Firefox 17:42:34 INFO - mozversion application_remotingname: firefox 17:42:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:42:34 INFO - mozversion application_vendor: Mozilla 17:42:34 INFO - mozversion application_version: 51.0a1 17:42:34 INFO - mozversion platform_buildid: 20160831142219 17:42:34 INFO - mozversion platform_changeset: 215b219482a545aea1118d436eb77334bbb4be21 17:42:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:42:34 INFO - mozversion platform_version: 51.0a1 17:42:34 INFO - using testdate: 1472690554 17:42:34 INFO - actual date: 1472690554 17:42:34 INFO - starting webserver on 'localhost:49267' 17:42:34 INFO - SUITE-START | Running 2 tests 17:42:34 INFO - TEST-START | dromaeo_css 17:42:34 INFO - operating with platform_type : mac_ 17:42:34 INFO - Initialising browser for dromaeo_css test... 17:42:34 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpn9mIs7/profile http://localhost:49267/getInfo.html) 17:42:37 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 17:42:37 INFO - PROCESS | 1651 | colorDepth:24 17:42:37 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 17:42:37 INFO - PROCESS | 1651 | __metrics 17:42:38 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 17:42:38 INFO - TEST-INFO | 1651: exit 0 17:42:38 INFO - Browser initialized. 17:42:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:38 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpn9mIs7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:50 INFO - PROCESS | 1654 | RSS: Main: 245194752 17:42:50 INFO - PROCESS | 1654 | 17:43:40 INFO - PROCESS | 1654 | 1472690620327 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] 17:45:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 17:45:53 INFO - PROCESS | 1654 | RSS: Main: 262868992 17:45:53 INFO - PROCESS | 1654 | 17:48:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 17:48:56 INFO - PROCESS | 1654 | RSS: Main: 268840960 17:48:56 INFO - PROCESS | 1654 | 17:51:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 17:51:59 INFO - PROCESS | 1654 | RSS: Main: 273641472 17:51:59 INFO - PROCESS | 1654 | 17:55:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 17:55:01 INFO - PROCESS | 1654 | RSS: Main: 269881344 17:55:01 INFO - PROCESS | 1654 | 17:58:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 17:58:05 INFO - PROCESS | 1654 | RSS: Main: 276660224 17:58:05 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 18:01:08 INFO - PROCESS | 1654 | RSS: Main: 279433216 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | __start_tp_report 18:01:08 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 18:01:08 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 18:01:08 INFO - PROCESS | 1654 | |i|pagename|runs| 18:01:08 INFO - PROCESS | 1654 | |0;dojo.html;2975.390045040767;3392.118049307181;3409.863605455782;3442.845071971761;3450.706689931356;5663.518600918922;5680.431956804317;5681.630694004892;5742.511886489643;5756.942430575693;5508.944910550903;5654.547636189105;5704.458076482738;5772.163036359725;5780.1907732917425;4599.931001034987;5125.1287281162195;5159.380874295071;5229.267902493654;5278.234655974881;4003.898927794851;4262.232798096342;4596.724196548201;5174.8706282343055;5446.128619420893;5077.162268225738;5152;5198.376194856603;5238.266642670029;5268.631195816294;4284.357346398034;5158.767855446514;5210.687358758487;5218.660787048868;5220.895582088375;4183.832646694129;5111.821086262;5156.355455568054;5169.612279079084;5183.585313174937;4481.551844815525;5523.867607140526;5629.127485239754;5676.176954341598;5734.4265573442735;6182.227221597301;6216.751329946796;6234.812955611339;6240.656763878031;6242.96878515609;6251.718672659741;6268;6268.905966410507;6283.96858015707;6286.402791734778;5589.860253493654;5775.797847075332;5780.075187969905;5822.359540450547;5849.970750146264;6231.127642130105;6258.593191442542;6271.6550589718;6289.905651415233;6293.244810622755;6055.848603784941;6160.10678451622;6168.444839964335;6172.475339596095;6178.62928224308;6095.908561371583;6151.323354431009;6171.012637977902;6189.133521307021;6267.592606480564;5988.700564971734;6099.915141108964;6116.944513560587;6171.9199140150295;6176.629402235881;6216.44052035319;6250.749970001149;6259.530535209878;6268.874622507525;6280.120783090371;4842.225243960949;4979.228219625964;4984.975075124601;4985.800567977313;4993.1262029144755;4432.756198409054;4434.800433980478;4442.511323754385;4461.977690111594;4471.731696098244;5690.715464226772;5750.396208398141;5754.136879468029;5758.222639943638;5766.682832444172;6116.449519543174;6243.907316219644;6251.9687401563615;6284.874302513924;6300.432961033529;5706.629069110494;5776.913346299809;5777.913331300034;5794.478496935296;5796.072628379523;5428.158635411518;5428.701421421781;5445.646033007842;5461.098918678374;5477.096279113902;6188.288346840171;6307.085472606446;6313.526485513605;6314.810555683245;6319.8104056878365;6158.291796443466;6172.567920245539;6204.472619827366;6267.874642507216;6269.68651567429;6228.844278893064;6265.216847894013;6268.2478102626155;6282.717277722422;6289.748410063729;5769.394213607511;6096.573239873166;6173.104899789595;6188.783392581238;6194.5973511721595;6171.47542458896;6219.968900155471;6226.688665566613;6266.905996410149;6276;5609;5755.8561035974435;6139.2325959255095;6148.938510615016;6152.261728592597;5889.204957330706;6157.599756015845;6161.168242287234;6161.6919154041225;6162.26052873658;5888.028475301528;5891;6007.759689612367;6017.157597936205;6031.879362412639;6138.447539721446;6144.354842741448;6147;6158.107074474086;6162.106494558354;5762.991476491681;5981.3719559445635;6013.218281623361;6018.36807135262;6033.034714445667 18:01:08 INFO - PROCESS | 1654 | |1;ext.html;481.89886110238115;516.2849453506894;532.169815088462;538.7252501224377;562.3589108416403;32672.346553068925;33375.499367509445;37270.627293727055;39581.2083758325;39743.60256397435;32899.50650740241;33983.66016339836;39956.00109997251;40945.59054409455;41028.38457423141;9635.18100961419;9838;9842;9842.655507057254;9847;8753.080926502722;9702;9751.317407781458;9767.951160244189;9785.315027948047;9511.3817601856;9824.508774561278;9839.852402213937;9867.25995550333;9982.50087495626;8432.198941100616;9778.853317200248;9796.510174491246;9802.215822734164;9820.950895245549;9676.951615241878;9781.804363912754;9790.51047447632;9809.950950245204;9810.264230182693;38801.80599097015;38932;39010.804945975375;39066.41400378996;39248.60751392507;3003.5044217704053;3310.536524886518;3343.8996830094893;3380.5436266104252;3459.8789042383396;31190;31540.842295788603;31927.201819954455;32439.675603244137;32978;3148.6536480987074;3252.902412927616;3276.8033917965;3286.211309285778;3315.7181639560667;458334;500307;503014.99999999633;509073;510431;51396.74301628468;64792;64818.02772958409;64858.35141648618;64944.35055649383;35217.64782352195;35897;36026.27947441037;37178.62821371806;69068.30931690619;16077.758833617505;16339;16492.587685307724;16532.917335413247;16559.751603725952;12470.5011799527;12581.811272830915;12642.241465511916;12656.050796190322;12669.873301267055;20515.58968820645;20568.79431205669;20682.862442565503;20748.688769668468;20775.58448831045;8756.956215218883;8819.250363719155;8886.4668119913;8890.244329231959;8943.105689431135;890.550272112579;958.8282540046799;988.7033889833021;1004.2769206171545;1015.9288849780445;27582.034628788297;28746.568801467994;29733.702662973094;30216.489175541574;30343.089707308816;1077.4235783855756;1094.9233553651327;1097.4183682648209;1108.2851560743275;1198.161287099034;14794;15320.927535072438;15344.92585519003;15380.077195368314;15697.372105115668;611262.4931878076;647323.5267647263;660721;669251;669489;55565.44434555683;56016.5995850107;56417.71791141018;56597;57378.42621573731;1333.3933060457468;1343.6640839790052;1381.785823197406;1383.5641772841523;1385.681293302546;26464;28885.133445996653;29108;29121.126366209046;29843.552346715252;38433;41285.1742965133;46732.766336168104;48482.5151748478;48495;528520;577555.1122244361;585294;591951.040244796;591992;26283;26501.469970600094;26601;26915.86542067277;27018.86490567613;45883.311750323104;46186.538134618226;46683;46989;47305.29042064303;35537.75617853363;35667.286654267285;38323.85028449151;38447.502736966024;39835.2032959345;37309.6269037317;37566;37925.81037094797;38297;38550.80724596359;34200.82899585586;37777.81111094427;37948.81025594854;37971.620283797914;38611.6138838608;32174.678253217167;33370.83314583509;34129;35432.645673543964;35449.82275088711;24842.751572484045;25446.363840903385;25452.618210726483;25498.74501255038;25886.74113258843 18:01:08 INFO - PROCESS | 1654 | |2;jquery.html;337.5594848722417;369.92046709957356;376.43346763121497;382.2145491015961;397.85677156223755;15829.920850395747;20505.48736281592;21141.57716845666;21287.361379158632;21545.922703864784;20525.07637156328;20781.896090519527;21062.368128956117;21223.469413264676;21447.785522144775;5220.373555173384;6040.879182416349;6101.420365065312;6161.383861613847;6161.691915404234;6054.878902421949;6169.413905678954;6181.134641150243;6181.196444462214;6183.907241391383;5574.275344205248;5692.459216374438;6028;6044.063170208625;6052.757889684407;5765.740541675593;6024.668643224642;6025.728842202111;6031.6984150792505;6056.212692349988;5918.733656985446;5994.520438364921;6022.97609406402;6029.397060293979;6043.8791224175275;12053.457594408274;13679.863201368058;21053.631513951543;25423.872880635663;25915.481690366276;2202.9008694608783;2210.491586935014;2229.8550594211324;2321;2373.6439534069855;8443.873341899876;9341.439513629137;9848.90151098487;10135.138513226384;10286.588536458532;1922.3464022232367;1987.49318923675;1996.5008747813047;2044.7341845560131;2112.9366119016454;93026.53486732591;116173.4191329038;123336;126284;127817.36091319576;10784.40685762275;11209.94395028036;11453.198276120758;11491;11575.826362604568;14439.927800361142;14443.85556144425;14460.493882714054;14465.468543004932;14475.638109047359;7709.884351734729;7917.614417476919;8191.508509489449;8514.585307057761;8678.913210867937;7167.247439018932;8450.450720703135;8455.450395724258;8458.238758511641;8497.320214382835;4468.687191896536;4525.140223357552;4565.20108980927;4596.540345965377;4668.089722504147;1663.96672066558;1888.0654076232354;1945.7081437784163;1964.666006778851;1964.9410517684491;832.2676045080291;844.2190973349627;849.7875531117221;901.256463417683;986.541258314887;17835.910820446075;19982.800171998384;21316.147354105662;21367.824769637507;21491.89254053751;861;899.9190072893471;909.8225845959975;914.4415090772494;946.9621215151317;9375.765605859908;11402.258853174517;11425.257358271852;11433.828492572618;11490.368029758443;569910;579415.1029244827;583402;605435;606015;112765.4361728186;119841;127029.85097011786;134398;137212.31393842967;961.3078583419926;965.6185806606351;1007.3905287301077;1010.8989101089833;1014.0721240065258;16712.582185445463;19383.224671013566;19751.604967900275;19839.50401239923;19878.801211987695;33857.15357116092;39787.80106099451;52305.91296804992;55878.16182757343;57149;48743;56462;73708;77399;85036;7728.729494467667;7909.24862138096;7919.524828510308;8238.958805205935;8285.917140828515;9070.501122438329;12056.75886482283;12621.305828179538;13144.868551314365;13204;9167.266618670623;9348.906510934803;10872.782544348911;10900.182486313399;11179.888201117885;10776.67669969902;10854.945725271324;10952.945235273774;11054.613088542184;11264.493097810782;11376.374299413612;11625.825612615648;11645.59240426581;11719.003884669899;11771.764564708486;6892.862142757217;7318.487705860539;7800.946872172184;8012.238837310446;8283.461574997606;10095.242856785624;11129.276597021168;11395.373254470753;11567.363794991355;11619.244749091282 18:01:08 INFO - PROCESS | 1654 | |3;mootools.html;1253.6113804720535;1476.4168153579333;1644.1696943043762;1829.8261665141806;1880.1539307311705;7965.362770978322;8482.703105391312;8660.393772435917;9039.231665308449;9092.045335239796;8666.306695464364;8846.20384165425;8858.202761751441;8881.245094167003;8889.95555022224;2384.3919800450863;2388.3790214544215;2418.8669623170717;2419.8064154867657;2432.136591510015;2363.1728894886824;2365.077619728307;2396.5087157132834;2402.7957623602015;2409.638554216864;1972.7040943858392;2370.8221883358733;2395.3053614451787;2397.5444665513583;2406.254061241012;2334.9533009339716;2339.6958395408574;2351.6354964980455;2354.376090336071;2377.738448770634;2349.953000939972;2366.0181024874655;2367.7277113132036;2376.322748016807;2376.7266764322153;7560.168381478033;8739.30085593151;8878.511681857495;8907.821843563157;8915.465072095694;5240.816571419982;5366.758495867695;5391.81128660499;5393.1370980643305;5398.2982212312545;3071.9692803071907;3580.1944562473495;3581.4806853006166;3648.562172539312;3649.7810131392202;1089.536946797608;1095.2333366643381;1108.6286094158468;1120.7758448310371;1126.4142645824124;10709.196810239186;11634.952854243158;11709.180357374902;11728.53085876564;11756.353400563052;4584.88537786558;4682.859514214579;4822.517748225149;4876.097921884392;4883.169861123618;10018.499075046218;10023.997600239918;10030.548625311878;10034.24743144267;10301.690949271533;5306.275460475361;5341.359036915517;5343.759530821122;5349.545288650431;5354.785808567692;4073.6556936210977;4349.543297953733;4792.209285467929;4918.55732984026;4941.555260026615;3141.607299087614;3431.433813420758;3602.603713591503;4050.1292222171787;4153.605407486284;1289.81337169804;1300.6683295759522;1300.876416740408;1304.934753262333;1308.2216081431534;740.5815714121612;822.8315791575976;897.6140259688266;904.2946501728662;924.2836801478908;5122.641415100981;5743.971280143656;5777.364489906107;5887.4406931341455;6032;941.5480569326761;980.3725615606018;984.3503287829998;993.8111758765956;1041.3023274406166;3296.862582409065;3443.810590417551;3637.1452708613456;3898.571157172709;3898.9220215596097;10597.576096956189;10955;10982.505787239594;10996.835047474295;11026.889731102747;10227.846582301272;10927.016568508872;10943.562257509611;10944.17918656104;11032.227744058;7887.290143886963;8167.918320816834;8182.631781569844;8205.58972051407;8216.835663286702;4922.237053256751;5742.885142297047;5809.331926828299;5827.621204621686;6127.264728232641;9950.701478955643;9990.700278991351;10160.034796694303;10195.133413659922;10201.132903703268;9734.809667824682;10065.446400448045;10198.796024079329;10270.691879243635;10335.94832025835;6943.791686249218;7315.48791584584;7406.07424071991;7513.962430187814;7581.848363032819;8379.539125348165;8455;8457.873131902903;8475.110113438;8486.830263394573;7369.8157546061775;7498.212687667717;7520.736774212876;7595;7624.123225828879;7352.5220860643885;7385.9630701846145;7392.112946446461;7544.585047822423;7565.924340756742;6845.486588505982;6943.930560694328;6978.68595913175;6997.335253150943;6998.195207551197;4878.0000099980125;4929.088118698052;4968.925466117938;5021;5080.593552515716;4435.512093669629;4809.975950120227;4862.978774457403;4971.279164521196;5061.848144555669 18:01:08 INFO - PROCESS | 1654 | |4;prototype.html;261.8271940519257;301.3957016182554;308.49406972565;313.1919647309941;314.2724592568203;5253.317068781058;5370.946290537094;5453.863653408666;5625.943740562593;5704;4839.298301746245;4971.980743947491;5336;5490.890182196354;5492.862678433041;3561.3589553880292;4255.5956534343595;4266.360045993102;4285.164392943378;4322.551945098396;3683.4843121962945;3968.6825053995753;4272.444582204324;4322;4339.002029533193;3483.9477407838904;3487;4095.8361665533344;4200.558941311164;4223.85955791936;4214.599613036757;4224.514180869209;4244.427002354689;4281.7002809803325;4291.828326866953;3104.9287995641694;3400.928707457143;3597.9100522486888;3716.2567486502808;3738.981305093457;4950.846381823882;5029.5221953914315;5190.532852043334;5290.55030322423;5347.491988261109;4830.830920917786;4857.611391088704;4859.951400485986;4875.7074575525585;4895.9510404895855;5118.159421521054;5133;5747.3677895431465;5847.970760146214;5900.2563807829565;3424.698614526464;3616.6383361663884;3981.601839816024;4004.2391945530258;4017.2367250222364;5786.218860453827;6036.275646922353;6109.541784366146;6157.261128664589;6158.692065396713;3442.431998720183;3656.1590834108306;3761.360568703327;4100.282450571198;4104.179164167179;3479.6694314040124;3596.8561257549404;3629.8928826708106;3944.8422063117728;4110.136871257069;4741.57325840676;4767.809287628525;4785.3300537924715;4815.398075240595;4834.347363106006;5869.300121943954;5871.207387002785;5894.646321220741;5912.793052243151;5960.423745752601;1244.6826059354808;1333.4799428223;1343.079990206692;1358.8844948179317;1389.6317475868902;933.6172169410645;946.3659348236698;970.7427531704104;971.9260217459747;973.0755782007121;4337.7180483268485;4428.955710442919;5404.513593776579;5404.6219663348;5437.864053398617;5478.123500239943;5525.640833345819;5611.80358687444;5945.346011938684;5971.880562388728;4763.499832517605;4898.779554920037;5189.465772720693;5401.540869026177;5427.864303392368;2442.2659911462706;2469.802415806731;2524.523153954957;2578.303857958378;2601.843889366644;4630.513796051433;5096.489606698099;5103.87240318995;5166.276721259027;5188.005235968283;4059.715819892579;4632.490426053131;4665.883352916204;4859.2954021666665;4952.826651067196;4032.2741906457118;4762.833300834454;5091.770870310845;5112.3865136183895;5171.456997015334;5002.549770520671;5005.424376196784;5010.69935803853;5048.318477005704;5058.2918391425965;4236.428082208862;4326.091520780671;4486.5962063414445;4955.529224723646;4970.826021089245;4851.937926381344;4899.975500122477;4977.601791856715;5160.638755287094;5165.354330708661;3558.0037589474987;3594.4608308753895;3610.891673249807;3611.2416392557857;3614.289283037722;4436.778161091868;4679.836205732783;5046.798128074836;5047.722375269395;5051.797928082982;3916.686665066845;4582.954170458386;4682.361173589353;4761.595264402565;4783.425988881357;4074.8166332515702;4360.86617479464;4600.516945720651;4838.346823178967;4884.584810291023;4304.794657495906;4451.643868490578;4604.5165257648805;4774.1883879739835;4791.904161916812;4819.674589487919;4834.951650483591;4910.386201724785;4931.50684931504;4933.531314525115;4114.835406583703;4279.2083464559155;4774.30772537987;4787.768256426828;4811.687240329367 18:01:08 INFO - PROCESS | 1654 | |5;yui.html;703.679825679316;718.4575645387731;771.2056581720826;782.772995831209;811.9715809946651;15547.844521554782;16246.83753162468;16251.674966500692;16261.186940652964;16327.83672163278;14762.11427314362;14810.25948702566;14893.553193404188;14899.702005959902;14942.775858362133;528.6669398279098;830.0827585518006;833.7582101190662;858.4162769316862;861.6036623153357;845.8477474054667;855.4653341661461;861.5218553702692;862.0474375814729;868.2186032570673;896.3098414221046;915.9358844880861;917.7522069041355;921.2537844346101;923.8475651517491;911.3574929674563;912.6030176873081;913.634546181526;914.236612428623;914.4239129348501;667.9966600166968;676.89169732843;678;678.2471456683078;679.9796006119775;14729.747971422335;14789.704205915928;14792.40830366784;14807.111573305636;14816;14434.278286085653;14453.277336133257;14483.275836208253;14492.565223043326;14599.70800583993;10782.353058816418;10984;11844.644660660195;12130.818037729441;12237.265764054186;3791.222799326159;3920.627540383659;3954.347532657137;4004.4794176757127;4019.738716983387;120177.79377721738;124229.9999999991;124386;124738.50522989489;125132.99999999908;10835.83746243807;10963.56145754177;11063.059639930696;11199.272047316897;11466.713332166762;22643.43391415195;22740;22751.658725119138;22752.08991640349;22856.771432285797;8027.598620068973;8059.919400806034;8096.878546821802;8163.469374490758;8256;4313.158934007838;4397.494288156839;4490.326451032372;4510.0528888933695;4605.148047611203;3057.556654285116;3065.816051036945;3080.2145452909363;3581.8925432237074;3600.4059330210744;558.7429782300187;569.9316082070178;632.4718859752066;649.655682488282;664.5315052887703;577.4023885278716;589.2045738253323;603.0510802177356;610.1488423648984;622.6233128957007;8894.021657617657;8902.24330931865;8927.642894284285;9032.45805251687;9204.815903682023;555.3141869790805;606.2179788073336;614.7018695932469;618.5979113576211;629.5939119268046;3702.7037836972977;4091.6112969267874;4381.948332400265;4386.539413361615;4504.009117994036;103461;161810;164808;170454;179339;139431;142542;143313.28343358217;144345.5565444353;146246.2687686555;121006;122273;122558;124115.13827292598;127233.3638331821;8354.45696029756;8527.829443410972;8539.74380768578;8541.231289184003;8868.379213454997;64944.67527662331;67216;68385;68596.62806743936;69188;102582.97417025734;104054;104519;104849;104877;11001.559937602406;11135.10919126484;11156.944215279196;11254.987051165434;11374.715632109264;12041.518339266331;12138.575149869712;12198.32909190003;12253.571125010938;12258.387080646111;11731.941340293244;11801;11908.40457977115;12198.634040978784;12200.084993625336;10153.593856245667;11271.703754068387;11607.709807254887;12005.099617528895;12236.755264894475;11436.599719009795;11465.942670286595;11541.82687259675;11830.17188796776;11965.581204657796;9641.710748677551;9686.70939871805;9751.976042515435;9857.457839818591;10053.944335844924;7547.924520754942;8577.785555361166;9784.655857938827;9812.411255324703;9927.801443971224 18:01:08 INFO - PROCESS | 1654 | __end_tp_report 18:01:08 INFO - PROCESS | 1654 | __start_cc_report 18:01:08 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,379 18:01:08 INFO - PROCESS | 1654 | __end_cc_report 18:01:08 INFO - PROCESS | 1654 | __startTimestamp1472691668405__endTimestamp 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | ------- Summary: start ------- 18:01:08 INFO - PROCESS | 1654 | Number of tests: 6 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5700.94 Median:5981.37 stddev:690.74 (11.5%) stddev-sans-first:658.94 18:01:08 INFO - PROCESS | 1654 | Values: 2975.4 3392.1 3409.9 3442.8 3450.7 5663.5 5680.4 5681.6 5742.5 5756.9 5508.9 5654.5 5704.5 5772.2 5780.2 4599.9 5125.1 5159.4 5229.3 5278.2 4003.9 4262.2 4596.7 5174.9 5446.1 5077.2 5152.0 5198.4 5238.3 5268.6 4284.4 5158.8 5210.7 5218.7 5220.9 4183.8 5111.8 5156.4 5169.6 5183.6 4481.6 5523.9 5629.1 5676.2 5734.4 6182.2 6216.8 6234.8 6240.7 6243.0 6251.7 6268.0 6268.9 6284.0 6286.4 5589.9 5775.8 5780.1 5822.4 5850.0 6231.1 6258.6 6271.7 6289.9 6293.2 6055.8 6160.1 6168.4 6172.5 6178.6 6095.9 6151.3 6171.0 6189.1 6267.6 5988.7 6099.9 6116.9 6171.9 6176.6 6216.4 6250.7 6259.5 6268.9 6280.1 4842.2 4979.2 4985.0 4985.8 4993.1 4432.8 4434.8 4442.5 4462.0 4471.7 5690.7 5750.4 5754.1 5758.2 5766.7 6116.4 6243.9 6252.0 6284.9 6300.4 5706.6 5776.9 5777.9 5794.5 5796.1 5428.2 5428.7 5445.6 5461.1 5477.1 6188.3 6307.1 6313.5 6314.8 6319.8 6158.3 6172.6 6204.5 6267.9 6269.7 6228.8 6265.2 6268.2 6282.7 6289.7 5769.4 6096.6 6173.1 6188.8 6194.6 6171.5 6220.0 6226.7 6266.9 6276.0 5609.0 5755.9 6139.2 6148.9 6152.3 5889.2 6157.6 6161.2 6161.7 6162.3 5888.0 5891.0 6007.8 6017.2 6031.9 6138.4 6144.4 6147.0 6158.1 6162.1 5763.0 5981.4 6013.2 6018.4 6033.0 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:69738.27 Median:38310.43 stddev:154682.30 (403.8%) stddev-sans-first:155028.83 18:01:08 INFO - PROCESS | 1654 | Values: 481.9 516.3 532.2 538.7 562.4 32672.3 33375.5 37270.6 39581.2 39743.6 32899.5 33983.7 39956.0 40945.6 41028.4 9635.2 9838.0 9842.0 9842.7 9847.0 8753.1 9702.0 9751.3 9768.0 9785.3 9511.4 9824.5 9839.9 9867.3 9982.5 8432.2 9778.9 9796.5 9802.2 9821.0 9677.0 9781.8 9790.5 9810.0 9810.3 38801.8 38932.0 39010.8 39066.4 39248.6 3003.5 3310.5 3343.9 3380.5 3459.9 31190.0 31540.8 31927.2 32439.7 32978.0 3148.7 3252.9 3276.8 3286.2 3315.7 458334.0 500307.0 503015.0 509073.0 510431.0 51396.7 64792.0 64818.0 64858.4 64944.4 35217.6 35897.0 36026.3 37178.6 69068.3 16077.8 16339.0 16492.6 16532.9 16559.8 12470.5 12581.8 12642.2 12656.1 12669.9 20515.6 20568.8 20682.9 20748.7 20775.6 8757.0 8819.3 8886.5 8890.2 8943.1 890.6 958.8 988.7 1004.3 1015.9 27582.0 28746.6 29733.7 30216.5 30343.1 1077.4 1094.9 1097.4 1108.3 1198.2 14794.0 15320.9 15344.9 15380.1 15697.4 611262.5 647323.5 660721.0 669251.0 669489.0 55565.4 56016.6 56417.7 56597.0 57378.4 1333.4 1343.7 1381.8 1383.6 1385.7 26464.0 28885.1 29108.0 29121.1 29843.6 38433.0 41285.2 46732.8 48482.5 48495.0 528520.0 577555.1 585294.0 591951.0 591992.0 26283.0 26501.5 26601.0 26915.9 27018.9 45883.3 46186.5 46683.0 46989.0 47305.3 35537.8 35667.3 38323.9 38447.5 39835.2 37309.6 37566.0 37925.8 38297.0 38550.8 34200.8 37777.8 37948.8 37971.6 38611.6 32174.7 33370.8 34129.0 35432.6 35449.8 24842.8 25446.4 25452.6 25498.7 25886.7 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:34085.77 Median:17097.36 stddev:98307.97 (575.0%) stddev-sans-first:98551.09 18:01:08 INFO - PROCESS | 1654 | Values: 337.6 369.9 376.4 382.2 397.9 15829.9 20505.5 21141.6 21287.4 21545.9 20525.1 20781.9 21062.4 21223.5 21447.8 5220.4 6040.9 6101.4 6161.4 6161.7 6054.9 6169.4 6181.1 6181.2 6183.9 5574.3 5692.5 6028.0 6044.1 6052.8 5765.7 6024.7 6025.7 6031.7 6056.2 5918.7 5994.5 6023.0 6029.4 6043.9 12053.5 13679.9 21053.6 25423.9 25915.5 2202.9 2210.5 2229.9 2321.0 2373.6 8443.9 9341.4 9848.9 10135.1 10286.6 1922.3 1987.5 1996.5 2044.7 2112.9 93026.5 116173.4 123336.0 126284.0 127817.4 10784.4 11209.9 11453.2 11491.0 11575.8 14439.9 14443.9 14460.5 14465.5 14475.6 7709.9 7917.6 8191.5 8514.6 8678.9 7167.2 8450.5 8455.5 8458.2 8497.3 4468.7 4525.1 4565.2 4596.5 4668.1 1664.0 1888.1 1945.7 1964.7 1964.9 832.3 844.2 849.8 901.3 986.5 17835.9 19982.8 21316.1 21367.8 21491.9 861.0 899.9 909.8 914.4 947.0 9375.8 11402.3 11425.3 11433.8 11490.4 569910.0 579415.1 583402.0 605435.0 606015.0 112765.4 119841.0 127029.9 134398.0 137212.3 961.3 965.6 1007.4 1010.9 1014.1 16712.6 19383.2 19751.6 19839.5 19878.8 33857.2 39787.8 52305.9 55878.2 57149.0 48743.0 56462.0 73708.0 77399.0 85036.0 7728.7 7909.2 7919.5 8239.0 8285.9 9070.5 12056.8 12621.3 13144.9 13204.0 9167.3 9348.9 10872.8 10900.2 11179.9 10776.7 10854.9 10952.9 11054.6 11264.5 11376.4 11625.8 11645.6 11719.0 11771.8 6892.9 7318.5 7800.9 8012.2 8283.5 10095.2 11129.3 11395.4 11567.4 11619.2 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5701.91 Median:4842.75 stddev:3227.82 (66.7%) stddev-sans-first:3219.56 18:01:08 INFO - PROCESS | 1654 | Values: 1253.6 1476.4 1644.2 1829.8 1880.2 7965.4 8482.7 8660.4 9039.2 9092.0 8666.3 8846.2 8858.2 8881.2 8890.0 2384.4 2388.4 2418.9 2419.8 2432.1 2363.2 2365.1 2396.5 2402.8 2409.6 1972.7 2370.8 2395.3 2397.5 2406.3 2335.0 2339.7 2351.6 2354.4 2377.7 2350.0 2366.0 2367.7 2376.3 2376.7 7560.2 8739.3 8878.5 8907.8 8915.5 5240.8 5366.8 5391.8 5393.1 5398.3 3072.0 3580.2 3581.5 3648.6 3649.8 1089.5 1095.2 1108.6 1120.8 1126.4 10709.2 11635.0 11709.2 11728.5 11756.4 4584.9 4682.9 4822.5 4876.1 4883.2 10018.5 10024.0 10030.5 10034.2 10301.7 5306.3 5341.4 5343.8 5349.5 5354.8 4073.7 4349.5 4792.2 4918.6 4941.6 3141.6 3431.4 3602.6 4050.1 4153.6 1289.8 1300.7 1300.9 1304.9 1308.2 740.6 822.8 897.6 904.3 924.3 5122.6 5744.0 5777.4 5887.4 6032.0 941.5 980.4 984.4 993.8 1041.3 3296.9 3443.8 3637.1 3898.6 3898.9 10597.6 10955.0 10982.5 10996.8 11026.9 10227.8 10927.0 10943.6 10944.2 11032.2 7887.3 8167.9 8182.6 8205.6 8216.8 4922.2 5742.9 5809.3 5827.6 6127.3 9950.7 9990.7 10160.0 10195.1 10201.1 9734.8 10065.4 10198.8 10270.7 10335.9 6943.8 7315.5 7406.1 7514.0 7581.8 8379.5 8455.0 8457.9 8475.1 8486.8 7369.8 7498.2 7520.7 7595.0 7624.1 7352.5 7386.0 7392.1 7544.6 7565.9 6845.5 6943.9 6978.7 6997.3 6998.2 4878.0 4929.1 4968.9 5021.0 5080.6 4435.5 4810.0 4863.0 4971.3 5061.8 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4332.91 Median:4784.38 stddev:1295.14 (27.1%) stddev-sans-first:1262.22 18:01:08 INFO - PROCESS | 1654 | Values: 261.8 301.4 308.5 313.2 314.3 5253.3 5370.9 5453.9 5625.9 5704.0 4839.3 4972.0 5336.0 5490.9 5492.9 3561.4 4255.6 4266.4 4285.2 4322.6 3683.5 3968.7 4272.4 4322.0 4339.0 3483.9 3487.0 4095.8 4200.6 4223.9 4214.6 4224.5 4244.4 4281.7 4291.8 3104.9 3400.9 3597.9 3716.3 3739.0 4950.8 5029.5 5190.5 5290.6 5347.5 4830.8 4857.6 4860.0 4875.7 4896.0 5118.2 5133.0 5747.4 5848.0 5900.3 3424.7 3616.6 3981.6 4004.2 4017.2 5786.2 6036.3 6109.5 6157.3 6158.7 3442.4 3656.2 3761.4 4100.3 4104.2 3479.7 3596.9 3629.9 3944.8 4110.1 4741.6 4767.8 4785.3 4815.4 4834.3 5869.3 5871.2 5894.6 5912.8 5960.4 1244.7 1333.5 1343.1 1358.9 1389.6 933.6 946.4 970.7 971.9 973.1 4337.7 4429.0 5404.5 5404.6 5437.9 5478.1 5525.6 5611.8 5945.3 5971.9 4763.5 4898.8 5189.5 5401.5 5427.9 2442.3 2469.8 2524.5 2578.3 2601.8 4630.5 5096.5 5103.9 5166.3 5188.0 4059.7 4632.5 4665.9 4859.3 4952.8 4032.3 4762.8 5091.8 5112.4 5171.5 5002.5 5005.4 5010.7 5048.3 5058.3 4236.4 4326.1 4486.6 4955.5 4970.8 4851.9 4900.0 4977.6 5160.6 5165.4 3558.0 3594.5 3610.9 3611.2 3614.3 4436.8 4679.8 5046.8 5047.7 5051.8 3916.7 4583.0 4682.4 4761.6 4783.4 4074.8 4360.9 4600.5 4838.3 4884.6 4304.8 4451.6 4604.5 4774.2 4791.9 4819.7 4835.0 4910.4 4931.5 4933.5 4114.8 4279.2 4774.3 4787.8 4811.7 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:26376.07 Median:3651.55 stddev:44010.06 (1205.2%) stddev-sans-first:44091.31 18:01:08 INFO - PROCESS | 1654 | Values: 703.7 718.5 771.2 782.8 812.0 15547.8 16246.8 16251.7 16261.2 16327.8 14762.1 14810.3 14893.6 14899.7 14942.8 528.7 830.1 833.8 858.4 861.6 845.8 855.5 861.5 862.0 868.2 896.3 915.9 917.8 921.3 923.8 911.4 912.6 913.6 914.2 914.4 668.0 676.9 678.0 678.2 680.0 14729.7 14789.7 14792.4 14807.1 14816.0 14434.3 14453.3 14483.3 14492.6 14599.7 10782.4 10984.0 11844.6 12130.8 12237.3 3791.2 3920.6 3954.3 4004.5 4019.7 120177.8 124230.0 124386.0 124738.5 125133.0 10835.8 10963.6 11063.1 11199.3 11466.7 22643.4 22740.0 22751.7 22752.1 22856.8 8027.6 8059.9 8096.9 8163.5 8256.0 4313.2 4397.5 4490.3 4510.1 4605.1 3057.6 3065.8 3080.2 3581.9 3600.4 558.7 569.9 632.5 649.7 664.5 577.4 589.2 603.1 610.1 622.6 8894.0 8902.2 8927.6 9032.5 9204.8 555.3 606.2 614.7 618.6 629.6 3702.7 4091.6 4381.9 4386.5 4504.0 103461.0 161810.0 164808.0 170454.0 179339.0 139431.0 142542.0 143313.3 144345.6 146246.3 121006.0 122273.0 122558.0 124115.1 127233.4 8354.5 8527.8 8539.7 8541.2 8868.4 64944.7 67216.0 68385.0 68596.6 69188.0 102583.0 104054.0 104519.0 104849.0 104877.0 11001.6 11135.1 11156.9 11255.0 11374.7 12041.5 12138.6 12198.3 12253.6 12258.4 11731.9 11801.0 11908.4 12198.6 12200.1 10153.6 11271.7 11607.7 12005.1 12236.8 11436.6 11465.9 11541.8 11830.2 11965.6 9641.7 9686.7 9752.0 9857.5 10053.9 7547.9 8577.8 9784.7 9812.4 9927.8 18:01:08 INFO - PROCESS | 1654 | -------- Summary: end -------- 18:01:08 INFO - PROCESS | 1654 | 18:01:08 INFO - TEST-INFO | 1654: exit 0 18:01:09 INFO - TEST-OK | dromaeo_css | took 1114092ms 18:01:09 INFO - TEST-START | kraken 18:01:09 INFO - operating with platform_type : mac_ 18:01:09 INFO - Initialising browser for kraken test... 18:01:09 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpGugYU0/profile http://localhost:49267/getInfo.html) 18:01:11 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 18:01:11 INFO - PROCESS | 1665 | colorDepth:24 18:01:11 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 18:01:11 INFO - PROCESS | 1665 | __metrics 18:01:11 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 18:01:12 INFO - TEST-INFO | 1665: exit 0 18:01:12 INFO - Browser initialized. 18:01:12 INFO - Running cycle 1/1 for kraken test... 18:01:12 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpGugYU0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:24 INFO - PROCESS | 1667 | RSS: Main: 244211712 18:01:24 INFO - PROCESS | 1667 | 18:01:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:28 INFO - PROCESS | 1667 | RSS: Main: 257368064 18:01:28 INFO - PROCESS | 1667 | 18:01:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 18:01:31 INFO - PROCESS | 1667 | RSS: Main: 265990144 18:01:31 INFO - PROCESS | 1667 | 18:01:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 18:01:36 INFO - PROCESS | 1667 | RSS: Main: 266874880 18:01:36 INFO - PROCESS | 1667 | 18:01:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 18:01:38 INFO - PROCESS | 1667 | RSS: Main: 268251136 18:01:38 INFO - PROCESS | 1667 | 18:01:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:01:41 INFO - PROCESS | 1667 | RSS: Main: 269889536 18:01:41 INFO - PROCESS | 1667 | 18:01:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 18:01:44 INFO - PROCESS | 1667 | RSS: Main: 270467072 18:01:44 INFO - PROCESS | 1667 | 18:01:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 18:01:48 INFO - PROCESS | 1667 | RSS: Main: 270671872 18:01:48 INFO - PROCESS | 1667 | 18:01:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 18:01:52 INFO - PROCESS | 1667 | RSS: Main: 270766080 18:01:52 INFO - PROCESS | 1667 | 18:01:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:01:54 INFO - PROCESS | 1667 | RSS: Main: 270643200 18:01:54 INFO - PROCESS | 1667 | 18:01:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:01:57 INFO - PROCESS | 1667 | RSS: Main: 270266368 18:01:57 INFO - PROCESS | 1667 | 18:01:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:00 INFO - PROCESS | 1667 | RSS: Main: 270360576 18:02:00 INFO - PROCESS | 1667 | 18:02:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:03 INFO - PROCESS | 1667 | RSS: Main: 270413824 18:02:03 INFO - PROCESS | 1667 | 18:02:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:07 INFO - PROCESS | 1667 | RSS: Main: 270397440 18:02:07 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 18:02:09 INFO - PROCESS | 1667 | RSS: Main: 272457728 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | __start_tp_report 18:02:09 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 18:02:09 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 18:02:09 INFO - PROCESS | 1667 | |i|pagename|runs| 18:02:09 INFO - PROCESS | 1667 | |0;ai-astar;109;161;152;114;114;133;118;121;117;129 18:02:09 INFO - PROCESS | 1667 | |1;audio-beat-detection;148;128;124;191;136;163;132;112;158;97 18:02:09 INFO - PROCESS | 1667 | |2;audio-dft;198;214;218;206;223;204;195;199;192;222 18:02:09 INFO - PROCESS | 1667 | |3;audio-fft;75;83;78;141;58;73;78;71;130;59 18:02:09 INFO - PROCESS | 1667 | |4;audio-oscillator;69;70;117;72;71;92;111;70;73;113 18:02:09 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;91;95;90;110;107;115;131;123;110;127 18:02:09 INFO - PROCESS | 1667 | |6;imaging-darkroom;100;113;100;99;100;100;124;167;108;101 18:02:09 INFO - PROCESS | 1667 | |7;imaging-desaturate;147;81;145;147;119;90;132;147;90;91 18:02:09 INFO - PROCESS | 1667 | |8;json-parse-financial;56;61;58;60;62;62;72;49;78;84 18:02:09 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;82;71;62;70;96;79;79;71;72;80 18:02:09 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;88;88;89;89;92;89;87;89;85;90 18:02:09 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;147;154;141;144;153;160;154;142;181;155 18:02:09 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;174;178;178;227;171;174;170;178;202;175 18:02:09 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;69;71;69;70;71;68;68;81;83 18:02:09 INFO - PROCESS | 1667 | __end_tp_report 18:02:09 INFO - PROCESS | 1667 | __start_cc_report 18:02:09 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,962 18:02:09 INFO - PROCESS | 1667 | __end_cc_report 18:02:09 INFO - PROCESS | 1667 | __startTimestamp1472691729500__endTimestamp 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | ------- Summary: start ------- 18:02:09 INFO - PROCESS | 1667 | Number of tests: 14 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:126.80 Median:125.00 stddev:17.32 (13.9%) stddev-sans-first:17.13 18:02:09 INFO - PROCESS | 1667 | Values: 109.0 161.0 152.0 114.0 114.0 133.0 118.0 121.0 117.0 129.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:153.00 stddev:27.12 (17.7%) stddev-sans-first:28.56 18:02:09 INFO - PROCESS | 1667 | Values: 148.0 128.0 124.0 191.0 136.0 163.0 132.0 112.0 158.0 97.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:207.10 Median:210.00 stddev:11.43 (5.4%) stddev-sans-first:11.63 18:02:09 INFO - PROCESS | 1667 | Values: 198.0 214.0 218.0 206.0 223.0 204.0 195.0 199.0 192.0 222.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:84.60 Median:74.00 stddev:28.10 (38.0%) stddev-sans-first:29.59 18:02:09 INFO - PROCESS | 1667 | Values: 75.0 83.0 78.0 141.0 58.0 73.0 78.0 71.0 130.0 59.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:70.50 stddev:20.39 (28.9%) stddev-sans-first:20.70 18:02:09 INFO - PROCESS | 1667 | Values: 69.0 70.0 117.0 72.0 71.0 92.0 111.0 70.0 73.0 113.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:129.00 stddev:14.60 (11.3%) stddev-sans-first:13.79 18:02:09 INFO - PROCESS | 1667 | Values: 91.0 95.0 90.0 110.0 107.0 115.0 131.0 123.0 110.0 127.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:110.50 stddev:21.20 (19.2%) stddev-sans-first:22.10 18:02:09 INFO - PROCESS | 1667 | Values: 100.0 113.0 100.0 99.0 100.0 100.0 124.0 167.0 108.0 101.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:118.90 Median:114.00 stddev:28.10 (24.6%) stddev-sans-first:27.91 18:02:09 INFO - PROCESS | 1667 | Values: 147.0 81.0 145.0 147.0 119.0 90.0 132.0 147.0 90.0 91.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:62.00 stddev:10.63 (17.2%) stddev-sans-first:10.86 18:02:09 INFO - PROCESS | 1667 | Values: 56.0 61.0 58.0 60.0 62.0 62.0 72.0 49.0 78.0 84.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:79.00 stddev:9.24 (11.7%) stddev-sans-first:9.55 18:02:09 INFO - PROCESS | 1667 | Values: 82.0 71.0 62.0 70.0 96.0 79.0 79.0 71.0 72.0 80.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:89.00 stddev:1.84 (2.1%) stddev-sans-first:1.94 18:02:09 INFO - PROCESS | 1667 | Values: 88.0 88.0 89.0 89.0 92.0 89.0 87.0 89.0 85.0 90.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:153.10 Median:154.00 stddev:11.65 (7.6%) stddev-sans-first:12.14 18:02:09 INFO - PROCESS | 1667 | Values: 147.0 154.0 141.0 144.0 153.0 160.0 154.0 142.0 181.0 155.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:178.00 stddev:17.98 (10.1%) stddev-sans-first:18.79 18:02:09 INFO - PROCESS | 1667 | Values: 174.0 178.0 178.0 227.0 171.0 174.0 170.0 178.0 202.0 175.0 18:02:09 INFO - PROCESS | 1667 | 18:02:09 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:70.50 stddev:5.51 (7.8%) stddev-sans-first:5.67 18:02:09 INFO - PROCESS | 1667 | Values: 68.0 69.0 71.0 69.0 70.0 71.0 68.0 68.0 81.0 83.0 18:02:09 INFO - PROCESS | 1667 | -------- Summary: end -------- 18:02:09 INFO - PROCESS | 1667 | 18:02:10 INFO - TEST-INFO | 1667: exit 0 18:02:10 INFO - TEST-OK | kraken | took 61311ms 18:02:10 INFO - SUITE-END | took 1175s 18:02:10 INFO - Completed test suite (00:19:35) 18:02:10 INFO - javascript benchmark 18:02:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.196405418857, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.390045040767, 3392.118049307181, 3409.863605455782, 3442.845071971761, 3450.706689931356, 5663.518600918922, 5680.431956804317, 5681.630694004892, 5742.511886489643, 5756.942430575693, 5508.944910550903, 5654.547636189105, 5704.458076482738, 5772.163036359725, 5780.1907732917425, 4599.931001034987, 5125.1287281162195, 5159.380874295071, 5229.267902493654, 5278.234655974881, 4003.898927794851, 4262.232798096342, 4596.724196548201, 5174.8706282343055, 5446.128619420893, 5077.162268225738, 5152.0, 5198.376194856603, 5238.266642670029, 5268.631195816294, 4284.357346398034, 5158.767855446514, 5210.687358758487, 5218.660787048868, 5220.895582088375, 4183.832646694129, 5111.821086262, 5156.355455568054, 5169.612279079084, 5183.585313174937, 4481.551844815525, 5523.867607140526, 5629.127485239754, 5676.176954341598, 5734.4265573442735, 6182.227221597301, 6216.751329946796, 6234.812955611339, 6240.656763878031, 6242.96878515609, 6251.718672659741, 6268.0, 6268.905966410507, 6283.96858015707, 6286.402791734778, 5589.860253493654, 5775.797847075332, 5780.075187969905, 5822.359540450547, 5849.970750146264, 6231.127642130105, 6258.593191442542, 6271.6550589718, 6289.905651415233, 6293.244810622755, 6055.848603784941, 6160.10678451622, 6168.444839964335, 6172.475339596095, 6178.62928224308, 6095.908561371583, 6151.323354431009, 6171.012637977902, 6189.133521307021, 6267.592606480564, 5988.700564971734, 6099.915141108964, 6116.944513560587, 6171.9199140150295, 6176.629402235881, 6216.44052035319, 6250.749970001149, 6259.530535209878, 6268.874622507525, 6280.120783090371, 4842.225243960949, 4979.228219625964, 4984.975075124601, 4985.800567977313, 4993.1262029144755, 4432.756198409054, 4434.800433980478, 4442.511323754385, 4461.977690111594, 4471.731696098244, 5690.715464226772, 5750.396208398141, 5754.136879468029, 5758.222639943638, 5766.682832444172, 6116.449519543174, 6243.907316219644, 6251.9687401563615, 6284.874302513924, 6300.432961033529, 5706.629069110494, 5776.913346299809, 5777.913331300034, 5794.478496935296, 5796.072628379523, 5428.158635411518, 5428.701421421781, 5445.646033007842, 5461.098918678374, 5477.096279113902, 6188.288346840171, 6307.085472606446, 6313.526485513605, 6314.810555683245, 6319.8104056878365, 6158.291796443466, 6172.567920245539, 6204.472619827366, 6267.874642507216, 6269.68651567429, 6228.844278893064, 6265.216847894013, 6268.2478102626155, 6282.717277722422, 6289.748410063729, 5769.394213607511, 6096.573239873166, 6173.104899789595, 6188.783392581238, 6194.5973511721595, 6171.47542458896, 6219.968900155471, 6226.688665566613, 6266.905996410149, 6276.0, 5609.0, 5755.8561035974435, 6139.2325959255095, 6148.938510615016, 6152.261728592597, 5889.204957330706, 6157.599756015845, 6161.168242287234, 6161.6919154041225, 6162.26052873658, 5888.028475301528, 5891.0, 6007.759689612367, 6017.157597936205, 6031.879362412639, 6138.447539721446, 6144.354842741448, 6147.0, 6158.107074474086, 6162.106494558354, 5762.991476491681, 5981.3719559445635, 6013.218281623361, 6018.36807135262, 6033.034714445667], "value": 5655.249588758487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.89886110238115, 516.2849453506894, 532.169815088462, 538.7252501224377, 562.3589108416403, 32672.346553068925, 33375.499367509445, 37270.627293727055, 39581.2083758325, 39743.60256397435, 32899.50650740241, 33983.66016339836, 39956.00109997251, 40945.59054409455, 41028.38457423141, 9635.18100961419, 9838.0, 9842.0, 9842.655507057254, 9847.0, 8753.080926502722, 9702.0, 9751.317407781458, 9767.951160244189, 9785.315027948047, 9511.3817601856, 9824.508774561278, 9839.852402213937, 9867.25995550333, 9982.50087495626, 8432.198941100616, 9778.853317200248, 9796.510174491246, 9802.215822734164, 9820.950895245549, 9676.951615241878, 9781.804363912754, 9790.51047447632, 9809.950950245204, 9810.264230182693, 38801.80599097015, 38932.0, 39010.804945975375, 39066.41400378996, 39248.60751392507, 3003.5044217704053, 3310.536524886518, 3343.8996830094893, 3380.5436266104252, 3459.8789042383396, 31190.0, 31540.842295788603, 31927.201819954455, 32439.675603244137, 32978.0, 3148.6536480987074, 3252.902412927616, 3276.8033917965, 3286.211309285778, 3315.7181639560667, 458334.0, 500307.0, 503014.99999999633, 509073.0, 510431.0, 51396.74301628468, 64792.0, 64818.02772958409, 64858.35141648618, 64944.35055649383, 35217.64782352195, 35897.0, 36026.27947441037, 37178.62821371806, 69068.30931690619, 16077.758833617505, 16339.0, 16492.587685307724, 16532.917335413247, 16559.751603725952, 12470.5011799527, 12581.811272830915, 12642.241465511916, 12656.050796190322, 12669.873301267055, 20515.58968820645, 20568.79431205669, 20682.862442565503, 20748.688769668468, 20775.58448831045, 8756.956215218883, 8819.250363719155, 8886.4668119913, 8890.244329231959, 8943.105689431135, 890.550272112579, 958.8282540046799, 988.7033889833021, 1004.2769206171545, 1015.9288849780445, 27582.034628788297, 28746.568801467994, 29733.702662973094, 30216.489175541574, 30343.089707308816, 1077.4235783855756, 1094.9233553651327, 1097.4183682648209, 1108.2851560743275, 1198.161287099034, 14794.0, 15320.927535072438, 15344.92585519003, 15380.077195368314, 15697.372105115668, 611262.4931878076, 647323.5267647263, 660721.0, 669251.0, 669489.0, 55565.44434555683, 56016.5995850107, 56417.71791141018, 56597.0, 57378.42621573731, 1333.3933060457468, 1343.6640839790052, 1381.785823197406, 1383.5641772841523, 1385.681293302546, 26464.0, 28885.133445996653, 29108.0, 29121.126366209046, 29843.552346715252, 38433.0, 41285.1742965133, 46732.766336168104, 48482.5151748478, 48495.0, 528520.0, 577555.1122244361, 585294.0, 591951.040244796, 591992.0, 26283.0, 26501.469970600094, 26601.0, 26915.86542067277, 27018.86490567613, 45883.311750323104, 46186.538134618226, 46683.0, 46989.0, 47305.29042064303, 35537.75617853363, 35667.286654267285, 38323.85028449151, 38447.502736966024, 39835.2032959345, 37309.6269037317, 37566.0, 37925.81037094797, 38297.0, 38550.80724596359, 34200.82899585586, 37777.81111094427, 37948.81025594854, 37971.620283797914, 38611.6138838608, 32174.678253217167, 33370.83314583509, 34129.0, 35432.645673543964, 35449.82275088711, 24842.751572484045, 25446.363840903385, 25452.618210726483, 25498.74501255038, 25886.74113258843], "value": 19740.472477668067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.5594848722417, 369.92046709957356, 376.43346763121497, 382.2145491015961, 397.85677156223755, 15829.920850395747, 20505.48736281592, 21141.57716845666, 21287.361379158632, 21545.922703864784, 20525.07637156328, 20781.896090519527, 21062.368128956117, 21223.469413264676, 21447.785522144775, 5220.373555173384, 6040.879182416349, 6101.420365065312, 6161.383861613847, 6161.691915404234, 6054.878902421949, 6169.413905678954, 6181.134641150243, 6181.196444462214, 6183.907241391383, 5574.275344205248, 5692.459216374438, 6028.0, 6044.063170208625, 6052.757889684407, 5765.740541675593, 6024.668643224642, 6025.728842202111, 6031.6984150792505, 6056.212692349988, 5918.733656985446, 5994.520438364921, 6022.97609406402, 6029.397060293979, 6043.8791224175275, 12053.457594408274, 13679.863201368058, 21053.631513951543, 25423.872880635663, 25915.481690366276, 2202.9008694608783, 2210.491586935014, 2229.8550594211324, 2321.0, 2373.6439534069855, 8443.873341899876, 9341.439513629137, 9848.90151098487, 10135.138513226384, 10286.588536458532, 1922.3464022232367, 1987.49318923675, 1996.5008747813047, 2044.7341845560131, 2112.9366119016454, 93026.53486732591, 116173.4191329038, 123336.0, 126284.0, 127817.36091319576, 10784.40685762275, 11209.94395028036, 11453.198276120758, 11491.0, 11575.826362604568, 14439.927800361142, 14443.85556144425, 14460.493882714054, 14465.468543004932, 14475.638109047359, 7709.884351734729, 7917.614417476919, 8191.508509489449, 8514.585307057761, 8678.913210867937, 7167.247439018932, 8450.450720703135, 8455.450395724258, 8458.238758511641, 8497.320214382835, 4468.687191896536, 4525.140223357552, 4565.20108980927, 4596.540345965377, 4668.089722504147, 1663.96672066558, 1888.0654076232354, 1945.7081437784163, 1964.666006778851, 1964.9410517684491, 832.2676045080291, 844.2190973349627, 849.7875531117221, 901.256463417683, 986.541258314887, 17835.910820446075, 19982.800171998384, 21316.147354105662, 21367.824769637507, 21491.89254053751, 861.0, 899.9190072893471, 909.8225845959975, 914.4415090772494, 946.9621215151317, 9375.765605859908, 11402.258853174517, 11425.257358271852, 11433.828492572618, 11490.368029758443, 569910.0, 579415.1029244827, 583402.0, 605435.0, 606015.0, 112765.4361728186, 119841.0, 127029.85097011786, 134398.0, 137212.31393842967, 961.3078583419926, 965.6185806606351, 1007.3905287301077, 1010.8989101089833, 1014.0721240065258, 16712.582185445463, 19383.224671013566, 19751.604967900275, 19839.50401239923, 19878.801211987695, 33857.15357116092, 39787.80106099451, 52305.91296804992, 55878.16182757343, 57149.0, 48743.0, 56462.0, 73708.0, 77399.0, 85036.0, 7728.729494467667, 7909.24862138096, 7919.524828510308, 8238.958805205935, 8285.917140828515, 9070.501122438329, 12056.75886482283, 12621.305828179538, 13144.868551314365, 13204.0, 9167.266618670623, 9348.906510934803, 10872.782544348911, 10900.182486313399, 11179.888201117885, 10776.67669969902, 10854.945725271324, 10952.945235273774, 11054.613088542184, 11264.493097810782, 11376.374299413612, 11625.825612615648, 11645.59240426581, 11719.003884669899, 11771.764564708486, 6892.862142757217, 7318.487705860539, 7800.946872172184, 8012.238837310446, 8283.461574997606, 10095.242856785624, 11129.276597021168, 11395.373254470753, 11567.363794991355, 11619.244749091282], "value": 9391.785788042303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.6113804720535, 1476.4168153579333, 1644.1696943043762, 1829.8261665141806, 1880.1539307311705, 7965.362770978322, 8482.703105391312, 8660.393772435917, 9039.231665308449, 9092.045335239796, 8666.306695464364, 8846.20384165425, 8858.202761751441, 8881.245094167003, 8889.95555022224, 2384.3919800450863, 2388.3790214544215, 2418.8669623170717, 2419.8064154867657, 2432.136591510015, 2363.1728894886824, 2365.077619728307, 2396.5087157132834, 2402.7957623602015, 2409.638554216864, 1972.7040943858392, 2370.8221883358733, 2395.3053614451787, 2397.5444665513583, 2406.254061241012, 2334.9533009339716, 2339.6958395408574, 2351.6354964980455, 2354.376090336071, 2377.738448770634, 2349.953000939972, 2366.0181024874655, 2367.7277113132036, 2376.322748016807, 2376.7266764322153, 7560.168381478033, 8739.30085593151, 8878.511681857495, 8907.821843563157, 8915.465072095694, 5240.816571419982, 5366.758495867695, 5391.81128660499, 5393.1370980643305, 5398.2982212312545, 3071.9692803071907, 3580.1944562473495, 3581.4806853006166, 3648.562172539312, 3649.7810131392202, 1089.536946797608, 1095.2333366643381, 1108.6286094158468, 1120.7758448310371, 1126.4142645824124, 10709.196810239186, 11634.952854243158, 11709.180357374902, 11728.53085876564, 11756.353400563052, 4584.88537786558, 4682.859514214579, 4822.517748225149, 4876.097921884392, 4883.169861123618, 10018.499075046218, 10023.997600239918, 10030.548625311878, 10034.24743144267, 10301.690949271533, 5306.275460475361, 5341.359036915517, 5343.759530821122, 5349.545288650431, 5354.785808567692, 4073.6556936210977, 4349.543297953733, 4792.209285467929, 4918.55732984026, 4941.555260026615, 3141.607299087614, 3431.433813420758, 3602.603713591503, 4050.1292222171787, 4153.605407486284, 1289.81337169804, 1300.6683295759522, 1300.876416740408, 1304.934753262333, 1308.2216081431534, 740.5815714121612, 822.8315791575976, 897.6140259688266, 904.2946501728662, 924.2836801478908, 5122.641415100981, 5743.971280143656, 5777.364489906107, 5887.4406931341455, 6032.0, 941.5480569326761, 980.3725615606018, 984.3503287829998, 993.8111758765956, 1041.3023274406166, 3296.862582409065, 3443.810590417551, 3637.1452708613456, 3898.571157172709, 3898.9220215596097, 10597.576096956189, 10955.0, 10982.505787239594, 10996.835047474295, 11026.889731102747, 10227.846582301272, 10927.016568508872, 10943.562257509611, 10944.17918656104, 11032.227744058, 7887.290143886963, 8167.918320816834, 8182.631781569844, 8205.58972051407, 8216.835663286702, 4922.237053256751, 5742.885142297047, 5809.331926828299, 5827.621204621686, 6127.264728232641, 9950.701478955643, 9990.700278991351, 10160.034796694303, 10195.133413659922, 10201.132903703268, 9734.809667824682, 10065.446400448045, 10198.796024079329, 10270.691879243635, 10335.94832025835, 6943.791686249218, 7315.48791584584, 7406.07424071991, 7513.962430187814, 7581.848363032819, 8379.539125348165, 8455.0, 8457.873131902903, 8475.110113438, 8486.830263394573, 7369.8157546061775, 7498.212687667717, 7520.736774212876, 7595.0, 7624.123225828879, 7352.5220860643885, 7385.9630701846145, 7392.112946446461, 7544.585047822423, 7565.924340756742, 6845.486588505982, 6943.930560694328, 6978.68595913175, 6997.335253150943, 6998.195207551197, 4878.0000099980125, 4929.088118698052, 4968.925466117938, 5021.0, 5080.593552515716, 4435.512093669629, 4809.975950120227, 4862.978774457403, 4971.279164521196, 5061.848144555669], "value": 4578.266645012048, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.8271940519257, 301.3957016182554, 308.49406972565, 313.1919647309941, 314.2724592568203, 5253.317068781058, 5370.946290537094, 5453.863653408666, 5625.943740562593, 5704.0, 4839.298301746245, 4971.980743947491, 5336.0, 5490.890182196354, 5492.862678433041, 3561.3589553880292, 4255.5956534343595, 4266.360045993102, 4285.164392943378, 4322.551945098396, 3683.4843121962945, 3968.6825053995753, 4272.444582204324, 4322.0, 4339.002029533193, 3483.9477407838904, 3487.0, 4095.8361665533344, 4200.558941311164, 4223.85955791936, 4214.599613036757, 4224.514180869209, 4244.427002354689, 4281.7002809803325, 4291.828326866953, 3104.9287995641694, 3400.928707457143, 3597.9100522486888, 3716.2567486502808, 3738.981305093457, 4950.846381823882, 5029.5221953914315, 5190.532852043334, 5290.55030322423, 5347.491988261109, 4830.830920917786, 4857.611391088704, 4859.951400485986, 4875.7074575525585, 4895.9510404895855, 5118.159421521054, 5133.0, 5747.3677895431465, 5847.970760146214, 5900.2563807829565, 3424.698614526464, 3616.6383361663884, 3981.601839816024, 4004.2391945530258, 4017.2367250222364, 5786.218860453827, 6036.275646922353, 6109.541784366146, 6157.261128664589, 6158.692065396713, 3442.431998720183, 3656.1590834108306, 3761.360568703327, 4100.282450571198, 4104.179164167179, 3479.6694314040124, 3596.8561257549404, 3629.8928826708106, 3944.8422063117728, 4110.136871257069, 4741.57325840676, 4767.809287628525, 4785.3300537924715, 4815.398075240595, 4834.347363106006, 5869.300121943954, 5871.207387002785, 5894.646321220741, 5912.793052243151, 5960.423745752601, 1244.6826059354808, 1333.4799428223, 1343.079990206692, 1358.8844948179317, 1389.6317475868902, 933.6172169410645, 946.3659348236698, 970.7427531704104, 971.9260217459747, 973.0755782007121, 4337.7180483268485, 4428.955710442919, 5404.513593776579, 5404.6219663348, 5437.864053398617, 5478.123500239943, 5525.640833345819, 5611.80358687444, 5945.346011938684, 5971.880562388728, 4763.499832517605, 4898.779554920037, 5189.465772720693, 5401.540869026177, 5427.864303392368, 2442.2659911462706, 2469.802415806731, 2524.523153954957, 2578.303857958378, 2601.843889366644, 4630.513796051433, 5096.489606698099, 5103.87240318995, 5166.276721259027, 5188.005235968283, 4059.715819892579, 4632.490426053131, 4665.883352916204, 4859.2954021666665, 4952.826651067196, 4032.2741906457118, 4762.833300834454, 5091.770870310845, 5112.3865136183895, 5171.456997015334, 5002.549770520671, 5005.424376196784, 5010.69935803853, 5048.318477005704, 5058.2918391425965, 4236.428082208862, 4326.091520780671, 4486.5962063414445, 4955.529224723646, 4970.826021089245, 4851.937926381344, 4899.975500122477, 4977.601791856715, 5160.638755287094, 5165.354330708661, 3558.0037589474987, 3594.4608308753895, 3610.891673249807, 3611.2416392557857, 3614.289283037722, 4436.778161091868, 4679.836205732783, 5046.798128074836, 5047.722375269395, 5051.797928082982, 3916.686665066845, 4582.954170458386, 4682.361173589353, 4761.595264402565, 4783.425988881357, 4074.8166332515702, 4360.86617479464, 4600.516945720651, 4838.346823178967, 4884.584810291023, 4304.794657495906, 4451.643868490578, 4604.5165257648805, 4774.1883879739835, 4791.904161916812, 4819.674589487919, 4834.951650483591, 4910.386201724785, 4931.50684931504, 4933.531314525115, 4114.835406583703, 4279.2083464559155, 4774.30772537987, 4787.768256426828, 4811.687240329367], "value": 3931.1139725786643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.679825679316, 718.4575645387731, 771.2056581720826, 782.772995831209, 811.9715809946651, 15547.844521554782, 16246.83753162468, 16251.674966500692, 16261.186940652964, 16327.83672163278, 14762.11427314362, 14810.25948702566, 14893.553193404188, 14899.702005959902, 14942.775858362133, 528.6669398279098, 830.0827585518006, 833.7582101190662, 858.4162769316862, 861.6036623153357, 845.8477474054667, 855.4653341661461, 861.5218553702692, 862.0474375814729, 868.2186032570673, 896.3098414221046, 915.9358844880861, 917.7522069041355, 921.2537844346101, 923.8475651517491, 911.3574929674563, 912.6030176873081, 913.634546181526, 914.236612428623, 914.4239129348501, 667.9966600166968, 676.89169732843, 678.0, 678.2471456683078, 679.9796006119775, 14729.747971422335, 14789.704205915928, 14792.40830366784, 14807.111573305636, 14816.0, 14434.278286085653, 14453.277336133257, 14483.275836208253, 14492.565223043326, 14599.70800583993, 10782.353058816418, 10984.0, 11844.644660660195, 12130.818037729441, 12237.265764054186, 3791.222799326159, 3920.627540383659, 3954.347532657137, 4004.4794176757127, 4019.738716983387, 120177.79377721738, 124229.9999999991, 124386.0, 124738.50522989489, 125132.99999999908, 10835.83746243807, 10963.56145754177, 11063.059639930696, 11199.272047316897, 11466.713332166762, 22643.43391415195, 22740.0, 22751.658725119138, 22752.08991640349, 22856.771432285797, 8027.598620068973, 8059.919400806034, 8096.878546821802, 8163.469374490758, 8256.0, 4313.158934007838, 4397.494288156839, 4490.326451032372, 4510.0528888933695, 4605.148047611203, 3057.556654285116, 3065.816051036945, 3080.2145452909363, 3581.8925432237074, 3600.4059330210744, 558.7429782300187, 569.9316082070178, 632.4718859752066, 649.655682488282, 664.5315052887703, 577.4023885278716, 589.2045738253323, 603.0510802177356, 610.1488423648984, 622.6233128957007, 8894.021657617657, 8902.24330931865, 8927.642894284285, 9032.45805251687, 9204.815903682023, 555.3141869790805, 606.2179788073336, 614.7018695932469, 618.5979113576211, 629.5939119268046, 3702.7037836972977, 4091.6112969267874, 4381.948332400265, 4386.539413361615, 4504.009117994036, 103461.0, 161810.0, 164808.0, 170454.0, 179339.0, 139431.0, 142542.0, 143313.28343358217, 144345.5565444353, 146246.2687686555, 121006.0, 122273.0, 122558.0, 124115.13827292598, 127233.3638331821, 8354.45696029756, 8527.829443410972, 8539.74380768578, 8541.231289184003, 8868.379213454997, 64944.67527662331, 67216.0, 68385.0, 68596.62806743936, 69188.0, 102582.97417025734, 104054.0, 104519.0, 104849.0, 104877.0, 11001.559937602406, 11135.10919126484, 11156.944215279196, 11254.987051165434, 11374.715632109264, 12041.518339266331, 12138.575149869712, 12198.32909190003, 12253.571125010938, 12258.387080646111, 11731.941340293244, 11801.0, 11908.40457977115, 12198.634040978784, 12200.084993625336, 10153.593856245667, 11271.703754068387, 11607.709807254887, 12005.099617528895, 12236.755264894475, 11436.599719009795, 11465.942670286595, 11541.82687259675, 11830.17188796776, 11965.581204657796, 9641.710748677551, 9686.70939871805, 9751.976042515435, 9857.457839818591, 10053.944335844924, 7547.924520754942, 8577.785555361166, 9784.655857938827, 9812.411255324703, 9927.801443971224], "value": 7664.4216993286645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 161.0, 152.0, 114.0, 114.0, 133.0, 118.0, 121.0, 117.0, 129.0], "value": 126.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 128.0, 124.0, 191.0, 136.0, 163.0, 132.0, 112.0, 158.0, 97.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 214.0, 218.0, 206.0, 223.0, 204.0, 195.0, 199.0, 192.0, 222.0], "value": 207.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 78.0, 141.0, 58.0, 73.0, 78.0, 71.0, 130.0, 59.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 117.0, 72.0, 71.0, 92.0, 111.0, 70.0, 73.0, 113.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 90.0, 110.0, 107.0, 115.0, 131.0, 123.0, 110.0, 127.0], "value": 109.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 100.0, 99.0, 100.0, 100.0, 124.0, 167.0, 108.0, 101.0], "value": 111.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 81.0, 145.0, 147.0, 119.0, 90.0, 132.0, 147.0, 90.0, 91.0], "value": 118.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 58.0, 60.0, 62.0, 62.0, 72.0, 49.0, 78.0, 84.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 62.0, 70.0, 96.0, 79.0, 79.0, 71.0, 72.0, 80.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 89.0, 92.0, 89.0, 87.0, 89.0, 85.0, 90.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 154.0, 141.0, 144.0, 153.0, 160.0, 154.0, 142.0, 181.0, 155.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 178.0, 178.0, 227.0, 171.0, 174.0, 170.0, 178.0, 202.0, 175.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 69.0, 70.0, 71.0, 68.0, 68.0, 81.0, 83.0], "value": 71.8, "unit": "score"}]}]} 18:02:10 INFO - Return code: 0 18:02:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:10 ERROR - # TBPL SUCCESS # 18:02:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:02:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:02:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:02:10 INFO - 2016-08-31 18:02:10.812 screenresolution[1672:10516] starting screenresolution argv=screenresolution get 18:02:10 INFO - 2016-08-31 18:02:10.814 screenresolution[1672:10516] Display 0: 1600x1200x32@60 18:02:10 INFO - 2016-08-31 18:02:10.820 screenresolution[1673:10519] starting screenresolution argv=screenresolution list 18:02:10 INFO - Available Modes on Display 0 18:02:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:02:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:02:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:02:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:02:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:02:11 INFO - Intel Iris: 18:02:11 INFO - Chipset Model: Intel Iris 18:02:11 INFO - Type: GPU 18:02:11 INFO - Bus: Built-In 18:02:11 INFO - VRAM (Dynamic, Max): 1536 MB 18:02:11 INFO - Vendor: Intel (0x8086) 18:02:11 INFO - Device ID: 0x0a2e 18:02:11 INFO - Revision ID: 0x0009 18:02:11 INFO - Displays: 18:02:11 INFO - Display: 18:02:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:02:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:02:11 INFO - Display Serial Number: 1600x1200 60 18:02:11 INFO - Main Display: Yes 18:02:11 INFO - Mirror: Off 18:02:11 INFO - Online: Yes 18:02:11 INFO - Rotation: Supported 18:02:11 INFO - Return code: 0 18:02:11 INFO - Running post-action listener: _resource_record_post_action 18:02:11 INFO - [mozharness: 2016-09-01 01:02:11.057695Z] Finished run-tests step (success) 18:02:11 INFO - Running post-run listener: _resource_record_post_run 18:02:11 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 37213184; Write bytes: 707991040; Read time: 238; Write time: 2048 18:02:11 INFO - TinderboxPrint: CPU usage
54.7% 18:02:11 INFO - TinderboxPrint: I/O read bytes / time
37,213,184 / 238 18:02:11 INFO - TinderboxPrint: I/O write bytes / time
707,991,040 / 2,048 18:02:11 INFO - TinderboxPrint: CPU idle
2,191.7 (45.3%) 18:02:11 INFO - TinderboxPrint: CPU system
978.3 (20.2%) 18:02:11 INFO - TinderboxPrint: CPU user
1,671.6 (34.5%) 18:02:11 INFO - TinderboxPrint: Swap in / out
443,559,936 / 0 18:02:11 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396749312; Write bytes: 391235072; Read time: 29715; Write time: 838 18:02:11 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 35206144; Write bytes: 298065920; Read time: 220; Write time: 1167 18:02:11 INFO - Running post-run listener: _upload_blobber_files 18:02:11 INFO - Blob upload gear active. 18:02:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:11 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 18:02:11 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'] 18:02:11 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 18:02:11 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:02:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:13 INFO - (blobuploader) - INFO - Done attempting. 18:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:14 INFO - (blobuploader) - INFO - Done attempting. 18:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:17 INFO - (blobuploader) - INFO - Done attempting. 18:02:17 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:17 INFO - Return code: 0 18:02:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4510e2a2425532e0af4cc1cd0c769d3374f8cd227f4a144a83d85890e5703e6c978e0d9d4c091fad004fcb88f5e4baf8122ccdda439503da0eba76898c8dc198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1bf06ae997fc10245fb0d9b92f1bee3f0042653b85a5962b385d65c607d5661556c69a60821e99880b1526f4b456e4e247e1ff6dc2db222afe251ee44005a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4dbe91df2843fecca3b2641a75f998095bf1d446af7092746393a6e08c6a96fc67dd22e9d5d8c7404cca7fa36202778608bc9aca93b1856ab35c42f05e1deb4"} 18:02:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:17 INFO - Contents: 18:02:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4510e2a2425532e0af4cc1cd0c769d3374f8cd227f4a144a83d85890e5703e6c978e0d9d4c091fad004fcb88f5e4baf8122ccdda439503da0eba76898c8dc198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1bf06ae997fc10245fb0d9b92f1bee3f0042653b85a5962b385d65c607d5661556c69a60821e99880b1526f4b456e4e247e1ff6dc2db222afe251ee44005a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4dbe91df2843fecca3b2641a75f998095bf1d446af7092746393a6e08c6a96fc67dd22e9d5d8c7404cca7fa36202778608bc9aca93b1856ab35c42f05e1deb4"} 18:02:17 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:17 INFO - Copying logs to upload dir... 18:02:17 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.178379 ========= master_lag: 7.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-31 18:02:25.196040) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 18:02:25.196988) ========= 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.AvSscmefOa/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.xiv5WQIjdJ/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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/4510e2a2425532e0af4cc1cd0c769d3374f8cd227f4a144a83d85890e5703e6c978e0d9d4c091fad004fcb88f5e4baf8122ccdda439503da0eba76898c8dc198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1bf06ae997fc10245fb0d9b92f1bee3f0042653b85a5962b385d65c607d5661556c69a60821e99880b1526f4b456e4e247e1ff6dc2db222afe251ee44005a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4dbe91df2843fecca3b2641a75f998095bf1d446af7092746393a6e08c6a96fc67dd22e9d5d8c7404cca7fa36202778608bc9aca93b1856ab35c42f05e1deb4"} build_url:https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010854 build_url: 'https://queue.taskcluster.net/v1/task/StoTJFtnTYO0ihRskczJMw/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/4510e2a2425532e0af4cc1cd0c769d3374f8cd227f4a144a83d85890e5703e6c978e0d9d4c091fad004fcb88f5e4baf8122ccdda439503da0eba76898c8dc198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1bf06ae997fc10245fb0d9b92f1bee3f0042653b85a5962b385d65c607d5661556c69a60821e99880b1526f4b456e4e247e1ff6dc2db222afe251ee44005a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4dbe91df2843fecca3b2641a75f998095bf1d446af7092746393a6e08c6a96fc67dd22e9d5d8c7404cca7fa36202778608bc9aca93b1856ab35c42f05e1deb4"}' ========= master_lag: 0.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 18:02:25.552394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 18:02:25.552694) ========= 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.AvSscmefOa/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.xiv5WQIjdJ/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.005018 ========= master_lag: 0.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 18:02:25.793118) ========= ========= Started reboot skipped (results: 3, elapsed: 2 mins, 10 secs) (at 2016-08-31 18:02:25.793387) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 mins, 10 secs) (at 2016-08-31 18:04:36.551895) ========= ========= Total master_lag: 8.24 =========