builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0223 starttime: 1470657906.92 results: success (0) buildid: 20160805131321 builduid: 3935528495d04780899dc77e8ecc8206 revision: f54fea6078ddf0023a4307a25264c6ece653e503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:06.920338) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:06.920852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:06.921119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:07.278218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:07.281533) ========= 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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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-08 05:05:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.90M=0.001s 2016-08-08 05:05:07 (7.90 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.468645 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:07.775231) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:07.776167) ========= 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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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.020657 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:07.826331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:05:07.826685) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f54fea6078ddf0023a4307a25264c6ece653e503 --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 f54fea6078ddf0023a4307a25264c6ece653e503 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Jgoj3EBfIY/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.5kurnPEnpf/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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-08 05:05:07,908 truncating revision to first 12 chars 2016-08-08 05:05:07,908 Setting DEBUG logging. 2016-08-08 05:05:07,909 attempt 1/10 2016-08-08 05:05:07,909 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f54fea6078dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:05:08,984 unpacking tar archive at: fx-team-f54fea6078dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.326866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:05:09.176251) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:09.176599) ========= script_repo_revision: f54fea6078ddf0023a4307a25264c6ece653e503 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:09.177023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:09.177326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:09.195076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-08 05:05:09.195426) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05:09 INFO - MultiFileLogger online at 20160808 05:05:09 in /builds/slave/test 05:05:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:05:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:09 INFO - {'append_to_log': False, 05:05:09 INFO - 'base_work_dir': '/builds/slave/test', 05:05:09 INFO - 'blob_upload_branch': 'Fx-Team', 05:05:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:09 INFO - 'branch': 'Fx-Team', 05:05:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:09 INFO - 'config_files': ('talos/mac_config.py',), 05:05:09 INFO - 'default_actions': ('clobber', 05:05:09 INFO - 'read-buildbot-config', 05:05:09 INFO - 'download-and-extract', 05:05:09 INFO - 'populate-webroot', 05:05:09 INFO - 'create-virtualenv', 05:05:09 INFO - 'install', 05:05:09 INFO - 'run-tests'), 05:05:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:09 INFO - 'download_minidump_stackwalk': True, 05:05:09 INFO - 'download_symbols': 'ondemand', 05:05:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:09 INFO - 'installer_path': 'installer.exe', 05:05:09 INFO - 'log_level': 'info', 05:05:09 INFO - 'log_name': 'talos', 05:05:09 INFO - 'log_to_console': True, 05:05:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:05:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:05:09 INFO - 'opt_config_files': (), 05:05:09 INFO - 'pip_index': False, 05:05:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:09 INFO - 'cmd': ('bash', 05:05:09 INFO - '-c', 05:05:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:09 INFO - 'enabled': True, 05:05:09 INFO - 'halt_on_failure': False, 05:05:09 INFO - 'name': 'check_screen_resolution'},), 05:05:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:09 INFO - 'cmd': ('bash', 05:05:09 INFO - '-c', 05:05:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:09 INFO - 'enabled': True, 05:05:09 INFO - 'halt_on_failure': False, 05:05:09 INFO - 'name': 'check_screen_resolution'},), 05:05:09 INFO - 'run_cmd_checks_enabled': True, 05:05:09 INFO - 'sps_profile': False, 05:05:09 INFO - 'sps_profile_interval': 0, 05:05:09 INFO - 'suite': 'dromaeojs', 05:05:09 INFO - 'system_bits': '32', 05:05:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:09 INFO - 'title': 't-yosemite-r7-0223', 05:05:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:09 INFO - 'use_talos_json': True, 05:05:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:09 INFO - 'work_dir': 'build'} 05:05:09 INFO - [mozharness: 2016-08-08 12:05:09.393346Z] Running clobber step. 05:05:09 INFO - Running pre-action listener: _resource_record_pre_action 05:05:09 INFO - Running main action method: clobber 05:05:09 INFO - rmtree: /builds/slave/test/build 05:05:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:09 INFO - Running post-action listener: _resource_record_post_action 05:05:09 INFO - [mozharness: 2016-08-08 12:05:09.584235Z] Finished clobber step (success) 05:05:09 INFO - [mozharness: 2016-08-08 12:05:09.584420Z] Running read-buildbot-config step. 05:05:09 INFO - Running pre-action listener: _resource_record_pre_action 05:05:09 INFO - Running main action method: read_buildbot_config 05:05:09 INFO - Using buildbot properties: 05:05:09 INFO - { 05:05:09 INFO - "project": "", 05:05:09 INFO - "product": "firefox", 05:05:09 INFO - "script_repo_revision": "production", 05:05:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:05:09 INFO - "repository": "", 05:05:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:05:09 INFO - "buildid": "20160805131321", 05:05:09 INFO - "pgo_build": "False", 05:05:09 INFO - "basedir": "/builds/slave/test", 05:05:09 INFO - "buildnumber": 910, 05:05:09 INFO - "slavename": "t-yosemite-r7-0223", 05:05:09 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:05:09 INFO - "platform": "yosemite_r7", 05:05:09 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:05:09 INFO - "branch": "fx-team", 05:05:09 INFO - "repo_path": "integration/fx-team", 05:05:09 INFO - "revision": "f54fea6078ddf0023a4307a25264c6ece653e503", 05:05:09 INFO - "stage_platform": "macosx64", 05:05:09 INFO - "builduid": "3935528495d04780899dc77e8ecc8206", 05:05:09 INFO - "slavebuilddir": "test" 05:05:09 INFO - } 05:05:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:05:09 INFO - Running post-action listener: _resource_record_post_action 05:05:09 INFO - [mozharness: 2016-08-08 12:05:09.587655Z] Finished read-buildbot-config step (success) 05:05:09 INFO - [mozharness: 2016-08-08 12:05:09.587762Z] Running download-and-extract step. 05:05:09 INFO - Running pre-action listener: _resource_record_pre_action 05:05:09 INFO - Running main action method: download_and_extract 05:05:09 INFO - mkdir: /builds/slave/test/build/tests 05:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:09 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:05:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:10 INFO - Downloaded 1199 bytes. 05:05:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:05:10 INFO - Using the following test package requirements: 05:05:10 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:05:10 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:05:10 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:05:10 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'jsshell-mac.zip'], 05:05:10 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:05:10 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:05:10 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:05:10 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:05:10 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:05:10 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:10 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:05:10 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:10 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:05:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:11 INFO - Downloaded 16320553 bytes. 05:05:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:05:18 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 05:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:18 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:05:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:19 INFO - Downloaded 16320553 bytes. 05:05:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:05: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')]} 05:05:25 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:05:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:26 INFO - Downloaded 14413723 bytes. 05:05:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:05:27 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')]} 05:05:27 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:30 INFO - Downloaded 111902381 bytes. 05:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:30 INFO - mkdir: /builds/slave/test/properties 05:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:30 INFO - Contents: 05:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:31 INFO - Running post-action listener: _resource_record_post_action 05:05:31 INFO - Running post-action listener: set_extra_try_arguments 05:05:31 INFO - [mozharness: 2016-08-08 12:05:31.498646Z] Finished download-and-extract step (success) 05:05:31 INFO - [mozharness: 2016-08-08 12:05:31.498766Z] Running populate-webroot step. 05:05:31 INFO - Running pre-action listener: _resource_record_pre_action 05:05:31 INFO - Running main action method: populate_webroot 05:05:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:31 INFO - '--tppagecycles', 05:05:31 INFO - '7'], 05:05:31 INFO - 'tests': ['tsvgm']}}, 05:05:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['damp', 'tps']}, 05:05:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'tests': ['damp', 'tps']}, 05:05:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['dromaeo_dom']}, 05:05:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['basic_compositor_video']}, 05:05:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:05:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tsvgx', 05:05:31 INFO - 'tsvgr_opacity', 05:05:31 INFO - 'tart', 05:05:31 INFO - 'tscrollx', 05:05:31 INFO - 'cart']}, 05:05:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:31 INFO - 'tsvgr_opacity', 05:05:31 INFO - 'tart', 05:05:31 INFO - 'tscrollx', 05:05:31 INFO - 'cart']}, 05:05:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tp5o']}, 05:05:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'tests': ['tp5o']}, 05:05:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s', 05:05:31 INFO - '--xperf_path', 05:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:31 INFO - 'tests': ['tp5n']}, 05:05:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--xperf_path', 05:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:31 INFO - 'tests': ['tp5n']}}, 05:05:31 INFO - 'talos.zip': {'path': '', 05:05:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:31 INFO - Running post-action listener: _resource_record_post_action 05:05:31 INFO - [mozharness: 2016-08-08 12:05:31.517691Z] Finished populate-webroot step (success) 05:05:31 INFO - [mozharness: 2016-08-08 12:05:31.517828Z] Running create-virtualenv step. 05:05:31 INFO - Running pre-action listener: _resource_record_pre_action 05:05:31 INFO - Running main action method: create_virtualenv 05:05:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:31 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 05:05:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:31 INFO - Using real prefix '/tools/python27' 05:05:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:35 INFO - Installing pip.................done. 05:05:35 INFO - Return code: 0 05:05:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:05:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:35 INFO - 'HOME': '/Users/cltbld', 05:05:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:35 INFO - 'LOGNAME': 'cltbld', 05:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:35 INFO - 'MOZ_NO_REMOTE': '1', 05:05:35 INFO - 'NO_EM_RESTART': '1', 05:05:35 INFO - 'PAGER': '/bin/cat', 05:05:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:35 INFO - 'PWD': '/builds/slave/test', 05:05:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:35 INFO - 'SHELL': '/bin/bash', 05:05:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:35 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:35 INFO - 'USER': 'cltbld', 05:05:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:35 INFO - 'XPC_FLAGS': '0x0', 05:05:35 INFO - 'XPC_SERVICE_NAME': '0', 05:05:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:35 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 05:05:35 INFO - Cleaning up... 05:05:35 INFO - Return code: 0 05:05:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:05:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:35 INFO - 'HOME': '/Users/cltbld', 05:05:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:35 INFO - 'LOGNAME': 'cltbld', 05:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:35 INFO - 'MOZ_NO_REMOTE': '1', 05:05:35 INFO - 'NO_EM_RESTART': '1', 05:05:35 INFO - 'PAGER': '/bin/cat', 05:05:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:35 INFO - 'PWD': '/builds/slave/test', 05:05:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:35 INFO - 'SHELL': '/bin/bash', 05:05:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:35 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:35 INFO - 'USER': 'cltbld', 05:05:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:35 INFO - 'XPC_FLAGS': '0x0', 05:05:35 INFO - 'XPC_SERVICE_NAME': '0', 05:05:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:35 INFO - Downloading/unpacking psutil>=3.1.1 05:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:39 INFO - Installing collected packages: psutil 05:05:39 INFO - Running setup.py install for psutil 05:05:39 INFO - building 'psutil._psutil_osx' extension 05:05:39 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 05:05:39 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 05:05:39 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 05:05:39 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 05:05:39 INFO - building 'psutil._psutil_posix' extension 05:05:39 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 05:05:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:05:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:05:39 INFO - ^ 05:05:39 INFO - 1 warning generated. 05:05:39 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 05:05:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:40 INFO - Successfully installed psutil 05:05:40 INFO - Cleaning up... 05:05:40 INFO - Return code: 0 05:05:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:05: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 mozsystemmonitor==0.3 05:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:40 INFO - 'HOME': '/Users/cltbld', 05:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:40 INFO - 'LOGNAME': 'cltbld', 05:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:40 INFO - 'MOZ_NO_REMOTE': '1', 05:05:40 INFO - 'NO_EM_RESTART': '1', 05:05:40 INFO - 'PAGER': '/bin/cat', 05:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:40 INFO - 'PWD': '/builds/slave/test', 05:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:40 INFO - 'SHELL': '/bin/bash', 05:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:40 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:40 INFO - 'USER': 'cltbld', 05:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:40 INFO - 'XPC_FLAGS': '0x0', 05:05:40 INFO - 'XPC_SERVICE_NAME': '0', 05:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:42 INFO - Installing collected packages: mozsystemmonitor 05:05:42 INFO - Running setup.py install for mozsystemmonitor 05:05:43 INFO - Successfully installed mozsystemmonitor 05:05:43 INFO - Cleaning up... 05:05:43 INFO - Return code: 0 05:05:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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', '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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:05: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 jsonschema==2.5.1 05:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:43 INFO - 'HOME': '/Users/cltbld', 05:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:43 INFO - 'LOGNAME': 'cltbld', 05:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:43 INFO - 'MOZ_NO_REMOTE': '1', 05:05:43 INFO - 'NO_EM_RESTART': '1', 05:05:43 INFO - 'PAGER': '/bin/cat', 05:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:43 INFO - 'PWD': '/builds/slave/test', 05:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:43 INFO - 'SHELL': '/bin/bash', 05:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:43 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:43 INFO - 'USER': 'cltbld', 05:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:43 INFO - 'XPC_FLAGS': '0x0', 05:05:43 INFO - 'XPC_SERVICE_NAME': '0', 05:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:43 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:45 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 05:05:45 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 05:05:45 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 05:05:45 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 05:05:45 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 05:05:45 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 05:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:46 INFO - warning: no files found matching '*.txt' 05:05:46 INFO - no previously-included directories found matching 'build' 05:05:46 INFO - no previously-included directories found matching 'dist' 05:05:46 INFO - no previously-included directories found matching '.git*' 05:05:46 INFO - Installing collected packages: jsonschema, functools32 05:05:46 INFO - Running setup.py install for functools32 05:05:46 INFO - warning: no files found matching '*.txt' 05:05:46 INFO - no previously-included directories found matching 'build' 05:05:46 INFO - no previously-included directories found matching 'dist' 05:05:46 INFO - no previously-included directories found matching '.git*' 05:05:46 INFO - Successfully installed jsonschema functools32 05:05:46 INFO - Cleaning up... 05:05:46 INFO - Return code: 0 05:05:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05:46 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')]} 05:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:46 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')]} 05:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:46 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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05:46 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 05:05:46 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 05:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:46 INFO - 'HOME': '/Users/cltbld', 05:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:46 INFO - 'LOGNAME': 'cltbld', 05:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:46 INFO - 'MOZ_NO_REMOTE': '1', 05:05:46 INFO - 'NO_EM_RESTART': '1', 05:05:46 INFO - 'PAGER': '/bin/cat', 05:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:46 INFO - 'PWD': '/builds/slave/test', 05:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:46 INFO - 'SHELL': '/bin/bash', 05:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:46 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:46 INFO - 'USER': 'cltbld', 05:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:46 INFO - 'XPC_FLAGS': '0x0', 05:05:46 INFO - 'XPC_SERVICE_NAME': '0', 05:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:46 INFO - Cleaning up... 05:05:46 INFO - Return code: 0 05:05:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05:46 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')]} 05:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:46 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')]} 05:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:46 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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05:46 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 05:05:46 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 05:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:46 INFO - 'HOME': '/Users/cltbld', 05:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:46 INFO - 'LOGNAME': 'cltbld', 05:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:46 INFO - 'MOZ_NO_REMOTE': '1', 05:05:46 INFO - 'NO_EM_RESTART': '1', 05:05:46 INFO - 'PAGER': '/bin/cat', 05:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:46 INFO - 'PWD': '/builds/slave/test', 05:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:46 INFO - 'SHELL': '/bin/bash', 05:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:46 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:46 INFO - 'USER': 'cltbld', 05:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:46 INFO - 'XPC_FLAGS': '0x0', 05:05:46 INFO - 'XPC_SERVICE_NAME': '0', 05:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:49 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 05:05:49 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 05:05:49 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 05:05:49 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 05:05:49 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 05:05:49 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 05:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:50 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 05:05:50 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 05:05:50 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 05:05:50 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 05:05:50 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 05:05:50 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 05:05:50 INFO - Downloading docopt-0.6.1.tar.gz 05:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:50 INFO - Running setup.py install for blobuploader 05:05:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:51 INFO - Running setup.py install for requests 05:05:51 INFO - Running setup.py install for docopt 05:05:51 INFO - Successfully installed blobuploader requests docopt 05:05:51 INFO - Cleaning up... 05:05:51 INFO - Return code: 0 05:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:51 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')]} 05:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:51 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')]} 05:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:51 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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05:51 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 05:05:51 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 05:05:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:51 INFO - 'HOME': '/Users/cltbld', 05:05:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:51 INFO - 'LOGNAME': 'cltbld', 05:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:51 INFO - 'MOZ_NO_REMOTE': '1', 05:05:51 INFO - 'NO_EM_RESTART': '1', 05:05:51 INFO - 'PAGER': '/bin/cat', 05:05:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:51 INFO - 'PWD': '/builds/slave/test', 05:05:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:51 INFO - 'SHELL': '/bin/bash', 05:05:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:51 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:51 INFO - 'USER': 'cltbld', 05:05:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:51 INFO - 'XPC_FLAGS': '0x0', 05:05:51 INFO - 'XPC_SERVICE_NAME': '0', 05:05:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-1eb5UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-5OpRcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-i34jGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-9Tz1zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-jU4_Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-PCz5GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-eQiLyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-YXcTnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:52 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-RP5IN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-acaJM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-MzwNY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-hQxZms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-xaRVO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-4HJJBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-lQx9O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-wDJx43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:53 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-sTh2TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:53 INFO - Running setup.py install for manifestparser 05:05:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:54 INFO - Running setup.py install for mozcrash 05:05:54 INFO - Running setup.py install for mozdebug 05:05:54 INFO - Running setup.py install for mozdevice 05:05:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:54 INFO - Running setup.py install for mozfile 05:05:54 INFO - Running setup.py install for mozhttpd 05:05:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:54 INFO - Running setup.py install for mozinfo 05:05:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:54 INFO - Running setup.py install for mozInstall 05:05:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Running setup.py install for mozleak 05:05:55 INFO - Running setup.py install for mozlog 05:05:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Running setup.py install for moznetwork 05:05:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Running setup.py install for mozprocess 05:05:55 INFO - Running setup.py install for mozprofile 05:05:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:55 INFO - Running setup.py install for mozrunner 05:05:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:56 INFO - Running setup.py install for mozscreenshot 05:05:56 INFO - Running setup.py install for moztest 05:05:56 INFO - Running setup.py install for mozversion 05:05:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:56 INFO - Cleaning up... 05:05:56 INFO - Return code: 0 05:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:56 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')]} 05:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:56 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')]} 05:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:56 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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:05:56 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 05:05:56 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 05:05:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:05:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:56 INFO - 'HOME': '/Users/cltbld', 05:05:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:56 INFO - 'LOGNAME': 'cltbld', 05:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:56 INFO - 'MOZ_NO_REMOTE': '1', 05:05:56 INFO - 'NO_EM_RESTART': '1', 05:05:56 INFO - 'PAGER': '/bin/cat', 05:05:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:56 INFO - 'PWD': '/builds/slave/test', 05:05:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:56 INFO - 'SHELL': '/bin/bash', 05:05:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:05:56 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:05:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:56 INFO - 'USER': 'cltbld', 05:05:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:56 INFO - 'XPC_FLAGS': '0x0', 05:05:56 INFO - 'XPC_SERVICE_NAME': '0', 05:05:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:56 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-4Y3wuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:56 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)) 05:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:56 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-oRGHJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:56 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)) 05:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:56 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-cnRgL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-mBKB4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-FvdnyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-xXqxlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-pVz48E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-tWajCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-okJjUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-vQRdRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-apFkQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:57 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)) 05:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:57 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-YkTm_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:58 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)) 05:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:58 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-vOkT_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:58 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)) 05:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:58 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-wL2R_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:58 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)) 05:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:58 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Wdpgpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:58 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)) 05:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:58 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-5QXhAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:58 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)) 05:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:58 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-TbIeQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:58 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)) 05:05:58 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)) 05:05:58 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)) 05:05:58 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)) 05:05:58 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)) 05:05:58 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)) 05:05:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:00 INFO - Downloading blessings-1.6.tar.gz 05:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:01 INFO - Installing collected packages: blessings 05:06:01 INFO - Running setup.py install for blessings 05:06:01 INFO - Successfully installed blessings 05:06:01 INFO - Cleaning up... 05:06:01 INFO - Return code: 0 05:06:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:01 INFO - Reading from file tmpfile_stdout 05:06:01 INFO - Current package versions: 05:06:01 INFO - blessings == 1.6 05:06:01 INFO - blobuploader == 1.2.4 05:06:01 INFO - docopt == 0.6.1 05:06:01 INFO - functools32 == 3.2.3-2 05:06:01 INFO - jsonschema == 2.5.1 05:06:01 INFO - manifestparser == 1.1 05:06:01 INFO - mozInstall == 1.12 05:06:01 INFO - mozcrash == 0.17 05:06:01 INFO - mozdebug == 0.1 05:06:01 INFO - mozdevice == 0.48 05:06:01 INFO - mozfile == 1.2 05:06:01 INFO - mozhttpd == 0.7 05:06:01 INFO - mozinfo == 0.9 05:06:01 INFO - mozleak == 0.1 05:06:01 INFO - mozlog == 3.3 05:06:01 INFO - moznetwork == 0.27 05:06:01 INFO - mozprocess == 0.23 05:06:01 INFO - mozprofile == 0.28 05:06:01 INFO - mozrunner == 6.12 05:06:01 INFO - mozscreenshot == 0.1 05:06:01 INFO - mozsystemmonitor == 0.3 05:06:01 INFO - moztest == 0.7 05:06:01 INFO - mozversion == 1.4 05:06:01 INFO - psutil == 3.1.1 05:06:01 INFO - requests == 1.2.3 05:06:01 INFO - wsgiref == 0.1.2 05:06:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:01 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')]} 05:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:01 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')]} 05:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:01 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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:06:01 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 05:06:01 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 05:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:01 INFO - 'HOME': '/Users/cltbld', 05:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:01 INFO - 'LOGNAME': 'cltbld', 05:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:01 INFO - 'MOZ_NO_REMOTE': '1', 05:06:01 INFO - 'NO_EM_RESTART': '1', 05:06:01 INFO - 'PAGER': '/bin/cat', 05:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:01 INFO - 'PWD': '/builds/slave/test', 05:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:01 INFO - 'SHELL': '/bin/bash', 05:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:06:01 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:01 INFO - 'USER': 'cltbld', 05:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:01 INFO - 'XPC_FLAGS': '0x0', 05:06:01 INFO - 'XPC_SERVICE_NAME': '0', 05:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 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)) 05:06:01 INFO - Cleaning up... 05:06:01 INFO - Return code: 0 05:06:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:01 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')]} 05:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:01 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')]} 05:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:01 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 0x10efd8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f06d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86b0700180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, '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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 05:06:01 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 05:06:01 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 05:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:01 INFO - 'HOME': '/Users/cltbld', 05:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:01 INFO - 'LOGNAME': 'cltbld', 05:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:01 INFO - 'MOZ_NO_REMOTE': '1', 05:06:01 INFO - 'NO_EM_RESTART': '1', 05:06:01 INFO - 'PAGER': '/bin/cat', 05:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:01 INFO - 'PWD': '/builds/slave/test', 05:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:01 INFO - 'SHELL': '/bin/bash', 05:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:06:01 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:01 INFO - 'USER': 'cltbld', 05:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:01 INFO - 'XPC_FLAGS': '0x0', 05:06:01 INFO - 'XPC_SERVICE_NAME': '0', 05:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:06:02 INFO - Cleaning up... 05:06:02 INFO - Return code: 0 05:06:02 INFO - Running post-action listener: _resource_record_post_action 05:06:02 INFO - Running post-action listener: _start_resource_monitoring 05:06:02 INFO - Starting resource monitoring. 05:06:02 INFO - [mozharness: 2016-08-08 12:06:02.186763Z] Finished create-virtualenv step (success) 05:06:02 INFO - [mozharness: 2016-08-08 12:06:02.187703Z] Running install step. 05:06:02 INFO - Running pre-action listener: _resource_record_pre_action 05:06:02 INFO - Running main action method: install 05:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:02 INFO - Reading from file tmpfile_stdout 05:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:02 INFO - Reading from file tmpfile_stdout 05:06:02 INFO - Output received: 05:06:02 INFO - Usage: mozinstall [options] installer 05:06:02 INFO - Options: 05:06:02 INFO - -h, --help show this help message and exit 05:06:02 INFO - -d DEST, --destination=DEST 05:06:02 INFO - Directory to install application into. [default: 05:06:02 INFO - "/builds/slave/test"] 05:06:02 INFO - --app=APP Application being installed. [default: firefox] 05:06:02 INFO - mkdir: /builds/slave/test/build/application 05:06:02 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'] 05:06:02 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 05:06:36 INFO - Reading from file tmpfile_stdout 05:06:36 INFO - Output received: 05:06:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:06:36 INFO - Running post-action listener: _resource_record_post_action 05:06:36 INFO - [mozharness: 2016-08-08 12:06:36.903773Z] Finished install step (success) 05:06:36 INFO - [mozharness: 2016-08-08 12:06:36.903914Z] Running run-tests step. 05:06:36 INFO - Running pre-action listener: _resource_record_pre_action 05:06:36 INFO - Running main action method: run_tests 05:06:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:36 INFO - 2016-08-08 05:06:36.918 screenresolution[1911:9722] starting screenresolution argv=screenresolution get 05:06:36 INFO - 2016-08-08 05:06:36.921 screenresolution[1911:9722] Display 0: 1600x1200x32@60 05:06:36 INFO - 2016-08-08 05:06:36.926 screenresolution[1912:9724] starting screenresolution argv=screenresolution list 05:06:36 INFO - Available Modes on Display 0 05:06:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:37 INFO - Intel Iris: 05:06:37 INFO - Chipset Model: Intel Iris 05:06:37 INFO - Type: GPU 05:06:37 INFO - Bus: Built-In 05:06:37 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:37 INFO - Vendor: Intel (0x8086) 05:06:37 INFO - Device ID: 0x0a2e 05:06:37 INFO - Revision ID: 0x0009 05:06:37 INFO - Displays: 05:06:37 INFO - Display: 05:06:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:37 INFO - Display Serial Number: 1600x1200 60 05:06:37 INFO - Main Display: Yes 05:06:37 INFO - Mirror: Off 05:06:37 INFO - Online: Yes 05:06:37 INFO - Rotation: Supported 05:06:37 INFO - Return code: 0 05:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:37 INFO - Python 2.7.3 05:06:37 INFO - Return code: 0 05:06:37 INFO - grabbing minidump binary from tooltool 05:06: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')]} 05:06:37 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 0x10ef3cd30>, '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 0x10eca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:37 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 05:06:37 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 05:06:37 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 05:06:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:37 INFO - Return code: 0 05:06:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:06:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:06:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:37 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0223', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:06:37 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0223 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Jgoj3EBfIY/Render', 05:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:37 INFO - 'HOME': '/Users/cltbld', 05:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:37 INFO - 'LOGNAME': 'cltbld', 05:06:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:37 INFO - 'MOZ_NO_REMOTE': '1', 05:06:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:37 INFO - 'NO_EM_RESTART': '1', 05:06:37 INFO - 'PAGER': '/bin/cat', 05:06:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:37 INFO - 'PWD': '/builds/slave/test', 05:06:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:37 INFO - 'SHELL': '/bin/bash', 05:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5kurnPEnpf/Listeners', 05:06:37 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 05:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:37 INFO - 'USER': 'cltbld', 05:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:37 INFO - 'XPC_FLAGS': '0x0', 05:06:37 INFO - 'XPC_SERVICE_NAME': '0', 05:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0223', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:06:37 INFO - mozversion application_buildid: 20160805131321 05:06:37 INFO - mozversion application_changeset: f54fea6078ddf0023a4307a25264c6ece653e503 05:06:37 INFO - mozversion application_display_name: Nightly 05:06:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:37 INFO - mozversion application_name: Firefox 05:06:37 INFO - mozversion application_remotingname: firefox 05:06:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:06:37 INFO - mozversion application_vendor: Mozilla 05:06:37 INFO - mozversion application_version: 51.0a1 05:06:37 INFO - mozversion platform_buildid: 20160805131321 05:06:37 INFO - mozversion platform_changeset: f54fea6078ddf0023a4307a25264c6ece653e503 05:06:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:06:37 INFO - mozversion platform_version: 51.0a1 05:06:37 INFO - using testdate: 1470657997 05:06:37 INFO - actual date: 1470657997 05:06:37 INFO - starting webserver on 'localhost:49462' 05:06:37 INFO - SUITE-START | Running 2 tests 05:06:37 INFO - TEST-START | dromaeo_css 05:06:37 INFO - operating with platform_type : mac_ 05:06:37 INFO - Initialising browser for dromaeo_css test... 05:06:37 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpCoga04/profile http://localhost:49462/getInfo.html) 05:06:40 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 05:06:40 INFO - PROCESS | 1922 | colorDepth:24 05:06:40 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 05:06:40 INFO - PROCESS | 1922 | __metrics 05:06:40 INFO - PROCESS | 1922 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:06:40 INFO - PROCESS | 1922 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:40 INFO - TEST-INFO | 1922: exit 0 05:06:40 INFO - Browser initialized. 05:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:40 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpCoga04/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:52 INFO - PROCESS | 1924 | RSS: Main: 243605504 05:06:52 INFO - PROCESS | 1924 | 05:07:44 INFO - PROCESS | 1924 | 1470658064532 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] 05:09:56 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49462/tests/dromaeo/cssquery-ext.html) 05:09:58 INFO - PROCESS | 1924 | RSS: Main: 346968064 05:09:58 INFO - PROCESS | 1924 | 05:13:01 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-ext.html (next: http://localhost:49462/tests/dromaeo/cssquery-jquery.html) 05:13:01 INFO - PROCESS | 1924 | RSS: Main: 387620864 05:13:01 INFO - PROCESS | 1924 | 05:16:04 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49462/tests/dromaeo/cssquery-mootools.html) 05:16:04 INFO - PROCESS | 1924 | RSS: Main: 353869824 05:16:04 INFO - PROCESS | 1924 | 05:19:07 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49462/tests/dromaeo/cssquery-prototype.html) 05:19:07 INFO - PROCESS | 1924 | RSS: Main: 360218624 05:19:07 INFO - PROCESS | 1924 | 05:22:11 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49462/tests/dromaeo/cssquery-yui.html) 05:22:11 INFO - PROCESS | 1924 | RSS: Main: 345378816 05:22:11 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-yui.html (next: http://localhost:49462/tests/dromaeo/cssquery-dojo.html) 05:25:15 INFO - PROCESS | 1924 | RSS: Main: 497598464 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | __start_tp_report 05:25:15 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 05:25:15 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 05:25:15 INFO - PROCESS | 1924 | |i|pagename|runs| 05:25:15 INFO - PROCESS | 1924 | |0;dojo.html;3278.83605819709;3310.337932413518;3322.601287845459;3329.400707872585;3365.2596428785673;5573.470520300575;5627.887442251153;5673.8581535461635;5737.971310143449;5796.275465566799;5645.887082258352;5685;5698.971505142479;5760.48155665991;5807.506361959228;5106.719130447824;5131.743412829363;5170.767315470813;5182.844514664547;5287.788488460457;5300.204969254623;5320.787168513255;5329.840104796862;5334;5373.785048598052;5095.363079615048;5132.743362831843;5150.510701483353;5179.689218646856;5262.999999999981;5147.3051138096625;5162.22566615007;5279.788808447657;5313.176457649032;5313.548348390392;5145.691258524501;5164.793408263702;5170.482951704837;5197.948020519784;5247.39654939683;5571.609987300891;5675.20547123399;5692.601517893749;5752.9712351437975;5758.6544807311275;6118.3269840317525;6132.110769107974;6155.292141403751;6165.075238714184;6200.689965501707;6211.782587609412;6251.218597675291;6307.558470907038;6312.368763123697;6316.084167795644;5639.915401268984;5687.914681279702;5817.360090390053;5825.679587622637;5829.067349224104;6309.873802524015;6313.05304204373;6317;6333.556651034383;6343.302236753953;6102.23403990958;6104.755809767648;6111.5309653553995;6114.633122012693;6117.541184411187;5690.231818704422;6225.097360882647;6243.43809057187;6251.874962500816;6252.843678908063;5734.111212762028;6055.818325450244;6103.267607886994;6119.632822030692;6136.969315153485;6130.6628135452975;6161.168242287324;6172.351903050115;6173.41352571505;6186.257649082139;4919.532644398776;4926.630502712311;4927.359443272351;4930.408350997904;4935.679180853305;4364.9305920049155;4368.191884501377;4378.8905277367685;4435.911281774411;4448.4439445069365;5659.971700141473;5667.518260947865;5670.06443936754;5677;5736.053551164011;6279.309275979638;6291.842703932347;6299.6850157491945;6305.495560355161;6314.494840412848;5515.696636685021;5580.972095139579;5588.832335029955;5653.208550802891;5655.4344565543115;5412.675239485643;5414.485623865727;5431.8098866539485;5436.157395603688;5450.591205659592;6263.906041409383;6292.465140463112;6297.685115744102;6318.210223722035;6322.589031712924;5035.471275516018;6161.630302181883;6165;6244.438000579969;6246.1255424239735;5176.767045483038;6274.309825919054;6283.434490895841;6285.371462853678;6294.150289711014;6110.877782444415;6113.144159817718;6131.785387511416;6132.9080063799975;6144.600600960924;5108.693478391308;6103.664298463449;6110.589135957228;6208.844778880564;6257.124002639725;6035;6057.454829065406;6074.848128796815;6097;6132.264128304632;4919.237518184687;5981.663796450354;6035.78874739382;6039.879202415839;6059.303180134341;5687.715614219355;5729.9713501432225;5793.8551536211935;5827.300723912988;5891.381404952418;6049.485793707584;6049.78825741097;6057.333693293822;6066.757329706762;6107.694615269308;5882.088276317178;5883.235179426647;5884.499817515388;5886.381929897299;5915.08316210988 05:25:15 INFO - PROCESS | 1924 | |1;ext.html;477.2578640214465;520.695393194981;526.1423879077104;526.8935236004389;537.878977230123;31436.52845207324;41973;43189.784051079776;43238.70283891484;45567.088658226814;44453.77773111138;44868.3269750954;44986;44987;45041.774791126;9760.804783904317;9956.054174853378;9961.203103751719;9974.950125249363;9993.750156246115;8835.867461988075;9091.590878410487;11580;11875.52497900083;11891.167618266725;12119.515219391214;12168.878311216908;12182.086343524226;12189.146759726822;12220.816687749691;12036.338001409918;12071.336076515789;12087.033037357078;12100.031997440272;12137.029037676964;11884.465199066062;11938.164328497009;11953.760924781544;11960.34218118003;11981.341026243554;41392.96517587084;41685.37471937893;41693;41877.581224187976;41880.58119418797;3431.811250381228;3549.361114999299;3566.3045706087064;3701.296753616831;4141.875743727693;31495;32637;32763.83618081918;32911.67088329134;32959.340813183844;3171.1279398165457;3182.9681703182905;3236.8219747913854;3343.6154842193214;3369.393509168349;484338;485519;486904.56547717034;488356;488963;63362;63392.36607633957;63539;63812;63906.36093639004;67013.99479007818;67194.9920751189;67286;67300.6634966822;67306;16396.426125085804;16623.6675266494;16626.58433539171;16645.583860403585;16660;11536.538538458535;11808.055355571534;12826.294553799631;12885.613431597067;12886.67783305425;17910.656700747495;18450.35423760189;18625.627487450176;18729.96985165829;19055.61888762217;6098.817035488943;6171.907421388682;6209.751609935643;6224.128621992924;6241.625502469867;889.6352495476953;955.8183945050419;969.6945462179391;975.8243516167158;997.0428388746884;29876.253093672833;30672.859164012574;30792.384152316827;30913.84543077315;31533.369332613678;998.4159266828841;1080.9675709728722;1100.708312297242;1115.59838458155;1212.1998831734866;12488.313142777053;15706.764398534031;15776.526704198892;15909.920450397905;16006;668130;672882;672958.6352068306;673261.6336918382;675156;59901;60092;60184;60257.698711506164;60441;1234.851817781854;1285.254552359629;1350.8851747601564;1366.3304980559453;1400.5588239704462;27770.722292776813;29380.706192937796;31822;32221.838890805397;32358.90824413513;51981;52711.68220794511;52735.94528109493;52808.67978300573;52821.7358913203;529643;533484;533718;534253;534539;23936.52126957486;26817.731822681522;26893.462130757667;27379;27703.861480692467;38877.416838746874;39846.800765995984;49431.76420589514;49438.258426124354;51997.220041698645;32904.84833030833;37985.43021854619;40923.043082675424;41792.791036044626;42234.57765422307;39837.40243896286;40377.78866634006;40600.79699601483;40732;42224.944376390835;38954;39466.013349666486;39576;39638.2072358557;40129.1974160521;34298.82850585731;35338;35732.82133589315;35878.46182307215;36154;26073.348166295993;26172.738272617793;26259.474810504063;26427;26680.733192667823 05:25:15 INFO - PROCESS | 1924 | |2;jquery.html;356.3532189076827;372.91236559408514;378.5381834162322;383.7486446377622;403.7113463873332;15386.461473848403;15652.530424087281;19887.50281242966;20202.797972020275;20215.79784202156;19480.512987175327;19971.400857974248;20062.99685015747;20093;20796.376108716726;5232.45059268777;5888.1462187982825;6137.508999280047;6146.108814221935;6155.661438620874;4262.1688770689725;4479.552044795527;5976.073708575178;6135.294441139259;6259.530535209855;6500.837479063038;6570.1458810354825;6582.670866456682;6592.3407659233935;6603.250138713245;6324.177856878599;6683.732650693942;6724.865502689968;6725.361090696425;6727.058211850345;5048.368953880765;5559.054960656657;5784.913226301609;5796.2464879565805;5797.391273916262;21434.24980125688;21542.676859847114;22182.336324775708;26098.608520872203;26478;2043.5095577061397;2827;3058.7247147756807;3078.9076327710204;3198.18446296193;10020.198384129251;10041.033791652257;10242.487875606264;10365.170786337076;10471.267011309212;1550.8914375993686;1849.9722504162448;1887.226237242724;1924.9711254331196;1936.1480948382666;100739.49630251802;110185.44907275413;122826;127732.36133819364;136165;11140.554377824958;11469.655910322703;11507.07943364529;11539.826902596467;11738.647840564796;14455.85544144545;14462.927685361716;14464.566063018126;14473.710525789425;14483.565493035227;6840.863182736317;8014.19858014194;8215.7946051348;8366.456180348257;8596.742097736953;8395.832083358298;8398.244158025807;8407.831843363221;8585.527795971157;8619.267362274277;4332.870013899588;4416.84541041062;4441.755703436277;4505.526919673387;4516.525764794649;1634.6975809475284;1710.1192885663893;1787.6335351252962;1837.8897266164072;1886.867919245667;861.7802460372565;889.7597648634833;892.1658249536704;903.8915330160291;941.915227629503;20487.180512779323;20584.691229631568;20834.895825520776;20868.686969695467;21394.893025534773;876.8553188723789;944;945.385499425379;1000.1498726082772;1023.948802559869;9469.90530094704;10069.244806639532;10425;10766.89233107659;10939.56241750337;581925;590498;599409;611749;612013;122530;129129.35435322952;129357;130505;133829;956.5121787888088;965.4496936745987;979.5445118020298;981.9263555233387;983.0857302708407;14143.504977325743;15587.688246234786;18458.81541184571;19288.8071119287;19346.129424175666;50408;51679.74160129326;52057;52154.56686181717;53023;76666;77439;78143.6092819555;78274;79790.2020979806;7109.82225444368;8070.636821342936;8086.676532938852;8161.224683655043;8411.032731235986;11176.776464470828;13310.001749868992;13368.732625347633;13739.931300343434;13893.166410015432;11312.377819220023;11344.149188810707;11810.05519558416;11886.28682279066;11888.702782430508;11440.656780296604;11562.88437115618;11771.176017678681;11800.52797888075;12049.156559040783;11300.43497825089;11458.656240312805;11538.88461115378;12015.158938874194;12030.518779248732;7419.554826710415;7542.170361260147;7587.772366829004;7598.924010759822;7606.771796846104;9388.436693798394;11719.414029298672;12000.57997970067;12033.518659253532;12041.397930103634 05:25:15 INFO - PROCESS | 1924 | |3;mootools.html;1511.5389806109135;1546.6133466633341;1737.357177844197;1864.8508119350454;1890.0833095948462;8338.91661083389;8908.198262156404;8911.777205569864;8931;8941.91058089419;7909.24862138096;8060.435769496123;8073.273405393514;8441.957790211056;8729.825403491926;2336.9298921032355;2380.33350661815;2388.008976274844;2388.916387926423;2391.784739373456;2330.650402439639;2374.525094981002;2379.0127097254704;2382.059086660768;2385.8091352691745;2339.087755775249;2351.318117745852;2352.4118970257437;2357.481354102095;2386.8209884258663;2332.288651961151;2347.1902193743217;2351.2240960483;2358.337372152637;2361.881905904715;1885.3966730646061;1886.1323791056132;1887.7923428423;1892.4228110426313;1893.8011508791517;8787.692430764957;8794.164554367326;8854.513001784899;8923.910760892373;8927.642894284221;5126.436092029874;5299.1786273127345;5303.204519322094;5307.946920530784;5315.627906046579;3495.178633021238;3496.4755286707195;3600.945985810215;3646.453032045188;3650.8539658413633;1075.569772091162;1076.7738774857212;1079.0180935348874;1104.7679987202698;1108.5953626926193;11406.486708098073;11626.360550169737;11649.650510484615;11656;11666.241694289844;4515.254982927846;4557.544245575482;4754.453237877619;4757.5718185363485;4762.142814293391;9930.950345248371;9947.452890091114;9952.502374881227;9955.55200016001;9975.052370024836;5322.92015619766;5325.068113080273;5326.227696983916;5329.573634109262;5330.333708286465;3690.7134316460647;4336.956630433655;4830.686005409637;4868.075065737498;4894.2658601210105;3902.6487616114687;3908.9804550977633;3933.095388060762;3973.562908080109;3987.1228329767987;1264.3385673158054;1271.4107365792759;1274.7705413025558;1284.640300715801;1291.7933130699043;846.1665259719172;869.56087175977;888.8488956877346;892.7857314244535;940.2290122099812;5596.832095037155;5792.855178620568;5900.675462849498;5982.910256346158;6084.269887613426;949.6296444386695;957.0764212534938;959.6737109382843;967.1489089601106;1010.5402042070987;3930.9869149046663;4026.174634199982;4030.1939612077704;4077.594219410503;4109.404136400205;10494.68515944523;10901.400422976654;10942.288751231144;10942.45287735626;10950.904909509145;10271.94864025675;10664.893351066545;10698.946505267579;10867.510962006729;10876.891231087746;8114.350851931831;8349.081601023883;8357.12250213731;8359.414840961195;8379.162083791694;5845.970770146122;5882.676452795137;5902.321233058082;6013.609115407485;6074.3318234994995;9844.803103938024;9902.405855648683;10071.143952763805;10151.187904967437;10225.897741022494;9396;9936.403815771077;10212.489375531046;10403.791924161626;10414.739631509274;7042.964785176041;7424.331810137113;7580.924190758243;7618.504797188165;7711.807204819925;8233.423660343959;8323.667053318042;8342.624581893951;8423.747287581382;8463.57682115904;7564.773056808304;7589.886151707839;7602.46782725204;7638.618069096634;7690.961545192238;7407.666655000646;7423.146338171179;7466.887996679946;7516.962415187889;7581.583012934341;6934.306569343025;7000.369966703021;7077.68150433242;7078.079849619517;7089.574625522278;4716.174669432767;4844.32179494864;4873.342098816756;4994.425641051325;5108.412532558803;4760.285957106462;4856.708597484162;5003.299538064746;5064.670796398223;5133.820316288912 05:25:15 INFO - PROCESS | 1924 | |4;prototype.html;296.18548990276724;298.4195739287087;307.40977323538795;312.7732394014341;316.7988327412094;4828.903421931568;4995.950040499594;5185.662931909424;5247.790088396459;5369.5435887949525;4296.753941357003;4832.323474713543;4930.408350997876;5133.871653208672;5213.791448342062;3697.6487233712824;3999.340108882031;4018.4976877890263;4027.335489644205;4029.536603290615;3705.906757506542;4037.2934736421007;4047.5345335286524;4058.6144316289906;4060.634542891139;3357.194273374385;3939.428782826503;3966.4645272888224;3976.284268831609;3980.3432433648413;3951.7826519541413;3960.6237407446247;3961.514432087967;3992.201559688074;3996.580359062286;3043.5738996540504;3406.2846802171575;3457.343104810078;3477.7739446935866;3482.703970162539;3994.0613955720673;4854.805807767685;4949.851504454872;5088.898222035538;5091.134507133796;3785.3754130568423;3883.990162557727;3972.66232370246;4514;4556.3621093047;4677;5015.799368025275;5179.326687530634;5454.91817622732;5458.727063646802;3158.6367567729776;3756.7745935243975;3790.3177428063213;3796.0130366104736;3805.9809700951596;5635.21107045014;5776.682282474462;5779.9655181029875;5793.2179155814265;5804.651720896802;3672.908177295589;3783.6027217142355;3783.7729736215915;4016.4176194452225;4017.5580686124504;3420.538227339327;3754.81225938702;3772.75477093988;4057.878263652095;4091.4272001919753;3974.7615143091507;4456.487503937024;4519.870032491877;4613.838515651936;4614.607758340511;4811.615070794328;5463.394159854477;5482.643628164156;5506.063969125258;5506.5870059744875;1153.9134564907665;1230.4155526125019;1312.6324629103867;1332.433715670836;1333.6599167212298;814.3078383374085;870.2515836380708;903.7876099116702;950.1686024728363;950.5484894674975;4687.5781179693995;5033.295338652591;5051.545360917462;5055.69665820052;5089.770960306795;4964.393693310968;4986.601071914238;5535.806246781343;5581.413951535112;5683.886322273532;4249.151619045725;5030.320906677625;5045.5459008689395;5058.418281897555;5095.414027386824;2407.7231118421255;2899.9565006524917;2928.7656987440955;2939.1476471823357;2942.6910174431805;5408.702521361363;5484.588655850827;5508.807191748269;5604.355499117572;5726.742296596663;5592.608517403743;5765.596408251382;5882.470497716734;5899.233099697012;5911.9704401478575;4697.741624210633;4961.578265847444;5734;5903.553629360834;5920.851978700481;5339.866503337447;5656.773729050792;5706.942930570641;5727.541796656341;5735;4997.675151115166;5633.0987042073075;5660;5680.6875621839545;5688.232088667977;4854.563089321978;5683.943160568341;5859.794907178399;5880.617759845596;5935.643861368331;3577.4633804929467;3810.1998580298446;3811.1615444602144;3811.5426148862316;3840.1007239533974;5713;5739.540836733135;5756.971215143897;5758.971205143947;5763.221965034834;4501.122281155274;4688.742119183477;5002.599792016703;5169.353830771153;5639.54883609302;5426.348838139448;5520.337559492726;5526.696031718133;5538.252335934597;5562.777488900399;5127.66670166438;5250.789968401221;5317.441668624739;5374.355077390738;5429.805442802577;4733.502982186958;5355.759765342068;5513.558915286687;5521.723913804374;5541.418151094077;5089.071084105332;5372.892542149213;5378.19327100938;5386.461353864739;5402.216678581663 05:25:15 INFO - PROCESS | 1924 | |5;yui.html;706.8762966480865;723.6888138100618;773.992260077399;776.9728059517918;863.7451951674255;15508.302126404311;15816.288267027983;16385.42651007215;16387.75418368724;16848.241829117687;14741.778873316909;15069.92465037676;15078;15093;15182.696346073071;692.5844493304003;721.7690339091492;835.377643655476;861.6122744764849;867.0852250875324;843.4686147726924;869.2394155114275;880.4189235104832;881.2113158722939;882.7704796752859;929.6746138851382;932.6595792535743;934.4299977014016;934.6308208257734;936.1247233836385;711.4983936324878;883.0330787787427;925.282905748044;927.7634203278188;928.9535523223846;681.2166009089538;681.8465845184843;683.0335075867641;684.1687349869882;684.5653010338422;15226.238688065663;15271.160086195256;15279.236038198045;15281.694366112726;15300.693986120326;12710.364481775874;13617.727645447036;14240.074395164282;14346.713065738732;14418.13491190532;12897.806532902014;12943.935280323538;12981.935090324583;13196.86803131966;13236;4596.7931443085145;4650.767461626905;4743.928841067387;4840.806367745286;4844.951550484485;96578;100000;100134;100903;104696;11226.943865280784;11239.920614686309;11241.21311508203;11279.874135304417;11621.825672614917;21992;22071.779282207295;22091.889540552194;22142;22384.440388990406;7930.484518506279;7958.840823183504;7991.120976692559;8017.879731804028;8088.878666820003;3829.291581057513;4416.205083085011;4454;4500.212462818994;4641.071785642885;3426.4860270959557;3608.5128507651657;3614.475900994341;3614.728895332808;3614.8373323200517;656.9835754106185;661.6658587413422;664.4485077385758;668.6957434367351;673.4780545077506;546.3553007451167;547.0290234833203;575.8646718021262;589.2487078974342;600.7206648908191;8245.299149572353;9259.30555208362;9261.591986083668;9321.95339023314;9543.379680320757;623.9361887980981;624.4941597306197;641.201703878674;654.9377809108128;706.6713978000255;4005.759654420744;4176.206520761046;4625.167469855458;4705.858824235278;4788.569028787356;136520.34796520468;161164;161467.4222661991;163595.72808544;165162;109444;146631;149842;150228;152433;87615;104864.42703359456;107453;109076.90923090668;109520;9701.320907536405;9787.951060244653;9941.801163976825;9975.501224938578;10083.445410502492;60048.69975650268;61637;62515.06227406683;62884.37115628785;64727.02909456268;90528;94808.52595736977;95869.5206523963;97094.51452742692;98165;12225.327606981702;12333.93833030829;12382.56661016896;12640.74718505643;12876.291803950498;15074.54776356711;15252.656539899976;15502.767458487906;15927;16092.839071609602;13978.930105349407;14033.578992630237;14138.363773630417;14346.713065738835;14425.85574144287;14067.805906962645;14072.437102515785;14095.929520352332;14157;14238;11687.941560292144;13527.932360338134;13689.726205475636;13934.163950163023;14388.640283992983;11065.668029959113;11321.320720756452;11423.029042531478;11630;11736.647900562997;11203.439828008404;11425.657230283105;11505.654830355103;11600.245984011011;11691.356975366436 05:25:15 INFO - PROCESS | 1924 | __end_tp_report 05:25:15 INFO - PROCESS | 1924 | __start_cc_report 05:25:15 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,1113 05:25:15 INFO - PROCESS | 1924 | __end_cc_report 05:25:15 INFO - PROCESS | 1924 | __startTimestamp1470659115404__endTimestamp 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | ------- Summary: start ------- 05:25:15 INFO - PROCESS | 1924 | Number of tests: 6 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | [#0] dojo.html Cycles:165 Average:5692.41 Median:5825.68 stddev:635.30 (10.9%) stddev-sans-first:608.38 05:25:15 INFO - PROCESS | 1924 | Values: 3278.8 3310.3 3322.6 3329.4 3365.3 5573.5 5627.9 5673.9 5738.0 5796.3 5645.9 5685.0 5699.0 5760.5 5807.5 5106.7 5131.7 5170.8 5182.8 5287.8 5300.2 5320.8 5329.8 5334.0 5373.8 5095.4 5132.7 5150.5 5179.7 5263.0 5147.3 5162.2 5279.8 5313.2 5313.5 5145.7 5164.8 5170.5 5197.9 5247.4 5571.6 5675.2 5692.6 5753.0 5758.7 6118.3 6132.1 6155.3 6165.1 6200.7 6211.8 6251.2 6307.6 6312.4 6316.1 5639.9 5687.9 5817.4 5825.7 5829.1 6309.9 6313.1 6317.0 6333.6 6343.3 6102.2 6104.8 6111.5 6114.6 6117.5 5690.2 6225.1 6243.4 6251.9 6252.8 5734.1 6055.8 6103.3 6119.6 6137.0 6130.7 6161.2 6172.4 6173.4 6186.3 4919.5 4926.6 4927.4 4930.4 4935.7 4364.9 4368.2 4378.9 4435.9 4448.4 5660.0 5667.5 5670.1 5677.0 5736.1 6279.3 6291.8 6299.7 6305.5 6314.5 5515.7 5581.0 5588.8 5653.2 5655.4 5412.7 5414.5 5431.8 5436.2 5450.6 6263.9 6292.5 6297.7 6318.2 6322.6 5035.5 6161.6 6165.0 6244.4 6246.1 5176.8 6274.3 6283.4 6285.4 6294.2 6110.9 6113.1 6131.8 6132.9 6144.6 5108.7 6103.7 6110.6 6208.8 6257.1 6035.0 6057.5 6074.8 6097.0 6132.3 4919.2 5981.7 6035.8 6039.9 6059.3 5687.7 5730.0 5793.9 5827.3 5891.4 6049.5 6049.8 6057.3 6066.8 6107.7 5882.1 5883.2 5884.5 5886.4 5915.1 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | [#1] ext.html Cycles:180 Average:70777.33 Median:39210.01 stddev:152059.99 (387.8%) stddev-sans-first:152394.95 05:25:15 INFO - PROCESS | 1924 | Values: 477.3 520.7 526.1 526.9 537.9 31436.5 41973.0 43189.8 43238.7 45567.1 44453.8 44868.3 44986.0 44987.0 45041.8 9760.8 9956.1 9961.2 9975.0 9993.8 8835.9 9091.6 11580.0 11875.5 11891.2 12119.5 12168.9 12182.1 12189.1 12220.8 12036.3 12071.3 12087.0 12100.0 12137.0 11884.5 11938.2 11953.8 11960.3 11981.3 41393.0 41685.4 41693.0 41877.6 41880.6 3431.8 3549.4 3566.3 3701.3 4141.9 31495.0 32637.0 32763.8 32911.7 32959.3 3171.1 3183.0 3236.8 3343.6 3369.4 484338.0 485519.0 486904.6 488356.0 488963.0 63362.0 63392.4 63539.0 63812.0 63906.4 67014.0 67195.0 67286.0 67300.7 67306.0 16396.4 16623.7 16626.6 16645.6 16660.0 11536.5 11808.1 12826.3 12885.6 12886.7 17910.7 18450.4 18625.6 18730.0 19055.6 6098.8 6171.9 6209.8 6224.1 6241.6 889.6 955.8 969.7 975.8 997.0 29876.3 30672.9 30792.4 30913.8 31533.4 998.4 1081.0 1100.7 1115.6 1212.2 12488.3 15706.8 15776.5 15909.9 16006.0 668130.0 672882.0 672958.6 673261.6 675156.0 59901.0 60092.0 60184.0 60257.7 60441.0 1234.9 1285.3 1350.9 1366.3 1400.6 27770.7 29380.7 31822.0 32221.8 32358.9 51981.0 52711.7 52735.9 52808.7 52821.7 529643.0 533484.0 533718.0 534253.0 534539.0 23936.5 26817.7 26893.5 27379.0 27703.9 38877.4 39846.8 49431.8 49438.3 51997.2 32904.8 37985.4 40923.0 41792.8 42234.6 39837.4 40377.8 40600.8 40732.0 42224.9 38954.0 39466.0 39576.0 39638.2 40129.2 34298.8 35338.0 35732.8 35878.5 36154.0 26073.3 26172.7 26259.5 26427.0 26680.7 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | [#2] jquery.html Cycles:180 Average:35001.85 Median:14652.50 stddev:100093.44 (683.1%) stddev-sans-first:100340.43 05:25:15 INFO - PROCESS | 1924 | Values: 356.4 372.9 378.5 383.7 403.7 15386.5 15652.5 19887.5 20202.8 20215.8 19480.5 19971.4 20063.0 20093.0 20796.4 5232.5 5888.1 6137.5 6146.1 6155.7 4262.2 4479.6 5976.1 6135.3 6259.5 6500.8 6570.1 6582.7 6592.3 6603.3 6324.2 6683.7 6724.9 6725.4 6727.1 5048.4 5559.1 5784.9 5796.2 5797.4 21434.2 21542.7 22182.3 26098.6 26478.0 2043.5 2827.0 3058.7 3078.9 3198.2 10020.2 10041.0 10242.5 10365.2 10471.3 1550.9 1850.0 1887.2 1925.0 1936.1 100739.5 110185.4 122826.0 127732.4 136165.0 11140.6 11469.7 11507.1 11539.8 11738.6 14455.9 14462.9 14464.6 14473.7 14483.6 6840.9 8014.2 8215.8 8366.5 8596.7 8395.8 8398.2 8407.8 8585.5 8619.3 4332.9 4416.8 4441.8 4505.5 4516.5 1634.7 1710.1 1787.6 1837.9 1886.9 861.8 889.8 892.2 903.9 941.9 20487.2 20584.7 20834.9 20868.7 21394.9 876.9 944.0 945.4 1000.1 1023.9 9469.9 10069.2 10425.0 10766.9 10939.6 581925.0 590498.0 599409.0 611749.0 612013.0 122530.0 129129.4 129357.0 130505.0 133829.0 956.5 965.4 979.5 981.9 983.1 14143.5 15587.7 18458.8 19288.8 19346.1 50408.0 51679.7 52057.0 52154.6 53023.0 76666.0 77439.0 78143.6 78274.0 79790.2 7109.8 8070.6 8086.7 8161.2 8411.0 11176.8 13310.0 13368.7 13739.9 13893.2 11312.4 11344.1 11810.1 11886.3 11888.7 11440.7 11562.9 11771.2 11800.5 12049.2 11300.4 11458.7 11538.9 12015.2 12030.5 7419.6 7542.2 7587.8 7598.9 7606.8 9388.4 11719.4 12000.6 12033.5 12041.4 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | [#3] mootools.html Cycles:180 Average:5713.34 Median:4883.80 stddev:3216.55 (65.9%) stddev-sans-first:3210.07 05:25:15 INFO - PROCESS | 1924 | Values: 1511.5 1546.6 1737.4 1864.9 1890.1 8338.9 8908.2 8911.8 8931.0 8941.9 7909.2 8060.4 8073.3 8442.0 8729.8 2336.9 2380.3 2388.0 2388.9 2391.8 2330.7 2374.5 2379.0 2382.1 2385.8 2339.1 2351.3 2352.4 2357.5 2386.8 2332.3 2347.2 2351.2 2358.3 2361.9 1885.4 1886.1 1887.8 1892.4 1893.8 8787.7 8794.2 8854.5 8923.9 8927.6 5126.4 5299.2 5303.2 5307.9 5315.6 3495.2 3496.5 3600.9 3646.5 3650.9 1075.6 1076.8 1079.0 1104.8 1108.6 11406.5 11626.4 11649.7 11656.0 11666.2 4515.3 4557.5 4754.5 4757.6 4762.1 9931.0 9947.5 9952.5 9955.6 9975.1 5322.9 5325.1 5326.2 5329.6 5330.3 3690.7 4337.0 4830.7 4868.1 4894.3 3902.6 3909.0 3933.1 3973.6 3987.1 1264.3 1271.4 1274.8 1284.6 1291.8 846.2 869.6 888.8 892.8 940.2 5596.8 5792.9 5900.7 5982.9 6084.3 949.6 957.1 959.7 967.1 1010.5 3931.0 4026.2 4030.2 4077.6 4109.4 10494.7 10901.4 10942.3 10942.5 10950.9 10271.9 10664.9 10698.9 10867.5 10876.9 8114.4 8349.1 8357.1 8359.4 8379.2 5846.0 5882.7 5902.3 6013.6 6074.3 9844.8 9902.4 10071.1 10151.2 10225.9 9396.0 9936.4 10212.5 10403.8 10414.7 7043.0 7424.3 7580.9 7618.5 7711.8 8233.4 8323.7 8342.6 8423.7 8463.6 7564.8 7589.9 7602.5 7638.6 7691.0 7407.7 7423.1 7466.9 7517.0 7581.6 6934.3 7000.4 7077.7 7078.1 7089.6 4716.2 4844.3 4873.3 4994.4 5108.4 4760.3 4856.7 5003.3 5064.7 5133.8 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | [#4] prototype.html Cycles:180 Average:4451.17 Median:5000.14 stddev:1370.00 (27.4%) stddev-sans-first:1337.88 05:25:15 INFO - PROCESS | 1924 | Values: 296.2 298.4 307.4 312.8 316.8 4828.9 4996.0 5185.7 5247.8 5369.5 4296.8 4832.3 4930.4 5133.9 5213.8 3697.6 3999.3 4018.5 4027.3 4029.5 3705.9 4037.3 4047.5 4058.6 4060.6 3357.2 3939.4 3966.5 3976.3 3980.3 3951.8 3960.6 3961.5 3992.2 3996.6 3043.6 3406.3 3457.3 3477.8 3482.7 3994.1 4854.8 4949.9 5088.9 5091.1 3785.4 3884.0 3972.7 4514.0 4556.4 4677.0 5015.8 5179.3 5454.9 5458.7 3158.6 3756.8 3790.3 3796.0 3806.0 5635.2 5776.7 5780.0 5793.2 5804.7 3672.9 3783.6 3783.8 4016.4 4017.6 3420.5 3754.8 3772.8 4057.9 4091.4 3974.8 4456.5 4519.9 4613.8 4614.6 4811.6 5463.4 5482.6 5506.1 5506.6 1153.9 1230.4 1312.6 1332.4 1333.7 814.3 870.3 903.8 950.2 950.5 4687.6 5033.3 5051.5 5055.7 5089.8 4964.4 4986.6 5535.8 5581.4 5683.9 4249.2 5030.3 5045.5 5058.4 5095.4 2407.7 2900.0 2928.8 2939.1 2942.7 5408.7 5484.6 5508.8 5604.4 5726.7 5592.6 5765.6 5882.5 5899.2 5912.0 4697.7 4961.6 5734.0 5903.6 5920.9 5339.9 5656.8 5706.9 5727.5 5735.0 4997.7 5633.1 5660.0 5680.7 5688.2 4854.6 5683.9 5859.8 5880.6 5935.6 3577.5 3810.2 3811.2 3811.5 3840.1 5713.0 5739.5 5757.0 5759.0 5763.2 4501.1 4688.7 5002.6 5169.4 5639.5 5426.3 5520.3 5526.7 5538.3 5562.8 5127.7 5250.8 5317.4 5374.4 5429.8 4733.5 5355.8 5513.6 5521.7 5541.4 5089.1 5372.9 5378.2 5386.5 5402.2 05:25:15 INFO - PROCESS | 1924 | 05:25:15 INFO - PROCESS | 1924 | [#5] yui.html Cycles:180 Average:25325.19 Median:3611.49 stddev:40725.16 (1127.7%) stddev-sans-first:40797.46 05:25:15 INFO - PROCESS | 1924 | Values: 706.9 723.7 774.0 777.0 863.7 15508.3 15816.3 16385.4 16387.8 16848.2 14741.8 15069.9 15078.0 15093.0 15182.7 692.6 721.8 835.4 861.6 867.1 843.5 869.2 880.4 881.2 882.8 929.7 932.7 934.4 934.6 936.1 711.5 883.0 925.3 927.8 929.0 681.2 681.8 683.0 684.2 684.6 15226.2 15271.2 15279.2 15281.7 15300.7 12710.4 13617.7 14240.1 14346.7 14418.1 12897.8 12943.9 12981.9 13196.9 13236.0 4596.8 4650.8 4743.9 4840.8 4845.0 96578.0 100000.0 100134.0 100903.0 104696.0 11226.9 11239.9 11241.2 11279.9 11621.8 21992.0 22071.8 22091.9 22142.0 22384.4 7930.5 7958.8 7991.1 8017.9 8088.9 3829.3 4416.2 4454.0 4500.2 4641.1 3426.5 3608.5 3614.5 3614.7 3614.8 657.0 661.7 664.4 668.7 673.5 546.4 547.0 575.9 589.2 600.7 8245.3 9259.3 9261.6 9322.0 9543.4 623.9 624.5 641.2 654.9 706.7 4005.8 4176.2 4625.2 4705.9 4788.6 136520.3 161164.0 161467.4 163595.7 165162.0 109444.0 146631.0 149842.0 150228.0 152433.0 87615.0 104864.4 107453.0 109076.9 109520.0 9701.3 9788.0 9941.8 9975.5 10083.4 60048.7 61637.0 62515.1 62884.4 64727.0 90528.0 94808.5 95869.5 97094.5 98165.0 12225.3 12333.9 12382.6 12640.7 12876.3 15074.5 15252.7 15502.8 15927.0 16092.8 13978.9 14033.6 14138.4 14346.7 14425.9 14067.8 14072.4 14095.9 14157.0 14238.0 11687.9 13527.9 13689.7 13934.2 14388.6 11065.7 11321.3 11423.0 11630.0 11736.6 11203.4 11425.7 11505.7 11600.2 11691.4 05:25:15 INFO - PROCESS | 1924 | -------- Summary: end -------- 05:25:15 INFO - PROCESS | 1924 | 05:25:16 INFO - TEST-INFO | 1924: exit 0 05:25:16 INFO - TEST-OK | dromaeo_css | took 1118545ms 05:25:16 INFO - TEST-START | kraken 05:25:16 INFO - operating with platform_type : mac_ 05:25:16 INFO - Initialising browser for kraken test... 05:25:16 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpIyLpYl/profile http://localhost:49462/getInfo.html) 05:25:18 INFO - PROCESS | 1932 | __metrics Screen width/height:1600/1200 05:25:18 INFO - PROCESS | 1932 | colorDepth:24 05:25:18 INFO - PROCESS | 1932 | Browser inner width/height: 1024/689 05:25:18 INFO - PROCESS | 1932 | __metrics 05:25:18 INFO - PROCESS | 1932 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:25:18 INFO - PROCESS | 1932 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:19 INFO - TEST-INFO | 1932: exit 0 05:25:19 INFO - Browser initialized. 05:25:19 INFO - Running cycle 1/1 for kraken test... 05:25:19 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpIyLpYl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:30 INFO - PROCESS | 1933 | RSS: Main: 243580928 05:25:30 INFO - PROCESS | 1933 | 05:25:33 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:34 INFO - PROCESS | 1933 | RSS: Main: 294137856 05:25:34 INFO - PROCESS | 1933 | 05:25:37 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-dft) 05:25:37 INFO - PROCESS | 1933 | RSS: Main: 300949504 05:25:37 INFO - PROCESS | 1933 | 05:25:41 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-fft) 05:25:42 INFO - PROCESS | 1933 | RSS: Main: 399425536 05:25:42 INFO - PROCESS | 1933 | 05:25:44 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator) 05:25:44 INFO - PROCESS | 1933 | RSS: Main: 300265472 05:25:44 INFO - PROCESS | 1933 | 05:25:46 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:47 INFO - PROCESS | 1933 | RSS: Main: 304877568 05:25:47 INFO - PROCESS | 1933 | 05:25:50 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:50 INFO - PROCESS | 1933 | RSS: Main: 343814144 05:25:50 INFO - PROCESS | 1933 | 05:25:53 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:54 INFO - PROCESS | 1933 | RSS: Main: 342827008 05:25:54 INFO - PROCESS | 1933 | 05:25:57 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial) 05:25:57 INFO - PROCESS | 1933 | RSS: Main: 340918272 05:25:57 INFO - PROCESS | 1933 | 05:25:59 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:00 INFO - PROCESS | 1933 | RSS: Main: 314310656 05:26:00 INFO - PROCESS | 1933 | 05:26:01 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:02 INFO - PROCESS | 1933 | RSS: Main: 318345216 05:26:02 INFO - PROCESS | 1933 | 05:26:04 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:05 INFO - PROCESS | 1933 | RSS: Main: 323584000 05:26:05 INFO - PROCESS | 1933 | 05:26:08 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:09 INFO - PROCESS | 1933 | RSS: Main: 330702848 05:26:09 INFO - PROCESS | 1933 | 05:26:12 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:12 INFO - PROCESS | 1933 | RSS: Main: 332009472 05:26:12 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49462/tests/kraken/driver.html?testName=ai-astar) 05:26:14 INFO - PROCESS | 1933 | RSS: Main: 374980608 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | __start_tp_report 05:26:14 INFO - PROCESS | 1933 | _x_x_mozilla_page_load 05:26:14 INFO - PROCESS | 1933 | _x_x_mozilla_page_load_details 05:26:14 INFO - PROCESS | 1933 | |i|pagename|runs| 05:26:14 INFO - PROCESS | 1933 | |0;ai-astar;100;114;112;113;113;118;163;163;112;113 05:26:14 INFO - PROCESS | 1933 | |1;audio-beat-detection;140;108;106;166;109;105;128;106;135;108 05:26:14 INFO - PROCESS | 1933 | |2;audio-dft;185;183;184;193;183;184;192;236;213;182 05:26:14 INFO - PROCESS | 1933 | |3;audio-fft;80;58;61;87;59;57;65;62;82;59 05:26:14 INFO - PROCESS | 1933 | |4;audio-oscillator;83;69;101;70;88;67;97;74;67;101 05:26:14 INFO - PROCESS | 1933 | |5;imaging-gaussian-blur;117;128;88;86;88;86;128;85;89;91 05:26:14 INFO - PROCESS | 1933 | |6;imaging-darkroom;92;94;131;147;129;93;95;94;94;94 05:26:14 INFO - PROCESS | 1933 | |7;imaging-desaturate;86;90;86;85;85;84;86;86;86;83 05:26:14 INFO - PROCESS | 1933 | |8;json-parse-financial;55;52;53;53;53;54;53;53;53;54 05:26:14 INFO - PROCESS | 1933 | |9;json-stringify-tinderbox;63;72;69;68;74;72;70;69;69;70 05:26:14 INFO - PROCESS | 1933 | |10;stanford-crypto-aes;84;83;74;83;95;91;92;86;84;79 05:26:14 INFO - PROCESS | 1933 | |11;stanford-crypto-ccm;138;161;145;146;133;125;145;145;154;140 05:26:14 INFO - PROCESS | 1933 | |12;stanford-crypto-pbkdf2;167;167;169;170;170;167;222;216;168;167 05:26:14 INFO - PROCESS | 1933 | |13;stanford-crypto-sha256-iterative;68;65;68;67;67;67;66;68;71;84 05:26:14 INFO - PROCESS | 1933 | __end_tp_report 05:26:14 INFO - PROCESS | 1933 | __start_cc_report 05:26:14 INFO - PROCESS | 1933 | _x_x_mozilla_cycle_collect,2031 05:26:14 INFO - PROCESS | 1933 | __end_cc_report 05:26:14 INFO - PROCESS | 1933 | __startTimestamp1470659174696__endTimestamp 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | ------- Summary: start ------- 05:26:14 INFO - PROCESS | 1933 | Number of tests: 14 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#0] ai-astar Cycles:10 Average:122.10 Median:113.50 stddev:22.03 (19.4%) stddev-sans-first:21.87 05:26:14 INFO - PROCESS | 1933 | Values: 100.0 114.0 112.0 113.0 113.0 118.0 163.0 163.0 112.0 113.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:118.50 stddev:20.60 (17.4%) stddev-sans-first:20.68 05:26:14 INFO - PROCESS | 1933 | Values: 140.0 108.0 106.0 166.0 109.0 105.0 128.0 106.0 135.0 108.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#2] audio-dft Cycles:10 Average:193.50 Median:188.50 stddev:17.62 (9.3%) stddev-sans-first:18.42 05:26:14 INFO - PROCESS | 1933 | Values: 185.0 183.0 184.0 193.0 183.0 184.0 192.0 236.0 213.0 182.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#3] audio-fft Cycles:10 Average:67.00 Median:63.50 stddev:11.39 (17.9%) stddev-sans-first:11.07 05:26:14 INFO - PROCESS | 1933 | Values: 80.0 58.0 61.0 87.0 59.0 57.0 65.0 62.0 82.0 59.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:72.00 stddev:14.18 (19.7%) stddev-sans-first:15.03 05:26:14 INFO - PROCESS | 1933 | Values: 83.0 69.0 101.0 70.0 88.0 67.0 97.0 74.0 67.0 101.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#5] imaging-gaussian-blur Cycles:10 Average:98.60 Median:87.00 stddev:18.09 (20.8%) stddev-sans-first:17.92 05:26:14 INFO - PROCESS | 1933 | Values: 117.0 128.0 88.0 86.0 88.0 86.0 128.0 85.0 89.0 91.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:94.00 stddev:20.81 (22.1%) stddev-sans-first:21.42 05:26:14 INFO - PROCESS | 1933 | Values: 92.0 94.0 131.0 147.0 129.0 93.0 95.0 94.0 94.0 94.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.83 (2.1%) stddev-sans-first:1.94 05:26:14 INFO - PROCESS | 1933 | Values: 86.0 90.0 86.0 85.0 85.0 84.0 86.0 86.0 86.0 83.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.60 05:26:14 INFO - PROCESS | 1933 | Values: 55.0 52.0 53.0 53.0 53.0 54.0 53.0 53.0 53.0 54.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:2.95 (4.2%) stddev-sans-first:1.94 05:26:14 INFO - PROCESS | 1933 | Values: 63.0 72.0 69.0 68.0 74.0 72.0 70.0 69.0 69.0 70.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:6.26 (7.4%) stddev-sans-first:6.63 05:26:14 INFO - PROCESS | 1933 | Values: 84.0 83.0 74.0 83.0 95.0 91.0 92.0 86.0 84.0 79.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:145.00 stddev:10.13 (7.0%) stddev-sans-first:10.57 05:26:14 INFO - PROCESS | 1933 | Values: 138.0 161.0 145.0 146.0 133.0 125.0 145.0 145.0 154.0 140.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:169.50 stddev:21.53 (12.7%) stddev-sans-first:22.44 05:26:14 INFO - PROCESS | 1933 | Values: 167.0 167.0 169.0 170.0 170.0 167.0 222.0 216.0 168.0 167.0 05:26:14 INFO - PROCESS | 1933 | 05:26:14 INFO - PROCESS | 1933 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:68.00 stddev:5.47 (8.0%) stddev-sans-first:5.78 05:26:14 INFO - PROCESS | 1933 | Values: 68.0 65.0 68.0 67.0 67.0 67.0 66.0 68.0 71.0 84.0 05:26:14 INFO - PROCESS | 1933 | -------- Summary: end -------- 05:26:14 INFO - PROCESS | 1933 | 05:26:15 INFO - TEST-INFO | 1933: exit 0 05:26:15 INFO - TEST-OK | kraken | took 59530ms 05:26:15 INFO - SUITE-END | took 1178s 05:26:15 INFO - Completed test suite (00:19:38) 05:26:15 INFO - javascript benchmark 05:26:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.83605819709, 3310.337932413518, 3322.601287845459, 3329.400707872585, 3365.2596428785673, 5573.470520300575, 5627.887442251153, 5673.8581535461635, 5737.971310143449, 5796.275465566799, 5645.887082258352, 5685.0, 5698.971505142479, 5760.48155665991, 5807.506361959228, 5106.719130447824, 5131.743412829363, 5170.767315470813, 5182.844514664547, 5287.788488460457, 5300.204969254623, 5320.787168513255, 5329.840104796862, 5334.0, 5373.785048598052, 5095.363079615048, 5132.743362831843, 5150.510701483353, 5179.689218646856, 5262.999999999981, 5147.3051138096625, 5162.22566615007, 5279.788808447657, 5313.176457649032, 5313.548348390392, 5145.691258524501, 5164.793408263702, 5170.482951704837, 5197.948020519784, 5247.39654939683, 5571.609987300891, 5675.20547123399, 5692.601517893749, 5752.9712351437975, 5758.6544807311275, 6118.3269840317525, 6132.110769107974, 6155.292141403751, 6165.075238714184, 6200.689965501707, 6211.782587609412, 6251.218597675291, 6307.558470907038, 6312.368763123697, 6316.084167795644, 5639.915401268984, 5687.914681279702, 5817.360090390053, 5825.679587622637, 5829.067349224104, 6309.873802524015, 6313.05304204373, 6317.0, 6333.556651034383, 6343.302236753953, 6102.23403990958, 6104.755809767648, 6111.5309653553995, 6114.633122012693, 6117.541184411187, 5690.231818704422, 6225.097360882647, 6243.43809057187, 6251.874962500816, 6252.843678908063, 5734.111212762028, 6055.818325450244, 6103.267607886994, 6119.632822030692, 6136.969315153485, 6130.6628135452975, 6161.168242287324, 6172.351903050115, 6173.41352571505, 6186.257649082139, 4919.532644398776, 4926.630502712311, 4927.359443272351, 4930.408350997904, 4935.679180853305, 4364.9305920049155, 4368.191884501377, 4378.8905277367685, 4435.911281774411, 4448.4439445069365, 5659.971700141473, 5667.518260947865, 5670.06443936754, 5677.0, 5736.053551164011, 6279.309275979638, 6291.842703932347, 6299.6850157491945, 6305.495560355161, 6314.494840412848, 5515.696636685021, 5580.972095139579, 5588.832335029955, 5653.208550802891, 5655.4344565543115, 5412.675239485643, 5414.485623865727, 5431.8098866539485, 5436.157395603688, 5450.591205659592, 6263.906041409383, 6292.465140463112, 6297.685115744102, 6318.210223722035, 6322.589031712924, 5035.471275516018, 6161.630302181883, 6165.0, 6244.438000579969, 6246.1255424239735, 5176.767045483038, 6274.309825919054, 6283.434490895841, 6285.371462853678, 6294.150289711014, 6110.877782444415, 6113.144159817718, 6131.785387511416, 6132.9080063799975, 6144.600600960924, 5108.693478391308, 6103.664298463449, 6110.589135957228, 6208.844778880564, 6257.124002639725, 6035.0, 6057.454829065406, 6074.848128796815, 6097.0, 6132.264128304632, 4919.237518184687, 5981.663796450354, 6035.78874739382, 6039.879202415839, 6059.303180134341, 5687.715614219355, 5729.9713501432225, 5793.8551536211935, 5827.300723912988, 5891.381404952418, 6049.485793707584, 6049.78825741097, 6057.333693293822, 6066.757329706762, 6107.694615269308, 5882.088276317178, 5883.235179426647, 5884.499817515388, 5886.381929897299, 5915.08316210988], "value": 5652.955018009527, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.2578640214465, 520.695393194981, 526.1423879077104, 526.8935236004389, 537.878977230123, 31436.52845207324, 41973.0, 43189.784051079776, 43238.70283891484, 45567.088658226814, 44453.77773111138, 44868.3269750954, 44986.0, 44987.0, 45041.774791126, 9760.804783904317, 9956.054174853378, 9961.203103751719, 9974.950125249363, 9993.750156246115, 8835.867461988075, 9091.590878410487, 11580.0, 11875.52497900083, 11891.167618266725, 12119.515219391214, 12168.878311216908, 12182.086343524226, 12189.146759726822, 12220.816687749691, 12036.338001409918, 12071.336076515789, 12087.033037357078, 12100.031997440272, 12137.029037676964, 11884.465199066062, 11938.164328497009, 11953.760924781544, 11960.34218118003, 11981.341026243554, 41392.96517587084, 41685.37471937893, 41693.0, 41877.581224187976, 41880.58119418797, 3431.811250381228, 3549.361114999299, 3566.3045706087064, 3701.296753616831, 4141.875743727693, 31495.0, 32637.0, 32763.83618081918, 32911.67088329134, 32959.340813183844, 3171.1279398165457, 3182.9681703182905, 3236.8219747913854, 3343.6154842193214, 3369.393509168349, 484338.0, 485519.0, 486904.56547717034, 488356.0, 488963.0, 63362.0, 63392.36607633957, 63539.0, 63812.0, 63906.36093639004, 67013.99479007818, 67194.9920751189, 67286.0, 67300.6634966822, 67306.0, 16396.426125085804, 16623.6675266494, 16626.58433539171, 16645.583860403585, 16660.0, 11536.538538458535, 11808.055355571534, 12826.294553799631, 12885.613431597067, 12886.67783305425, 17910.656700747495, 18450.35423760189, 18625.627487450176, 18729.96985165829, 19055.61888762217, 6098.817035488943, 6171.907421388682, 6209.751609935643, 6224.128621992924, 6241.625502469867, 889.6352495476953, 955.8183945050419, 969.6945462179391, 975.8243516167158, 997.0428388746884, 29876.253093672833, 30672.859164012574, 30792.384152316827, 30913.84543077315, 31533.369332613678, 998.4159266828841, 1080.9675709728722, 1100.708312297242, 1115.59838458155, 1212.1998831734866, 12488.313142777053, 15706.764398534031, 15776.526704198892, 15909.920450397905, 16006.0, 668130.0, 672882.0, 672958.6352068306, 673261.6336918382, 675156.0, 59901.0, 60092.0, 60184.0, 60257.698711506164, 60441.0, 1234.851817781854, 1285.254552359629, 1350.8851747601564, 1366.3304980559453, 1400.5588239704462, 27770.722292776813, 29380.706192937796, 31822.0, 32221.838890805397, 32358.90824413513, 51981.0, 52711.68220794511, 52735.94528109493, 52808.67978300573, 52821.7358913203, 529643.0, 533484.0, 533718.0, 534253.0, 534539.0, 23936.52126957486, 26817.731822681522, 26893.462130757667, 27379.0, 27703.861480692467, 38877.416838746874, 39846.800765995984, 49431.76420589514, 49438.258426124354, 51997.220041698645, 32904.84833030833, 37985.43021854619, 40923.043082675424, 41792.791036044626, 42234.57765422307, 39837.40243896286, 40377.78866634006, 40600.79699601483, 40732.0, 42224.944376390835, 38954.0, 39466.013349666486, 39576.0, 39638.2072358557, 40129.1974160521, 34298.82850585731, 35338.0, 35732.82133589315, 35878.46182307215, 36154.0, 26073.348166295993, 26172.738272617793, 26259.474810504063, 26427.0, 26680.733192667823], "value": 20691.54891698879, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.3532189076827, 372.91236559408514, 378.5381834162322, 383.7486446377622, 403.7113463873332, 15386.461473848403, 15652.530424087281, 19887.50281242966, 20202.797972020275, 20215.79784202156, 19480.512987175327, 19971.400857974248, 20062.99685015747, 20093.0, 20796.376108716726, 5232.45059268777, 5888.1462187982825, 6137.508999280047, 6146.108814221935, 6155.661438620874, 4262.1688770689725, 4479.552044795527, 5976.073708575178, 6135.294441139259, 6259.530535209855, 6500.837479063038, 6570.1458810354825, 6582.670866456682, 6592.3407659233935, 6603.250138713245, 6324.177856878599, 6683.732650693942, 6724.865502689968, 6725.361090696425, 6727.058211850345, 5048.368953880765, 5559.054960656657, 5784.913226301609, 5796.2464879565805, 5797.391273916262, 21434.24980125688, 21542.676859847114, 22182.336324775708, 26098.608520872203, 26478.0, 2043.5095577061397, 2827.0, 3058.7247147756807, 3078.9076327710204, 3198.18446296193, 10020.198384129251, 10041.033791652257, 10242.487875606264, 10365.170786337076, 10471.267011309212, 1550.8914375993686, 1849.9722504162448, 1887.226237242724, 1924.9711254331196, 1936.1480948382666, 100739.49630251802, 110185.44907275413, 122826.0, 127732.36133819364, 136165.0, 11140.554377824958, 11469.655910322703, 11507.07943364529, 11539.826902596467, 11738.647840564796, 14455.85544144545, 14462.927685361716, 14464.566063018126, 14473.710525789425, 14483.565493035227, 6840.863182736317, 8014.19858014194, 8215.7946051348, 8366.456180348257, 8596.742097736953, 8395.832083358298, 8398.244158025807, 8407.831843363221, 8585.527795971157, 8619.267362274277, 4332.870013899588, 4416.84541041062, 4441.755703436277, 4505.526919673387, 4516.525764794649, 1634.6975809475284, 1710.1192885663893, 1787.6335351252962, 1837.8897266164072, 1886.867919245667, 861.7802460372565, 889.7597648634833, 892.1658249536704, 903.8915330160291, 941.915227629503, 20487.180512779323, 20584.691229631568, 20834.895825520776, 20868.686969695467, 21394.893025534773, 876.8553188723789, 944.0, 945.385499425379, 1000.1498726082772, 1023.948802559869, 9469.90530094704, 10069.244806639532, 10425.0, 10766.89233107659, 10939.56241750337, 581925.0, 590498.0, 599409.0, 611749.0, 612013.0, 122530.0, 129129.35435322952, 129357.0, 130505.0, 133829.0, 956.5121787888088, 965.4496936745987, 979.5445118020298, 981.9263555233387, 983.0857302708407, 14143.504977325743, 15587.688246234786, 18458.81541184571, 19288.8071119287, 19346.129424175666, 50408.0, 51679.74160129326, 52057.0, 52154.56686181717, 53023.0, 76666.0, 77439.0, 78143.6092819555, 78274.0, 79790.2020979806, 7109.82225444368, 8070.636821342936, 8086.676532938852, 8161.224683655043, 8411.032731235986, 11176.776464470828, 13310.001749868992, 13368.732625347633, 13739.931300343434, 13893.166410015432, 11312.377819220023, 11344.149188810707, 11810.05519558416, 11886.28682279066, 11888.702782430508, 11440.656780296604, 11562.88437115618, 11771.176017678681, 11800.52797888075, 12049.156559040783, 11300.43497825089, 11458.656240312805, 11538.88461115378, 12015.158938874194, 12030.518779248732, 7419.554826710415, 7542.170361260147, 7587.772366829004, 7598.924010759822, 7606.771796846104, 9388.436693798394, 11719.414029298672, 12000.57997970067, 12033.518659253532, 12041.397930103634], "value": 9568.96761694827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.5389806109135, 1546.6133466633341, 1737.357177844197, 1864.8508119350454, 1890.0833095948462, 8338.91661083389, 8908.198262156404, 8911.777205569864, 8931.0, 8941.91058089419, 7909.24862138096, 8060.435769496123, 8073.273405393514, 8441.957790211056, 8729.825403491926, 2336.9298921032355, 2380.33350661815, 2388.008976274844, 2388.916387926423, 2391.784739373456, 2330.650402439639, 2374.525094981002, 2379.0127097254704, 2382.059086660768, 2385.8091352691745, 2339.087755775249, 2351.318117745852, 2352.4118970257437, 2357.481354102095, 2386.8209884258663, 2332.288651961151, 2347.1902193743217, 2351.2240960483, 2358.337372152637, 2361.881905904715, 1885.3966730646061, 1886.1323791056132, 1887.7923428423, 1892.4228110426313, 1893.8011508791517, 8787.692430764957, 8794.164554367326, 8854.513001784899, 8923.910760892373, 8927.642894284221, 5126.436092029874, 5299.1786273127345, 5303.204519322094, 5307.946920530784, 5315.627906046579, 3495.178633021238, 3496.4755286707195, 3600.945985810215, 3646.453032045188, 3650.8539658413633, 1075.569772091162, 1076.7738774857212, 1079.0180935348874, 1104.7679987202698, 1108.5953626926193, 11406.486708098073, 11626.360550169737, 11649.650510484615, 11656.0, 11666.241694289844, 4515.254982927846, 4557.544245575482, 4754.453237877619, 4757.5718185363485, 4762.142814293391, 9930.950345248371, 9947.452890091114, 9952.502374881227, 9955.55200016001, 9975.052370024836, 5322.92015619766, 5325.068113080273, 5326.227696983916, 5329.573634109262, 5330.333708286465, 3690.7134316460647, 4336.956630433655, 4830.686005409637, 4868.075065737498, 4894.2658601210105, 3902.6487616114687, 3908.9804550977633, 3933.095388060762, 3973.562908080109, 3987.1228329767987, 1264.3385673158054, 1271.4107365792759, 1274.7705413025558, 1284.640300715801, 1291.7933130699043, 846.1665259719172, 869.56087175977, 888.8488956877346, 892.7857314244535, 940.2290122099812, 5596.832095037155, 5792.855178620568, 5900.675462849498, 5982.910256346158, 6084.269887613426, 949.6296444386695, 957.0764212534938, 959.6737109382843, 967.1489089601106, 1010.5402042070987, 3930.9869149046663, 4026.174634199982, 4030.1939612077704, 4077.594219410503, 4109.404136400205, 10494.68515944523, 10901.400422976654, 10942.288751231144, 10942.45287735626, 10950.904909509145, 10271.94864025675, 10664.893351066545, 10698.946505267579, 10867.510962006729, 10876.891231087746, 8114.350851931831, 8349.081601023883, 8357.12250213731, 8359.414840961195, 8379.162083791694, 5845.970770146122, 5882.676452795137, 5902.321233058082, 6013.609115407485, 6074.3318234994995, 9844.803103938024, 9902.405855648683, 10071.143952763805, 10151.187904967437, 10225.897741022494, 9396.0, 9936.403815771077, 10212.489375531046, 10403.791924161626, 10414.739631509274, 7042.964785176041, 7424.331810137113, 7580.924190758243, 7618.504797188165, 7711.807204819925, 8233.423660343959, 8323.667053318042, 8342.624581893951, 8423.747287581382, 8463.57682115904, 7564.773056808304, 7589.886151707839, 7602.46782725204, 7638.618069096634, 7690.961545192238, 7407.666655000646, 7423.146338171179, 7466.887996679946, 7516.962415187889, 7581.583012934341, 6934.306569343025, 7000.369966703021, 7077.68150433242, 7078.079849619517, 7089.574625522278, 4716.174669432767, 4844.32179494864, 4873.342098816756, 4994.425641051325, 5108.412532558803, 4760.285957106462, 4856.708597484162, 5003.299538064746, 5064.670796398223, 5133.820316288912], "value": 4581.977348150555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.18548990276724, 298.4195739287087, 307.40977323538795, 312.7732394014341, 316.7988327412094, 4828.903421931568, 4995.950040499594, 5185.662931909424, 5247.790088396459, 5369.5435887949525, 4296.753941357003, 4832.323474713543, 4930.408350997876, 5133.871653208672, 5213.791448342062, 3697.6487233712824, 3999.340108882031, 4018.4976877890263, 4027.335489644205, 4029.536603290615, 3705.906757506542, 4037.2934736421007, 4047.5345335286524, 4058.6144316289906, 4060.634542891139, 3357.194273374385, 3939.428782826503, 3966.4645272888224, 3976.284268831609, 3980.3432433648413, 3951.7826519541413, 3960.6237407446247, 3961.514432087967, 3992.201559688074, 3996.580359062286, 3043.5738996540504, 3406.2846802171575, 3457.343104810078, 3477.7739446935866, 3482.703970162539, 3994.0613955720673, 4854.805807767685, 4949.851504454872, 5088.898222035538, 5091.134507133796, 3785.3754130568423, 3883.990162557727, 3972.66232370246, 4514.0, 4556.3621093047, 4677.0, 5015.799368025275, 5179.326687530634, 5454.91817622732, 5458.727063646802, 3158.6367567729776, 3756.7745935243975, 3790.3177428063213, 3796.0130366104736, 3805.9809700951596, 5635.21107045014, 5776.682282474462, 5779.9655181029875, 5793.2179155814265, 5804.651720896802, 3672.908177295589, 3783.6027217142355, 3783.7729736215915, 4016.4176194452225, 4017.5580686124504, 3420.538227339327, 3754.81225938702, 3772.75477093988, 4057.878263652095, 4091.4272001919753, 3974.7615143091507, 4456.487503937024, 4519.870032491877, 4613.838515651936, 4614.607758340511, 4811.615070794328, 5463.394159854477, 5482.643628164156, 5506.063969125258, 5506.5870059744875, 1153.9134564907665, 1230.4155526125019, 1312.6324629103867, 1332.433715670836, 1333.6599167212298, 814.3078383374085, 870.2515836380708, 903.7876099116702, 950.1686024728363, 950.5484894674975, 4687.5781179693995, 5033.295338652591, 5051.545360917462, 5055.69665820052, 5089.770960306795, 4964.393693310968, 4986.601071914238, 5535.806246781343, 5581.413951535112, 5683.886322273532, 4249.151619045725, 5030.320906677625, 5045.5459008689395, 5058.418281897555, 5095.414027386824, 2407.7231118421255, 2899.9565006524917, 2928.7656987440955, 2939.1476471823357, 2942.6910174431805, 5408.702521361363, 5484.588655850827, 5508.807191748269, 5604.355499117572, 5726.742296596663, 5592.608517403743, 5765.596408251382, 5882.470497716734, 5899.233099697012, 5911.9704401478575, 4697.741624210633, 4961.578265847444, 5734.0, 5903.553629360834, 5920.851978700481, 5339.866503337447, 5656.773729050792, 5706.942930570641, 5727.541796656341, 5735.0, 4997.675151115166, 5633.0987042073075, 5660.0, 5680.6875621839545, 5688.232088667977, 4854.563089321978, 5683.943160568341, 5859.794907178399, 5880.617759845596, 5935.643861368331, 3577.4633804929467, 3810.1998580298446, 3811.1615444602144, 3811.5426148862316, 3840.1007239533974, 5713.0, 5739.540836733135, 5756.971215143897, 5758.971205143947, 5763.221965034834, 4501.122281155274, 4688.742119183477, 5002.599792016703, 5169.353830771153, 5639.54883609302, 5426.348838139448, 5520.337559492726, 5526.696031718133, 5538.252335934597, 5562.777488900399, 5127.66670166438, 5250.789968401221, 5317.441668624739, 5374.355077390738, 5429.805442802577, 4733.502982186958, 5355.759765342068, 5513.558915286687, 5521.723913804374, 5541.418151094077, 5089.071084105332, 5372.892542149213, 5378.19327100938, 5386.461353864739, 5402.216678581663], "value": 4017.0816068484605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.8762966480865, 723.6888138100618, 773.992260077399, 776.9728059517918, 863.7451951674255, 15508.302126404311, 15816.288267027983, 16385.42651007215, 16387.75418368724, 16848.241829117687, 14741.778873316909, 15069.92465037676, 15078.0, 15093.0, 15182.696346073071, 692.5844493304003, 721.7690339091492, 835.377643655476, 861.6122744764849, 867.0852250875324, 843.4686147726924, 869.2394155114275, 880.4189235104832, 881.2113158722939, 882.7704796752859, 929.6746138851382, 932.6595792535743, 934.4299977014016, 934.6308208257734, 936.1247233836385, 711.4983936324878, 883.0330787787427, 925.282905748044, 927.7634203278188, 928.9535523223846, 681.2166009089538, 681.8465845184843, 683.0335075867641, 684.1687349869882, 684.5653010338422, 15226.238688065663, 15271.160086195256, 15279.236038198045, 15281.694366112726, 15300.693986120326, 12710.364481775874, 13617.727645447036, 14240.074395164282, 14346.713065738732, 14418.13491190532, 12897.806532902014, 12943.935280323538, 12981.935090324583, 13196.86803131966, 13236.0, 4596.7931443085145, 4650.767461626905, 4743.928841067387, 4840.806367745286, 4844.951550484485, 96578.0, 100000.0, 100134.0, 100903.0, 104696.0, 11226.943865280784, 11239.920614686309, 11241.21311508203, 11279.874135304417, 11621.825672614917, 21992.0, 22071.779282207295, 22091.889540552194, 22142.0, 22384.440388990406, 7930.484518506279, 7958.840823183504, 7991.120976692559, 8017.879731804028, 8088.878666820003, 3829.291581057513, 4416.205083085011, 4454.0, 4500.212462818994, 4641.071785642885, 3426.4860270959557, 3608.5128507651657, 3614.475900994341, 3614.728895332808, 3614.8373323200517, 656.9835754106185, 661.6658587413422, 664.4485077385758, 668.6957434367351, 673.4780545077506, 546.3553007451167, 547.0290234833203, 575.8646718021262, 589.2487078974342, 600.7206648908191, 8245.299149572353, 9259.30555208362, 9261.591986083668, 9321.95339023314, 9543.379680320757, 623.9361887980981, 624.4941597306197, 641.201703878674, 654.9377809108128, 706.6713978000255, 4005.759654420744, 4176.206520761046, 4625.167469855458, 4705.858824235278, 4788.569028787356, 136520.34796520468, 161164.0, 161467.4222661991, 163595.72808544, 165162.0, 109444.0, 146631.0, 149842.0, 150228.0, 152433.0, 87615.0, 104864.42703359456, 107453.0, 109076.90923090668, 109520.0, 9701.320907536405, 9787.951060244653, 9941.801163976825, 9975.501224938578, 10083.445410502492, 60048.69975650268, 61637.0, 62515.06227406683, 62884.37115628785, 64727.02909456268, 90528.0, 94808.52595736977, 95869.5206523963, 97094.51452742692, 98165.0, 12225.327606981702, 12333.93833030829, 12382.56661016896, 12640.74718505643, 12876.291803950498, 15074.54776356711, 15252.656539899976, 15502.767458487906, 15927.0, 16092.839071609602, 13978.930105349407, 14033.578992630237, 14138.363773630417, 14346.713065738835, 14425.85574144287, 14067.805906962645, 14072.437102515785, 14095.929520352332, 14157.0, 14238.0, 11687.941560292144, 13527.932360338134, 13689.726205475636, 13934.163950163023, 14388.640283992983, 11065.668029959113, 11321.320720756452, 11423.029042531478, 11630.0, 11736.647900562997, 11203.439828008404, 11425.657230283105, 11505.654830355103, 11600.245984011011, 11691.356975366436], "value": 7970.567565372474, "unit": "score"}], "name": "dromaeo_css", "value": 7400.126612110146, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 114.0, 112.0, 113.0, 113.0, 118.0, 163.0, 163.0, 112.0, 113.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 106.0, 166.0, 109.0, 105.0, 128.0, 106.0, 135.0, 108.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 184.0, 193.0, 183.0, 184.0, 192.0, 236.0, 213.0, 182.0], "value": 193.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 61.0, 87.0, 59.0, 57.0, 65.0, 62.0, 82.0, 59.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 101.0, 70.0, 88.0, 67.0, 97.0, 74.0, 67.0, 101.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 128.0, 88.0, 86.0, 88.0, 86.0, 128.0, 85.0, 89.0, 91.0], "value": 98.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 131.0, 147.0, 129.0, 93.0, 95.0, 94.0, 94.0, 94.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 86.0, 85.0, 85.0, 84.0, 86.0, 86.0, 86.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 69.0, 68.0, 74.0, 72.0, 70.0, 69.0, 69.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 74.0, 83.0, 95.0, 91.0, 92.0, 86.0, 84.0, 79.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 161.0, 145.0, 146.0, 133.0, 125.0, 145.0, 145.0, 154.0, 140.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 169.0, 170.0, 170.0, 167.0, 222.0, 216.0, 168.0, 167.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 67.0, 67.0, 67.0, 66.0, 68.0, 71.0, 84.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1474.6, "alertThreshold": 2.0}]} 05:26:15 INFO - Return code: 0 05:26:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:26:15 INFO - # TBPL SUCCESS # 05:26:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:15 INFO - 2016-08-08 05:26:15.963 screenresolution[1937:11911] starting screenresolution argv=screenresolution get 05:26:15 INFO - 2016-08-08 05:26:15.967 screenresolution[1937:11911] Display 0: 1600x1200x32@60 05:26:15 INFO - 2016-08-08 05:26:15.973 screenresolution[1938:11914] starting screenresolution argv=screenresolution list 05:26:15 INFO - Available Modes on Display 0 05:26:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:16 INFO - Intel Iris: 05:26:16 INFO - Chipset Model: Intel Iris 05:26:16 INFO - Type: GPU 05:26:16 INFO - Bus: Built-In 05:26:16 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:16 INFO - Vendor: Intel (0x8086) 05:26:16 INFO - Device ID: 0x0a2e 05:26:16 INFO - Revision ID: 0x0009 05:26:16 INFO - Displays: 05:26:16 INFO - Display: 05:26:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:16 INFO - Display Serial Number: 1600x1200 60 05:26:16 INFO - Main Display: Yes 05:26:16 INFO - Mirror: Off 05:26:16 INFO - Online: Yes 05:26:16 INFO - Rotation: Supported 05:26:16 INFO - Return code: 0 05:26:16 INFO - Running post-action listener: _resource_record_post_action 05:26:16 INFO - [mozharness: 2016-08-08 12:26:16.211307Z] Finished run-tests step (success) 05:26:16 INFO - Running post-run listener: _resource_record_post_run 05:26:16 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 2007040; Write bytes: 707656704; Read time: 22; Write time: 1944 05:26:16 INFO - TinderboxPrint: CPU usage
53.6% 05:26:16 INFO - TinderboxPrint: I/O read bytes / time
2,007,040 / 22 05:26:16 INFO - TinderboxPrint: I/O write bytes / time
707,656,704 / 1,944 05:26:16 INFO - TinderboxPrint: CPU idle
2,253.9 (46.4%) 05:26:16 INFO - TinderboxPrint: CPU system
972.0 (20.0%) 05:26:16 INFO - TinderboxPrint: CPU user
1,627.8 (33.5%) 05:26:16 INFO - TinderboxPrint: Swap in / out
410,222,592 / 0 05:26:16 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391967232; Write bytes: 386365440; Read time: 29294; Write time: 789 05:26:16 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1998848; Write bytes: 298099712; Read time: 21; Write time: 1098 05:26:16 INFO - Running post-run listener: _upload_blobber_files 05:26:16 INFO - Blob upload gear active. 05:26:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:16 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 05:26:16 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'] 05:26:16 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 05:26:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:18 INFO - (blobuploader) - INFO - Done attempting. 05:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:19 INFO - (blobuploader) - INFO - Done attempting. 05:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:22 INFO - (blobuploader) - INFO - Done attempting. 05:26:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:22 INFO - Return code: 0 05:26:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8a22ae7482667e1a111ee9e85789142cc8bc21f9b1c989598fb4fddc890433b6da2e4dc57bd4c3be4252617407cbd557aa63415885b430b737ba5e834092dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f52f4207b59f26fa769a56ac689bfc6bc49dd12fadc2b7c14aa35521ee923938ec51ef97e3ec041f35e7286b90bbd98a5f4afe2a5ebebd3e5b8cd63e6f20e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d621400dbb0fd85c8a7de1a9aaf943708592643101f95b3141720d042e5757af1fdb47ed1bdaf106817a937169fefc9e7a00b2a15711aef31cf4b5e690075b11"} 05:26:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:22 INFO - Contents: 05:26:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8a22ae7482667e1a111ee9e85789142cc8bc21f9b1c989598fb4fddc890433b6da2e4dc57bd4c3be4252617407cbd557aa63415885b430b737ba5e834092dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f52f4207b59f26fa769a56ac689bfc6bc49dd12fadc2b7c14aa35521ee923938ec51ef97e3ec041f35e7286b90bbd98a5f4afe2a5ebebd3e5b8cd63e6f20e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d621400dbb0fd85c8a7de1a9aaf943708592643101f95b3141720d042e5757af1fdb47ed1bdaf106817a937169fefc9e7a00b2a15711aef31cf4b5e690075b11"} 05:26:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:22 INFO - Copying logs to upload dir... 05:26:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.009264 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-08 05:26:22.243841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:22.247803) ========= 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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8a22ae7482667e1a111ee9e85789142cc8bc21f9b1c989598fb4fddc890433b6da2e4dc57bd4c3be4252617407cbd557aa63415885b430b737ba5e834092dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f52f4207b59f26fa769a56ac689bfc6bc49dd12fadc2b7c14aa35521ee923938ec51ef97e3ec041f35e7286b90bbd98a5f4afe2a5ebebd3e5b8cd63e6f20e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d621400dbb0fd85c8a7de1a9aaf943708592643101f95b3141720d042e5757af1fdb47ed1bdaf106817a937169fefc9e7a00b2a15711aef31cf4b5e690075b11"} build_url:https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011009 build_url: 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8a22ae7482667e1a111ee9e85789142cc8bc21f9b1c989598fb4fddc890433b6da2e4dc57bd4c3be4252617407cbd557aa63415885b430b737ba5e834092dea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f52f4207b59f26fa769a56ac689bfc6bc49dd12fadc2b7c14aa35521ee923938ec51ef97e3ec041f35e7286b90bbd98a5f4afe2a5ebebd3e5b8cd63e6f20e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d621400dbb0fd85c8a7de1a9aaf943708592643101f95b3141720d042e5757af1fdb47ed1bdaf106817a937169fefc9e7a00b2a15711aef31cf4b5e690075b11"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:22.284739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:22.285554) ========= 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.Jgoj3EBfIY/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.5kurnPEnpf/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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.005202 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:22.338224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:26:22.338915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:26:22.339351) ========= ========= Total master_lag: 0.19 =========